builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-062 starttime: 1456620138.53 results: success (0) buildid: 20160227155713 builduid: 7c29a532cd0c47faa28a5f9a51de91f0 revision: 1e55f160b4ae5237c3bd8053acba9ff434c1b609 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-27 16:42:18.532228) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-27 16:42:18.532616) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-27 16:42:18.532942) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.009067 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-27 16:42:18.574215) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-27 16:42:18.574543) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-27 16:42:18.593254) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 16:42:18.593534) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 16:42:18.660636) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-27 16:42:18.660920) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-27 16:42:18.661276) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 16:42:18.661571) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-27 16:42:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.3M=0s 2016-02-27 16:42:19 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.244077 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 16:42:18.922281) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 16:42:18.922985) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015479 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 16:42:18.977444) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 16:42:18.978209) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1e55f160b4ae5237c3bd8053acba9ff434c1b609 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 1e55f160b4ae5237c3bd8053acba9ff434c1b609 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-27 16:42:19,131 truncating revision to first 12 chars 2016-02-27 16:42:19,131 Setting DEBUG logging. 2016-02-27 16:42:19,131 attempt 1/10 2016-02-27 16:42:19,131 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1e55f160b4ae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-27 16:42:19,380 unpacking tar archive at: fx-team-1e55f160b4ae/testing/mozharness/ program finished with exit code 0 elapsedTime=0.586581 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 16:42:19.584900) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-27 16:42:19.585729) ========= echo 1e55f160b4ae5237c3bd8053acba9ff434c1b609 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1e55f160b4ae5237c3bd8053acba9ff434c1b609'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 1e55f160b4ae5237c3bd8053acba9ff434c1b609 program finished with exit code 0 elapsedTime=0.004584 script_repo_revision: '1e55f160b4ae5237c3bd8053acba9ff434c1b609' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-27 16:42:19.638222) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-27 16:42:19.638523) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-27 16:42:19.648759) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 44 secs) (at 2016-02-27 16:42:19.649227) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:42:19 INFO - MultiFileLogger online at 20160227 16:42:19 in /builds/slave/test 16:42:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 16:42:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:42:19 INFO - {'append_to_log': False, 16:42:19 INFO - 'base_work_dir': '/builds/slave/test', 16:42:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:42:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:42:19 INFO - 'branch': 'Fx-Team-Non-PGO', 16:42:19 INFO - 'buildbot_json_path': 'buildprops.json', 16:42:19 INFO - 'config_files': ('talos/linux_config.py',), 16:42:19 INFO - 'default_actions': ('clobber', 16:42:19 INFO - 'read-buildbot-config', 16:42:19 INFO - 'download-and-extract', 16:42:19 INFO - 'populate-webroot', 16:42:19 INFO - 'create-virtualenv', 16:42:19 INFO - 'install', 16:42:19 INFO - 'run-tests'), 16:42:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:42:19 INFO - 'download_minidump_stackwalk': True, 16:42:19 INFO - 'download_symbols': 'ondemand', 16:42:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:42:19 INFO - 'tooltool.py': '/tools/tooltool.py', 16:42:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:42:19 INFO - '/tools/misc-python/virtualenv.py')}, 16:42:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:42:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:42:19 INFO - 'installer_path': 'installer.exe', 16:42:19 INFO - 'log_level': 'info', 16:42:19 INFO - 'log_name': 'talos', 16:42:19 INFO - 'log_to_console': True, 16:42:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:42:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:42:19 INFO - 'opt_config_files': (), 16:42:19 INFO - 'pip_index': False, 16:42:19 INFO - 'sps_profile': False, 16:42:19 INFO - 'sps_profile_interval': 0, 16:42:19 INFO - 'suite': 'dromaeojs-e10s', 16:42:19 INFO - 'system_bits': '32', 16:42:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:42:19 INFO - 'title': 'talos-linux64-ix-062', 16:42:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:42:19 INFO - 'use_talos_json': True, 16:42:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:42:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:42:19 INFO - 'work_dir': 'build'} 16:42:19 INFO - ##### 16:42:19 INFO - ##### Running clobber step. 16:42:19 INFO - ##### 16:42:19 INFO - Running pre-action listener: _resource_record_pre_action 16:42:19 INFO - Running main action method: clobber 16:42:19 INFO - rmtree: /builds/slave/test/build 16:42:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:42:20 INFO - Running post-action listener: _resource_record_post_action 16:42:20 INFO - ##### 16:42:20 INFO - ##### Running read-buildbot-config step. 16:42:20 INFO - ##### 16:42:20 INFO - Running pre-action listener: _resource_record_pre_action 16:42:20 INFO - Running main action method: read_buildbot_config 16:42:20 INFO - Using buildbot properties: 16:42:20 INFO - { 16:42:20 INFO - "project": "", 16:42:20 INFO - "product": "firefox", 16:42:20 INFO - "script_repo_revision": "production", 16:42:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:42:20 INFO - "repository": "", 16:42:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 16:42:20 INFO - "buildid": "20160227155713", 16:42:20 INFO - "pgo_build": "False", 16:42:20 INFO - "basedir": "/builds/slave/test", 16:42:20 INFO - "buildnumber": 1166, 16:42:20 INFO - "slavename": "talos-linux64-ix-062", 16:42:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:42:20 INFO - "platform": "ubuntu64_hw", 16:42:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:42:20 INFO - "branch": "fx-team", 16:42:20 INFO - "repo_path": "integration/fx-team", 16:42:20 INFO - "revision": "1e55f160b4ae5237c3bd8053acba9ff434c1b609", 16:42:20 INFO - "stage_platform": "linux64", 16:42:20 INFO - "builduid": "7c29a532cd0c47faa28a5f9a51de91f0", 16:42:20 INFO - "slavebuilddir": "test" 16:42:20 INFO - } 16:42:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 16:42:20 INFO - Running post-action listener: _resource_record_post_action 16:42:20 INFO - ##### 16:42:20 INFO - ##### Running download-and-extract step. 16:42:20 INFO - ##### 16:42:20 INFO - Running pre-action listener: _resource_record_pre_action 16:42:20 INFO - Running main action method: download_and_extract 16:42:20 INFO - mkdir: /builds/slave/test/build/tests 16:42:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:20 INFO - https://queue.taskcluster.net/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:42:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/test_packages.json 16:42:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/test_packages.json 16:42:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:42:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:42:26 INFO - Downloaded 1448 bytes. 16:42:26 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:42:26 INFO - Using the following test package requirements: 16:42:26 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 16:42:26 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:42:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:42:26 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:42:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:42:26 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:42:26 INFO - u'jsshell-linux-x86_64.zip'], 16:42:26 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:42:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:42:26 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 16:42:26 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:42:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:42:26 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:42:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:42:26 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:42:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:42:26 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 16:42:26 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:42:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:42:26 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:42:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:26 INFO - https://queue.taskcluster.net/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:42:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:42:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:42:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:42:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:42:28 INFO - Downloaded 22056809 bytes. 16:42:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:42:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:42:29 INFO - Return code: 0 16:42:29 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:29 INFO - https://queue.taskcluster.net/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:42:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:42:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:42:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:42:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:42:40 INFO - Downloaded 22056809 bytes. 16:42:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:42:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:42:41 INFO - Return code: 0 16:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:41 INFO - https://queue.taskcluster.net/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:42:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 16:42:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 16:42:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 16:42:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:42:42 INFO - Downloaded 10713410 bytes. 16:42:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:42:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:42:42 INFO - Return code: 0 16:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:42 INFO - https://queue.taskcluster.net/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:42:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:42:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:42:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:42:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:42:43 INFO - Downloaded 54840585 bytes. 16:42:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:42:43 INFO - mkdir: /builds/slave/test/properties 16:42:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:42:43 INFO - Writing to file /builds/slave/test/properties/build_url 16:42:43 INFO - Contents: 16:42:43 INFO - build_url:https://queue.taskcluster.net/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:42:44 INFO - Running post-action listener: _resource_record_post_action 16:42:44 INFO - Running post-action listener: set_extra_try_arguments 16:42:44 INFO - ##### 16:42:44 INFO - ##### Running populate-webroot step. 16:42:44 INFO - ##### 16:42:44 INFO - Running pre-action listener: _resource_record_pre_action 16:42:44 INFO - Running main action method: populate_webroot 16:42:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:42:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:42:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:42:44 INFO - '--tppagecycles', 16:42:44 INFO - '7'], 16:42:44 INFO - 'tests': ['tsvgm']}}, 16:42:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:42:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:42:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:42:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:42:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:42:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:42:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:42:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:44 INFO - 'talos_options': ['--e10s'], 16:42:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:42:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:44 INFO - 'tests': ['damp', 'tps']}, 16:42:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:44 INFO - 'talos_options': ['--e10s'], 16:42:44 INFO - 'tests': ['damp', 'tps']}, 16:42:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:42:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:42:44 INFO - 'other': {'tests': ['a11yr', 16:42:44 INFO - 'ts_paint', 16:42:44 INFO - 'tpaint', 16:42:44 INFO - 'sessionrestore', 16:42:44 INFO - 'sessionrestore_no_auto_restore']}, 16:42:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:42:44 INFO - 'tests': ['a11yr', 16:42:44 INFO - 'ts_paint', 16:42:44 INFO - 'tpaint', 16:42:44 INFO - 'sessionrestore', 16:42:44 INFO - 'sessionrestore_no_auto_restore']}, 16:42:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:42:44 INFO - 'tests': ['a11yr', 16:42:44 INFO - 'ts_paint', 16:42:44 INFO - 'tpaint', 16:42:44 INFO - 'sessionrestore', 16:42:44 INFO - 'sessionrestore_no_auto_restore']}, 16:42:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:42:44 INFO - 'tests': ['a11yr', 16:42:44 INFO - 'ts_paint', 16:42:44 INFO - 'tpaint', 16:42:44 INFO - 'sessionrestore', 16:42:44 INFO - 'sessionrestore_no_auto_restore']}, 16:42:44 INFO - 'other_l64': {'tests': ['a11yr', 16:42:44 INFO - 'ts_paint', 16:42:44 INFO - 'tpaint', 16:42:44 INFO - 'sessionrestore', 16:42:44 INFO - 'sessionrestore_no_auto_restore']}, 16:42:44 INFO - 'other_nol64': {'tests': ['a11yr', 16:42:44 INFO - 'ts_paint', 16:42:44 INFO - 'tpaint', 16:42:44 INFO - 'sessionrestore', 16:42:44 INFO - 'sessionrestore_no_auto_restore']}, 16:42:44 INFO - 'svgr': {'tests': ['tsvgx', 16:42:44 INFO - 'tsvgr_opacity', 16:42:44 INFO - 'tart', 16:42:44 INFO - 'tscrollx', 16:42:44 INFO - 'cart']}, 16:42:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:42:44 INFO - 'tests': ['tsvgx', 16:42:44 INFO - 'tsvgr_opacity', 16:42:44 INFO - 'tart', 16:42:44 INFO - 'tscrollx', 16:42:44 INFO - 'cart']}, 16:42:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:44 INFO - 'tests': ['tp5o']}, 16:42:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:44 INFO - 'talos_options': ['--e10s'], 16:42:44 INFO - 'tests': ['tp5o']}, 16:42:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:44 INFO - 'talos_options': ['--xperf_path', 16:42:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:42:44 INFO - 'tests': ['tp5n']}, 16:42:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:44 INFO - 'talos_options': ['--e10s', 16:42:44 INFO - '--xperf_path', 16:42:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:42:44 INFO - 'tests': ['tp5n']}}, 16:42:44 INFO - 'talos.zip': {'path': '', 16:42:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:42:44 INFO - Running post-action listener: _resource_record_post_action 16:42:44 INFO - ##### 16:42:44 INFO - ##### Running create-virtualenv step. 16:42:44 INFO - ##### 16:42:44 INFO - Running pre-action listener: _resource_record_pre_action 16:42:44 INFO - Running main action method: create_virtualenv 16:42:44 INFO - Creating virtualenv /builds/slave/test/build/venv 16:42:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:42:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:42:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:42:44 INFO - Using real prefix '/usr' 16:42:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:42:45 INFO - Installing distribute.............................................................................................................................................................................................done. 16:42:47 INFO - Installing pip.................done. 16:42:47 INFO - Return code: 0 16:42:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcee33d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d93b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1168100>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1169490>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:42:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:42:47 INFO - Using env: {'DISPLAY': ':0', 16:42:47 INFO - 'HOME': '/home/cltbld', 16:42:47 INFO - 'LANG': 'en_US.UTF-8', 16:42:47 INFO - 'LANGUAGE': 'en_US:en', 16:42:47 INFO - 'LOGNAME': 'cltbld', 16:42:47 INFO - 'MAIL': '/var/mail/cltbld', 16:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:47 INFO - 'MOZ_NO_REMOTE': '1', 16:42:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:47 INFO - 'NO_EM_RESTART': '1', 16:42:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:47 INFO - 'PWD': '/builds/slave/test', 16:42:47 INFO - 'SHELL': '/bin/bash', 16:42:47 INFO - 'SHLVL': '1', 16:42:47 INFO - 'TERM': 'linux', 16:42:47 INFO - 'TMOUT': '86400', 16:42:47 INFO - 'USER': 'cltbld', 16:42:47 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088', 16:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:47 INFO - '_': '/tools/buildbot/bin/python'} 16:42:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:42:47 INFO - Cleaning up... 16:42:47 INFO - Return code: 0 16:42:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcee33d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d93b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1168100>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1169490>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:42:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:42:47 INFO - Using env: {'DISPLAY': ':0', 16:42:47 INFO - 'HOME': '/home/cltbld', 16:42:47 INFO - 'LANG': 'en_US.UTF-8', 16:42:47 INFO - 'LANGUAGE': 'en_US:en', 16:42:47 INFO - 'LOGNAME': 'cltbld', 16:42:47 INFO - 'MAIL': '/var/mail/cltbld', 16:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:47 INFO - 'MOZ_NO_REMOTE': '1', 16:42:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:47 INFO - 'NO_EM_RESTART': '1', 16:42:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:47 INFO - 'PWD': '/builds/slave/test', 16:42:47 INFO - 'SHELL': '/bin/bash', 16:42:47 INFO - 'SHLVL': '1', 16:42:47 INFO - 'TERM': 'linux', 16:42:47 INFO - 'TMOUT': '86400', 16:42:47 INFO - 'USER': 'cltbld', 16:42:47 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088', 16:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:47 INFO - '_': '/tools/buildbot/bin/python'} 16:42:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:47 INFO - Downloading/unpacking psutil>=0.7.1 16:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:42:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:42:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:42:49 INFO - Installing collected packages: psutil 16:42:49 INFO - Running setup.py install for psutil 16:42:49 INFO - building 'psutil._psutil_linux' extension 16:42:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:42:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:42:50 INFO - building 'psutil._psutil_posix' extension 16:42:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:42:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:42:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:42:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:42:50 INFO - Successfully installed psutil 16:42:50 INFO - Cleaning up... 16:42:50 INFO - Return code: 0 16:42:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcee33d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d93b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1168100>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1169490>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:42:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:42:50 INFO - Using env: {'DISPLAY': ':0', 16:42:50 INFO - 'HOME': '/home/cltbld', 16:42:50 INFO - 'LANG': 'en_US.UTF-8', 16:42:50 INFO - 'LANGUAGE': 'en_US:en', 16:42:50 INFO - 'LOGNAME': 'cltbld', 16:42:50 INFO - 'MAIL': '/var/mail/cltbld', 16:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:50 INFO - 'MOZ_NO_REMOTE': '1', 16:42:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:50 INFO - 'NO_EM_RESTART': '1', 16:42:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:50 INFO - 'PWD': '/builds/slave/test', 16:42:50 INFO - 'SHELL': '/bin/bash', 16:42:50 INFO - 'SHLVL': '1', 16:42:50 INFO - 'TERM': 'linux', 16:42:50 INFO - 'TMOUT': '86400', 16:42:50 INFO - 'USER': 'cltbld', 16:42:50 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088', 16:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:50 INFO - '_': '/tools/buildbot/bin/python'} 16:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:42:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:42:52 INFO - Installing collected packages: mozsystemmonitor 16:42:52 INFO - Running setup.py install for mozsystemmonitor 16:42:52 INFO - Successfully installed mozsystemmonitor 16:42:52 INFO - Cleaning up... 16:42:52 INFO - Return code: 0 16:42:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcee33d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d93b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1168100>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1169490>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:42:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:42:52 INFO - Using env: {'DISPLAY': ':0', 16:42:52 INFO - 'HOME': '/home/cltbld', 16:42:52 INFO - 'LANG': 'en_US.UTF-8', 16:42:52 INFO - 'LANGUAGE': 'en_US:en', 16:42:52 INFO - 'LOGNAME': 'cltbld', 16:42:52 INFO - 'MAIL': '/var/mail/cltbld', 16:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:52 INFO - 'MOZ_NO_REMOTE': '1', 16:42:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:52 INFO - 'NO_EM_RESTART': '1', 16:42:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:52 INFO - 'PWD': '/builds/slave/test', 16:42:52 INFO - 'SHELL': '/bin/bash', 16:42:52 INFO - 'SHLVL': '1', 16:42:52 INFO - 'TERM': 'linux', 16:42:52 INFO - 'TMOUT': '86400', 16:42:52 INFO - 'USER': 'cltbld', 16:42:52 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088', 16:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:52 INFO - '_': '/tools/buildbot/bin/python'} 16:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:52 INFO - Downloading/unpacking blobuploader==1.2.4 16:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:54 INFO - Downloading blobuploader-1.2.4.tar.gz 16:42:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:42:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:42:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:56 INFO - Downloading docopt-0.6.1.tar.gz 16:42:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:42:56 INFO - Installing collected packages: blobuploader, requests, docopt 16:42:56 INFO - Running setup.py install for blobuploader 16:42:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:42:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:42:56 INFO - Running setup.py install for requests 16:42:57 INFO - Running setup.py install for docopt 16:42:57 INFO - Successfully installed blobuploader requests docopt 16:42:57 INFO - Cleaning up... 16:42:57 INFO - Return code: 0 16:42:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcee33d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d93b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1168100>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1169490>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:42:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:42:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:42:57 INFO - Using env: {'DISPLAY': ':0', 16:42:57 INFO - 'HOME': '/home/cltbld', 16:42:57 INFO - 'LANG': 'en_US.UTF-8', 16:42:57 INFO - 'LANGUAGE': 'en_US:en', 16:42:57 INFO - 'LOGNAME': 'cltbld', 16:42:57 INFO - 'MAIL': '/var/mail/cltbld', 16:42:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:57 INFO - 'MOZ_NO_REMOTE': '1', 16:42:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:57 INFO - 'NO_EM_RESTART': '1', 16:42:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:57 INFO - 'PWD': '/builds/slave/test', 16:42:57 INFO - 'SHELL': '/bin/bash', 16:42:57 INFO - 'SHLVL': '1', 16:42:57 INFO - 'TERM': 'linux', 16:42:57 INFO - 'TMOUT': '86400', 16:42:57 INFO - 'USER': 'cltbld', 16:42:57 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088', 16:42:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:57 INFO - '_': '/tools/buildbot/bin/python'} 16:42:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:42:57 INFO - Running setup.py (path:/tmp/pip-FpeIy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:42:57 INFO - Running setup.py (path:/tmp/pip-SZLxLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:42:57 INFO - Running setup.py (path:/tmp/pip-UCQNgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:42:57 INFO - Running setup.py (path:/tmp/pip-Gde8m7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:42:57 INFO - Running setup.py (path:/tmp/pip-8rGjaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:42:58 INFO - Running setup.py (path:/tmp/pip-TfHc4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:42:58 INFO - Running setup.py (path:/tmp/pip-hH8DzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:42:58 INFO - Running setup.py (path:/tmp/pip-5tFieB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:42:58 INFO - Running setup.py (path:/tmp/pip-kNgh8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:42:58 INFO - Running setup.py (path:/tmp/pip-PKIa7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:42:58 INFO - Running setup.py (path:/tmp/pip-OkpMnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:42:58 INFO - Running setup.py (path:/tmp/pip-5w2p2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:42:58 INFO - Running setup.py (path:/tmp/pip-Cpm4aM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:42:58 INFO - Running setup.py (path:/tmp/pip-yJl7u6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:42:58 INFO - Running setup.py (path:/tmp/pip-8gntP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:42:58 INFO - Running setup.py (path:/tmp/pip-ikscqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:42:58 INFO - Running setup.py (path:/tmp/pip-OQ6jyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:42:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:42:58 INFO - Running setup.py install for manifestparser 16:42:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:42:58 INFO - Running setup.py install for mozcrash 16:42:59 INFO - Running setup.py install for mozdebug 16:42:59 INFO - Running setup.py install for mozdevice 16:42:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:42:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:42:59 INFO - Running setup.py install for mozfile 16:42:59 INFO - Running setup.py install for mozhttpd 16:42:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:42:59 INFO - Running setup.py install for mozinfo 16:42:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:42:59 INFO - Running setup.py install for mozInstall 16:42:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:42:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:42:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:42:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:42:59 INFO - Running setup.py install for mozleak 16:42:59 INFO - Running setup.py install for mozlog 16:42:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:42:59 INFO - Running setup.py install for moznetwork 16:42:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:42:59 INFO - Running setup.py install for mozprocess 16:43:00 INFO - Running setup.py install for mozprofile 16:43:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:43:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:43:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:43:00 INFO - Running setup.py install for mozrunner 16:43:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:43:00 INFO - Running setup.py install for mozscreenshot 16:43:00 INFO - Running setup.py install for moztest 16:43:00 INFO - Running setup.py install for mozversion 16:43:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:43:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:43:00 INFO - Cleaning up... 16:43:00 INFO - Return code: 0 16:43:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:43:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcee33d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d93b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1168100>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1169490>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:43:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:43:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:43:00 INFO - Using env: {'DISPLAY': ':0', 16:43:00 INFO - 'HOME': '/home/cltbld', 16:43:00 INFO - 'LANG': 'en_US.UTF-8', 16:43:00 INFO - 'LANGUAGE': 'en_US:en', 16:43:00 INFO - 'LOGNAME': 'cltbld', 16:43:00 INFO - 'MAIL': '/var/mail/cltbld', 16:43:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:00 INFO - 'MOZ_NO_REMOTE': '1', 16:43:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:00 INFO - 'NO_EM_RESTART': '1', 16:43:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:00 INFO - 'PWD': '/builds/slave/test', 16:43:00 INFO - 'SHELL': '/bin/bash', 16:43:00 INFO - 'SHLVL': '1', 16:43:00 INFO - 'TERM': 'linux', 16:43:00 INFO - 'TMOUT': '86400', 16:43:00 INFO - 'USER': 'cltbld', 16:43:00 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088', 16:43:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:00 INFO - '_': '/tools/buildbot/bin/python'} 16:43:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:43:00 INFO - Running setup.py (path:/tmp/pip-LaBIUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:43:00 INFO - Running setup.py (path:/tmp/pip-lvn7DM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:43:01 INFO - Running setup.py (path:/tmp/pip-hl7ZFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:43:01 INFO - Running setup.py (path:/tmp/pip-m8pOcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:43:01 INFO - Running setup.py (path:/tmp/pip-R0sosO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:43:01 INFO - Running setup.py (path:/tmp/pip-0AjNxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:43:01 INFO - Running setup.py (path:/tmp/pip-epnmdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:43:01 INFO - Running setup.py (path:/tmp/pip-eLcBf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:43:01 INFO - Running setup.py (path:/tmp/pip-JyivnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:43:01 INFO - Running setup.py (path:/tmp/pip-8Xk216-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:43:01 INFO - Running setup.py (path:/tmp/pip-ATOP3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:43:01 INFO - Running setup.py (path:/tmp/pip-1mPLTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:43:01 INFO - Running setup.py (path:/tmp/pip-31lCyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:43:01 INFO - Running setup.py (path:/tmp/pip-p0nJOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:43:01 INFO - Running setup.py (path:/tmp/pip-l6N_ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:43:01 INFO - Running setup.py (path:/tmp/pip-qtlxDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:43:02 INFO - Running setup.py (path:/tmp/pip-gtR9IB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:43:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:03 INFO - Downloading blessings-1.6.tar.gz 16:43:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:43:04 INFO - Installing collected packages: blessings 16:43:04 INFO - Running setup.py install for blessings 16:43:04 INFO - Successfully installed blessings 16:43:04 INFO - Cleaning up... 16:43:04 INFO - Return code: 0 16:43:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:43:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:43:04 INFO - Reading from file tmpfile_stdout 16:43:04 INFO - Current package versions: 16:43:04 INFO - argparse == 1.2.1 16:43:04 INFO - blessings == 1.6 16:43:04 INFO - blobuploader == 1.2.4 16:43:04 INFO - docopt == 0.6.1 16:43:04 INFO - manifestparser == 1.1 16:43:04 INFO - mozInstall == 1.12 16:43:04 INFO - mozcrash == 0.16 16:43:04 INFO - mozdebug == 0.1 16:43:04 INFO - mozdevice == 0.48 16:43:04 INFO - mozfile == 1.2 16:43:04 INFO - mozhttpd == 0.7 16:43:04 INFO - mozinfo == 0.9 16:43:04 INFO - mozleak == 0.1 16:43:04 INFO - mozlog == 3.1 16:43:04 INFO - moznetwork == 0.27 16:43:04 INFO - mozprocess == 0.22 16:43:04 INFO - mozprofile == 0.28 16:43:04 INFO - mozrunner == 6.11 16:43:04 INFO - mozscreenshot == 0.1 16:43:04 INFO - mozsystemmonitor == 0.0 16:43:04 INFO - moztest == 0.7 16:43:04 INFO - mozversion == 1.4 16:43:04 INFO - psutil == 3.1.1 16:43:04 INFO - requests == 1.2.3 16:43:04 INFO - wsgiref == 0.1.2 16:43:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcee33d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d93b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1168100>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1169490>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:43:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:43:04 INFO - Using env: {'DISPLAY': ':0', 16:43:04 INFO - 'HOME': '/home/cltbld', 16:43:04 INFO - 'LANG': 'en_US.UTF-8', 16:43:04 INFO - 'LANGUAGE': 'en_US:en', 16:43:04 INFO - 'LOGNAME': 'cltbld', 16:43:04 INFO - 'MAIL': '/var/mail/cltbld', 16:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:04 INFO - 'MOZ_NO_REMOTE': '1', 16:43:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:04 INFO - 'NO_EM_RESTART': '1', 16:43:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:04 INFO - 'PWD': '/builds/slave/test', 16:43:04 INFO - 'SHELL': '/bin/bash', 16:43:04 INFO - 'SHLVL': '1', 16:43:04 INFO - 'TERM': 'linux', 16:43:04 INFO - 'TMOUT': '86400', 16:43:04 INFO - 'USER': 'cltbld', 16:43:04 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088', 16:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:04 INFO - '_': '/tools/buildbot/bin/python'} 16:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:43:04 INFO - Cleaning up... 16:43:04 INFO - Return code: 0 16:43:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcee33d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d93b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1168100>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1169490>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:43:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:43:04 INFO - Using env: {'DISPLAY': ':0', 16:43:04 INFO - 'HOME': '/home/cltbld', 16:43:04 INFO - 'LANG': 'en_US.UTF-8', 16:43:04 INFO - 'LANGUAGE': 'en_US:en', 16:43:04 INFO - 'LOGNAME': 'cltbld', 16:43:04 INFO - 'MAIL': '/var/mail/cltbld', 16:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:04 INFO - 'MOZ_NO_REMOTE': '1', 16:43:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:04 INFO - 'NO_EM_RESTART': '1', 16:43:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:04 INFO - 'PWD': '/builds/slave/test', 16:43:04 INFO - 'SHELL': '/bin/bash', 16:43:04 INFO - 'SHLVL': '1', 16:43:04 INFO - 'TERM': 'linux', 16:43:04 INFO - 'TMOUT': '86400', 16:43:04 INFO - 'USER': 'cltbld', 16:43:04 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088', 16:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:04 INFO - '_': '/tools/buildbot/bin/python'} 16:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:04 INFO - Downloading/unpacking jsonschema 16:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:43:06 INFO - Downloading/unpacking functools32 (from jsonschema) 16:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:06 INFO - Downloading functools32-3.2.3-2.tar.gz 16:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:43:06 INFO - warning: no files found matching '*.txt' 16:43:06 INFO - no previously-included directories found matching 'build' 16:43:06 INFO - no previously-included directories found matching 'dist' 16:43:06 INFO - no previously-included directories found matching '.git*' 16:43:06 INFO - Installing collected packages: jsonschema, functools32 16:43:06 INFO - Running setup.py install for functools32 16:43:07 INFO - warning: no files found matching '*.txt' 16:43:07 INFO - no previously-included directories found matching 'build' 16:43:07 INFO - no previously-included directories found matching 'dist' 16:43:07 INFO - no previously-included directories found matching '.git*' 16:43:07 INFO - Successfully installed jsonschema functools32 16:43:07 INFO - Cleaning up... 16:43:07 INFO - Return code: 0 16:43:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:43:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcee33d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d93b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1168100>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1169490>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:43:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:43:07 INFO - Using env: {'DISPLAY': ':0', 16:43:07 INFO - 'HOME': '/home/cltbld', 16:43:07 INFO - 'LANG': 'en_US.UTF-8', 16:43:07 INFO - 'LANGUAGE': 'en_US:en', 16:43:07 INFO - 'LOGNAME': 'cltbld', 16:43:07 INFO - 'MAIL': '/var/mail/cltbld', 16:43:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:07 INFO - 'MOZ_NO_REMOTE': '1', 16:43:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:07 INFO - 'NO_EM_RESTART': '1', 16:43:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:07 INFO - 'PWD': '/builds/slave/test', 16:43:07 INFO - 'SHELL': '/bin/bash', 16:43:07 INFO - 'SHLVL': '1', 16:43:07 INFO - 'TERM': 'linux', 16:43:07 INFO - 'TMOUT': '86400', 16:43:07 INFO - 'USER': 'cltbld', 16:43:07 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088', 16:43:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:07 INFO - '_': '/tools/buildbot/bin/python'} 16:43:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:07 INFO - Downloading/unpacking flake8 16:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:43:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:43:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:43:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:43:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:43:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:43:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:43:09 INFO - no previously-included directories found matching 'docs/_build' 16:43:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:43:09 INFO - Running setup.py install for pep8 16:43:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:43:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:43:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:43:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:43:10 INFO - no previously-included directories found matching 'docs/_build' 16:43:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:43:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:43:10 INFO - Cleaning up... 16:43:10 INFO - Return code: 0 16:43:10 INFO - Running post-action listener: _resource_record_post_action 16:43:10 INFO - Running post-action listener: _start_resource_monitoring 16:43:10 INFO - Starting resource monitoring. 16:43:10 INFO - ##### 16:43:10 INFO - ##### Running install step. 16:43:10 INFO - ##### 16:43:10 INFO - Running pre-action listener: _resource_record_pre_action 16:43:10 INFO - Running main action method: install 16:43:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:43:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:43:10 INFO - Reading from file tmpfile_stdout 16:43:10 INFO - Detecting whether we're running mozinstall >=1.0... 16:43:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:43:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:43:10 INFO - Reading from file tmpfile_stdout 16:43:10 INFO - Output received: 16:43:10 INFO - Usage: mozinstall [options] installer 16:43:10 INFO - Options: 16:43:10 INFO - -h, --help show this help message and exit 16:43:10 INFO - -d DEST, --destination=DEST 16:43:10 INFO - Directory to install application into. [default: 16:43:10 INFO - "/builds/slave/test"] 16:43:10 INFO - --app=APP Application being installed. [default: firefox] 16:43:10 INFO - mkdir: /builds/slave/test/build/application 16:43:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:43:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:43:26 INFO - Reading from file tmpfile_stdout 16:43:26 INFO - Output received: 16:43:26 INFO - /builds/slave/test/build/application/firefox/firefox 16:43:26 INFO - Running post-action listener: _resource_record_post_action 16:43:26 INFO - ##### 16:43:26 INFO - ##### Running run-tests step. 16:43:26 INFO - ##### 16:43:26 INFO - Running pre-action listener: _resource_record_pre_action 16:43:26 INFO - Running main action method: run_tests 16:43:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:43:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:43:26 INFO - Python 2.7.3 16:43:26 INFO - Return code: 0 16:43:26 INFO - grabbing minidump binary from tooltool 16:43:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:26 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1168100>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1169490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:43:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:43:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:43:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:43:26 INFO - Return code: 0 16:43:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:43:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:43:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:43:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:43:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:43:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:43:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:43:27 INFO - Return code: 0 16:43:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:43:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:43:27 INFO - Using env: {'DISPLAY': ':0', 16:43:27 INFO - 'HOME': '/home/cltbld', 16:43:27 INFO - 'LANG': 'en_US.UTF-8', 16:43:27 INFO - 'LANGUAGE': 'en_US:en', 16:43:27 INFO - 'LOGNAME': 'cltbld', 16:43:27 INFO - 'MAIL': '/var/mail/cltbld', 16:43:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:43:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:43:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:27 INFO - 'MOZ_NO_REMOTE': '1', 16:43:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:43:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:27 INFO - 'NO_EM_RESTART': '1', 16:43:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:27 INFO - 'PWD': '/builds/slave/test', 16:43:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:43:27 INFO - 'SHELL': '/bin/bash', 16:43:27 INFO - 'SHLVL': '1', 16:43:27 INFO - 'TERM': 'linux', 16:43:27 INFO - 'TMOUT': '86400', 16:43:27 INFO - 'USER': 'cltbld', 16:43:27 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088', 16:43:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:27 INFO - '_': '/tools/buildbot/bin/python'} 16:43:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:43:27 INFO - mozversion application_buildid: 20160227155713 16:43:27 INFO - mozversion application_changeset: 1e55f160b4ae5237c3bd8053acba9ff434c1b609 16:43:27 INFO - mozversion application_display_name: Nightly 16:43:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:43:27 INFO - mozversion application_name: Firefox 16:43:27 INFO - mozversion application_remotingname: firefox 16:43:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:43:27 INFO - mozversion application_vendor: Mozilla 16:43:27 INFO - mozversion application_version: 47.0a1 16:43:27 INFO - mozversion platform_buildid: 20160227155713 16:43:27 INFO - mozversion platform_changeset: 1e55f160b4ae5237c3bd8053acba9ff434c1b609 16:43:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:43:27 INFO - mozversion platform_version: 47.0a1 16:43:27 INFO - using testdate: 1456620207 16:43:27 INFO - actual date: 1456620207 16:43:27 INFO - starting webserver on 'localhost:37686' 16:43:27 INFO - SUITE-START | Running 2 tests 16:43:27 INFO - TEST-START | dromaeo_css 16:43:27 INFO - operating with platform_type : linux_ 16:43:27 INFO - Initialising browser for dromaeo_css test... 16:43:27 INFO - TEST-INFO | started process 4420 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptfH24p/profile http://localhost:37686/getInfo.html) 16:43:32 INFO - PROCESS | 4420 | 16:43:32 INFO - PROCESS | 4420 | (process:4499): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:43:32 INFO - PROCESS | 4420 | __metrics Screen width/height:1600/1200 16:43:32 INFO - PROCESS | 4420 | colorDepth:24 16:43:32 INFO - PROCESS | 4420 | Browser inner width/height: 1024/697 16:43:32 INFO - PROCESS | 4420 | __metrics 16:43:33 ERROR - PROCESS | 4420 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 16:43:33 INFO - PROCESS | 4420 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:43:33 INFO - PROCESS | 4420 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:43:33 INFO - PROCESS | 4420 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:43:33 INFO - PROCESS | 4420 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:43:33 INFO - PROCESS | 4420 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:43:33 INFO - PROCESS | 4420 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:43:33 INFO - PROCESS | 4420 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:43:33 INFO - PROCESS | 4420 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:43:33 INFO - PROCESS | 4420 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:43:34 INFO - TEST-INFO | 4420: exit 0 16:43:34 INFO - Browser initialized. 16:43:34 INFO - Running cycle 1/1 for dromaeo_css test... 16:43:34 INFO - TEST-INFO | started process 4550 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptfH24p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:43:36 INFO - PROCESS | 4550 | 16:43:36 INFO - PROCESS | 4550 | (process:4606): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:43:46 INFO - PROCESS | 4550 | RSS: Main: 158560256 16:43:46 INFO - PROCESS | 4550 | 16:44:36 INFO - PROCESS | 4550 | 1456620276182 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:46:46 INFO - PROCESS | 4550 | Cycle 1(1): loaded http://localhost:37686/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37686/tests/dromaeo/cssquery-ext.html) 16:46:47 INFO - PROCESS | 4550 | RSS: Main: 164679680 16:46:47 INFO - PROCESS | 4550 | 16:49:49 INFO - PROCESS | 4550 | Cycle 1(1): loaded http://localhost:37686/tests/dromaeo/cssquery-ext.html (next: http://localhost:37686/tests/dromaeo/cssquery-jquery.html) 16:49:50 INFO - PROCESS | 4550 | RSS: Main: 162091008 16:49:50 INFO - PROCESS | 4550 | 16:52:52 INFO - PROCESS | 4550 | Cycle 1(1): loaded http://localhost:37686/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37686/tests/dromaeo/cssquery-mootools.html) 16:52:52 INFO - PROCESS | 4550 | RSS: Main: 162795520 16:52:52 INFO - PROCESS | 4550 | 16:55:54 INFO - PROCESS | 4550 | Cycle 1(1): loaded http://localhost:37686/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37686/tests/dromaeo/cssquery-prototype.html) 16:55:54 INFO - PROCESS | 4550 | RSS: Main: 160665600 16:55:54 INFO - PROCESS | 4550 | 16:58:57 INFO - PROCESS | 4550 | Cycle 1(1): loaded http://localhost:37686/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37686/tests/dromaeo/cssquery-yui.html) 16:58:58 INFO - PROCESS | 4550 | RSS: Main: 161951744 16:58:58 INFO - PROCESS | 4550 | 17:02:00 INFO - PROCESS | 4550 | Cycle 1(1): loaded http://localhost:37686/tests/dromaeo/cssquery-yui.html (next: http://localhost:37686/tests/dromaeo/cssquery-dojo.html) 17:02:00 INFO - PROCESS | 4550 | RSS: Main: 165548032 17:02:00 INFO - PROCESS | 4550 | 17:02:00 INFO - PROCESS | 4550 | __start_tp_report 17:02:00 INFO - PROCESS | 4550 | _x_x_mozilla_page_load 17:02:00 INFO - PROCESS | 4550 | _x_x_mozilla_page_load_details 17:02:00 INFO - PROCESS | 4550 | |i|pagename|runs| 17:02:00 INFO - PROCESS | 4550 | |0;dojo.html;2596.9091081812116;2621.2922510922053;2660.388110734531;2660.747229013243;2677.08978947158;4439.311906654466;4467.396901418303;4549.11292298002;4567.840125595605;4574.702644328125;4443.355713421552;4510.323451482271;4527.38880251166;4586.403767510227;4599.724016559009;4164.500259968808;4218.957810421903;4229.70392072555;4247.341662042373;4273.786310684469;80.82247956205808;4068.1456894052285;4130.979345103286;4159.105792254664;4175.436316097318;4222.387753775685;4230.302000169999;4236.788160591974;4253.999999999969;4257.723247988886;4218.683598730107;4225.9788701056295;4233.830646774125;4259.531451540328;4292.570742925714;4033.1530378620523;4152.1695660867945;4216.03031302799;4224.5353011168745;4234.089670720809;4501.684882058257;4512.481064677539;4515.164694531522;4516.1193567254395;4534.9773251133865;4618.769061546909;4822.204336284509;4852.587530059949;4867.659263851532;4872.805087796484;4788.7366194859615;4882.365292511986;4899.534544218293;4913.459519452857;4916.58209052231;4518.81924723014;4521.796519156645;4527.071950250191;4529.230030894722;4568.931466028012;4769.785359658824;4904.8773780655765;4963.2306992415515;4971.577415919687;5013.072581572421;4713.670043097019;4769.308450274691;4775.785089670973;4783.306420568998;4809.206480930678;4816.397950256218;4832.033593281358;4853.053654537332;4857.635677324215;4869.415670119608;4627.1439783640135;4744.098621261949;4775.164346239394;4813.181759100961;4842.854714358575;4785.521447855256;4798.088363210979;4800.087983283165;4801.159797035574;4831.758412079453;4079.8780335407405;4082.1835632873544;4105.178964207171;4117.114820313647;4118.711690181718;3550.822458877046;3575.6781889630056;3627.220147668264;3660.011796814845;3664.486971823947;4094.774787386663;4200.4959404871615;4201.054762678373;4217.683673724483;4218.282891908383;4839.975800120977;4873.585745211626;4875.414950205998;4878.975605121952;4893.804247830119;4089.9795501022304;4174.979125104416;4215.557366476537;4236.279832428495;4253.2769429197115;4328.870133895988;4332.588404101605;4344.044310251739;4345.543717909637;4370.475542934868;4529.048899731093;4551.52209018055;4553.886152846139;4592.311153327028;4608.700434471749;4596.88507787308;4723.4331880174595;4732.621390288838;4801.327814105958;4894.314795928644;4557.430321209848;4600.930986035279;4621.291448516579;4634.83778067766;4637.1421287062;4709.81160753566;4784.091022705675;4792.0895029944195;4799.112164249485;4826.0830442215865;4743.762811859324;4783.760811959319;4858.854234372974;4871.95128048715;4895.4370247422;4639.420072490939;4648.442186937589;4683.8360657376825;4684.8360307389075;4697.859064228079;4654.6741728078705;4711.575958163782;4729.952700472952;4742.264948932921;4751.334813126096;4458.799354029012;4563.155816174019;4573.131105090022;4641.978764671901;4648.907021859612;4681.485036645898;4731.148393289241;4744;4755.120302743865;4802.039592081667;4538.387317712067;4653.906921861611;4668.323093151406;4676.672632915664;4706.247000479907 17:02:00 INFO - PROCESS | 4550 | |1;ext.html;493.3808070871056;500.59952038369295;517.7721802406941;522.7987224918406;562.4291344285548;31786.68213317866;32267;32419.189520261945;32590.185245368848;32619.51070733941;32989.67010329902;33228.33543329132;33535;33709.325813483716;33790.831045844796;7381.446391520631;7518.398528117737;7606.505577137496;7612;7619.80950476237;7546.2831031051965;7913.089994650602;7926.167752386003;7930.801729956768;7951.284384405402;7884.724034658788;7926.088499822507;7985.560794156319;8006.199380062006;8021.799455013613;7783.961080194619;7839.686412543491;7860.646270917851;7985.960070199611;7996;7538.660760265746;7680.846383072363;7683.961580192119;7698.461107722405;7700.9229907700765;33355.499667505006;33873.830630846685;33877.32245355104;33879;33989.320213595835;2120.819730322909;2552.438463538019;2622.5672763993916;2833.1642165561;2897.3191300044473;23722.169724059575;26256.343591410176;26670.46659066808;26962.325941851414;27319.86340068307;3169.6513383527795;3186.5698130752517;3194.34515924235;3314.386838434897;3322.7175690066374;209657;210549.9472502643;212348;213028;213615;38820.611793882264;39551.40672889909;53931.73034134804;54131.18803217955;54530;39436;39726;39731.40402893959;39751.602483975366;39913.80043099824;12929;13067;13071.477140914447;13088.672783180496;13165.27590982486;9903.504824758733;9909.702708918743;9917.603295868228;9918.702438926844;9927.106560409598;13229.801552976713;13260.668483287802;13380.732385352238;13384.330783460788;13449.394777235048;5598.86002849932;5705.003248862948;5766.769329226868;5768.509676677446;5862.03276459388;890.8619164029586;905.1898550797132;910.7586489580267;1004.6082028009082;1063.4682658670665;25598.488030239292;25632.743672563407;25639.230823075337;25836;25957.870210648827;963.6723514005272;987.5062468765617;990.2770977186694;1005.8994100590029;1042.781015986636;13431.664208394674;13673.247971361472;13712.834409075142;13767.518136865161;13911.4435422584;254342;255706;256570;256676;259184;45310;45513.77243113763;45714.54285457169;45759.77120114378;46242;1147.6270212181075;1210.5157936825165;1218.226426219357;1229.5266322465916;1246.2709315050615;25134.74865251324;25358.87320563459;25961.221163365128;26113.347166320233;26477.470450591267;40110.79944600258;40332;40494.392584110676;40635;40642.79678601706;237163;238621;239408;239546;239874;29398.55902161512;29855;38997.6100238994;40234;40599;34335;35093.19254459688;35104;35163.82418087893;35673.821630892715;33238.5014224782;33259;33335.33329333448;33337;33411.66588334086;32231.35537289288;32392.83803580967;32659.836700817294;32896;32917.78992468521;32865.178370540925;33488.66511334856;33555.16112097119;33770;33824.830875845466;30046.84976575103;30060;30343.544846826873;30378.696213037587;30535.847320763252;23829.404264893517;23945.401364966016;24001.639975400034;24157.879210603835;24341.26976190717 17:02:00 INFO - PROCESS | 4550 | |2;jquery.html;330.22397366189443;334.64527600743213;342.88684734037764;345.34212325519894;346.65334665334666;15232.39070437184;15830.445934392299;16364.181790910467;16402.425915092976;16447.342106315748;13801;13969.441222351119;14017.36921838517;14534.636634084127;14604.561863144123;4905.362302900618;5093.159628661267;5094.363204599425;5119.0529751996;5172.069027575035;4832.565069143777;4973.850784476472;5039.344885164924;5041.798328066891;5050.141475949079;4916.213405855064;4925.729084900329;4929.3591833061655;4995.6003519718515;5165.612579056567;5618.662880227159;5657.349404818437;5657.57568182388;5672.858178545528;5686;4843.5398637129765;4992.151334273146;5042.949570504285;5046.343975283226;5053.393592768854;11276.154288428319;11345.489452974554;11488.253263537843;11524.366159861203;11603.76792464146;1737.470071628153;1783.9148350277849;1827.616200597876;1853.4995551201234;1897.601503684228;8658.696945606936;8880.955595222047;8913.064128266567;8984.8652270216;9084.68203612877;1615.7091723489884;1734.9590245852514;1760.64787042592;1787.8480329172037;1832.6334733053309;54873.725631371984;55133.724331378486;55575.72212138954;56026;56740.43259567393;9418.62325506972;9496.620135194515;9771.560279787427;9777.364471309342;9957.302988790716;12222.083343749255;12225.44985475638;12295;12331;12415.317157556241;6673.599584024974;6765.42493888025;6791.4227290679855;6888.586684798928;6911;6159.692015399212;6213.689315534205;6253.030780229072;6295.6537390443045;6356.8410789729705;3921.5882332355263;4068.959310406917;4113.300738874398;4134.565870583546;4170.332746760504;1761.3130878957218;1773.7162054071546;1776.7068433708553;1790.534461040139;1818.363572749527;377.66199251669605;394.23518374354234;403.5117507815576;834.9165083491723;887.2148148888281;9414.67048653294;9643.228541716646;9870.25973052024;9920.603175873028;9932.304738668225;402.4506548561193;402.4767801857573;408.06756561257384;416.4274123080764;426.266821067763;5168.224766285088;5176.534111929869;5279.102552566073;5368.677879327252;5418.620696551204;362961;370591;376559;376571;377088;52272.21591676128;57708.13437798437;58517.41482585205;62815.685921571014;64009.679951599945;361.1206711657071;370.3500356873669;370.9239605880788;372.2369143256368;372.31308236303977;8946.731598052069;9047.366684332033;9347.906520934703;13244.470221191044;14520.709585808436;28973;29006.7099329004;29260.707392926648;29451.852740736158;29567.408651827274;35042.474362884066;36096.639033609325;36157;36512.81743591265;40595.59404405918;6820.590764554143;6851.383375496229;6888.896666549906;6938.098047253825;6942.548734332252;9723;10101;10168.33905796121;10198.082172604501;10931.234813562975;9187.081291871027;9479.952600236955;9518.762030949281;9612.903870961201;9900.613914051894;9192.17270445663;9216.30877684163;9233.261339092991;9280.211182049601;9314.72055838326;8752.037275899773;9105.271578273854;9406.905930940604;9555.849292877068;9846.31075824714;6807.795766127024;7124.964375178299;7285.927140728737;7295.671694773641;7341.192468828318;7052.33002864727;9495.85756213671;9590.904090959;9822.263330250116;9933.602655893683 17:02:00 INFO - PROCESS | 4550 | |3;mootools.html;1298.1107941060375;1303.8044293356;1385.7852032934898;1684.5114916674165;1699.864010879129;5604.887902241952;6394.944834102379;6795.626240556773;6995.650217489124;6998.895016574749;6721.5630983986;6765.255821859591;6773.72905083796;6845.281245469228;6860.382565569098;1937.4187743676875;1973.5263536751147;1979.1984246380239;2008.3272103845156;2010.105503051143;1981.6829307310834;2003.4290227285226;2011.6379051770675;2014.385612388221;2029.6955456681542;2009.437357539891;2010;2017.8688385254984;2041.652919003773;2048.1909645689943;2033.2781862438917;2049.497873021112;2057.351934140748;2078.490769761411;2087.0503920716037;1982.583657431941;1991.3528103366318;2002.2991952816544;2026.8548270227275;2028.0265472573246;6848.657567121624;6872.450203983669;6879.552829066145;6888.724451022003;6891.207511136234;3982.980085099556;4163.812628431728;4166.66666666669;4167.666586673059;4179.247735407625;2541.5933450647995;2621.0433191885018;2689.273896048056;2715.4026114254834;2725.8909643614234;787.4527203593505;793.8690116130831;798.2336956521746;798.9161138080534;809.8015986083448;9058.818823623491;9060.546972651407;9117.544122793834;9131.36080474367;9134.406263592846;3776.584575696671;3835;3912.726109172331;3917.4515567820526;3928.332183528807;7606.935029095931;7622.5517151741;7627.351675107567;7645.120811106683;7675.692972281046;4199.517055538591;4209.4948606166845;4214.536400995888;4215.78921053946;4239.067405170919;3083.92290192747;3677.5403074615674;3737.9626203738158;3813.637704418076;3844.038990252437;3241.4813629819114;3287.4575695010535;3314.171457135716;3377.9493307600405;3391.7117045051446;1028.6862506935456;1030.9845352319721;1033.3076838518211;1048.1719441641171;1066.9519871605642;1145.9770804583861;1156.1386766858575;1164.6214980131322;1167.5855071449682;1172.5720112159001;6309.779157729457;6337.144485494491;6340.651264180515;6342.429181373698;6352.0789485525265;419.8089869109548;423.1536926147705;425.47453894440343;442.911417716458;445.1786453992444;5056.089903817348;5081.28861959326;5098.286239926413;5136.203888397305;5144;7966.800829979181;8048.718294859652;8298;8374.743788431784;8393.874091888627;7992.240737129963;8167.42828002046;8169;8207.794805129919;8251.669933202726;6386.776462823779;6393.328700486475;6475;6476.319986401454;6589.47284217271;6218.81343559694;6223.19098517208;6224.906626400698;6226.470749986121;6262.561620686691;7070.575765453884;7198.424126070006;7220.241874603301;7395.667194976347;7406.4074874008875;7373.115226172679;7501.774946751606;7519.323260906544;7542.585157816373;7636.160022397421;4772.0455908817685;5331.573474121983;5720.542356611544;5737.8524295140305;5782.508486778671;6174.506039516738;6201.937980620136;6223.471004964629;6256.436920677161;6257.655828929271;5696.943030569807;5733.111367738007;5761.625494342854;5911.379305173067;5925.170476133431;5488.17677348401;5815.098659707752;5891.644921668126;5914.112883067574;5936.168936349001;6028.969855150872;6128.662923539248;6156.815295541141;6186.752529898754;6194.81415557534;5679.403662615366;5695.060315047971;5700.857478563069;5710;5728.4271572844045;5598.720063996865;5660.971695141498;5706.743196556248;5717;5719.113537401709 17:02:00 INFO - PROCESS | 4550 | |4;prototype.html;283.26068960014356;287.4423618180729;296.0039467192895;299.3802828145738;301.81287601686955;5533.225348451215;5536.252605898202;5595.1886976388505;5603.747831347594;5670.914936275959;5532.446755324466;5606.523445507127;5619.5785316101255;5623.859403514914;5633.0987042073275;3939.5666476687543;4099.918001639965;4174.791260436981;4180.91638167238;4253.680973926945;4181.080162364275;4194.685398595102;4209.368594710802;4220.514640816299;4225;4147.813348399314;4150.9584904151025;4158.6673066154635;4183.644390226835;4189.937150942723;4161.146964872194;4162.250794856925;4162.812673429703;4173.728707633994;4215.59951804578;3588.318219538279;3592.209713862972;3605;3607.9639203608153;3623.4564815277654;5333.893322133536;5340.652857564285;5358.356997160366;5375.032494151052;5398.109311963522;4690.9530904690855;4781.0676918001;4796.424429068499;4814.7833347499445;4830.758462076882;5801.0428279333855;5808.070708686632;5808.12878068289;5842.766289348421;5847.064469684872;3853.441251018615;3884.9899026253097;3892.9610703893163;3895.2599006189016;3895.8636447724475;6054.758774451227;6136.815895523141;6163.414475624809;6163.969180154116;6170.50635949123;4010.6590939770444;4012.237674841829;4014.8996275093355;4015.819288132041;4019.1157945252;4071.226466971266;4071.8371265149653;4076.3274059780397;4083.4283200351974;4086.203190377848;4518.209313370147;4680.227762419163;4699.882502937454;4727.290906364073;4796.736179510091;5719.7712091516705;5752.654840709571;5765.567582431335;5782.335031471351;5796.072628379439;1412.8445870954188;1445.6313640021726;1448.9275536223147;1449.0725935401351;1452.0924422236103;937.8733870927338;939.1031564855547;949.943003419797;958.2621381536178;970.7864269860619;5059.519345662156;5067.594592432597;5068.923966140511;5074.720890351066;5081.822136225214;6092.573519853657;6101.816945491642;6109.2974307955155;6110.663913484712;6121.143039974407;4859.757012149449;5028.994201159782;5061.4179369373;5071.644984851025;5072.112380333427;3180.2367431816197;3291.588551431071;3300.7194388477246;3304.273059926812;3305.2067503799394;5757;5760.855978600569;5766;5792.913106303409;5821.708914554255;6292.4966002719675;6308.621482711052;6310.8422289442215;6311.873762524724;6340.873182536324;5728.885422291531;5760.963026655242;5779.393163717833;5788.88422231553;5799.246098007232;5962.284525856925;6109.847253818512;6129.387061294014;6183.072539118988;6204.906926396198;5996.88006239864;6005.6396616203165;6006.129111278928;6007.849803754941;6023.427774361428;5733.3406658234835;5783.7397317119985;5797.8550536236935;5823.242978412779;5825.475707186373;4163.188178305201;4212.304969680091;4227.112306415687;4229.513605935357;4246.660267178557;6085.908711369245;6099.603525770811;6102.877942441038;6104.11490333908;6106.45041946227;5724;5843.474087332161;5850.824475265749;5929.377415371324;5958.970205148947;5909.172715819703;5934.228550288608;5945.316288626863;5956.5532585055425;5962.4633782959745;5813.09896965971;5814.447627475383;5818.883622327445;5821.679807610452;5837.241158649348;5923.822285331447;5975.850603734768;5978.551608629457;5986.940130598812;5991.460768530679;5593.244911936999;5800.1299805029585;5812.244408226903;5826.941730582809;5834.15404766315 17:02:00 INFO - PROCESS | 4550 | |5;yui.html;575.315374704102;583.4515555377943;636.7866764633848;682.2801943949133;706.2161001288565;10507.527161277741;10615.575376984922;10714.678559643213;10821.080208182313;10836.566537338516;10253.077223049924;10334.328268662532;10370.948145259283;10401.427921464316;10441.686749397511;406.066048089394;756.8675481790692;773.0723132241304;775.9185285545021;776.2664282253273;758.6813538313894;769.1116760142017;770.8535378278137;774.1716363491067;775.5308038636629;815.6615004773012;816.9019717633893;821.2321479416764;822.2599660305743;822.4900561651784;810.5744484145841;814.071957967917;814.3851392198852;816.7753867686374;818.7461886815106;597.5070566782379;605.3794860268216;608.1394826320795;612.3447910735515;612.969351532426;11184;11238.606648767336;11242.887571124265;11259.380734059623;11269.323840569592;11191.104711623051;11410.258333208398;11785.410729463492;11956;12252.44863981123;8740.606672699743;8970.551472426418;9016.413933094327;9143.862842057375;9163.175314221751;2900.535914253709;2964.8221106733663;3003.4743919813945;3019.1697283247063;3028.394321135782;36215.63784362149;36380.27239455196;36384;36549.81725091358;36563.63436365629;8572.871406928902;8681.479111253346;8746.781330466789;8770.693025744196;8850.468971861581;15530.9223453882;15608.3756649735;15619.062856228662;15624.609384765472;15665.530034098996;5809.970950145223;5885.205497257815;5922.407759224043;6050.394960503914;6050.57645964787;3434.708049815744;3443.1736383267835;3447.052060683332;3478.565179352581;3620.6198349173483;2464.9260522184363;2509.7490250974756;2510.472800711834;2521.420073383132;2522.1928982725717;439.59118020240845;446.8168051099034;451.58228638509246;456;462.4843299720787;497.8158081509792;514.269736973491;528.8122716435687;543.3344153412039;566.3826429192201;6704;6879.484038697117;7025.367716905503;7041.436685065182;7064.964675176591;440.88757366871243;501.6839391183531;503.91522367413626;515.0008982573795;516.2978349444752;3346.1969127409734;3375.628680845105;3377.4258376076127;3418.333424982154;3523.823808809549;46696.5330346699;46823.29765053527;46836;47117.764411177726;47182.76408617935;41733.1653366931;42060.36909446299;42495.36256956148;42510.362344564855;42666;39873.40189897154;40189.397159042055;40200.195996079914;40302.59697402988;40305.79847100746;6956.764406881041;7053;7478.102627684712;7556.811079723051;7700.152983171959;30496.847515762278;30605;30767.692323076484;31523.21191970219;31584.526232106076;35600.64399355973;35755;36120.638793611724;39765.80117099396;39913.401298981116;9048.230900373543;9114.316426267924;9295.953520232355;9314.906850931404;9428.811423771624;10895.78208435811;10899.945500272448;10977.066949309397;11019.338839669324;11466.656000320003;10017.248706346907;10121.291509594257;10319.277650564389;10535.73660658459;10552.84170737455;9311.72064838056;9993.750156246151;10015.449150296803;10334.948325258325;10368.326058806153;10113.544890480092;10143.34068285559;10247.641332553325;10327.122194613241;10345.172386208935;8369.163083691583;8498.150184981452;8579.914200858162;8731.738047858575;8954.298683250161;8296.502209867427;8526;8640.222379985831;8659.177378149066;8782.429142105999 17:02:00 INFO - PROCESS | 4550 | __end_tp_report 17:02:00 INFO - PROCESS | 4550 | __start_cc_report 17:02:00 INFO - PROCESS | 4550 | _x_x_mozilla_cycle_collect,348 17:02:00 INFO - PROCESS | 4550 | __end_cc_report 17:02:00 INFO - PROCESS | 4550 | __startTimestamp1456621320800__endTimestamp 17:02:00 INFO - PROCESS | 4550 | 17:02:00 INFO - PROCESS | 4550 | ------- Summary: start ------- 17:02:00 INFO - PROCESS | 4550 | Number of tests: 6 17:02:00 INFO - PROCESS | 4550 | 17:02:00 INFO - PROCESS | 4550 | [#0] dojo.html Cycles:165 Average:4453.21 Median:4596.89 stddev:559.92 (12.2%) stddev-sans-first:542.37 17:02:00 INFO - PROCESS | 4550 | Values: 2596.9 2621.3 2660.4 2660.7 2677.1 4439.3 4467.4 4549.1 4567.8 4574.7 4443.4 4510.3 4527.4 4586.4 4599.7 4164.5 4219.0 4229.7 4247.3 4273.8 80.8 4068.1 4131.0 4159.1 4175.4 4222.4 4230.3 4236.8 4254.0 4257.7 4218.7 4226.0 4233.8 4259.5 4292.6 4033.2 4152.2 4216.0 4224.5 4234.1 4501.7 4512.5 4515.2 4516.1 4535.0 4618.8 4822.2 4852.6 4867.7 4872.8 4788.7 4882.4 4899.5 4913.5 4916.6 4518.8 4521.8 4527.1 4529.2 4568.9 4769.8 4904.9 4963.2 4971.6 5013.1 4713.7 4769.3 4775.8 4783.3 4809.2 4816.4 4832.0 4853.1 4857.6 4869.4 4627.1 4744.1 4775.2 4813.2 4842.9 4785.5 4798.1 4800.1 4801.2 4831.8 4079.9 4082.2 4105.2 4117.1 4118.7 3550.8 3575.7 3627.2 3660.0 3664.5 4094.8 4200.5 4201.1 4217.7 4218.3 4840.0 4873.6 4875.4 4879.0 4893.8 4090.0 4175.0 4215.6 4236.3 4253.3 4328.9 4332.6 4344.0 4345.5 4370.5 4529.0 4551.5 4553.9 4592.3 4608.7 4596.9 4723.4 4732.6 4801.3 4894.3 4557.4 4600.9 4621.3 4634.8 4637.1 4709.8 4784.1 4792.1 4799.1 4826.1 4743.8 4783.8 4858.9 4872.0 4895.4 4639.4 4648.4 4683.8 4684.8 4697.9 4654.7 4711.6 4730.0 4742.3 4751.3 4458.8 4563.2 4573.1 4642.0 4648.9 4681.5 4731.1 4744.0 4755.1 4802.0 4538.4 4653.9 4668.3 4676.7 4706.2 17:02:00 INFO - PROCESS | 4550 | 17:02:00 INFO - PROCESS | 4550 | [#1] ext.html Cycles:180 Average:38541.25 Median:33297.17 stddev:61545.35 (184.8%) stddev-sans-first:61651.70 17:02:00 INFO - PROCESS | 4550 | Values: 493.4 500.6 517.8 522.8 562.4 31786.7 32267.0 32419.2 32590.2 32619.5 32989.7 33228.3 33535.0 33709.3 33790.8 7381.4 7518.4 7606.5 7612.0 7619.8 7546.3 7913.1 7926.2 7930.8 7951.3 7884.7 7926.1 7985.6 8006.2 8021.8 7784.0 7839.7 7860.6 7986.0 7996.0 7538.7 7680.8 7684.0 7698.5 7700.9 33355.5 33873.8 33877.3 33879.0 33989.3 2120.8 2552.4 2622.6 2833.2 2897.3 23722.2 26256.3 26670.5 26962.3 27319.9 3169.7 3186.6 3194.3 3314.4 3322.7 209657.0 210549.9 212348.0 213028.0 213615.0 38820.6 39551.4 53931.7 54131.2 54530.0 39436.0 39726.0 39731.4 39751.6 39913.8 12929.0 13067.0 13071.5 13088.7 13165.3 9903.5 9909.7 9917.6 9918.7 9927.1 13229.8 13260.7 13380.7 13384.3 13449.4 5598.9 5705.0 5766.8 5768.5 5862.0 890.9 905.2 910.8 1004.6 1063.5 25598.5 25632.7 25639.2 25836.0 25957.9 963.7 987.5 990.3 1005.9 1042.8 13431.7 13673.2 13712.8 13767.5 13911.4 254342.0 255706.0 256570.0 256676.0 259184.0 45310.0 45513.8 45714.5 45759.8 46242.0 1147.6 1210.5 1218.2 1229.5 1246.3 25134.7 25358.9 25961.2 26113.3 26477.5 40110.8 40332.0 40494.4 40635.0 40642.8 237163.0 238621.0 239408.0 239546.0 239874.0 29398.6 29855.0 38997.6 40234.0 40599.0 34335.0 35093.2 35104.0 35163.8 35673.8 33238.5 33259.0 33335.3 33337.0 33411.7 32231.4 32392.8 32659.8 32896.0 32917.8 32865.2 33488.7 33555.2 33770.0 33824.8 30046.8 30060.0 30343.5 30378.7 30535.8 23829.4 23945.4 24001.6 24157.9 24341.3 17:02:00 INFO - PROCESS | 4550 | 17:02:00 INFO - PROCESS | 4550 | [#2] jquery.html Cycles:180 Average:21214.96 Median:5044.65 stddev:61079.81 (1210.8%) stddev-sans-first:61231.03 17:02:00 INFO - PROCESS | 4550 | Values: 330.2 334.6 342.9 345.3 346.7 15232.4 15830.4 16364.2 16402.4 16447.3 13801.0 13969.4 14017.4 14534.6 14604.6 4905.4 5093.2 5094.4 5119.1 5172.1 4832.6 4973.9 5039.3 5041.8 5050.1 4916.2 4925.7 4929.4 4995.6 5165.6 5618.7 5657.3 5657.6 5672.9 5686.0 4843.5 4992.2 5042.9 5046.3 5053.4 11276.2 11345.5 11488.3 11524.4 11603.8 1737.5 1783.9 1827.6 1853.5 1897.6 8658.7 8881.0 8913.1 8984.9 9084.7 1615.7 1735.0 1760.6 1787.8 1832.6 54873.7 55133.7 55575.7 56026.0 56740.4 9418.6 9496.6 9771.6 9777.4 9957.3 12222.1 12225.4 12295.0 12331.0 12415.3 6673.6 6765.4 6791.4 6888.6 6911.0 6159.7 6213.7 6253.0 6295.7 6356.8 3921.6 4069.0 4113.3 4134.6 4170.3 1761.3 1773.7 1776.7 1790.5 1818.4 377.7 394.2 403.5 834.9 887.2 9414.7 9643.2 9870.3 9920.6 9932.3 402.5 402.5 408.1 416.4 426.3 5168.2 5176.5 5279.1 5368.7 5418.6 362961.0 370591.0 376559.0 376571.0 377088.0 52272.2 57708.1 58517.4 62815.7 64009.7 361.1 370.4 370.9 372.2 372.3 8946.7 9047.4 9347.9 13244.5 14520.7 28973.0 29006.7 29260.7 29451.9 29567.4 35042.5 36096.6 36157.0 36512.8 40595.6 6820.6 6851.4 6888.9 6938.1 6942.5 9723.0 10101.0 10168.3 10198.1 10931.2 9187.1 9480.0 9518.8 9612.9 9900.6 9192.2 9216.3 9233.3 9280.2 9314.7 8752.0 9105.3 9406.9 9555.8 9846.3 6807.8 7125.0 7285.9 7295.7 7341.2 7052.3 9495.9 9590.9 9822.3 9933.6 17:02:00 INFO - PROCESS | 4550 | 17:02:00 INFO - PROCESS | 4550 | [#3] mootools.html Cycles:180 Average:4719.38 Median:5708.37 stddev:2432.94 (42.6%) stddev-sans-first:2426.18 17:02:00 INFO - PROCESS | 4550 | Values: 1298.1 1303.8 1385.8 1684.5 1699.9 5604.9 6394.9 6795.6 6995.7 6998.9 6721.6 6765.3 6773.7 6845.3 6860.4 1937.4 1973.5 1979.2 2008.3 2010.1 1981.7 2003.4 2011.6 2014.4 2029.7 2009.4 2010.0 2017.9 2041.7 2048.2 2033.3 2049.5 2057.4 2078.5 2087.1 1982.6 1991.4 2002.3 2026.9 2028.0 6848.7 6872.5 6879.6 6888.7 6891.2 3983.0 4163.8 4166.7 4167.7 4179.2 2541.6 2621.0 2689.3 2715.4 2725.9 787.5 793.9 798.2 798.9 809.8 9058.8 9060.5 9117.5 9131.4 9134.4 3776.6 3835.0 3912.7 3917.5 3928.3 7606.9 7622.6 7627.4 7645.1 7675.7 4199.5 4209.5 4214.5 4215.8 4239.1 3083.9 3677.5 3738.0 3813.6 3844.0 3241.5 3287.5 3314.2 3377.9 3391.7 1028.7 1031.0 1033.3 1048.2 1067.0 1146.0 1156.1 1164.6 1167.6 1172.6 6309.8 6337.1 6340.7 6342.4 6352.1 419.8 423.2 425.5 442.9 445.2 5056.1 5081.3 5098.3 5136.2 5144.0 7966.8 8048.7 8298.0 8374.7 8393.9 7992.2 8167.4 8169.0 8207.8 8251.7 6386.8 6393.3 6475.0 6476.3 6589.5 6218.8 6223.2 6224.9 6226.5 6262.6 7070.6 7198.4 7220.2 7395.7 7406.4 7373.1 7501.8 7519.3 7542.6 7636.2 4772.0 5331.6 5720.5 5737.9 5782.5 6174.5 6201.9 6223.5 6256.4 6257.7 5696.9 5733.1 5761.6 5911.4 5925.2 5488.2 5815.1 5891.6 5914.1 5936.2 6029.0 6128.7 6156.8 6186.8 6194.8 5679.4 5695.1 5700.9 5710.0 5728.4 5598.7 5661.0 5706.7 5717.0 5719.1 17:02:00 INFO - PROCESS | 4550 | 17:02:00 INFO - PROCESS | 4550 | [#4] prototype.html Cycles:180 Average:4822.94 Median:5605.14 stddev:1468.03 (26.2%) stddev-sans-first:1432.06 17:02:00 INFO - PROCESS | 4550 | Values: 283.3 287.4 296.0 299.4 301.8 5533.2 5536.3 5595.2 5603.7 5670.9 5532.4 5606.5 5619.6 5623.9 5633.1 3939.6 4099.9 4174.8 4180.9 4253.7 4181.1 4194.7 4209.4 4220.5 4225.0 4147.8 4151.0 4158.7 4183.6 4189.9 4161.1 4162.3 4162.8 4173.7 4215.6 3588.3 3592.2 3605.0 3608.0 3623.5 5333.9 5340.7 5358.4 5375.0 5398.1 4691.0 4781.1 4796.4 4814.8 4830.8 5801.0 5808.1 5808.1 5842.8 5847.1 3853.4 3885.0 3893.0 3895.3 3895.9 6054.8 6136.8 6163.4 6164.0 6170.5 4010.7 4012.2 4014.9 4015.8 4019.1 4071.2 4071.8 4076.3 4083.4 4086.2 4518.2 4680.2 4699.9 4727.3 4796.7 5719.8 5752.7 5765.6 5782.3 5796.1 1412.8 1445.6 1448.9 1449.1 1452.1 937.9 939.1 949.9 958.3 970.8 5059.5 5067.6 5068.9 5074.7 5081.8 6092.6 6101.8 6109.3 6110.7 6121.1 4859.8 5029.0 5061.4 5071.6 5072.1 3180.2 3291.6 3300.7 3304.3 3305.2 5757.0 5760.9 5766.0 5792.9 5821.7 6292.5 6308.6 6310.8 6311.9 6340.9 5728.9 5761.0 5779.4 5788.9 5799.2 5962.3 6109.8 6129.4 6183.1 6204.9 5996.9 6005.6 6006.1 6007.8 6023.4 5733.3 5783.7 5797.9 5823.2 5825.5 4163.2 4212.3 4227.1 4229.5 4246.7 6085.9 6099.6 6102.9 6104.1 6106.5 5724.0 5843.5 5850.8 5929.4 5959.0 5909.2 5934.2 5945.3 5956.6 5962.5 5813.1 5814.4 5818.9 5821.7 5837.2 5923.8 5975.9 5978.6 5986.9 5991.5 5593.2 5800.1 5812.2 5826.9 5834.2 17:02:00 INFO - PROCESS | 4550 | 17:02:00 INFO - PROCESS | 4550 | [#5] yui.html Cycles:180 Average:11613.67 Median:443.85 stddev:13134.69 (2959.2%) stddev-sans-first:13145.38 17:02:00 INFO - PROCESS | 4550 | Values: 575.3 583.5 636.8 682.3 706.2 10507.5 10615.6 10714.7 10821.1 10836.6 10253.1 10334.3 10370.9 10401.4 10441.7 406.1 756.9 773.1 775.9 776.3 758.7 769.1 770.9 774.2 775.5 815.7 816.9 821.2 822.3 822.5 810.6 814.1 814.4 816.8 818.7 597.5 605.4 608.1 612.3 613.0 11184.0 11238.6 11242.9 11259.4 11269.3 11191.1 11410.3 11785.4 11956.0 12252.4 8740.6 8970.6 9016.4 9143.9 9163.2 2900.5 2964.8 3003.5 3019.2 3028.4 36215.6 36380.3 36384.0 36549.8 36563.6 8572.9 8681.5 8746.8 8770.7 8850.5 15530.9 15608.4 15619.1 15624.6 15665.5 5810.0 5885.2 5922.4 6050.4 6050.6 3434.7 3443.2 3447.1 3478.6 3620.6 2464.9 2509.7 2510.5 2521.4 2522.2 439.6 446.8 451.6 456.0 462.5 497.8 514.3 528.8 543.3 566.4 6704.0 6879.5 7025.4 7041.4 7065.0 440.9 501.7 503.9 515.0 516.3 3346.2 3375.6 3377.4 3418.3 3523.8 46696.5 46823.3 46836.0 47117.8 47182.8 41733.2 42060.4 42495.4 42510.4 42666.0 39873.4 40189.4 40200.2 40302.6 40305.8 6956.8 7053.0 7478.1 7556.8 7700.2 30496.8 30605.0 30767.7 31523.2 31584.5 35600.6 35755.0 36120.6 39765.8 39913.4 9048.2 9114.3 9296.0 9314.9 9428.8 10895.8 10899.9 10977.1 11019.3 11466.7 10017.2 10121.3 10319.3 10535.7 10552.8 9311.7 9993.8 10015.4 10334.9 10368.3 10113.5 10143.3 10247.6 10327.1 10345.2 8369.2 8498.2 8579.9 8731.7 8954.3 8296.5 8526.0 8640.2 8659.2 8782.4 17:02:00 INFO - PROCESS | 4550 | -------- Summary: end -------- 17:02:00 INFO - PROCESS | 4550 | 17:02:00 INFO - PROCESS | 4550 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:02:00 INFO - PROCESS | 4550 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:02:00 INFO - PROCESS | 4550 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:02:00 INFO - PROCESS | 4550 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:02:00 INFO - PROCESS | 4550 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:02:00 INFO - PROCESS | 4550 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:02:00 INFO - PROCESS | 4550 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:02:00 INFO - PROCESS | 4550 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:02:01 INFO - TEST-INFO | 4550: exit 0 17:02:01 INFO - TEST-OK | dromaeo_css | took 1113873ms 17:02:01 INFO - TEST-START | kraken 17:02:01 INFO - operating with platform_type : linux_ 17:02:01 INFO - Initialising browser for kraken test... 17:02:01 INFO - TEST-INFO | started process 4785 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk6N7wB/profile http://localhost:37686/getInfo.html) 17:02:05 INFO - PROCESS | 4785 | 17:02:05 INFO - PROCESS | 4785 | (process:4854): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:02:06 INFO - PROCESS | 4785 | __metrics Screen width/height:1600/1200 17:02:06 INFO - PROCESS | 4785 | colorDepth:24 17:02:06 INFO - PROCESS | 4785 | Browser inner width/height: 1024/697 17:02:06 INFO - PROCESS | 4785 | __metrics 17:02:06 ERROR - PROCESS | 4785 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 17:02:06 INFO - PROCESS | 4785 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:02:06 INFO - PROCESS | 4785 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:02:06 INFO - PROCESS | 4785 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:02:06 INFO - PROCESS | 4785 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:02:06 INFO - PROCESS | 4785 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:02:06 INFO - PROCESS | 4785 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:02:06 INFO - PROCESS | 4785 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:02:06 INFO - PROCESS | 4785 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:02:06 INFO - PROCESS | 4785 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:02:07 INFO - TEST-INFO | 4785: exit 0 17:02:07 INFO - Browser initialized. 17:02:07 INFO - Running cycle 1/1 for kraken test... 17:02:07 INFO - TEST-INFO | started process 4905 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk6N7wB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:02:09 INFO - PROCESS | 4905 | 17:02:09 INFO - PROCESS | 4905 | (process:4965): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:02:19 INFO - PROCESS | 4905 | RSS: Main: 158556160 17:02:19 INFO - PROCESS | 4905 | 17:02:22 INFO - PROCESS | 4905 | Cycle 1(1): loaded http://localhost:37686/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37686/tests/kraken/driver.html?testName=audio-beat-detection) 17:02:22 INFO - PROCESS | 4905 | RSS: Main: 164515840 17:02:22 INFO - PROCESS | 4905 | 17:02:25 INFO - PROCESS | 4905 | Cycle 1(1): loaded http://localhost:37686/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37686/tests/kraken/driver.html?testName=audio-dft) 17:02:26 INFO - PROCESS | 4905 | RSS: Main: 166895616 17:02:26 INFO - PROCESS | 4905 | 17:02:29 INFO - PROCESS | 4905 | Cycle 1(1): loaded http://localhost:37686/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37686/tests/kraken/driver.html?testName=audio-fft) 17:02:29 INFO - PROCESS | 4905 | RSS: Main: 161292288 17:02:29 INFO - PROCESS | 4905 | 17:02:31 INFO - PROCESS | 4905 | Cycle 1(1): loaded http://localhost:37686/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37686/tests/kraken/driver.html?testName=audio-oscillator) 17:02:32 INFO - PROCESS | 4905 | RSS: Main: 161611776 17:02:32 INFO - PROCESS | 4905 | 17:02:34 INFO - PROCESS | 4905 | Cycle 1(1): loaded http://localhost:37686/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37686/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:02:35 INFO - PROCESS | 4905 | RSS: Main: 160473088 17:02:35 INFO - PROCESS | 4905 | 17:02:38 INFO - PROCESS | 4905 | Cycle 1(1): loaded http://localhost:37686/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37686/tests/kraken/driver.html?testName=imaging-darkroom) 17:02:39 INFO - PROCESS | 4905 | RSS: Main: 161034240 17:02:39 INFO - PROCESS | 4905 | 17:02:42 INFO - PROCESS | 4905 | Cycle 1(1): loaded http://localhost:37686/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37686/tests/kraken/driver.html?testName=imaging-desaturate) 17:02:43 INFO - PROCESS | 4905 | RSS: Main: 160989184 17:02:43 INFO - PROCESS | 4905 | 17:02:46 INFO - PROCESS | 4905 | Cycle 1(1): loaded http://localhost:37686/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37686/tests/kraken/driver.html?testName=json-parse-financial) 17:02:46 INFO - PROCESS | 4905 | RSS: Main: 161046528 17:02:46 INFO - PROCESS | 4905 | 17:02:48 INFO - PROCESS | 4905 | Cycle 1(1): loaded http://localhost:37686/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37686/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:02:49 INFO - PROCESS | 4905 | RSS: Main: 163196928 17:02:49 INFO - PROCESS | 4905 | 17:02:50 INFO - PROCESS | 4905 | Cycle 1(1): loaded http://localhost:37686/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37686/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:02:51 INFO - PROCESS | 4905 | RSS: Main: 163418112 17:02:51 INFO - PROCESS | 4905 | 17:02:53 INFO - PROCESS | 4905 | Cycle 1(1): loaded http://localhost:37686/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37686/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:02:54 INFO - PROCESS | 4905 | RSS: Main: 163123200 17:02:54 INFO - PROCESS | 4905 | 17:02:56 INFO - PROCESS | 4905 | Cycle 1(1): loaded http://localhost:37686/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37686/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:02:57 INFO - PROCESS | 4905 | RSS: Main: 163749888 17:02:57 INFO - PROCESS | 4905 | 17:03:00 INFO - PROCESS | 4905 | Cycle 1(1): loaded http://localhost:37686/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37686/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:03:00 INFO - PROCESS | 4905 | RSS: Main: 162144256 17:03:00 INFO - PROCESS | 4905 | 17:03:02 INFO - PROCESS | 4905 | Cycle 1(1): loaded http://localhost:37686/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37686/tests/kraken/driver.html?testName=ai-astar) 17:03:02 INFO - PROCESS | 4905 | RSS: Main: 163966976 17:03:02 INFO - PROCESS | 4905 | 17:03:02 INFO - PROCESS | 4905 | __start_tp_report 17:03:02 INFO - PROCESS | 4905 | _x_x_mozilla_page_load 17:03:02 INFO - PROCESS | 4905 | _x_x_mozilla_page_load_details 17:03:02 INFO - PROCESS | 4905 | |i|pagename|runs| 17:03:02 INFO - PROCESS | 4905 | |0;ai-astar;117;110;117;118;116;125;115;113;113;116 17:03:02 INFO - PROCESS | 4905 | |1;audio-beat-detection;158;133;157;188;141;155;160;148;179;133 17:03:02 INFO - PROCESS | 4905 | |2;audio-dft;162;163;164;162;164;171;168;164;164;164 17:03:02 INFO - PROCESS | 4905 | |3;audio-fft;74;77;76;150;74;75;75;74;154;76 17:03:02 INFO - PROCESS | 4905 | |4;audio-oscillator;98;98;146;102;98;98;152;99;99;135 17:03:02 INFO - PROCESS | 4905 | |5;imaging-gaussian-blur;120;116;116;117;116;116;116;115;116;115 17:03:02 INFO - PROCESS | 4905 | |6;imaging-darkroom;149;149;149;149;149;148;148;149;149;149 17:03:02 INFO - PROCESS | 4905 | |7;imaging-desaturate;97;97;97;98;97;98;98;98;97;96 17:03:02 INFO - PROCESS | 4905 | |8;json-parse-financial;69;69;68;68;69;71;68;75;66;66 17:03:02 INFO - PROCESS | 4905 | |9;json-stringify-tinderbox;69;69;69;71;70;70;70;69;70;70 17:03:02 INFO - PROCESS | 4905 | |10;stanford-crypto-aes;85;85;86;87;86;94;88;85;87;86 17:03:02 INFO - PROCESS | 4905 | |11;stanford-crypto-ccm;127;128;125;145;134;127;122;130;121;122 17:03:02 INFO - PROCESS | 4905 | |12;stanford-crypto-pbkdf2;142;157;158;157;153;140;144;154;153;139 17:03:02 INFO - PROCESS | 4905 | |13;stanford-crypto-sha256-iterative;74;71;74;72;74;71;71;72;70;75 17:03:02 INFO - PROCESS | 4905 | __end_tp_report 17:03:02 INFO - PROCESS | 4905 | __start_cc_report 17:03:02 INFO - PROCESS | 4905 | _x_x_mozilla_cycle_collect,890 17:03:02 INFO - PROCESS | 4905 | __end_cc_report 17:03:02 INFO - PROCESS | 4905 | __startTimestamp1456621382921__endTimestamp 17:03:02 INFO - PROCESS | 4905 | 17:03:02 INFO - PROCESS | 4905 | ------- Summary: start ------- 17:03:02 INFO - PROCESS | 4905 | Number of tests: 14 17:03:02 INFO - PROCESS | 4905 | 17:03:02 INFO - PROCESS | 4905 | [#0] ai-astar Cycles:10 Average:116.00 Median:116.50 stddev:3.97 (3.4%) stddev-sans-first:4.20 17:03:02 INFO - PROCESS | 4905 | Values: 117.0 110.0 117.0 118.0 116.0 125.0 115.0 113.0 113.0 116.0 17:03:02 INFO - PROCESS | 4905 | 17:03:02 INFO - PROCESS | 4905 | [#1] audio-beat-detection Cycles:10 Average:155.20 Median:157.50 stddev:18.00 (11.4%) stddev-sans-first:19.06 17:03:02 INFO - PROCESS | 4905 | Values: 158.0 133.0 157.0 188.0 141.0 155.0 160.0 148.0 179.0 133.0 17:03:02 INFO - PROCESS | 4905 | 17:03:02 INFO - PROCESS | 4905 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:2.80 (1.7%) stddev-sans-first:2.80 17:03:02 INFO - PROCESS | 4905 | Values: 162.0 163.0 164.0 162.0 164.0 171.0 168.0 164.0 164.0 164.0 17:03:02 INFO - PROCESS | 4905 | 17:03:02 INFO - PROCESS | 4905 | [#3] audio-fft Cycles:10 Average:90.50 Median:75.00 stddev:32.44 (43.3%) stddev-sans-first:33.86 17:03:02 INFO - PROCESS | 4905 | Values: 74.0 77.0 76.0 150.0 74.0 75.0 75.0 74.0 154.0 76.0 17:03:02 INFO - PROCESS | 4905 | 17:03:02 INFO - PROCESS | 4905 | [#4] audio-oscillator Cycles:10 Average:112.50 Median:98.00 stddev:22.37 (22.8%) stddev-sans-first:23.11 17:03:02 INFO - PROCESS | 4905 | Values: 98.0 98.0 146.0 102.0 98.0 98.0 152.0 99.0 99.0 135.0 17:03:02 INFO - PROCESS | 4905 | 17:03:02 INFO - PROCESS | 4905 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:116.00 stddev:1.42 (1.2%) stddev-sans-first:0.60 17:03:02 INFO - PROCESS | 4905 | Values: 120.0 116.0 116.0 117.0 116.0 116.0 116.0 115.0 116.0 115.0 17:03:02 INFO - PROCESS | 4905 | 17:03:02 INFO - PROCESS | 4905 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 17:03:02 INFO - PROCESS | 4905 | Values: 149.0 149.0 149.0 149.0 149.0 148.0 148.0 149.0 149.0 149.0 17:03:02 INFO - PROCESS | 4905 | 17:03:02 INFO - PROCESS | 4905 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:97.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 17:03:02 INFO - PROCESS | 4905 | Values: 97.0 97.0 97.0 98.0 97.0 98.0 98.0 98.0 97.0 96.0 17:03:02 INFO - PROCESS | 4905 | 17:03:02 INFO - PROCESS | 4905 | [#8] json-parse-financial Cycles:10 Average:68.90 Median:69.00 stddev:2.60 (3.8%) stddev-sans-first:2.76 17:03:02 INFO - PROCESS | 4905 | Values: 69.0 69.0 68.0 68.0 69.0 71.0 68.0 75.0 66.0 66.0 17:03:02 INFO - PROCESS | 4905 | 17:03:02 INFO - PROCESS | 4905 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:70.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 17:03:02 INFO - PROCESS | 4905 | Values: 69.0 69.0 69.0 71.0 70.0 70.0 70.0 69.0 70.0 70.0 17:03:02 INFO - PROCESS | 4905 | 17:03:02 INFO - PROCESS | 4905 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:86.50 stddev:2.69 (3.1%) stddev-sans-first:2.76 17:03:02 INFO - PROCESS | 4905 | Values: 85.0 85.0 86.0 87.0 86.0 94.0 88.0 85.0 87.0 86.0 17:03:02 INFO - PROCESS | 4905 | 17:03:02 INFO - PROCESS | 4905 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:127.50 stddev:7.16 (5.6%) stddev-sans-first:7.58 17:03:02 INFO - PROCESS | 4905 | Values: 127.0 128.0 125.0 145.0 134.0 127.0 122.0 130.0 121.0 122.0 17:03:02 INFO - PROCESS | 4905 | 17:03:02 INFO - PROCESS | 4905 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.70 Median:153.50 stddev:7.57 (4.9%) stddev-sans-first:7.50 17:03:02 INFO - PROCESS | 4905 | Values: 142.0 157.0 158.0 157.0 153.0 140.0 144.0 154.0 153.0 139.0 17:03:02 INFO - PROCESS | 4905 | 17:03:02 INFO - PROCESS | 4905 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:73.00 stddev:1.71 (2.3%) stddev-sans-first:1.72 17:03:02 INFO - PROCESS | 4905 | Values: 74.0 71.0 74.0 72.0 74.0 71.0 71.0 72.0 70.0 75.0 17:03:02 INFO - PROCESS | 4905 | -------- Summary: end -------- 17:03:02 INFO - PROCESS | 4905 | 17:03:03 INFO - PROCESS | 4905 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:03:03 INFO - PROCESS | 4905 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:03:03 INFO - PROCESS | 4905 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:03:03 INFO - PROCESS | 4905 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:03:03 INFO - PROCESS | 4905 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:03:03 INFO - PROCESS | 4905 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:03:03 INFO - PROCESS | 4905 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:03:03 INFO - PROCESS | 4905 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:03:03 INFO - TEST-INFO | 4905: exit 0 17:03:03 INFO - TEST-OK | kraken | took 62295ms 17:03:03 INFO - SUITE-END | took 1176s 17:03:04 INFO - Completed test suite (00:19:36) 17:03:04 INFO - Working with test: dromaeo_css 17:03:04 INFO - Generating results file: dromaeo_css 17:03:04 INFO - Working with test: kraken 17:03:04 INFO - Generating results file: kraken 17:03:04 INFO - javascript benchmark 17:03:04 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:03:04 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 17:03:04 INFO - process_Request line: dromaeo_css 5915.28 graph.html#tests=[[72,132,43]] 17:03:04 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:03:04 INFO - process_Request line: kraken 1576.90 graph.html#tests=[[232,132,43]] 17:03:04 INFO - RETURN: dromaeo_css: 5915.28 17:03:04 INFO - RETURN: kraken: 1576.90 17:03:04 INFO - javascript benchmark 17:03:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2596.9091081812116, 2621.2922510922053, 2660.388110734531, 2660.747229013243, 2677.08978947158, 4439.311906654466, 4467.396901418303, 4549.11292298002, 4567.840125595605, 4574.702644328125, 4443.355713421552, 4510.323451482271, 4527.38880251166, 4586.403767510227, 4599.724016559009, 4164.500259968808, 4218.957810421903, 4229.70392072555, 4247.341662042373, 4273.786310684469, 80.82247956205808, 4068.1456894052285, 4130.979345103286, 4159.105792254664, 4175.436316097318, 4222.387753775685, 4230.302000169999, 4236.788160591974, 4253.999999999969, 4257.723247988886, 4218.683598730107, 4225.9788701056295, 4233.830646774125, 4259.531451540328, 4292.570742925714, 4033.1530378620523, 4152.1695660867945, 4216.03031302799, 4224.5353011168745, 4234.089670720809, 4501.684882058257, 4512.481064677539, 4515.164694531522, 4516.1193567254395, 4534.9773251133865, 4618.769061546909, 4822.204336284509, 4852.587530059949, 4867.659263851532, 4872.805087796484, 4788.7366194859615, 4882.365292511986, 4899.534544218293, 4913.459519452857, 4916.58209052231, 4518.81924723014, 4521.796519156645, 4527.071950250191, 4529.230030894722, 4568.931466028012, 4769.785359658824, 4904.8773780655765, 4963.2306992415515, 4971.577415919687, 5013.072581572421, 4713.670043097019, 4769.308450274691, 4775.785089670973, 4783.306420568998, 4809.206480930678, 4816.397950256218, 4832.033593281358, 4853.053654537332, 4857.635677324215, 4869.415670119608, 4627.1439783640135, 4744.098621261949, 4775.164346239394, 4813.181759100961, 4842.854714358575, 4785.521447855256, 4798.088363210979, 4800.087983283165, 4801.159797035574, 4831.758412079453, 4079.8780335407405, 4082.1835632873544, 4105.178964207171, 4117.114820313647, 4118.711690181718, 3550.822458877046, 3575.6781889630056, 3627.220147668264, 3660.011796814845, 3664.486971823947, 4094.774787386663, 4200.4959404871615, 4201.054762678373, 4217.683673724483, 4218.282891908383, 4839.975800120977, 4873.585745211626, 4875.414950205998, 4878.975605121952, 4893.804247830119, 4089.9795501022304, 4174.979125104416, 4215.557366476537, 4236.279832428495, 4253.2769429197115, 4328.870133895988, 4332.588404101605, 4344.044310251739, 4345.543717909637, 4370.475542934868, 4529.048899731093, 4551.52209018055, 4553.886152846139, 4592.311153327028, 4608.700434471749, 4596.88507787308, 4723.4331880174595, 4732.621390288838, 4801.327814105958, 4894.314795928644, 4557.430321209848, 4600.930986035279, 4621.291448516579, 4634.83778067766, 4637.1421287062, 4709.81160753566, 4784.091022705675, 4792.0895029944195, 4799.112164249485, 4826.0830442215865, 4743.762811859324, 4783.760811959319, 4858.854234372974, 4871.95128048715, 4895.4370247422, 4639.420072490939, 4648.442186937589, 4683.8360657376825, 4684.8360307389075, 4697.859064228079, 4654.6741728078705, 4711.575958163782, 4729.952700472952, 4742.264948932921, 4751.334813126096, 4458.799354029012, 4563.155816174019, 4573.131105090022, 4641.978764671901, 4648.907021859612, 4681.485036645898, 4731.148393289241, 4744.0, 4755.120302743865, 4802.039592081667, 4538.387317712067, 4653.906921861611, 4668.323093151406, 4676.672632915664, 4706.247000479907], "unit": "score", "name": "dojo.html", "value": 4422.132091574976}, {"lowerIsBetter": false, "replicates": [493.3808070871056, 500.59952038369295, 517.7721802406941, 522.7987224918406, 562.4291344285548, 31786.68213317866, 32267.0, 32419.189520261945, 32590.185245368848, 32619.51070733941, 32989.67010329902, 33228.33543329132, 33535.0, 33709.325813483716, 33790.831045844796, 7381.446391520631, 7518.398528117737, 7606.505577137496, 7612.0, 7619.80950476237, 7546.2831031051965, 7913.089994650602, 7926.167752386003, 7930.801729956768, 7951.284384405402, 7884.724034658788, 7926.088499822507, 7985.560794156319, 8006.199380062006, 8021.799455013613, 7783.961080194619, 7839.686412543491, 7860.646270917851, 7985.960070199611, 7996.0, 7538.660760265746, 7680.846383072363, 7683.961580192119, 7698.461107722405, 7700.9229907700765, 33355.499667505006, 33873.830630846685, 33877.32245355104, 33879.0, 33989.320213595835, 2120.819730322909, 2552.438463538019, 2622.5672763993916, 2833.1642165561, 2897.3191300044473, 23722.169724059575, 26256.343591410176, 26670.46659066808, 26962.325941851414, 27319.86340068307, 3169.6513383527795, 3186.5698130752517, 3194.34515924235, 3314.386838434897, 3322.7175690066374, 209657.0, 210549.9472502643, 212348.0, 213028.0, 213615.0, 38820.611793882264, 39551.40672889909, 53931.73034134804, 54131.18803217955, 54530.0, 39436.0, 39726.0, 39731.40402893959, 39751.602483975366, 39913.80043099824, 12929.0, 13067.0, 13071.477140914447, 13088.672783180496, 13165.27590982486, 9903.504824758733, 9909.702708918743, 9917.603295868228, 9918.702438926844, 9927.106560409598, 13229.801552976713, 13260.668483287802, 13380.732385352238, 13384.330783460788, 13449.394777235048, 5598.86002849932, 5705.003248862948, 5766.769329226868, 5768.509676677446, 5862.03276459388, 890.8619164029586, 905.1898550797132, 910.7586489580267, 1004.6082028009082, 1063.4682658670665, 25598.488030239292, 25632.743672563407, 25639.230823075337, 25836.0, 25957.870210648827, 963.6723514005272, 987.5062468765617, 990.2770977186694, 1005.8994100590029, 1042.781015986636, 13431.664208394674, 13673.247971361472, 13712.834409075142, 13767.518136865161, 13911.4435422584, 254342.0, 255706.0, 256570.0, 256676.0, 259184.0, 45310.0, 45513.77243113763, 45714.54285457169, 45759.77120114378, 46242.0, 1147.6270212181075, 1210.5157936825165, 1218.226426219357, 1229.5266322465916, 1246.2709315050615, 25134.74865251324, 25358.87320563459, 25961.221163365128, 26113.347166320233, 26477.470450591267, 40110.79944600258, 40332.0, 40494.392584110676, 40635.0, 40642.79678601706, 237163.0, 238621.0, 239408.0, 239546.0, 239874.0, 29398.55902161512, 29855.0, 38997.6100238994, 40234.0, 40599.0, 34335.0, 35093.19254459688, 35104.0, 35163.82418087893, 35673.821630892715, 33238.5014224782, 33259.0, 33335.33329333448, 33337.0, 33411.66588334086, 32231.35537289288, 32392.83803580967, 32659.836700817294, 32896.0, 32917.78992468521, 32865.178370540925, 33488.66511334856, 33555.16112097119, 33770.0, 33824.830875845466, 30046.84976575103, 30060.0, 30343.544846826873, 30378.696213037587, 30535.847320763252, 23829.404264893517, 23945.401364966016, 24001.639975400034, 24157.879210603835, 24341.26976190717], "unit": "score", "name": "ext.html", "value": 15932.726996425601}, {"lowerIsBetter": false, "replicates": [330.22397366189443, 334.64527600743213, 342.88684734037764, 345.34212325519894, 346.65334665334666, 15232.39070437184, 15830.445934392299, 16364.181790910467, 16402.425915092976, 16447.342106315748, 13801.0, 13969.441222351119, 14017.36921838517, 14534.636634084127, 14604.561863144123, 4905.362302900618, 5093.159628661267, 5094.363204599425, 5119.0529751996, 5172.069027575035, 4832.565069143777, 4973.850784476472, 5039.344885164924, 5041.798328066891, 5050.141475949079, 4916.213405855064, 4925.729084900329, 4929.3591833061655, 4995.6003519718515, 5165.612579056567, 5618.662880227159, 5657.349404818437, 5657.57568182388, 5672.858178545528, 5686.0, 4843.5398637129765, 4992.151334273146, 5042.949570504285, 5046.343975283226, 5053.393592768854, 11276.154288428319, 11345.489452974554, 11488.253263537843, 11524.366159861203, 11603.76792464146, 1737.470071628153, 1783.9148350277849, 1827.616200597876, 1853.4995551201234, 1897.601503684228, 8658.696945606936, 8880.955595222047, 8913.064128266567, 8984.8652270216, 9084.68203612877, 1615.7091723489884, 1734.9590245852514, 1760.64787042592, 1787.8480329172037, 1832.6334733053309, 54873.725631371984, 55133.724331378486, 55575.72212138954, 56026.0, 56740.43259567393, 9418.62325506972, 9496.620135194515, 9771.560279787427, 9777.364471309342, 9957.302988790716, 12222.083343749255, 12225.44985475638, 12295.0, 12331.0, 12415.317157556241, 6673.599584024974, 6765.42493888025, 6791.4227290679855, 6888.586684798928, 6911.0, 6159.692015399212, 6213.689315534205, 6253.030780229072, 6295.6537390443045, 6356.8410789729705, 3921.5882332355263, 4068.959310406917, 4113.300738874398, 4134.565870583546, 4170.332746760504, 1761.3130878957218, 1773.7162054071546, 1776.7068433708553, 1790.534461040139, 1818.363572749527, 377.66199251669605, 394.23518374354234, 403.5117507815576, 834.9165083491723, 887.2148148888281, 9414.67048653294, 9643.228541716646, 9870.25973052024, 9920.603175873028, 9932.304738668225, 402.4506548561193, 402.4767801857573, 408.06756561257384, 416.4274123080764, 426.266821067763, 5168.224766285088, 5176.534111929869, 5279.102552566073, 5368.677879327252, 5418.620696551204, 362961.0, 370591.0, 376559.0, 376571.0, 377088.0, 52272.21591676128, 57708.13437798437, 58517.41482585205, 62815.685921571014, 64009.679951599945, 361.1206711657071, 370.3500356873669, 370.9239605880788, 372.2369143256368, 372.31308236303977, 8946.731598052069, 9047.366684332033, 9347.906520934703, 13244.470221191044, 14520.709585808436, 28973.0, 29006.7099329004, 29260.707392926648, 29451.852740736158, 29567.408651827274, 35042.474362884066, 36096.639033609325, 36157.0, 36512.81743591265, 40595.59404405918, 6820.590764554143, 6851.383375496229, 6888.896666549906, 6938.098047253825, 6942.548734332252, 9723.0, 10101.0, 10168.33905796121, 10198.082172604501, 10931.234813562975, 9187.081291871027, 9479.952600236955, 9518.762030949281, 9612.903870961201, 9900.613914051894, 9192.17270445663, 9216.30877684163, 9233.261339092991, 9280.211182049601, 9314.72055838326, 8752.037275899773, 9105.271578273854, 9406.905930940604, 9555.849292877068, 9846.31075824714, 6807.795766127024, 7124.964375178299, 7285.927140728737, 7295.671694773641, 7341.192468828318, 7052.33002864727, 9495.85756213671, 9590.904090959, 9822.263330250116, 9933.602655893683], "unit": "score", "name": "jquery.html", "value": 6780.473017226362}, {"lowerIsBetter": false, "replicates": [1298.1107941060375, 1303.8044293356, 1385.7852032934898, 1684.5114916674165, 1699.864010879129, 5604.887902241952, 6394.944834102379, 6795.626240556773, 6995.650217489124, 6998.895016574749, 6721.5630983986, 6765.255821859591, 6773.72905083796, 6845.281245469228, 6860.382565569098, 1937.4187743676875, 1973.5263536751147, 1979.1984246380239, 2008.3272103845156, 2010.105503051143, 1981.6829307310834, 2003.4290227285226, 2011.6379051770675, 2014.385612388221, 2029.6955456681542, 2009.437357539891, 2010.0, 2017.8688385254984, 2041.652919003773, 2048.1909645689943, 2033.2781862438917, 2049.497873021112, 2057.351934140748, 2078.490769761411, 2087.0503920716037, 1982.583657431941, 1991.3528103366318, 2002.2991952816544, 2026.8548270227275, 2028.0265472573246, 6848.657567121624, 6872.450203983669, 6879.552829066145, 6888.724451022003, 6891.207511136234, 3982.980085099556, 4163.812628431728, 4166.66666666669, 4167.666586673059, 4179.247735407625, 2541.5933450647995, 2621.0433191885018, 2689.273896048056, 2715.4026114254834, 2725.8909643614234, 787.4527203593505, 793.8690116130831, 798.2336956521746, 798.9161138080534, 809.8015986083448, 9058.818823623491, 9060.546972651407, 9117.544122793834, 9131.36080474367, 9134.406263592846, 3776.584575696671, 3835.0, 3912.726109172331, 3917.4515567820526, 3928.332183528807, 7606.935029095931, 7622.5517151741, 7627.351675107567, 7645.120811106683, 7675.692972281046, 4199.517055538591, 4209.4948606166845, 4214.536400995888, 4215.78921053946, 4239.067405170919, 3083.92290192747, 3677.5403074615674, 3737.9626203738158, 3813.637704418076, 3844.038990252437, 3241.4813629819114, 3287.4575695010535, 3314.171457135716, 3377.9493307600405, 3391.7117045051446, 1028.6862506935456, 1030.9845352319721, 1033.3076838518211, 1048.1719441641171, 1066.9519871605642, 1145.9770804583861, 1156.1386766858575, 1164.6214980131322, 1167.5855071449682, 1172.5720112159001, 6309.779157729457, 6337.144485494491, 6340.651264180515, 6342.429181373698, 6352.0789485525265, 419.8089869109548, 423.1536926147705, 425.47453894440343, 442.911417716458, 445.1786453992444, 5056.089903817348, 5081.28861959326, 5098.286239926413, 5136.203888397305, 5144.0, 7966.800829979181, 8048.718294859652, 8298.0, 8374.743788431784, 8393.874091888627, 7992.240737129963, 8167.42828002046, 8169.0, 8207.794805129919, 8251.669933202726, 6386.776462823779, 6393.328700486475, 6475.0, 6476.319986401454, 6589.47284217271, 6218.81343559694, 6223.19098517208, 6224.906626400698, 6226.470749986121, 6262.561620686691, 7070.575765453884, 7198.424126070006, 7220.241874603301, 7395.667194976347, 7406.4074874008875, 7373.115226172679, 7501.774946751606, 7519.323260906544, 7542.585157816373, 7636.160022397421, 4772.0455908817685, 5331.573474121983, 5720.542356611544, 5737.8524295140305, 5782.508486778671, 6174.506039516738, 6201.937980620136, 6223.471004964629, 6256.436920677161, 6257.655828929271, 5696.943030569807, 5733.111367738007, 5761.625494342854, 5911.379305173067, 5925.170476133431, 5488.17677348401, 5815.098659707752, 5891.644921668126, 5914.112883067574, 5936.168936349001, 6028.969855150872, 6128.662923539248, 6156.815295541141, 6186.752529898754, 6194.81415557534, 5679.403662615366, 5695.060315047971, 5700.857478563069, 5710.0, 5728.4271572844045, 5598.720063996865, 5660.971695141498, 5706.743196556248, 5717.0, 5719.113537401709], "unit": "score", "name": "mootools.html", "value": 3834.1607328129544}, {"lowerIsBetter": false, "replicates": [283.26068960014356, 287.4423618180729, 296.0039467192895, 299.3802828145738, 301.81287601686955, 5533.225348451215, 5536.252605898202, 5595.1886976388505, 5603.747831347594, 5670.914936275959, 5532.446755324466, 5606.523445507127, 5619.5785316101255, 5623.859403514914, 5633.0987042073275, 3939.5666476687543, 4099.918001639965, 4174.791260436981, 4180.91638167238, 4253.680973926945, 4181.080162364275, 4194.685398595102, 4209.368594710802, 4220.514640816299, 4225.0, 4147.813348399314, 4150.9584904151025, 4158.6673066154635, 4183.644390226835, 4189.937150942723, 4161.146964872194, 4162.250794856925, 4162.812673429703, 4173.728707633994, 4215.59951804578, 3588.318219538279, 3592.209713862972, 3605.0, 3607.9639203608153, 3623.4564815277654, 5333.893322133536, 5340.652857564285, 5358.356997160366, 5375.032494151052, 5398.109311963522, 4690.9530904690855, 4781.0676918001, 4796.424429068499, 4814.7833347499445, 4830.758462076882, 5801.0428279333855, 5808.070708686632, 5808.12878068289, 5842.766289348421, 5847.064469684872, 3853.441251018615, 3884.9899026253097, 3892.9610703893163, 3895.2599006189016, 3895.8636447724475, 6054.758774451227, 6136.815895523141, 6163.414475624809, 6163.969180154116, 6170.50635949123, 4010.6590939770444, 4012.237674841829, 4014.8996275093355, 4015.819288132041, 4019.1157945252, 4071.226466971266, 4071.8371265149653, 4076.3274059780397, 4083.4283200351974, 4086.203190377848, 4518.209313370147, 4680.227762419163, 4699.882502937454, 4727.290906364073, 4796.736179510091, 5719.7712091516705, 5752.654840709571, 5765.567582431335, 5782.335031471351, 5796.072628379439, 1412.8445870954188, 1445.6313640021726, 1448.9275536223147, 1449.0725935401351, 1452.0924422236103, 937.8733870927338, 939.1031564855547, 949.943003419797, 958.2621381536178, 970.7864269860619, 5059.519345662156, 5067.594592432597, 5068.923966140511, 5074.720890351066, 5081.822136225214, 6092.573519853657, 6101.816945491642, 6109.2974307955155, 6110.663913484712, 6121.143039974407, 4859.757012149449, 5028.994201159782, 5061.4179369373, 5071.644984851025, 5072.112380333427, 3180.2367431816197, 3291.588551431071, 3300.7194388477246, 3304.273059926812, 3305.2067503799394, 5757.0, 5760.855978600569, 5766.0, 5792.913106303409, 5821.708914554255, 6292.4966002719675, 6308.621482711052, 6310.8422289442215, 6311.873762524724, 6340.873182536324, 5728.885422291531, 5760.963026655242, 5779.393163717833, 5788.88422231553, 5799.246098007232, 5962.284525856925, 6109.847253818512, 6129.387061294014, 6183.072539118988, 6204.906926396198, 5996.88006239864, 6005.6396616203165, 6006.129111278928, 6007.849803754941, 6023.427774361428, 5733.3406658234835, 5783.7397317119985, 5797.8550536236935, 5823.242978412779, 5825.475707186373, 4163.188178305201, 4212.304969680091, 4227.112306415687, 4229.513605935357, 4246.660267178557, 6085.908711369245, 6099.603525770811, 6102.877942441038, 6104.11490333908, 6106.45041946227, 5724.0, 5843.474087332161, 5850.824475265749, 5929.377415371324, 5958.970205148947, 5909.172715819703, 5934.228550288608, 5945.316288626863, 5956.5532585055425, 5962.4633782959745, 5813.09896965971, 5814.447627475383, 5818.883622327445, 5821.679807610452, 5837.241158649348, 5923.822285331447, 5975.850603734768, 5978.551608629457, 5986.940130598812, 5991.460768530679, 5593.244911936999, 5800.1299805029585, 5812.244408226903, 5826.941730582809, 5834.15404766315], "unit": "score", "name": "prototype.html", "value": 4339.769519290413}, {"lowerIsBetter": false, "replicates": [575.315374704102, 583.4515555377943, 636.7866764633848, 682.2801943949133, 706.2161001288565, 10507.527161277741, 10615.575376984922, 10714.678559643213, 10821.080208182313, 10836.566537338516, 10253.077223049924, 10334.328268662532, 10370.948145259283, 10401.427921464316, 10441.686749397511, 406.066048089394, 756.8675481790692, 773.0723132241304, 775.9185285545021, 776.2664282253273, 758.6813538313894, 769.1116760142017, 770.8535378278137, 774.1716363491067, 775.5308038636629, 815.6615004773012, 816.9019717633893, 821.2321479416764, 822.2599660305743, 822.4900561651784, 810.5744484145841, 814.071957967917, 814.3851392198852, 816.7753867686374, 818.7461886815106, 597.5070566782379, 605.3794860268216, 608.1394826320795, 612.3447910735515, 612.969351532426, 11184.0, 11238.606648767336, 11242.887571124265, 11259.380734059623, 11269.323840569592, 11191.104711623051, 11410.258333208398, 11785.410729463492, 11956.0, 12252.44863981123, 8740.606672699743, 8970.551472426418, 9016.413933094327, 9143.862842057375, 9163.175314221751, 2900.535914253709, 2964.8221106733663, 3003.4743919813945, 3019.1697283247063, 3028.394321135782, 36215.63784362149, 36380.27239455196, 36384.0, 36549.81725091358, 36563.63436365629, 8572.871406928902, 8681.479111253346, 8746.781330466789, 8770.693025744196, 8850.468971861581, 15530.9223453882, 15608.3756649735, 15619.062856228662, 15624.609384765472, 15665.530034098996, 5809.970950145223, 5885.205497257815, 5922.407759224043, 6050.394960503914, 6050.57645964787, 3434.708049815744, 3443.1736383267835, 3447.052060683332, 3478.565179352581, 3620.6198349173483, 2464.9260522184363, 2509.7490250974756, 2510.472800711834, 2521.420073383132, 2522.1928982725717, 439.59118020240845, 446.8168051099034, 451.58228638509246, 456.0, 462.4843299720787, 497.8158081509792, 514.269736973491, 528.8122716435687, 543.3344153412039, 566.3826429192201, 6704.0, 6879.484038697117, 7025.367716905503, 7041.436685065182, 7064.964675176591, 440.88757366871243, 501.6839391183531, 503.91522367413626, 515.0008982573795, 516.2978349444752, 3346.1969127409734, 3375.628680845105, 3377.4258376076127, 3418.333424982154, 3523.823808809549, 46696.5330346699, 46823.29765053527, 46836.0, 47117.764411177726, 47182.76408617935, 41733.1653366931, 42060.36909446299, 42495.36256956148, 42510.362344564855, 42666.0, 39873.40189897154, 40189.397159042055, 40200.195996079914, 40302.59697402988, 40305.79847100746, 6956.764406881041, 7053.0, 7478.102627684712, 7556.811079723051, 7700.152983171959, 30496.847515762278, 30605.0, 30767.692323076484, 31523.21191970219, 31584.526232106076, 35600.64399355973, 35755.0, 36120.638793611724, 39765.80117099396, 39913.401298981116, 9048.230900373543, 9114.316426267924, 9295.953520232355, 9314.906850931404, 9428.811423771624, 10895.78208435811, 10899.945500272448, 10977.066949309397, 11019.338839669324, 11466.656000320003, 10017.248706346907, 10121.291509594257, 10319.277650564389, 10535.73660658459, 10552.84170737455, 9311.72064838056, 9993.750156246151, 10015.449150296803, 10334.948325258325, 10368.326058806153, 10113.544890480092, 10143.34068285559, 10247.641332553325, 10327.122194613241, 10345.172386208935, 8369.163083691583, 8498.150184981452, 8579.914200858162, 8731.738047858575, 8954.298683250161, 8296.502209867427, 8526.0, 8640.222379985831, 8659.177378149066, 8782.429142105999], "unit": "score", "name": "yui.html", "value": 5388.779309197533}], "name": "dromaeo_css", "value": 5915.280637630872}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 110.0, 117.0, 118.0, 116.0, 125.0, 115.0, 113.0, 113.0, 116.0], "unit": "score", "name": "ai-astar", "value": 116.0}, {"lowerIsBetter": true, "replicates": [158.0, 133.0, 157.0, 188.0, 141.0, 155.0, 160.0, 148.0, 179.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 155.2}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 164.0, 162.0, 164.0, 171.0, 168.0, 164.0, 164.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.6}, {"lowerIsBetter": true, "replicates": [74.0, 77.0, 76.0, 150.0, 74.0, 75.0, 75.0, 74.0, 154.0, 76.0], "unit": "score", "name": "audio-fft", "value": 90.5}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 146.0, 102.0, 98.0, 98.0, 152.0, 99.0, 99.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 112.5}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 116.0, 117.0, 116.0, 116.0, 116.0, 115.0, 116.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.3}, {"lowerIsBetter": true, "replicates": [149.0, 149.0, 149.0, 149.0, 149.0, 148.0, 148.0, 149.0, 149.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 148.8}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 98.0, 97.0, 98.0, 98.0, 98.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 97.3}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 68.0, 69.0, 71.0, 68.0, 75.0, 66.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 68.9}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 71.0, 70.0, 70.0, 70.0, 69.0, 70.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.7}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 86.0, 87.0, 86.0, 94.0, 88.0, 85.0, 87.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.9}, {"lowerIsBetter": true, "replicates": [127.0, 128.0, 125.0, 145.0, 134.0, 127.0, 122.0, 130.0, 121.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.1}, {"lowerIsBetter": true, "replicates": [142.0, 157.0, 158.0, 157.0, 153.0, 140.0, 144.0, 154.0, 153.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.7}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 74.0, 72.0, 74.0, 71.0, 71.0, 72.0, 70.0, 75.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.4}], "name": "kraken", "value": 1576.9}]} 17:03:04 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1576.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "5915.28"}}} 17:03:04 INFO - Return code: 0 17:03:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:03:04 ERROR - # TBPL SUCCESS # 17:03:04 INFO - Running post-action listener: _resource_record_post_action 17:03:04 INFO - Running post-run listener: _resource_record_post_run 17:03:05 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292253696; Read time: 12; Write time: 228224 17:03:05 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1290240; Read time: 0; Write time: 84 17:03:05 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290963456; Read time: 12; Write time: 228140 17:03:05 INFO - Running post-run listener: _upload_blobber_files 17:03:05 INFO - Blob upload gear active. 17:03:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:03:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:03:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:03:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:03:05 INFO - (blobuploader) - INFO - Open directory for files ... 17:03:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:03:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:03:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:03:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:03:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:03:06 INFO - (blobuploader) - INFO - Done attempting. 17:03:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:03:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:03:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:03:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:03:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:03:07 INFO - (blobuploader) - INFO - Done attempting. 17:03:07 INFO - (blobuploader) - INFO - Iteration through files over. 17:03:07 INFO - Return code: 0 17:03:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:03:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:03:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/42a1e23942b1ff917c2412e7e1efa8ea50dbc643b576fd77c4bea66e61b109ba4e091a8e5f4083e9b87938270e26efba25b5089c1219a8084bfb3828a5dd88f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/38eceb2794d44b5c72158fd68740d6bc0ecc9f1e9bd058c256b979e03e4624558b163dc575ba816762a2fa306fea04150518baf5d57e8825c616b40c98839476"} 17:03:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:03:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:03:07 INFO - Contents: 17:03:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/42a1e23942b1ff917c2412e7e1efa8ea50dbc643b576fd77c4bea66e61b109ba4e091a8e5f4083e9b87938270e26efba25b5089c1219a8084bfb3828a5dd88f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/38eceb2794d44b5c72158fd68740d6bc0ecc9f1e9bd058c256b979e03e4624558b163dc575ba816762a2fa306fea04150518baf5d57e8825c616b40c98839476"} 17:03:07 INFO - Running post-run listener: copy_logs_to_upload_dir 17:03:07 INFO - Copying logs to upload dir... 17:03:07 INFO - mkdir: /builds/slave/test/build/upload/logs 17:03:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.802804 ========= master_lag: 57.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 44 secs) (at 2016-02-27 17:04:04.482770) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-27 17:04:04.486713) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/42a1e23942b1ff917c2412e7e1efa8ea50dbc643b576fd77c4bea66e61b109ba4e091a8e5f4083e9b87938270e26efba25b5089c1219a8084bfb3828a5dd88f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/38eceb2794d44b5c72158fd68740d6bc0ecc9f1e9bd058c256b979e03e4624558b163dc575ba816762a2fa306fea04150518baf5d57e8825c616b40c98839476"} build_url:https://queue.taskcluster.net/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011368 build_url: 'https://queue.taskcluster.net/v1/task/KghrPqCVQ0q2HTK6u33_XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/42a1e23942b1ff917c2412e7e1efa8ea50dbc643b576fd77c4bea66e61b109ba4e091a8e5f4083e9b87938270e26efba25b5089c1219a8084bfb3828a5dd88f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/38eceb2794d44b5c72158fd68740d6bc0ecc9f1e9bd058c256b979e03e4624558b163dc575ba816762a2fa306fea04150518baf5d57e8825c616b40c98839476"}' ========= master_lag: 0.27 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-27 17:04:04.765994) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 17:04:04.766314) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1456618222.749372-1457965088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 17:04:04.782188) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-27 17:04:04.782489) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-27 17:04:04.783744) ========= ========= Total master_lag: 57.53 =========