builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-055 starttime: 1462793637.89 results: success (0) buildid: 20160509024850 builduid: 19c9eb1de1f448e0a508eb57f0ef353e revision: cb53cee341a60d134fd5dc55ead4a95632a22dce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 04:33:57.892689) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 04:33:57.893140) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 04:33:57.893445) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 04:33:57.909798) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:33:57.910099) ========= 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=82e07478c745e68b1fe4678a000001bc-1462793631.798382-677419622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 04:33:58-- 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% 22.0M=0.001s 2016-05-09 04:33:58 (22.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.415612 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:33:58.342288) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:33:58.343025) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=82e07478c745e68b1fe4678a000001bc-1462793631.798382-677419622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018888 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:33:58.393460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:33:58.393832) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cb53cee341a60d134fd5dc55ead4a95632a22dce --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 cb53cee341a60d134fd5dc55ead4a95632a22dce --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=82e07478c745e68b1fe4678a000001bc-1462793631.798382-677419622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 04:33:58,841 truncating revision to first 12 chars 2016-05-09 04:33:58,841 Setting DEBUG logging. 2016-05-09 04:33:58,841 attempt 1/10 2016-05-09 04:33:58,841 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cb53cee341a6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 04:33:59,328 unpacking tar archive at: fx-team-cb53cee341a6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.779903 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:33:59.186877) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 04:33:59.187224) ========= script_repo_revision: cb53cee341a60d134fd5dc55ead4a95632a22dce ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 04:33:59.187661) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 04:33:59.187984) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 04:33:59.198222) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-09 04:33:59.198625) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=82e07478c745e68b1fe4678a000001bc-1462793631.798382-677419622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:33:59 INFO - MultiFileLogger online at 20160509 04:33:59 in /builds/slave/test 04:33:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 04:33:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:33:59 INFO - {'append_to_log': False, 04:33:59 INFO - 'base_work_dir': '/builds/slave/test', 04:33:59 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:33:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:33:59 INFO - 'branch': 'Fx-Team-Non-PGO', 04:33:59 INFO - 'buildbot_json_path': 'buildprops.json', 04:33:59 INFO - 'config_files': ('talos/linux_config.py',), 04:33:59 INFO - 'default_actions': ('clobber', 04:33:59 INFO - 'read-buildbot-config', 04:33:59 INFO - 'download-and-extract', 04:33:59 INFO - 'populate-webroot', 04:33:59 INFO - 'create-virtualenv', 04:33:59 INFO - 'install', 04:33:59 INFO - 'run-tests'), 04:33:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:33:59 INFO - 'download_minidump_stackwalk': True, 04:33:59 INFO - 'download_symbols': 'ondemand', 04:33:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:33:59 INFO - 'tooltool.py': '/tools/tooltool.py', 04:33:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:33:59 INFO - '/tools/misc-python/virtualenv.py')}, 04:33:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:33:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:33:59 INFO - 'installer_path': 'installer.exe', 04:33:59 INFO - 'log_level': 'info', 04:33:59 INFO - 'log_name': 'talos', 04:33:59 INFO - 'log_to_console': True, 04:33:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:33:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:33:59 INFO - 'opt_config_files': (), 04:33:59 INFO - 'pip_index': False, 04:33:59 INFO - 'sps_profile': False, 04:33:59 INFO - 'sps_profile_interval': 0, 04:33:59 INFO - 'suite': 'dromaeojs', 04:33:59 INFO - 'system_bits': '32', 04:33:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:33:59 INFO - 'title': 'talos-linux64-ix-055', 04:33:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:33:59 INFO - 'use_talos_json': True, 04:33:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:33:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:33:59 INFO - 'work_dir': 'build'} 04:33:59 INFO - ##### 04:33:59 INFO - ##### Running clobber step. 04:33:59 INFO - ##### 04:33:59 INFO - Running pre-action listener: _resource_record_pre_action 04:33:59 INFO - Running main action method: clobber 04:33:59 INFO - rmtree: /builds/slave/test/build 04:33:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:34:00 INFO - Running post-action listener: _resource_record_post_action 04:34:00 INFO - ##### 04:34:00 INFO - ##### Finished clobber step (success) 04:34:00 INFO - ##### 04:34:00 INFO - ##### 04:34:00 INFO - ##### Running read-buildbot-config step. 04:34:00 INFO - ##### 04:34:00 INFO - Running pre-action listener: _resource_record_pre_action 04:34:00 INFO - Running main action method: read_buildbot_config 04:34:00 INFO - Using buildbot properties: 04:34:00 INFO - { 04:34:00 INFO - "project": "", 04:34:00 INFO - "product": "firefox", 04:34:00 INFO - "script_repo_revision": "production", 04:34:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:34:00 INFO - "repository": "", 04:34:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:34:00 INFO - "buildid": "20160509024850", 04:34:00 INFO - "pgo_build": "False", 04:34:00 INFO - "basedir": "/builds/slave/test", 04:34:00 INFO - "buildnumber": 2937, 04:34:00 INFO - "slavename": "talos-linux64-ix-055", 04:34:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:34:00 INFO - "platform": "ubuntu64_hw", 04:34:00 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:34:00 INFO - "branch": "fx-team", 04:34:00 INFO - "repo_path": "integration/fx-team", 04:34:00 INFO - "revision": "cb53cee341a60d134fd5dc55ead4a95632a22dce", 04:34:00 INFO - "stage_platform": "linux64", 04:34:00 INFO - "builduid": "19c9eb1de1f448e0a508eb57f0ef353e", 04:34:00 INFO - "slavebuilddir": "test" 04:34:00 INFO - } 04:34:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:34:00 INFO - Running post-action listener: _resource_record_post_action 04:34:00 INFO - ##### 04:34:00 INFO - ##### Finished read-buildbot-config step (success) 04:34:00 INFO - ##### 04:34:00 INFO - ##### 04:34:00 INFO - ##### Running download-and-extract step. 04:34:00 INFO - ##### 04:34:00 INFO - Running pre-action listener: _resource_record_pre_action 04:34:00 INFO - Running main action method: download_and_extract 04:34:00 INFO - mkdir: /builds/slave/test/build/tests 04:34: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')]} 04:34:00 INFO - https://queue.taskcluster.net/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:34:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:34:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:34:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:34:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:34:00 INFO - Downloaded 1361 bytes. 04:34:00 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:34:00 INFO - Using the following test package requirements: 04:34:00 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:34:00 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:34:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:34:00 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:34:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:34:00 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:34:00 INFO - u'jsshell-linux-x86_64.zip'], 04:34:00 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:34:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:34:00 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:34:00 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:34:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:34:00 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:34:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:34:00 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:34:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:34:00 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:34:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:34:00 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:34: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')]} 04:34:00 INFO - https://queue.taskcluster.net/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:34:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:34:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:34:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:34:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:34:01 INFO - Downloaded 22322863 bytes. 04:34:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:34:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:34:03 INFO - Return code: 0 04:34:03 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:34:03 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')]} 04:34:03 INFO - https://queue.taskcluster.net/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:34:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:34:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:34:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:34:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:34:04 INFO - Downloaded 22322863 bytes. 04:34:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:34:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:34:05 INFO - Return code: 0 04:34:05 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')]} 04:34:05 INFO - https://queue.taskcluster.net/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:34:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:34:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:34:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:34:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:34:06 INFO - Downloaded 10840152 bytes. 04:34:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:34:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:34:06 INFO - Return code: 0 04:34:06 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')]} 04:34:06 INFO - https://queue.taskcluster.net/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:34:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:34:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:34:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:34:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:34:08 INFO - Downloaded 54864569 bytes. 04:34:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:34:08 INFO - mkdir: /builds/slave/test/properties 04:34:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:34:08 INFO - Writing to file /builds/slave/test/properties/build_url 04:34:08 INFO - Contents: 04:34:08 INFO - build_url:https://queue.taskcluster.net/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:34:08 INFO - Running post-action listener: _resource_record_post_action 04:34:08 INFO - Running post-action listener: set_extra_try_arguments 04:34:08 INFO - ##### 04:34:08 INFO - ##### Finished download-and-extract step (success) 04:34:08 INFO - ##### 04:34:08 INFO - ##### 04:34:08 INFO - ##### Running populate-webroot step. 04:34:08 INFO - ##### 04:34:08 INFO - Running pre-action listener: _resource_record_pre_action 04:34:08 INFO - Running main action method: populate_webroot 04:34:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:34:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:34:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:34:08 INFO - '--tppagecycles', 04:34:08 INFO - '7'], 04:34:08 INFO - 'tests': ['tsvgm']}}, 04:34:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:34:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:34:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:34:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:34:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:34:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:34:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:08 INFO - 'talos_options': ['--disable-e10s'], 04:34:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:34:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:34:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:08 INFO - 'talos_options': ['--disable-e10s'], 04:34:08 INFO - 'tests': ['damp', 'tps']}, 04:34:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:08 INFO - 'tests': ['damp', 'tps']}, 04:34:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:34:08 INFO - 'tests': ['dromaeo_dom']}, 04:34:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:34:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:34:08 INFO - 'tests': ['a11yr', 04:34:08 INFO - 'ts_paint', 04:34:08 INFO - 'tpaint', 04:34:08 INFO - 'sessionrestore', 04:34:08 INFO - 'sessionrestore_no_auto_restore', 04:34:08 INFO - 'tabpaint']}, 04:34:08 INFO - 'other-e10s': {'tests': ['a11yr', 04:34:08 INFO - 'ts_paint', 04:34:08 INFO - 'tpaint', 04:34:08 INFO - 'sessionrestore', 04:34:08 INFO - 'sessionrestore_no_auto_restore', 04:34:08 INFO - 'tabpaint']}, 04:34:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:34:08 INFO - 'ts_paint', 04:34:08 INFO - 'tpaint', 04:34:08 INFO - 'sessionrestore', 04:34:08 INFO - 'sessionrestore_no_auto_restore', 04:34:08 INFO - 'tabpaint']}, 04:34:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:34:08 INFO - 'ts_paint', 04:34:08 INFO - 'tpaint', 04:34:08 INFO - 'sessionrestore', 04:34:08 INFO - 'sessionrestore_no_auto_restore', 04:34:08 INFO - 'tabpaint']}, 04:34:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:34:08 INFO - 'tests': ['a11yr', 04:34:08 INFO - 'ts_paint', 04:34:08 INFO - 'tpaint', 04:34:08 INFO - 'sessionrestore', 04:34:08 INFO - 'sessionrestore_no_auto_restore', 04:34:08 INFO - 'tabpaint']}, 04:34:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:34:08 INFO - 'tests': ['a11yr', 04:34:08 INFO - 'ts_paint', 04:34:08 INFO - 'tpaint', 04:34:08 INFO - 'sessionrestore', 04:34:08 INFO - 'sessionrestore_no_auto_restore', 04:34:08 INFO - 'tabpaint']}, 04:34:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:34:08 INFO - 'tests': ['tsvgx', 04:34:08 INFO - 'tsvgr_opacity', 04:34:08 INFO - 'tart', 04:34:08 INFO - 'tscrollx', 04:34:08 INFO - 'cart']}, 04:34:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:34:08 INFO - 'tsvgr_opacity', 04:34:08 INFO - 'tart', 04:34:08 INFO - 'tscrollx', 04:34:08 INFO - 'cart']}, 04:34:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:08 INFO - 'talos_options': ['--disable-e10s'], 04:34:08 INFO - 'tests': ['tp5o']}, 04:34:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:08 INFO - 'tests': ['tp5o']}, 04:34:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:08 INFO - 'talos_options': ['--disable-e10s', 04:34:08 INFO - '--xperf_path', 04:34:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:34:08 INFO - 'tests': ['tp5n']}, 04:34:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:08 INFO - 'talos_options': ['--xperf_path', 04:34:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:34:08 INFO - 'tests': ['tp5n']}}, 04:34:08 INFO - 'talos.zip': {'path': '', 04:34:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:34:08 INFO - Running post-action listener: _resource_record_post_action 04:34:08 INFO - ##### 04:34:08 INFO - ##### Finished populate-webroot step (success) 04:34:08 INFO - ##### 04:34:08 INFO - ##### 04:34:08 INFO - ##### Running create-virtualenv step. 04:34:08 INFO - ##### 04:34:08 INFO - Running pre-action listener: _resource_record_pre_action 04:34:08 INFO - Running main action method: create_virtualenv 04:34:08 INFO - Creating virtualenv /builds/slave/test/build/venv 04:34:08 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 04:34:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:34:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:34:08 INFO - Using real prefix '/usr' 04:34:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:34:09 INFO - Installing distribute.............................................................................................................................................................................................done. 04:34:11 INFO - Installing pip.................done. 04:34:11 INFO - Return code: 0 04:34:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:34:11 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')]} 04:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:11 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')]} 04:34:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:11 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 0x7f434e9cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fe770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8d9c0>, '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 0x2a8e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8ed50>, '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': '82e07478c745e68b1fe4678a000001bc-1462793631.798382-677419622', '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 04:34:11 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 04:34:11 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 04:34:11 INFO - Using env: {'DISPLAY': ':0', 04:34:11 INFO - 'HOME': '/home/cltbld', 04:34:11 INFO - 'LANG': 'en_US.UTF-8', 04:34:11 INFO - 'LANGUAGE': 'en_US:en', 04:34:11 INFO - 'LOGNAME': 'cltbld', 04:34:11 INFO - 'MAIL': '/var/mail/cltbld', 04:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:11 INFO - 'MOZ_NO_REMOTE': '1', 04:34:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:11 INFO - 'NO_EM_RESTART': '1', 04:34:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:11 INFO - 'PWD': '/builds/slave/test', 04:34:11 INFO - 'SHELL': '/bin/bash', 04:34:11 INFO - 'SHLVL': '1', 04:34:11 INFO - 'TERM': 'linux', 04:34:11 INFO - 'TMOUT': '86400', 04:34:11 INFO - 'USER': 'cltbld', 04:34:11 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462793631.798382-677419622', 04:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:11 INFO - '_': '/tools/buildbot/bin/python'} 04:34:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:11 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 04:34:11 INFO - Cleaning up... 04:34:11 INFO - Return code: 0 04:34:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:34:11 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')]} 04:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:11 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')]} 04:34:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:11 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 0x7f434e9cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fe770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8d9c0>, '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 0x2a8e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8ed50>, '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': '82e07478c745e68b1fe4678a000001bc-1462793631.798382-677419622', '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 04:34:11 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 04:34:11 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 04:34:11 INFO - Using env: {'DISPLAY': ':0', 04:34:11 INFO - 'HOME': '/home/cltbld', 04:34:11 INFO - 'LANG': 'en_US.UTF-8', 04:34:11 INFO - 'LANGUAGE': 'en_US:en', 04:34:11 INFO - 'LOGNAME': 'cltbld', 04:34:11 INFO - 'MAIL': '/var/mail/cltbld', 04:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:11 INFO - 'MOZ_NO_REMOTE': '1', 04:34:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:11 INFO - 'NO_EM_RESTART': '1', 04:34:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:11 INFO - 'PWD': '/builds/slave/test', 04:34:11 INFO - 'SHELL': '/bin/bash', 04:34:11 INFO - 'SHLVL': '1', 04:34:11 INFO - 'TERM': 'linux', 04:34:11 INFO - 'TMOUT': '86400', 04:34:11 INFO - 'USER': 'cltbld', 04:34:11 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462793631.798382-677419622', 04:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:11 INFO - '_': '/tools/buildbot/bin/python'} 04:34:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:11 INFO - Downloading/unpacking psutil>=0.7.1 04:34:11 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 04:34:11 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 04:34:11 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 04:34:11 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 04:34:11 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 04:34:11 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 04:34:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:34:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:34:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:34:13 INFO - Installing collected packages: psutil 04:34:13 INFO - Running setup.py install for psutil 04:34:13 INFO - building 'psutil._psutil_linux' extension 04:34:13 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 04:34:14 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 04:34:14 INFO - building 'psutil._psutil_posix' extension 04:34:14 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 04:34:14 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 04:34:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:34:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:34:14 INFO - Successfully installed psutil 04:34:14 INFO - Cleaning up... 04:34:14 INFO - Return code: 0 04:34:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:34:14 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')]} 04:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:14 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')]} 04:34:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:14 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 0x7f434e9cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fe770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8d9c0>, '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 0x2a8e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8ed50>, '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': '82e07478c745e68b1fe4678a000001bc-1462793631.798382-677419622', '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 04:34:14 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 04:34:14 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 04:34:14 INFO - Using env: {'DISPLAY': ':0', 04:34:14 INFO - 'HOME': '/home/cltbld', 04:34:14 INFO - 'LANG': 'en_US.UTF-8', 04:34:14 INFO - 'LANGUAGE': 'en_US:en', 04:34:14 INFO - 'LOGNAME': 'cltbld', 04:34:14 INFO - 'MAIL': '/var/mail/cltbld', 04:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:14 INFO - 'MOZ_NO_REMOTE': '1', 04:34:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:14 INFO - 'NO_EM_RESTART': '1', 04:34:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:14 INFO - 'PWD': '/builds/slave/test', 04:34:14 INFO - 'SHELL': '/bin/bash', 04:34:14 INFO - 'SHLVL': '1', 04:34:14 INFO - 'TERM': 'linux', 04:34:14 INFO - 'TMOUT': '86400', 04:34:14 INFO - 'USER': 'cltbld', 04:34:14 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462793631.798382-677419622', 04:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:14 INFO - '_': '/tools/buildbot/bin/python'} 04:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:34:14 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 04:34:14 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 04:34:14 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 04:34:14 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 04:34:14 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 04:34:14 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 04:34:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:34:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:34:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:34:16 INFO - Installing collected packages: mozsystemmonitor 04:34:16 INFO - Running setup.py install for mozsystemmonitor 04:34:16 INFO - Successfully installed mozsystemmonitor 04:34:16 INFO - Cleaning up... 04:34:16 INFO - Return code: 0 04:34:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:34:16 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')]} 04:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:16 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')]} 04:34:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:16 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 0x7f434e9cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fe770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8d9c0>, '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 0x2a8e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8ed50>, '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': '82e07478c745e68b1fe4678a000001bc-1462793631.798382-677419622', '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 04:34:16 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 04:34:16 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 04:34:16 INFO - Using env: {'DISPLAY': ':0', 04:34:16 INFO - 'HOME': '/home/cltbld', 04:34:16 INFO - 'LANG': 'en_US.UTF-8', 04:34:16 INFO - 'LANGUAGE': 'en_US:en', 04:34:16 INFO - 'LOGNAME': 'cltbld', 04:34:16 INFO - 'MAIL': '/var/mail/cltbld', 04:34:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:16 INFO - 'MOZ_NO_REMOTE': '1', 04:34:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:16 INFO - 'NO_EM_RESTART': '1', 04:34:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:16 INFO - 'PWD': '/builds/slave/test', 04:34:16 INFO - 'SHELL': '/bin/bash', 04:34:16 INFO - 'SHLVL': '1', 04:34:16 INFO - 'TERM': 'linux', 04:34:16 INFO - 'TMOUT': '86400', 04:34:16 INFO - 'USER': 'cltbld', 04:34:16 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462793631.798382-677419622', 04:34:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:16 INFO - '_': '/tools/buildbot/bin/python'} 04:34:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:16 INFO - Downloading/unpacking blobuploader==1.2.4 04:34:16 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 04:34:16 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 04:34:16 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 04:34:16 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 04:34:16 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 04:34:16 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 04:34:18 INFO - Downloading blobuploader-1.2.4.tar.gz 04:34:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:34:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:34:18 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 04:34:18 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 04:34:18 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 04:34:18 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 04:34:18 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 04:34:18 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 04:34:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:34:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:34:19 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 04:34:19 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 04:34:19 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 04:34:19 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 04:34:19 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 04:34:19 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 04:34:19 INFO - Downloading docopt-0.6.1.tar.gz 04:34:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:34:19 INFO - Installing collected packages: blobuploader, requests, docopt 04:34:19 INFO - Running setup.py install for blobuploader 04:34:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:34:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:34:19 INFO - Running setup.py install for requests 04:34:19 INFO - Running setup.py install for docopt 04:34:20 INFO - Successfully installed blobuploader requests docopt 04:34:20 INFO - Cleaning up... 04:34:20 INFO - Return code: 0 04:34:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34: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')]} 04:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34: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')]} 04:34:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:20 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 0x7f434e9cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fe770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8d9c0>, '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 0x2a8e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8ed50>, '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': '82e07478c745e68b1fe4678a000001bc-1462793631.798382-677419622', '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 04:34:20 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 04:34:20 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 04:34:20 INFO - Using env: {'DISPLAY': ':0', 04:34:20 INFO - 'HOME': '/home/cltbld', 04:34:20 INFO - 'LANG': 'en_US.UTF-8', 04:34:20 INFO - 'LANGUAGE': 'en_US:en', 04:34:20 INFO - 'LOGNAME': 'cltbld', 04:34:20 INFO - 'MAIL': '/var/mail/cltbld', 04:34:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:20 INFO - 'MOZ_NO_REMOTE': '1', 04:34:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:20 INFO - 'NO_EM_RESTART': '1', 04:34:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:20 INFO - 'PWD': '/builds/slave/test', 04:34:20 INFO - 'SHELL': '/bin/bash', 04:34:20 INFO - 'SHLVL': '1', 04:34:20 INFO - 'TERM': 'linux', 04:34:20 INFO - 'TMOUT': '86400', 04:34:20 INFO - 'USER': 'cltbld', 04:34:20 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462793631.798382-677419622', 04:34:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:20 INFO - '_': '/tools/buildbot/bin/python'} 04:34:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:34:20 INFO - Running setup.py (path:/tmp/pip-PxATg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:34:20 INFO - Running setup.py (path:/tmp/pip-J1xnnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:34:20 INFO - Running setup.py (path:/tmp/pip-7hVGmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:34:20 INFO - Running setup.py (path:/tmp/pip-6RI5B6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:34:20 INFO - Running setup.py (path:/tmp/pip-Flx61n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:34:20 INFO - Running setup.py (path:/tmp/pip-Jb8E5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:34:20 INFO - Running setup.py (path:/tmp/pip-j6reFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:34:20 INFO - Running setup.py (path:/tmp/pip-I56ESj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:34:20 INFO - Running setup.py (path:/tmp/pip-yXxA3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:34:20 INFO - Running setup.py (path:/tmp/pip-Xzfwwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:34:21 INFO - Running setup.py (path:/tmp/pip-co6gdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:34:21 INFO - Running setup.py (path:/tmp/pip-EVLAJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:34:21 INFO - Running setup.py (path:/tmp/pip-oPA8Ix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:34:21 INFO - Running setup.py (path:/tmp/pip-hMXDpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:21 INFO - Running setup.py (path:/tmp/pip-5ak3qq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:34:21 INFO - Running setup.py (path:/tmp/pip-Oxuq_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:34:21 INFO - Running setup.py (path:/tmp/pip-ZgXMMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:34:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:34:21 INFO - Running setup.py install for manifestparser 04:34:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:34:21 INFO - Running setup.py install for mozcrash 04:34:21 INFO - Running setup.py install for mozdebug 04:34:21 INFO - Running setup.py install for mozdevice 04:34:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:34:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:34:21 INFO - Running setup.py install for mozfile 04:34:22 INFO - Running setup.py install for mozhttpd 04:34:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:34:22 INFO - Running setup.py install for mozinfo 04:34:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:34:22 INFO - Running setup.py install for mozInstall 04:34:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:34:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:34:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:34:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:34:22 INFO - Running setup.py install for mozleak 04:34:22 INFO - Running setup.py install for mozlog 04:34:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:34:22 INFO - Running setup.py install for moznetwork 04:34:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:34:22 INFO - Running setup.py install for mozprocess 04:34:22 INFO - Running setup.py install for mozprofile 04:34:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:34:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:34:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:34:22 INFO - Running setup.py install for mozrunner 04:34:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:34:23 INFO - Running setup.py install for mozscreenshot 04:34:23 INFO - Running setup.py install for moztest 04:34:23 INFO - Running setup.py install for mozversion 04:34:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:34:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:34:23 INFO - Cleaning up... 04:34:23 INFO - Return code: 0 04:34:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:23 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')]} 04:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:23 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')]} 04:34:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:23 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 0x7f434e9cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fe770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8d9c0>, '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 0x2a8e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8ed50>, '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': '82e07478c745e68b1fe4678a000001bc-1462793631.798382-677419622', '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 04:34:23 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 04:34:23 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 04:34:23 INFO - Using env: {'DISPLAY': ':0', 04:34:23 INFO - 'HOME': '/home/cltbld', 04:34:23 INFO - 'LANG': 'en_US.UTF-8', 04:34:23 INFO - 'LANGUAGE': 'en_US:en', 04:34:23 INFO - 'LOGNAME': 'cltbld', 04:34:23 INFO - 'MAIL': '/var/mail/cltbld', 04:34:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:23 INFO - 'MOZ_NO_REMOTE': '1', 04:34:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:23 INFO - 'NO_EM_RESTART': '1', 04:34:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:23 INFO - 'PWD': '/builds/slave/test', 04:34:23 INFO - 'SHELL': '/bin/bash', 04:34:23 INFO - 'SHLVL': '1', 04:34:23 INFO - 'TERM': 'linux', 04:34:23 INFO - 'TMOUT': '86400', 04:34:23 INFO - 'USER': 'cltbld', 04:34:23 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462793631.798382-677419622', 04:34:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:23 INFO - '_': '/tools/buildbot/bin/python'} 04:34:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:34:23 INFO - Running setup.py (path:/tmp/pip-iLeSTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:34:23 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)) 04:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:34:23 INFO - Running setup.py (path:/tmp/pip-QfdrMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:34:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 04:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:34:23 INFO - Running setup.py (path:/tmp/pip-aHcfJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:34:23 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)) 04:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:34:23 INFO - Running setup.py (path:/tmp/pip-HJls0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:34:23 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)) 04:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:34:23 INFO - Running setup.py (path:/tmp/pip-70rZEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:34:23 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)) 04:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:34:23 INFO - Running setup.py (path:/tmp/pip-9xsqwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:34:23 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)) 04:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:34:24 INFO - Running setup.py (path:/tmp/pip-f4CXhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:34:24 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)) 04:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:34:24 INFO - Running setup.py (path:/tmp/pip-kGVtBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:34:24 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)) 04:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:34:24 INFO - Running setup.py (path:/tmp/pip-i8MJUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:34:24 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)) 04:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:34:24 INFO - Running setup.py (path:/tmp/pip-vJajG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:34:24 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)) 04:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:34:24 INFO - Running setup.py (path:/tmp/pip-aYxkYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:34:24 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)) 04:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:34:24 INFO - Running setup.py (path:/tmp/pip-PMe_Ol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:34:24 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)) 04:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:34:24 INFO - Running setup.py (path:/tmp/pip-TcDS8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:34:24 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)) 04:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:34:24 INFO - Running setup.py (path:/tmp/pip-QqQYjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:34:24 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)) 04:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:24 INFO - Running setup.py (path:/tmp/pip-Bks8m9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:24 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)) 04:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:34:24 INFO - Running setup.py (path:/tmp/pip-_mEa06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:34:24 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)) 04:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:34:24 INFO - Running setup.py (path:/tmp/pip-G6x1uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:34:24 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)) 04:34:24 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:34:24 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:34:24 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)) 04:34:24 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)) 04:34:24 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)) 04:34:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:34:24 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 04:34:24 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 04:34:24 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 04:34:24 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 04:34:24 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 04:34:24 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 04:34:26 INFO - Downloading blessings-1.6.tar.gz 04:34:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:34:26 INFO - Installing collected packages: blessings 04:34:26 INFO - Running setup.py install for blessings 04:34:26 INFO - Successfully installed blessings 04:34:26 INFO - Cleaning up... 04:34:26 INFO - Return code: 0 04:34:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:34:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:34:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:34:27 INFO - Reading from file tmpfile_stdout 04:34:27 INFO - Current package versions: 04:34:27 INFO - argparse == 1.2.1 04:34:27 INFO - blessings == 1.6 04:34:27 INFO - blobuploader == 1.2.4 04:34:27 INFO - docopt == 0.6.1 04:34:27 INFO - manifestparser == 1.1 04:34:27 INFO - mozInstall == 1.12 04:34:27 INFO - mozcrash == 0.17 04:34:27 INFO - mozdebug == 0.1 04:34:27 INFO - mozdevice == 0.48 04:34:27 INFO - mozfile == 1.2 04:34:27 INFO - mozhttpd == 0.7 04:34:27 INFO - mozinfo == 0.9 04:34:27 INFO - mozleak == 0.1 04:34:27 INFO - mozlog == 3.1 04:34:27 INFO - moznetwork == 0.27 04:34:27 INFO - mozprocess == 0.22 04:34:27 INFO - mozprofile == 0.28 04:34:27 INFO - mozrunner == 6.11 04:34:27 INFO - mozscreenshot == 0.1 04:34:27 INFO - mozsystemmonitor == 0.0 04:34:27 INFO - moztest == 0.7 04:34:27 INFO - mozversion == 1.4 04:34:27 INFO - psutil == 3.1.1 04:34:27 INFO - requests == 1.2.3 04:34:27 INFO - wsgiref == 0.1.2 04:34:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:27 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')]} 04:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:27 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')]} 04:34:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:27 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 0x7f434e9cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fe770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8d9c0>, '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 0x2a8e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8ed50>, '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': '82e07478c745e68b1fe4678a000001bc-1462793631.798382-677419622', '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 04:34:27 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 04:34:27 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 04:34:27 INFO - Using env: {'DISPLAY': ':0', 04:34:27 INFO - 'HOME': '/home/cltbld', 04:34:27 INFO - 'LANG': 'en_US.UTF-8', 04:34:27 INFO - 'LANGUAGE': 'en_US:en', 04:34:27 INFO - 'LOGNAME': 'cltbld', 04:34:27 INFO - 'MAIL': '/var/mail/cltbld', 04:34:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:27 INFO - 'MOZ_NO_REMOTE': '1', 04:34:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:27 INFO - 'NO_EM_RESTART': '1', 04:34:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:27 INFO - 'PWD': '/builds/slave/test', 04:34:27 INFO - 'SHELL': '/bin/bash', 04:34:27 INFO - 'SHLVL': '1', 04:34:27 INFO - 'TERM': 'linux', 04:34:27 INFO - 'TMOUT': '86400', 04:34:27 INFO - 'USER': 'cltbld', 04:34:27 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462793631.798382-677419622', 04:34:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:27 INFO - '_': '/tools/buildbot/bin/python'} 04:34:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:27 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)) 04:34:27 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)) 04:34:27 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)) 04:34:27 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)) 04:34:27 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)) 04:34:27 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)) 04:34:27 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)) 04:34:27 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)) 04:34:27 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)) 04:34:27 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)) 04:34:27 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)) 04:34:27 INFO - Cleaning up... 04:34:27 INFO - Return code: 0 04:34:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:34:27 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')]} 04:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:27 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')]} 04:34:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:27 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 0x7f434e9cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fe770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8d9c0>, '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 0x2a8e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8ed50>, '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': '82e07478c745e68b1fe4678a000001bc-1462793631.798382-677419622', '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 04:34:27 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 04:34:27 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 04:34:27 INFO - Using env: {'DISPLAY': ':0', 04:34:27 INFO - 'HOME': '/home/cltbld', 04:34:27 INFO - 'LANG': 'en_US.UTF-8', 04:34:27 INFO - 'LANGUAGE': 'en_US:en', 04:34:27 INFO - 'LOGNAME': 'cltbld', 04:34:27 INFO - 'MAIL': '/var/mail/cltbld', 04:34:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:27 INFO - 'MOZ_NO_REMOTE': '1', 04:34:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:27 INFO - 'NO_EM_RESTART': '1', 04:34:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:27 INFO - 'PWD': '/builds/slave/test', 04:34:27 INFO - 'SHELL': '/bin/bash', 04:34:27 INFO - 'SHLVL': '1', 04:34:27 INFO - 'TERM': 'linux', 04:34:27 INFO - 'TMOUT': '86400', 04:34:27 INFO - 'USER': 'cltbld', 04:34:27 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462793631.798382-677419622', 04:34:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:27 INFO - '_': '/tools/buildbot/bin/python'} 04:34:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:27 INFO - Downloading/unpacking jsonschema 04:34:27 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 04:34:27 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 04:34:27 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 04:34:27 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 04:34:27 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 04:34:27 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 04:34:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:34:29 INFO - Downloading/unpacking functools32 (from jsonschema) 04:34:29 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 04:34:29 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 04:34:29 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 04:34:29 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 04:34:29 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 04:34:29 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 04:34:29 INFO - Downloading functools32-3.2.3-2.tar.gz 04:34:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:34:29 INFO - warning: no files found matching '*.txt' 04:34:29 INFO - no previously-included directories found matching 'build' 04:34:29 INFO - no previously-included directories found matching 'dist' 04:34:29 INFO - no previously-included directories found matching '.git*' 04:34:29 INFO - Installing collected packages: jsonschema, functools32 04:34:29 INFO - Running setup.py install for functools32 04:34:29 INFO - warning: no files found matching '*.txt' 04:34:29 INFO - no previously-included directories found matching 'build' 04:34:29 INFO - no previously-included directories found matching 'dist' 04:34:29 INFO - no previously-included directories found matching '.git*' 04:34:29 INFO - Successfully installed jsonschema functools32 04:34:29 INFO - Cleaning up... 04:34:30 INFO - Return code: 0 04:34:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:34:30 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')]} 04:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:30 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')]} 04:34:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:30 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 0x7f434e9cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fe770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8d9c0>, '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 0x2a8e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8ed50>, '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': '82e07478c745e68b1fe4678a000001bc-1462793631.798382-677419622', '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 04:34:30 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 04:34:30 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 04:34:30 INFO - Using env: {'DISPLAY': ':0', 04:34:30 INFO - 'HOME': '/home/cltbld', 04:34:30 INFO - 'LANG': 'en_US.UTF-8', 04:34:30 INFO - 'LANGUAGE': 'en_US:en', 04:34:30 INFO - 'LOGNAME': 'cltbld', 04:34:30 INFO - 'MAIL': '/var/mail/cltbld', 04:34:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:30 INFO - 'MOZ_NO_REMOTE': '1', 04:34:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:30 INFO - 'NO_EM_RESTART': '1', 04:34:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:30 INFO - 'PWD': '/builds/slave/test', 04:34:30 INFO - 'SHELL': '/bin/bash', 04:34:30 INFO - 'SHLVL': '1', 04:34:30 INFO - 'TERM': 'linux', 04:34:30 INFO - 'TMOUT': '86400', 04:34:30 INFO - 'USER': 'cltbld', 04:34:30 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462793631.798382-677419622', 04:34:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:30 INFO - '_': '/tools/buildbot/bin/python'} 04:34:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:30 INFO - Downloading/unpacking flake8 04:34:30 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 04:34:30 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 04:34:30 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 04:34:30 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 04:34:30 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 04:34:30 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 04:34:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:34:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:34:32 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 04:34:32 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 04:34:32 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 04:34:32 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 04:34:32 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 04:34:32 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 04:34:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:34:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:34:32 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 04:34:32 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 04:34:32 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 04:34:32 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 04:34:32 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 04:34:32 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 04:34:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:34:32 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 04:34:32 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 04:34:32 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 04:34:32 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 04:34:32 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 04:34:32 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 04:34:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:34:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:34:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:34:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:34:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:34:32 INFO - no previously-included directories found matching 'docs/_build' 04:34:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:34:32 INFO - Running setup.py install for pep8 04:34:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:34:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:34:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:34:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:34:32 INFO - no previously-included directories found matching 'docs/_build' 04:34:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:34:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:34:32 INFO - Cleaning up... 04:34:33 INFO - Return code: 0 04:34:33 INFO - Running post-action listener: _resource_record_post_action 04:34:33 INFO - Running post-action listener: _start_resource_monitoring 04:34:33 INFO - Starting resource monitoring. 04:34:33 INFO - ##### 04:34:33 INFO - ##### Finished create-virtualenv step (success) 04:34:33 INFO - ##### 04:34:33 INFO - ##### 04:34:33 INFO - ##### Running install step. 04:34:33 INFO - ##### 04:34:33 INFO - Running pre-action listener: _resource_record_pre_action 04:34:33 INFO - Running main action method: install 04:34:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:34:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:34:33 INFO - Reading from file tmpfile_stdout 04:34:33 INFO - Detecting whether we're running mozinstall >=1.0... 04:34:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:34:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:34:33 INFO - Reading from file tmpfile_stdout 04:34:33 INFO - Output received: 04:34:33 INFO - Usage: mozinstall [options] installer 04:34:33 INFO - Options: 04:34:33 INFO - -h, --help show this help message and exit 04:34:33 INFO - -d DEST, --destination=DEST 04:34:33 INFO - Directory to install application into. [default: 04:34:33 INFO - "/builds/slave/test"] 04:34:33 INFO - --app=APP Application being installed. [default: firefox] 04:34:33 INFO - mkdir: /builds/slave/test/build/application 04:34:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:34:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:34:49 INFO - Reading from file tmpfile_stdout 04:34:49 INFO - Output received: 04:34:49 INFO - /builds/slave/test/build/application/firefox/firefox 04:34:49 INFO - Running post-action listener: _resource_record_post_action 04:34:49 INFO - ##### 04:34:49 INFO - ##### Finished install step (success) 04:34:49 INFO - ##### 04:34:49 INFO - ##### 04:34:49 INFO - ##### Running run-tests step. 04:34:49 INFO - ##### 04:34:49 INFO - Running pre-action listener: _resource_record_pre_action 04:34:49 INFO - Running main action method: run_tests 04:34:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:34:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:34:49 INFO - Python 2.7.3 04:34:49 INFO - Return code: 0 04:34:49 INFO - grabbing minidump binary from tooltool 04:34:49 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')]} 04:34:49 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 0x2a8d9c0>, '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 0x2a8e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8ed50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:34:49 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 04:34:49 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 04:34:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:34:49 INFO - Return code: 0 04:34:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:34:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:34:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:34:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:34:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:34:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:34:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:34:50 INFO - Return code: 0 04:34:50 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:34:50 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:34:50 INFO - Using env: {'DISPLAY': ':0', 04:34:50 INFO - 'HOME': '/home/cltbld', 04:34:50 INFO - 'LANG': 'en_US.UTF-8', 04:34:50 INFO - 'LANGUAGE': 'en_US:en', 04:34:50 INFO - 'LOGNAME': 'cltbld', 04:34:50 INFO - 'MAIL': '/var/mail/cltbld', 04:34:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:34:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:50 INFO - 'MOZ_NO_REMOTE': '1', 04:34:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:34:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:50 INFO - 'NO_EM_RESTART': '1', 04:34:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:50 INFO - 'PWD': '/builds/slave/test', 04:34:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:34:50 INFO - 'SHELL': '/bin/bash', 04:34:50 INFO - 'SHLVL': '1', 04:34:50 INFO - 'TERM': 'linux', 04:34:50 INFO - 'TMOUT': '86400', 04:34:50 INFO - 'USER': 'cltbld', 04:34:50 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462793631.798382-677419622', 04:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:50 INFO - '_': '/tools/buildbot/bin/python'} 04:34:50 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:34:50 INFO - mozversion application_buildid: 20160509024850 04:34:50 INFO - mozversion application_changeset: cb53cee341a60d134fd5dc55ead4a95632a22dce 04:34:50 INFO - mozversion application_display_name: Nightly 04:34:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:34:50 INFO - mozversion application_name: Firefox 04:34:50 INFO - mozversion application_remotingname: firefox 04:34:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:34:50 INFO - mozversion application_vendor: Mozilla 04:34:50 INFO - mozversion application_version: 49.0a1 04:34:50 INFO - mozversion platform_buildid: 20160509024850 04:34:50 INFO - mozversion platform_changeset: cb53cee341a60d134fd5dc55ead4a95632a22dce 04:34:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:34:50 INFO - mozversion platform_version: 49.0a1 04:34:50 INFO - using testdate: 1462793690 04:34:50 INFO - actual date: 1462793690 04:34:50 INFO - starting webserver on 'localhost:41276' 04:34:50 INFO - SUITE-START | Running 2 tests 04:34:50 INFO - TEST-START | dromaeo_css 04:34:50 INFO - operating with platform_type : linux_ 04:34:50 INFO - Initialising browser for dromaeo_css test... 04:34:50 INFO - TEST-INFO | started process 24171 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe5lzEh/profile http://localhost:41276/getInfo.html) 04:34:54 INFO - PROCESS | 24171 | __metrics Screen width/height:1600/1200 04:34:54 INFO - PROCESS | 24171 | colorDepth:24 04:34:54 INFO - PROCESS | 24171 | Browser inner width/height: 1024/697 04:34:54 INFO - PROCESS | 24171 | __metrics 04:34:55 ERROR - PROCESS | 24171 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:34:56 INFO - TEST-INFO | 24171: exit 0 04:34:56 INFO - Browser initialized. 04:34:56 INFO - Running cycle 1/1 for dromaeo_css test... 04:34:56 INFO - TEST-INFO | started process 24251 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe5lzEh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:35:08 INFO - PROCESS | 24251 | RSS: Main: 153972736 04:35:08 INFO - PROCESS | 24251 | 04:36:00 INFO - PROCESS | 24251 | 1462793760184 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] 04:38:11 INFO - PROCESS | 24251 | Cycle 1(1): loaded http://localhost:41276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41276/tests/dromaeo/cssquery-ext.html) 04:38:12 INFO - PROCESS | 24251 | RSS: Main: 265572352 04:38:12 INFO - PROCESS | 24251 | 04:41:15 INFO - PROCESS | 24251 | Cycle 1(1): loaded http://localhost:41276/tests/dromaeo/cssquery-ext.html (next: http://localhost:41276/tests/dromaeo/cssquery-jquery.html) 04:41:16 INFO - PROCESS | 24251 | RSS: Main: 241557504 04:41:16 INFO - PROCESS | 24251 | 04:44:18 INFO - PROCESS | 24251 | Cycle 1(1): loaded http://localhost:41276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41276/tests/dromaeo/cssquery-mootools.html) 04:44:18 INFO - PROCESS | 24251 | RSS: Main: 242294784 04:44:18 INFO - PROCESS | 24251 | 04:47:20 INFO - PROCESS | 24251 | Cycle 1(1): loaded http://localhost:41276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41276/tests/dromaeo/cssquery-prototype.html) 04:47:21 INFO - PROCESS | 24251 | RSS: Main: 237309952 04:47:21 INFO - PROCESS | 24251 | 04:50:24 INFO - PROCESS | 24251 | Cycle 1(1): loaded http://localhost:41276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41276/tests/dromaeo/cssquery-yui.html) 04:50:24 INFO - PROCESS | 24251 | RSS: Main: 204746752 04:50:24 INFO - PROCESS | 24251 | 04:53:27 INFO - PROCESS | 24251 | Cycle 1(1): loaded http://localhost:41276/tests/dromaeo/cssquery-yui.html (next: http://localhost:41276/tests/dromaeo/cssquery-dojo.html) 04:53:27 INFO - PROCESS | 24251 | RSS: Main: 291418112 04:53:27 INFO - PROCESS | 24251 | 04:53:27 INFO - PROCESS | 24251 | __start_tp_report 04:53:27 INFO - PROCESS | 24251 | _x_x_mozilla_page_load 04:53:27 INFO - PROCESS | 24251 | _x_x_mozilla_page_load_details 04:53:27 INFO - PROCESS | 24251 | |i|pagename|runs| 04:53:27 INFO - PROCESS | 24251 | |0;dojo.html;2644.7487488688575;2662.161419152968;2692.5153472374977;2701.702812690604;2702.18934319704;4573.748443835596;4605.217113090775;4645.69802962808;4662.393888794456;4706.105839890422;4632.791524381402;4639.164950308943;4642.048380082084;4682.929756053662;4707.62339012879;4321.351797230417;4328.112736888946;4336.956630433687;4419.64642828573;4433.357163211333;4336.371226172203;4433.157700036999;4454.465464144308;4478.193925093482;4486.7083639563325;4185.769782661952;4387.780610969438;4407.625351845097;4430.158269928719;4446.9777651111535;4227.725197862129;4299.290617048183;4300.09697963425;4337.37108119321;4346.174226896879;4305.461817272841;4352.129574085164;4352.260115780325;4353.25994580922;4404.207242696313;4437.0682156747125;4686.789094490756;4695.5069717679835;4696.718196908197;4703.341532185496;4971.7514124294;5013.273075404082;5020.472850350697;5027.874303142451;5077.5684066854365;5027.622928280393;5054.090263752523;5075.847724568232;5078.21287700407;5088.2622019807295;4537.682362234612;4733.881652958635;4772.117158325686;4775.498572649822;4775.498572649891;5202.687838729688;5209.348831396075;5223.216517522402;5274.4198138204765;5278.498542638443;4998.850034498971;5009.524095210949;5045.924311135336;5054;5056.266841308064;4849.733264670406;4962.950370496249;4999.075171093359;5087.516685914832;5090.720010399389;4943.209086546135;4954.653174277766;4959;4970.627202959792;5002.499750024968;4954.479779623088;4960.851174464772;4966.180580204298;4971.328870602495;5009.649324547247;4212.662986961036;4241.554636763095;4260.339647354603;4307.56924307573;4341.066670665822;3781.4516895050065;3792.488014118059;3820.102275965146;3856.6914646828186;3872.8450861965207;4297.419848320436;4298.5271620122385;4306.987857853402;4345.543717909637;4352.608265256142;4815.807367705323;5075.111855425286;5076.974615126901;5083.059633967654;5122.641415100981;4328.956710432918;4335.219660461147;4339.934900976488;4386.254336762694;4401.603855653007;4632.814687412466;4638.304254361805;4642.79107440166;4642.883927901829;4691.272852707836;4585.19759042173;4784.091022705675;4809.5430934061205;4820.156472617278;4823.300621409946;5125.333706618116;5145.665531740575;5147.40804807452;5147.948520514747;5174.689518628894;4847.103285892122;4850.029994001144;4851.102546028996;4851.636127290397;4877.6829506081995;4763.237881938873;4959.57843583285;4988.201887697951;4994.425641051325;5103.234514822658;5058.418281897629;5071.54356107952;5079.5428411443145;5079.822206222764;5115.335006449138;4929.260610908249;4933.753312334441;4934.383202099738;4940.728259945738;4986.900261994812;4755.167845626932;4871.244957031524;4920.237363208708;4927.581155601814;4930.359053323045;4830.516948305282;4863.635227357891;4898.289747986593;4915.557599816034;4920.286558449076;4664.906701865876;4964.7765850537535;4976.328195693535;5013.749312534285;5016.448190698947;4671;4721.008588196517;4859.31969524274;4862.07620552094;4913.336699545515 04:53:27 INFO - PROCESS | 24251 | |1;ext.html;552.045455657732;580.1645630292379;594.2304715393565;598.3089531591013;599.1163034524075;26024.089156879512;28565;28595.571066433993;40182.598174018254;41250.79374603123;41583;41920.58079419205;41961.580384196146;41975.370369444405;41998.58001419985;7775.066991960958;7931.405144614148;7935.64289606969;7944.245296696805;7944.642491087915;7868.409869259828;7972.760817175494;7975.680972761083;7981.561014144219;7983.600819959008;7974.561399123046;8025.23760242776;8026.799330016738;8027.719029833957;8028.438009339348;7960.681572737083;7977.641006154737;8000.399970002244;8004.559749213791;8005.399595030338;7868.803279917991;7916.208379162095;7921.405894557931;7926.24700653437;7932;37481.812590937145;37717.24565508674;37769.43345849787;37874.810625946695;37875.24249515022;3339.666033396665;3378.5101160331615;3472.6006509251256;3605.6214097519646;3976.403539469074;28252.03353647858;28540.714592854012;28907.421851562853;29007.85496072506;29150.708492915222;3202.3755367703307;3203.3112880730755;3210.5184222366597;3251.154699778051;3332.216929021678;248949;301065;301446;303136;438539.80730096466;33761.83119084389;57832;57904.420955790745;58176.70911645415;58401.70799145977;31866.681333186836;33865.66134338625;33871.49192762111;33879.66120338815;33921.66078339185;13072.607821765363;13154.4080516377;13178.802317965237;13195.538156164488;13201.537946171838;10766.192535559865;10794;10858.945705271422;10872.130229581615;10873;8228.465149765247;8245.422820402515;8273.214044665747;8330.750077497563;8377.120402357787;3160.2099475131217;3192.824394658316;3199.088259845933;3248.13924310058;3263.249452625862;929.6420877961898;944.5513381143902;960.9375390599729;1022.243539780572;1040.552562398176;26808.415063262866;27043.729562704513;27101.322466938484;27521.17436476909;27607.447851042867;927.4945154890601;949.1789601994225;999.0509016434416;1022.9181665466745;1060.734816295926;14906.70186596262;15701.371945122295;16419.343226271056;16507.422240221775;17434.302627894995;347105;382355;384295;384323;385274;50319.49680503148;50978.23532647013;51109.48890511122;51197.74401128045;51207.7439612807;1169.1231576317762;1251.8622951475331;1272.2557303977092;1301;1313.5336955380894;27705.307367315978;28250;28360.71639283663;28892;28894.855525722236;40779.1844163121;41270.1745965085;41429.685625150516;41473.37789933093;41785.373219401125;304774;307690;308571;308847;309814;22219.333419997427;24250.878745606864;24935.75064249407;24981;25035.874820626508;40959.59040409558;40967.795161024005;41680.1663966725;41865.79067104645;41974;34805.84112381188;34955.30089398249;35433.64566354406;35482.46776298306;35529;34678.82660586681;34905;35042.824785875906;35659.82170089133;35710.8214458926;34610.48084278688;34694.13264668303;35069.47395789116;35143.648563514034;36903.44644830276;28824.279393014505;31065.378692425573;33530.161745956546;33744.662553375136;33764.3247135051;25251.494970100863;25507.23478295654;25591.265615861124;26127.905058513406;26399.73600263973 04:53:27 INFO - PROCESS | 24251 | |2;jquery.html;360.9079684680406;380.90477380654835;387.09999251739714;390.24682363039324;394.6546771574872;16101.677966440664;16141.919290403546;17005;17030.148492575383;17073.40243091492;11606.129540284492;16378.590535236624;17572.82427175728;17582.032988185645;17591.560210994732;4702.741349225791;4872.780724867372;4909.116359055369;4911.386076740408;4916.803327866881;4824.252240902666;4845.781939812699;4853.757312134379;4862.0275944811;4884.267359896008;4784.330193772875;4862.538058884418;4863.27050942358;4878.048780487807;4897.951020489785;4849.078675051746;4880.951190488103;4884.389451318603;4894.559489645949;4955.157623204064;4763.237881938873;4771.188897887368;4787.712737235742;4789.114013907439;4802.4237091548885;19890.50273743168;20230;20881.164753409845;20948.895255523777;20968.47578810527;2036.684313931343;2047.938561843147;2054.096197673019;2289.496310811619;2423.3093568333115;5379.300690910196;5762.250907382014;9399.436033837992;10607.681769546925;13441.798373024412;1771.681097402467;1838.1911958738247;1852.231324000538;1926.8747531410413;2047.406252186864;69037;69482.30517694859;69973.65013174902;71835.26824146434;72000.27999719988;10279.229057820543;10283;10298.485075746332;10337.534810933375;10459.424731639681;14228.502002429865;14390.712185756227;14415.279236038155;14421.495247666282;14428.567142985517;7210.412960015053;7218.530795498275;7232.783016509513;7278.1266248049515;7332.0834895638045;7097;7136.928630713626;7255.45584081196;7266.45501587383;7285.963570182115;4434.490033646108;4477.798499067485;4509.12072145935;4536.228841097021;4561.589456948891;1856.7400563921062;1874.7187921811565;1887.0941947865101;1891.6027634196973;1906.752122224102;902.3953950852945;929.7257309093834;937.9822892162081;975.5463709375175;984.3011461862015;16062.919685401499;16435.83564164343;16443.342266309453;16968.23642936071;17416.738748918775;858.2361698088706;901.553730903194;924.542351535994;933.2021121940778;990.3513198854762;8784.78038049054;9519.476428796483;9631.133198012212;9724.513774311255;9832.803343933081;406271;410273;429873;430257;433028;77700;79348.20651793524;80543;81272.59363703143;82673;903.814717982812;922.4557511068367;938.3016739701163;947.5735918836551;955.5365647661018;15019.549413517612;15079.698406032037;15279.465218717292;15280;15284.617884552976;34564.30871382508;34931.30137397187;35234.8238258807;35724.821375892956;35780.64219357773;44662;45316.54683453255;48246.517534824205;48387.75806120947;48734.26898596595;6839.760608378683;7246.492745507764;7968.163342848918;7994.2405471480115;8044.3162331200165;7419.554826710415;10688.358698478116;11317.320960742381;12042.879571204176;12155.939220303842;10075.244356673133;10516.737081573021;10687;10694.19793515505;10753.408562529135;5152.355955505562;9620.037996200605;9838.9016109838;10787.838182427113;10878.292910960763;10824.891751082389;10858.67423977282;11023.228374013743;11180.552777888794;11239.887601123884;7362.116546014298;7439.070116235471;7465.552066876005;7566.167721550515;7596.202398748052;10139.797204056025;10771.515281812493;10851.728706782395;10888.346699198073;11051.502682379152 04:53:27 INFO - PROCESS | 24251 | |3;mootools.html;1203.7411956429366;1413.9363728632206;1454.0185374871962;1580.49424184261;1775.4851093182976;6266.9686651566735;6855.485838562109;7067.646617669109;7096.82257943551;7253.492255542114;7028.789136325919;7191.7842464726145;7192.712291508346;7194.7122115115335;7200.423966082714;2145.8927053647294;2156.0944403350554;2167.2631305356176;2189.1462329691435;2191.057845126595;2086.926957556486;2108.335874199622;2130.1585873579925;2130.5419334843004;2133.871967681944;2093.026742564707;2095.413284280404;2104.389726979182;2109.2512158183854;2120.978790212101;2065.328768150357;2079.9376018719463;2082.937511874646;2083.8228750556145;2086.540960988588;2038.714579958807;2084.6351888419617;2086.685388205421;2087.3424871165535;2088.0395018291606;6979.965100174518;7071.575705457638;7115.608641524714;7118.822029449253;7198.7840364789145;4194.790260486994;4330.02574420756;4343.522212556616;4350.108227813291;4360.324149756792;2821.2241633550734;2901.2166714987047;2915.285754990041;2961.526155815059;2995.4009198160456;967.6032826541084;980.5489474841581;987.5555999800118;999.221385933033;1002.3134153105074;9104.271658267322;9298.581563829577;9349.485778282191;9416.152546270869;9536.141747242782;4007.2586571484367;4064.837406503707;4115.691323150776;4190.790460476964;4196.118815048813;8217.876731849026;8222.588870556448;8266.958665206635;8276.503409795432;8322.20939010793;4477.485089214782;4589.931151032737;4593.379893714373;4595.563421475022;4601.309803529497;3503.211777350127;3984.561698213194;4127.050778321003;4144.316187829035;4150.709450338508;3484.756067075331;3555.484454754046;3623.836927338276;3634.60019397866;3663.249033948034;1139.6979800352913;1152.982705259422;1159.4492616007328;1186.0630102219322;1191.1185722565413;744.8063503489024;826.7726375246855;887.9023307436177;904.5522466379184;914.5290175559592;5016.473270306638;5058.291839142523;5129.640925135204;5145.408278047998;5212.3223980883;854.3976496569903;897.4166791585391;899;906.5603182456504;962.5331714118647;3535.540379750616;3553.9466907996402;3741.382671859167;3742.5883152853166;3766.152615661509;8488.872666910001;8739.213470787532;8834.469931804113;8927.821443571092;8934.195922366887;8840.690575829814;8851.46891186531;8856.335774816915;8862;8864.20222180007;6528.738850445929;6788.694508747119;7010.228874823765;7016.824579385454;7024.964875175591;5200.011997720572;5219;5278.208268759717;5362.410134885237;5411.918821217763;7856.528608283521;8036.758897233092;8239.95880020596;8300.792480188044;8332.50004999702;8177.550234737147;8340.332773377993;8405.243528082501;8429.704960326359;8491.575421229038;5634.267545219259;6236.095766113979;6270.7805226816845;6401.29585745577;6446.677666116581;6977.33715297046;7009.492959013836;7042.471814614027;7060.505764596429;7075.82310442243;6278.937210627835;6434.099226108255;6434.517411194086;6493.8701225976165;6549.148610680581;6198.194234749454;6289.150964619901;6374.29882712892;6433.324500927522;6526.608403495806;6087.634741915499;6148.907766383597;6166.568340216142;6171.475424588781;6179.752809887555;4466.57567531084;4584.633229341712;4639.605633521189;4648.511906249931;4656.301554766812;4389.582989615981;4474.3959565459545;4494.932576011428;4510.909781804411;4541.341505481752 04:53:27 INFO - PROCESS | 24251 | |4;prototype.html;306.2420509239632;313.6142544670055;317.9809211447313;318.39504940612846;323.2597352063774;4852.441969173546;4858.708477491344;4876.366072410586;4878.731669758162;4880.804767809293;4740.885891815421;4743.4545027321865;4772.3795906532105;4778.928316075262;4809.687370320936;3596.9100772480765;3696.9463702844696;3728.5898551159353;3801.448789925459;3835.865744698936;3753.3994560870265;3774.67915227206;3804.9239015219678;3808.7714737115725;3817.7973938209516;3604.1530240393486;3778.565464971522;3784.6593806557403;3789.924201515968;3813.6949044076546;3577.8568857245677;3715.516982792233;3721.106934335767;3731.7014638828828;3786.4320351947154;3370.1237678203843;3379.594448666151;3384.627690953993;3388.491726241059;3404.931901361984;4557.612602928755;4577.9542204577865;4581.152486789922;4587.256842399866;4590.288505281654;4221.514525829508;4243.92869960524;4287.63555097814;4310.275889644167;4320.6327462165755;4901.828436004758;4944.975275123637;4967.50324967504;4968.90062198754;4970.353853998993;3703.4629978653215;3716.925661486755;3733.2720119576693;3736.1406876418305;3743.9142648631864;4977.278294647292;5199.818006369796;5214.73159175756;5222.608304377149;5222.764975576109;3756.417755247941;3780.3006443807985;3781.7331194050303;3796.734228603971;3800.657940785343;3822.9235415291537;3825.2731980923536;3831.59768224338;3854.419687927992;3861.826217820205;4272.380504826782;4307.698461107755;4319.373690814814;4320.546342634041;4329.956700433018;4757.976210118927;5008.670967999898;5019.247112933089;5027.220780778912;5073.518015788494;1246.3145270101588;1246.9961680847005;1247.5571172233908;1248.2649117726367;1259.5150866916304;839.0518713853306;871.2855458524076;875.3566128895256;879.9560021999002;886.2821114896955;4200.600942910419;4297.763623000703;4305.440292761984;4337.587929146726;4372.606465418127;4931.3589233399425;5180.818671346485;5188.688678679291;5223.059849227176;5226.294450249244;4424.690271680952;4436.511983681792;4439.801253661493;4440.911181776346;4460.933086003713;2617.4164630398714;2667.8799454024615;2693.393986353055;2693.8012584399753;2705.7970652201166;4752.691075080109;4776.808927642855;4818.277258411266;4834.492378300298;4834.613230941516;5123.820666276662;5130.51260130287;5152.639315247897;5156.20078887773;5222.4255331913455;4616.446026476844;4912.852614421573;4929.162042452864;4939.827106051271;4956.4547899731;5171.63798534099;5176.301199338041;5178.119719647744;5222.164453687392;5235.450277720937;4912.435069966999;5131.897362052813;5147.9227811583605;5156.278121062979;5169.638125331191;4849;4894.975525122351;4920.40955085392;4930.285108659153;4961.652684312064;3658.48781170631;3696.3900956342977;3712.5173727415263;3712.9814350928073;3715.9442608361437;5231.372235331784;5242.97378513105;5245.423003469692;5250.97374513125;5252.89494210106;4803.903921921612;5032.370953630796;5052.368453943257;5069.695818250917;5129.563987061141;5003.674761140514;5046.873828154326;5055.090083784954;5055.823046193365;5061.569766569735;4850.962595709881;4935.544014515798;4963.362090510051;4985.177445721415;4989.351384320015;4845.927311090407;4950.331705219749;5067.618219436858;5092.465291144376;5097.337346144977;4912.238603016538;4931.309616653743;4955.975220123876;4965.45380008206;4989.376327959005 04:53:27 INFO - PROCESS | 24251 | |5;yui.html;696.491561160353;789.3132974312349;799.7680672604943;810.3881569415095;818.8730746734251;11014.559417623286;11658.125640576949;11669.824952625706;11672.299662020274;11678.883211167886;11161.553537858475;11257.211995160342;11277.266977646468;11313.547458101666;11945.522179112824;868.6916144768611;880.3705350674298;886.6896586194813;886.6896586194845;887.6360692116234;868.3964644572025;871.2942516561574;872.3021582733819;872.4765140915464;872.5288344294073;906.2885634776702;915.7207051849183;916.1022198245723;916.445550441983;916.7845556294266;900.743288162877;903.9909600903973;905.9818803623923;905.9818803623923;906.0848542971613;665.278173182098;665.7769647168204;666.0808084842935;666.2704338749062;666.2837449741547;10801.40592267425;10852.891471085268;10885.891141088567;10902.890971090346;10919.454027298603;10434.113100386476;10592.41741704206;10630.09644180238;10795.5681772729;10935.726606834813;9311.487868167249;9316.394434361744;9326.860097098548;9479.28905332096;9524.333296669236;3147.1817327494787;3159.3207460396125;3168.889088881901;3195.1692559934354;3333.4166520858994;43006;43073.56926430727;43153.35269970953;43223.567764322266;43252.13495730068;8138.959305203436;8211.302039326605;8326.958365208135;8412.537310447862;8470.195331443503;15788;15832.28754706041;15858.127802970717;15862.44481443144;15871.841281587267;6313.715882785285;6542.214934207926;6575.967120164369;6586.604803711793;6747.257801641816;3331.9833400833327;3398.218409765718;3514.4728290756593;3529.258855640293;3622.7645203061716;2793.622860913791;2881.063654312357;2894.1172942252815;2894.768418526513;2896.898608548691;568.6247076929207;592.1295695327861;592.4638202426811;603.2007589943343;604.066716922356;511.93600799900014;526.2165033409772;584.1354794903566;634.2547506679633;641.1024565608093;7724.7682569523;7845.333146682482;7880.960595197102;7881;7987.3610111190965;597.6503745308956;599.5293694449836;605.893968555501;620.1534904854841;620.8416853702277;3759.323321802102;3760.6239376062176;3812.790296533717;3829.6744776694295;3852.1910398816563;45066.32400513995;45901.31148032782;46598.5340146601;52498.47501525012;53876.73061634745;34407.31185376278;44323.77838110853;46509.06981860411;46964;47078.29382559264;42712.78643606762;43264.56735432606;43495.78252108719;43559.78220108879;44078;7517.398608111229;7538.170801211752;7714.074311082706;7716.961415192888;7835.988613094759;29101.85449072826;29536.852315738284;30054.549181761853;30655.846720767146;30737.231569210053;36573.45139822851;38012.80993595014;38108.61891381162;38230.808845955595;40286.597134028285;10623.521941512805;10668.413237272025;10794.784104318027;10857.67426977192;10953.45232738344;11650.41747912618;11862.881371186179;11902.40487975615;12383.62849114528;12423.875761242272;11066.833997490205;11103.222774406036;11183.049440797624;11789.351585662527;11805;10966.670999870017;11500.309981401142;11512.884871151517;11535.287039707402;11719.238249513754;10128.303169343284;10428.634997775041;10732.892671073188;10882.29265097766;11228.550857965916;8439.620217090369;8591.097934716765;8730.91269087301;8805.735827925173;8939.150780675825;8964.955175224082;9034.322425817958;9356.204722598655;9367.250619950524;9407.952960235156 04:53:27 INFO - PROCESS | 24251 | __end_tp_report 04:53:27 INFO - PROCESS | 24251 | __start_cc_report 04:53:27 INFO - PROCESS | 24251 | _x_x_mozilla_cycle_collect,1039 04:53:27 INFO - PROCESS | 24251 | __end_cc_report 04:53:27 INFO - PROCESS | 24251 | __startTimestamp1462794807917__endTimestamp 04:53:27 INFO - PROCESS | 24251 | 04:53:27 INFO - PROCESS | 24251 | ------- Summary: start ------- 04:53:27 INFO - PROCESS | 24251 | Number of tests: 6 04:53:27 INFO - PROCESS | 24251 | 04:53:27 INFO - PROCESS | 24251 | [#0] dojo.html Cycles:165 Average:4672.28 Median:4809.54 stddev:480.62 (10.0%) stddev-sans-first:455.02 04:53:27 INFO - PROCESS | 24251 | Values: 2644.7 2662.2 2692.5 2701.7 2702.2 4573.7 4605.2 4645.7 4662.4 4706.1 4632.8 4639.2 4642.0 4682.9 4707.6 4321.4 4328.1 4337.0 4419.6 4433.4 4336.4 4433.2 4454.5 4478.2 4486.7 4185.8 4387.8 4407.6 4430.2 4447.0 4227.7 4299.3 4300.1 4337.4 4346.2 4305.5 4352.1 4352.3 4353.3 4404.2 4437.1 4686.8 4695.5 4696.7 4703.3 4971.8 5013.3 5020.5 5027.9 5077.6 5027.6 5054.1 5075.8 5078.2 5088.3 4537.7 4733.9 4772.1 4775.5 4775.5 5202.7 5209.3 5223.2 5274.4 5278.5 4998.9 5009.5 5045.9 5054.0 5056.3 4849.7 4963.0 4999.1 5087.5 5090.7 4943.2 4954.7 4959.0 4970.6 5002.5 4954.5 4960.9 4966.2 4971.3 5009.6 4212.7 4241.6 4260.3 4307.6 4341.1 3781.5 3792.5 3820.1 3856.7 3872.8 4297.4 4298.5 4307.0 4345.5 4352.6 4815.8 5075.1 5077.0 5083.1 5122.6 4329.0 4335.2 4339.9 4386.3 4401.6 4632.8 4638.3 4642.8 4642.9 4691.3 4585.2 4784.1 4809.5 4820.2 4823.3 5125.3 5145.7 5147.4 5147.9 5174.7 4847.1 4850.0 4851.1 4851.6 4877.7 4763.2 4959.6 4988.2 4994.4 5103.2 5058.4 5071.5 5079.5 5079.8 5115.3 4929.3 4933.8 4934.4 4940.7 4986.9 4755.2 4871.2 4920.2 4927.6 4930.4 4830.5 4863.6 4898.3 4915.6 4920.3 4664.9 4964.8 4976.3 5013.7 5016.4 4671.0 4721.0 4859.3 4862.1 4913.3 04:53:27 INFO - PROCESS | 24251 | 04:53:27 INFO - PROCESS | 24251 | [#1] ext.html Cycles:180 Average:47520.90 Median:34930.15 stddev:89212.60 (255.4%) stddev-sans-first:89393.17 04:53:27 INFO - PROCESS | 24251 | Values: 552.0 580.2 594.2 598.3 599.1 26024.1 28565.0 28595.6 40182.6 41250.8 41583.0 41920.6 41961.6 41975.4 41998.6 7775.1 7931.4 7935.6 7944.2 7944.6 7868.4 7972.8 7975.7 7981.6 7983.6 7974.6 8025.2 8026.8 8027.7 8028.4 7960.7 7977.6 8000.4 8004.6 8005.4 7868.8 7916.2 7921.4 7926.2 7932.0 37481.8 37717.2 37769.4 37874.8 37875.2 3339.7 3378.5 3472.6 3605.6 3976.4 28252.0 28540.7 28907.4 29007.9 29150.7 3202.4 3203.3 3210.5 3251.2 3332.2 248949.0 301065.0 301446.0 303136.0 438539.8 33761.8 57832.0 57904.4 58176.7 58401.7 31866.7 33865.7 33871.5 33879.7 33921.7 13072.6 13154.4 13178.8 13195.5 13201.5 10766.2 10794.0 10858.9 10872.1 10873.0 8228.5 8245.4 8273.2 8330.8 8377.1 3160.2 3192.8 3199.1 3248.1 3263.2 929.6 944.6 960.9 1022.2 1040.6 26808.4 27043.7 27101.3 27521.2 27607.4 927.5 949.2 999.1 1022.9 1060.7 14906.7 15701.4 16419.3 16507.4 17434.3 347105.0 382355.0 384295.0 384323.0 385274.0 50319.5 50978.2 51109.5 51197.7 51207.7 1169.1 1251.9 1272.3 1301.0 1313.5 27705.3 28250.0 28360.7 28892.0 28894.9 40779.2 41270.2 41429.7 41473.4 41785.4 304774.0 307690.0 308571.0 308847.0 309814.0 22219.3 24250.9 24935.8 24981.0 25035.9 40959.6 40967.8 41680.2 41865.8 41974.0 34805.8 34955.3 35433.6 35482.5 35529.0 34678.8 34905.0 35042.8 35659.8 35710.8 34610.5 34694.1 35069.5 35143.6 36903.4 28824.3 31065.4 33530.2 33744.7 33764.3 25251.5 25507.2 25591.3 26127.9 26399.7 04:53:27 INFO - PROCESS | 24251 | 04:53:27 INFO - PROCESS | 24251 | [#2] jquery.html Cycles:180 Average:25087.40 Median:4493.46 stddev:69571.86 (1548.3%) stddev-sans-first:69742.26 04:53:27 INFO - PROCESS | 24251 | Values: 360.9 380.9 387.1 390.2 394.7 16101.7 16141.9 17005.0 17030.1 17073.4 11606.1 16378.6 17572.8 17582.0 17591.6 4702.7 4872.8 4909.1 4911.4 4916.8 4824.3 4845.8 4853.8 4862.0 4884.3 4784.3 4862.5 4863.3 4878.0 4898.0 4849.1 4881.0 4884.4 4894.6 4955.2 4763.2 4771.2 4787.7 4789.1 4802.4 19890.5 20230.0 20881.2 20948.9 20968.5 2036.7 2047.9 2054.1 2289.5 2423.3 5379.3 5762.3 9399.4 10607.7 13441.8 1771.7 1838.2 1852.2 1926.9 2047.4 69037.0 69482.3 69973.7 71835.3 72000.3 10279.2 10283.0 10298.5 10337.5 10459.4 14228.5 14390.7 14415.3 14421.5 14428.6 7210.4 7218.5 7232.8 7278.1 7332.1 7097.0 7136.9 7255.5 7266.5 7286.0 4434.5 4477.8 4509.1 4536.2 4561.6 1856.7 1874.7 1887.1 1891.6 1906.8 902.4 929.7 938.0 975.5 984.3 16062.9 16435.8 16443.3 16968.2 17416.7 858.2 901.6 924.5 933.2 990.4 8784.8 9519.5 9631.1 9724.5 9832.8 406271.0 410273.0 429873.0 430257.0 433028.0 77700.0 79348.2 80543.0 81272.6 82673.0 903.8 922.5 938.3 947.6 955.5 15019.5 15079.7 15279.5 15280.0 15284.6 34564.3 34931.3 35234.8 35724.8 35780.6 44662.0 45316.5 48246.5 48387.8 48734.3 6839.8 7246.5 7968.2 7994.2 8044.3 7419.6 10688.4 11317.3 12042.9 12155.9 10075.2 10516.7 10687.0 10694.2 10753.4 5152.4 9620.0 9838.9 10787.8 10878.3 10824.9 10858.7 11023.2 11180.6 11239.9 7362.1 7439.1 7465.6 7566.2 7596.2 10139.8 10771.5 10851.7 10888.3 11051.5 04:53:27 INFO - PROCESS | 24251 | 04:53:27 INFO - PROCESS | 24251 | [#3] mootools.html Cycles:180 Average:4849.68 Median:5523.09 stddev:2571.17 (46.6%) stddev-sans-first:2563.78 04:53:27 INFO - PROCESS | 24251 | Values: 1203.7 1413.9 1454.0 1580.5 1775.5 6267.0 6855.5 7067.6 7096.8 7253.5 7028.8 7191.8 7192.7 7194.7 7200.4 2145.9 2156.1 2167.3 2189.1 2191.1 2086.9 2108.3 2130.2 2130.5 2133.9 2093.0 2095.4 2104.4 2109.3 2121.0 2065.3 2079.9 2082.9 2083.8 2086.5 2038.7 2084.6 2086.7 2087.3 2088.0 6980.0 7071.6 7115.6 7118.8 7198.8 4194.8 4330.0 4343.5 4350.1 4360.3 2821.2 2901.2 2915.3 2961.5 2995.4 967.6 980.5 987.6 999.2 1002.3 9104.3 9298.6 9349.5 9416.2 9536.1 4007.3 4064.8 4115.7 4190.8 4196.1 8217.9 8222.6 8267.0 8276.5 8322.2 4477.5 4589.9 4593.4 4595.6 4601.3 3503.2 3984.6 4127.1 4144.3 4150.7 3484.8 3555.5 3623.8 3634.6 3663.2 1139.7 1153.0 1159.4 1186.1 1191.1 744.8 826.8 887.9 904.6 914.5 5016.5 5058.3 5129.6 5145.4 5212.3 854.4 897.4 899.0 906.6 962.5 3535.5 3553.9 3741.4 3742.6 3766.2 8488.9 8739.2 8834.5 8927.8 8934.2 8840.7 8851.5 8856.3 8862.0 8864.2 6528.7 6788.7 7010.2 7016.8 7025.0 5200.0 5219.0 5278.2 5362.4 5411.9 7856.5 8036.8 8240.0 8300.8 8332.5 8177.6 8340.3 8405.2 8429.7 8491.6 5634.3 6236.1 6270.8 6401.3 6446.7 6977.3 7009.5 7042.5 7060.5 7075.8 6278.9 6434.1 6434.5 6493.9 6549.1 6198.2 6289.2 6374.3 6433.3 6526.6 6087.6 6148.9 6166.6 6171.5 6179.8 4466.6 4584.6 4639.6 4648.5 4656.3 4389.6 4474.4 4494.9 4510.9 4541.3 04:53:27 INFO - PROCESS | 24251 | 04:53:27 INFO - PROCESS | 24251 | [#4] prototype.html Cycles:180 Average:4182.77 Median:4774.59 stddev:1203.82 (25.2%) stddev-sans-first:1171.51 04:53:27 INFO - PROCESS | 24251 | Values: 306.2 313.6 318.0 318.4 323.3 4852.4 4858.7 4876.4 4878.7 4880.8 4740.9 4743.5 4772.4 4778.9 4809.7 3596.9 3696.9 3728.6 3801.4 3835.9 3753.4 3774.7 3804.9 3808.8 3817.8 3604.2 3778.6 3784.7 3789.9 3813.7 3577.9 3715.5 3721.1 3731.7 3786.4 3370.1 3379.6 3384.6 3388.5 3404.9 4557.6 4578.0 4581.2 4587.3 4590.3 4221.5 4243.9 4287.6 4310.3 4320.6 4901.8 4945.0 4967.5 4968.9 4970.4 3703.5 3716.9 3733.3 3736.1 3743.9 4977.3 5199.8 5214.7 5222.6 5222.8 3756.4 3780.3 3781.7 3796.7 3800.7 3822.9 3825.3 3831.6 3854.4 3861.8 4272.4 4307.7 4319.4 4320.5 4330.0 4758.0 5008.7 5019.2 5027.2 5073.5 1246.3 1247.0 1247.6 1248.3 1259.5 839.1 871.3 875.4 880.0 886.3 4200.6 4297.8 4305.4 4337.6 4372.6 4931.4 5180.8 5188.7 5223.1 5226.3 4424.7 4436.5 4439.8 4440.9 4460.9 2617.4 2667.9 2693.4 2693.8 2705.8 4752.7 4776.8 4818.3 4834.5 4834.6 5123.8 5130.5 5152.6 5156.2 5222.4 4616.4 4912.9 4929.2 4939.8 4956.5 5171.6 5176.3 5178.1 5222.2 5235.5 4912.4 5131.9 5147.9 5156.3 5169.6 4849.0 4895.0 4920.4 4930.3 4961.7 3658.5 3696.4 3712.5 3713.0 3715.9 5231.4 5243.0 5245.4 5251.0 5252.9 4803.9 5032.4 5052.4 5069.7 5129.6 5003.7 5046.9 5055.1 5055.8 5061.6 4851.0 4935.5 4963.4 4985.2 4989.4 4845.9 4950.3 5067.6 5092.5 5097.3 4912.2 4931.3 4956.0 4965.5 4989.4 04:53:27 INFO - PROCESS | 24251 | 04:53:27 INFO - PROCESS | 24251 | [#5] yui.html Cycles:180 Average:12277.80 Median:44200.89 stddev:13923.91 (31.5%) stddev-sans-first:13935.81 04:53:27 INFO - PROCESS | 24251 | Values: 696.5 789.3 799.8 810.4 818.9 11014.6 11658.1 11669.8 11672.3 11678.9 11161.6 11257.2 11277.3 11313.5 11945.5 868.7 880.4 886.7 886.7 887.6 868.4 871.3 872.3 872.5 872.5 906.3 915.7 916.1 916.4 916.8 900.7 904.0 906.0 906.0 906.1 665.3 665.8 666.1 666.3 666.3 10801.4 10852.9 10885.9 10902.9 10919.5 10434.1 10592.4 10630.1 10795.6 10935.7 9311.5 9316.4 9326.9 9479.3 9524.3 3147.2 3159.3 3168.9 3195.2 3333.4 43006.0 43073.6 43153.4 43223.6 43252.1 8139.0 8211.3 8327.0 8412.5 8470.2 15788.0 15832.3 15858.1 15862.4 15871.8 6313.7 6542.2 6576.0 6586.6 6747.3 3332.0 3398.2 3514.5 3529.3 3622.8 2793.6 2881.1 2894.1 2894.8 2896.9 568.6 592.1 592.5 603.2 604.1 511.9 526.2 584.1 634.3 641.1 7724.8 7845.3 7881.0 7881.0 7987.4 597.7 599.5 605.9 620.2 620.8 3759.3 3760.6 3812.8 3829.7 3852.2 45066.3 45901.3 46598.5 52498.5 53876.7 34407.3 44323.8 46509.1 46964.0 47078.3 42712.8 43264.6 43495.8 43559.8 44078.0 7517.4 7538.2 7714.1 7717.0 7836.0 29101.9 29536.9 30054.5 30655.8 30737.2 36573.5 38012.8 38108.6 38230.8 40286.6 10623.5 10668.4 10794.8 10857.7 10953.5 11650.4 11862.9 11902.4 12383.6 12423.9 11066.8 11103.2 11183.0 11789.4 11805.0 10966.7 11500.3 11512.9 11535.3 11719.2 10128.3 10428.6 10732.9 10882.3 11228.6 8439.6 8591.1 8730.9 8805.7 8939.2 8965.0 9034.3 9356.2 9367.3 9408.0 04:53:27 INFO - PROCESS | 24251 | -------- Summary: end -------- 04:53:27 INFO - PROCESS | 24251 | 04:53:28 INFO - TEST-INFO | 24251: exit 0 04:53:28 INFO - TEST-OK | dromaeo_css | took 1118313ms 04:53:28 INFO - TEST-START | kraken 04:53:28 INFO - operating with platform_type : linux_ 04:53:28 INFO - Initialising browser for kraken test... 04:53:28 INFO - TEST-INFO | started process 24428 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphPvCvv/profile http://localhost:41276/getInfo.html) 04:53:32 INFO - PROCESS | 24428 | __metrics Screen width/height:1600/1200 04:53:32 INFO - PROCESS | 24428 | colorDepth:24 04:53:32 INFO - PROCESS | 24428 | Browser inner width/height: 1024/697 04:53:32 INFO - PROCESS | 24428 | __metrics 04:53:33 ERROR - PROCESS | 24428 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:53:34 INFO - TEST-INFO | 24428: exit 0 04:53:34 INFO - Browser initialized. 04:53:34 INFO - Running cycle 1/1 for kraken test... 04:53:34 INFO - TEST-INFO | started process 24508 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphPvCvv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:53:46 INFO - PROCESS | 24508 | RSS: Main: 153886720 04:53:46 INFO - PROCESS | 24508 | 04:53:49 INFO - PROCESS | 24508 | Cycle 1(1): loaded http://localhost:41276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41276/tests/kraken/driver.html?testName=audio-beat-detection) 04:53:50 INFO - PROCESS | 24508 | RSS: Main: 209309696 04:53:50 INFO - PROCESS | 24508 | 04:53:52 INFO - PROCESS | 24508 | Cycle 1(1): loaded http://localhost:41276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41276/tests/kraken/driver.html?testName=audio-dft) 04:53:53 INFO - PROCESS | 24508 | RSS: Main: 197419008 04:53:53 INFO - PROCESS | 24508 | 04:53:56 INFO - PROCESS | 24508 | Cycle 1(1): loaded http://localhost:41276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41276/tests/kraken/driver.html?testName=audio-fft) 04:53:57 INFO - PROCESS | 24508 | RSS: Main: 266731520 04:53:57 INFO - PROCESS | 24508 | 04:53:59 INFO - PROCESS | 24508 | Cycle 1(1): loaded http://localhost:41276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41276/tests/kraken/driver.html?testName=audio-oscillator) 04:54:00 INFO - PROCESS | 24508 | RSS: Main: 175149056 04:54:00 INFO - PROCESS | 24508 | 04:54:02 INFO - PROCESS | 24508 | Cycle 1(1): loaded http://localhost:41276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:54:03 INFO - PROCESS | 24508 | RSS: Main: 178733056 04:54:03 INFO - PROCESS | 24508 | 04:54:06 INFO - PROCESS | 24508 | Cycle 1(1): loaded http://localhost:41276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41276/tests/kraken/driver.html?testName=imaging-darkroom) 04:54:07 INFO - PROCESS | 24508 | RSS: Main: 215203840 04:54:07 INFO - PROCESS | 24508 | 04:54:11 INFO - PROCESS | 24508 | Cycle 1(1): loaded http://localhost:41276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41276/tests/kraken/driver.html?testName=imaging-desaturate) 04:54:11 INFO - PROCESS | 24508 | RSS: Main: 213200896 04:54:11 INFO - PROCESS | 24508 | 04:54:14 INFO - PROCESS | 24508 | Cycle 1(1): loaded http://localhost:41276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41276/tests/kraken/driver.html?testName=json-parse-financial) 04:54:15 INFO - PROCESS | 24508 | RSS: Main: 214679552 04:54:15 INFO - PROCESS | 24508 | 04:54:17 INFO - PROCESS | 24508 | Cycle 1(1): loaded http://localhost:41276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:54:17 INFO - PROCESS | 24508 | RSS: Main: 205430784 04:54:17 INFO - PROCESS | 24508 | 04:54:19 INFO - PROCESS | 24508 | Cycle 1(1): loaded http://localhost:41276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41276/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:54:20 INFO - PROCESS | 24508 | RSS: Main: 208089088 04:54:20 INFO - PROCESS | 24508 | 04:54:22 INFO - PROCESS | 24508 | Cycle 1(1): loaded http://localhost:41276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:54:23 INFO - PROCESS | 24508 | RSS: Main: 217858048 04:54:23 INFO - PROCESS | 24508 | 04:54:26 INFO - PROCESS | 24508 | Cycle 1(1): loaded http://localhost:41276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:54:26 INFO - PROCESS | 24508 | RSS: Main: 222740480 04:54:26 INFO - PROCESS | 24508 | 04:54:29 INFO - PROCESS | 24508 | Cycle 1(1): loaded http://localhost:41276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:54:30 INFO - PROCESS | 24508 | RSS: Main: 221675520 04:54:30 INFO - PROCESS | 24508 | 04:54:32 INFO - PROCESS | 24508 | Cycle 1(1): loaded http://localhost:41276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41276/tests/kraken/driver.html?testName=ai-astar) 04:54:32 INFO - PROCESS | 24508 | RSS: Main: 268156928 04:54:32 INFO - PROCESS | 24508 | 04:54:32 INFO - PROCESS | 24508 | __start_tp_report 04:54:32 INFO - PROCESS | 24508 | _x_x_mozilla_page_load 04:54:32 INFO - PROCESS | 24508 | _x_x_mozilla_page_load_details 04:54:32 INFO - PROCESS | 24508 | |i|pagename|runs| 04:54:32 INFO - PROCESS | 24508 | |0;ai-astar;114;108;117;115;117;114;114;115;116;115 04:54:32 INFO - PROCESS | 24508 | |1;audio-beat-detection;158;129;162;216;130;167;155;131;193;132 04:54:32 INFO - PROCESS | 24508 | |2;audio-dft;160;160;162;161;161;163;161;161;161;161 04:54:32 INFO - PROCESS | 24508 | |3;audio-fft;76;75;76;151;76;76;78;75;129;79 04:54:32 INFO - PROCESS | 24508 | |4;audio-oscillator;93;93;162;93;93;96;125;92;91;124 04:54:32 INFO - PROCESS | 24508 | |5;imaging-gaussian-blur;116;116;117;116;117;117;117;117;116;117 04:54:32 INFO - PROCESS | 24508 | |6;imaging-darkroom;146;146;147;147;145;145;147;146;146;146 04:54:32 INFO - PROCESS | 24508 | |7;imaging-desaturate;94;94;95;95;96;95;95;94;94;94 04:54:32 INFO - PROCESS | 24508 | |8;json-parse-financial;65;66;64;65;65;65;74;119;63;63 04:54:32 INFO - PROCESS | 24508 | |9;json-stringify-tinderbox;64;64;64;64;64;64;64;64;64;64 04:54:32 INFO - PROCESS | 24508 | |10;stanford-crypto-aes;81;81;89;81;84;82;81;81;82;88 04:54:32 INFO - PROCESS | 24508 | |11;stanford-crypto-ccm;135;132;142;129;133;140;129;135;272;133 04:54:32 INFO - PROCESS | 24508 | |12;stanford-crypto-pbkdf2;178;173;173;173;172;170;171;171;173;170 04:54:32 INFO - PROCESS | 24508 | |13;stanford-crypto-sha256-iterative;69;72;72;68;69;70;70;68;68;67 04:54:32 INFO - PROCESS | 24508 | __end_tp_report 04:54:32 INFO - PROCESS | 24508 | __start_cc_report 04:54:32 INFO - PROCESS | 24508 | _x_x_mozilla_cycle_collect,2116 04:54:32 INFO - PROCESS | 24508 | __end_cc_report 04:54:32 INFO - PROCESS | 24508 | __startTimestamp1462794872656__endTimestamp 04:54:32 INFO - PROCESS | 24508 | 04:54:32 INFO - PROCESS | 24508 | ------- Summary: start ------- 04:54:32 INFO - PROCESS | 24508 | Number of tests: 14 04:54:32 INFO - PROCESS | 24508 | 04:54:32 INFO - PROCESS | 24508 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:2.55 (2.2%) stddev-sans-first:2.70 04:54:32 INFO - PROCESS | 24508 | Values: 114.0 108.0 117.0 115.0 117.0 114.0 114.0 115.0 116.0 115.0 04:54:32 INFO - PROCESS | 24508 | 04:54:32 INFO - PROCESS | 24508 | [#1] audio-beat-detection Cycles:10 Average:157.30 Median:160.00 stddev:29.29 (18.3%) stddev-sans-first:31.06 04:54:32 INFO - PROCESS | 24508 | Values: 158.0 129.0 162.0 216.0 130.0 167.0 155.0 131.0 193.0 132.0 04:54:32 INFO - PROCESS | 24508 | 04:54:32 INFO - PROCESS | 24508 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.83 04:54:32 INFO - PROCESS | 24508 | Values: 160.0 160.0 162.0 161.0 161.0 163.0 161.0 161.0 161.0 161.0 04:54:32 INFO - PROCESS | 24508 | 04:54:32 INFO - PROCESS | 24508 | [#3] audio-fft Cycles:10 Average:89.10 Median:76.00 stddev:27.35 (36.0%) stddev-sans-first:28.60 04:54:32 INFO - PROCESS | 24508 | Values: 76.0 75.0 76.0 151.0 76.0 76.0 78.0 75.0 129.0 79.0 04:54:32 INFO - PROCESS | 24508 | 04:54:32 INFO - PROCESS | 24508 | [#4] audio-oscillator Cycles:10 Average:106.20 Median:93.00 stddev:23.61 (25.4%) stddev-sans-first:24.56 04:54:32 INFO - PROCESS | 24508 | Values: 93.0 93.0 162.0 93.0 93.0 96.0 125.0 92.0 91.0 124.0 04:54:32 INFO - PROCESS | 24508 | 04:54:32 INFO - PROCESS | 24508 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:54:32 INFO - PROCESS | 24508 | Values: 116.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 04:54:32 INFO - PROCESS | 24508 | 04:54:32 INFO - PROCESS | 24508 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 04:54:32 INFO - PROCESS | 24508 | Values: 146.0 146.0 147.0 147.0 145.0 145.0 147.0 146.0 146.0 146.0 04:54:32 INFO - PROCESS | 24508 | 04:54:32 INFO - PROCESS | 24508 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 04:54:32 INFO - PROCESS | 24508 | Values: 94.0 94.0 95.0 95.0 96.0 95.0 95.0 94.0 94.0 94.0 04:54:32 INFO - PROCESS | 24508 | 04:54:32 INFO - PROCESS | 24508 | [#8] json-parse-financial Cycles:10 Average:70.90 Median:65.00 stddev:17.19 (26.4%) stddev-sans-first:18.10 04:54:32 INFO - PROCESS | 24508 | Values: 65.0 66.0 64.0 65.0 65.0 65.0 74.0 119.0 63.0 63.0 04:54:32 INFO - PROCESS | 24508 | 04:54:32 INFO - PROCESS | 24508 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 04:54:32 INFO - PROCESS | 24508 | Values: 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 04:54:32 INFO - PROCESS | 24508 | 04:54:32 INFO - PROCESS | 24508 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:82.00 stddev:3.06 (3.7%) stddev-sans-first:3.15 04:54:32 INFO - PROCESS | 24508 | Values: 81.0 81.0 89.0 81.0 84.0 82.0 81.0 81.0 82.0 88.0 04:54:32 INFO - PROCESS | 24508 | 04:54:32 INFO - PROCESS | 24508 | [#11] stanford-crypto-ccm Cycles:10 Average:148.00 Median:135.00 stddev:43.77 (32.4%) stddev-sans-first:46.17 04:54:32 INFO - PROCESS | 24508 | Values: 135.0 132.0 142.0 129.0 133.0 140.0 129.0 135.0 272.0 133.0 04:54:32 INFO - PROCESS | 24508 | 04:54:32 INFO - PROCESS | 24508 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:173.00 stddev:2.32 (1.3%) stddev-sans-first:1.30 04:54:32 INFO - PROCESS | 24508 | Values: 178.0 173.0 173.0 173.0 172.0 170.0 171.0 171.0 173.0 170.0 04:54:32 INFO - PROCESS | 24508 | 04:54:32 INFO - PROCESS | 24508 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:1.70 (2.5%) stddev-sans-first:1.80 04:54:32 INFO - PROCESS | 24508 | Values: 69.0 72.0 72.0 68.0 69.0 70.0 70.0 68.0 68.0 67.0 04:54:32 INFO - PROCESS | 24508 | -------- Summary: end -------- 04:54:32 INFO - PROCESS | 24508 | 04:54:33 INFO - TEST-INFO | 24508: exit 0 04:54:33 INFO - TEST-OK | kraken | took 65044ms 04:54:33 INFO - SUITE-END | took 1183s 04:54:33 INFO - Completed test suite (00:19:43) 04:54:33 INFO - javascript benchmark 04:54:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2644.7487488688575, 2662.161419152968, 2692.5153472374977, 2701.702812690604, 2702.18934319704, 4573.748443835596, 4605.217113090775, 4645.69802962808, 4662.393888794456, 4706.105839890422, 4632.791524381402, 4639.164950308943, 4642.048380082084, 4682.929756053662, 4707.62339012879, 4321.351797230417, 4328.112736888946, 4336.956630433687, 4419.64642828573, 4433.357163211333, 4336.371226172203, 4433.157700036999, 4454.465464144308, 4478.193925093482, 4486.7083639563325, 4185.769782661952, 4387.780610969438, 4407.625351845097, 4430.158269928719, 4446.9777651111535, 4227.725197862129, 4299.290617048183, 4300.09697963425, 4337.37108119321, 4346.174226896879, 4305.461817272841, 4352.129574085164, 4352.260115780325, 4353.25994580922, 4404.207242696313, 4437.0682156747125, 4686.789094490756, 4695.5069717679835, 4696.718196908197, 4703.341532185496, 4971.7514124294, 5013.273075404082, 5020.472850350697, 5027.874303142451, 5077.5684066854365, 5027.622928280393, 5054.090263752523, 5075.847724568232, 5078.21287700407, 5088.2622019807295, 4537.682362234612, 4733.881652958635, 4772.117158325686, 4775.498572649822, 4775.498572649891, 5202.687838729688, 5209.348831396075, 5223.216517522402, 5274.4198138204765, 5278.498542638443, 4998.850034498971, 5009.524095210949, 5045.924311135336, 5054.0, 5056.266841308064, 4849.733264670406, 4962.950370496249, 4999.075171093359, 5087.516685914832, 5090.720010399389, 4943.209086546135, 4954.653174277766, 4959.0, 4970.627202959792, 5002.499750024968, 4954.479779623088, 4960.851174464772, 4966.180580204298, 4971.328870602495, 5009.649324547247, 4212.662986961036, 4241.554636763095, 4260.339647354603, 4307.56924307573, 4341.066670665822, 3781.4516895050065, 3792.488014118059, 3820.102275965146, 3856.6914646828186, 3872.8450861965207, 4297.419848320436, 4298.5271620122385, 4306.987857853402, 4345.543717909637, 4352.608265256142, 4815.807367705323, 5075.111855425286, 5076.974615126901, 5083.059633967654, 5122.641415100981, 4328.956710432918, 4335.219660461147, 4339.934900976488, 4386.254336762694, 4401.603855653007, 4632.814687412466, 4638.304254361805, 4642.79107440166, 4642.883927901829, 4691.272852707836, 4585.19759042173, 4784.091022705675, 4809.5430934061205, 4820.156472617278, 4823.300621409946, 5125.333706618116, 5145.665531740575, 5147.40804807452, 5147.948520514747, 5174.689518628894, 4847.103285892122, 4850.029994001144, 4851.102546028996, 4851.636127290397, 4877.6829506081995, 4763.237881938873, 4959.57843583285, 4988.201887697951, 4994.425641051325, 5103.234514822658, 5058.418281897629, 5071.54356107952, 5079.5428411443145, 5079.822206222764, 5115.335006449138, 4929.260610908249, 4933.753312334441, 4934.383202099738, 4940.728259945738, 4986.900261994812, 4755.167845626932, 4871.244957031524, 4920.237363208708, 4927.581155601814, 4930.359053323045, 4830.516948305282, 4863.635227357891, 4898.289747986593, 4915.557599816034, 4920.286558449076, 4664.906701865876, 4964.7765850537535, 4976.328195693535, 5013.749312534285, 5016.448190698947, 4671.0, 4721.008588196517, 4859.31969524274, 4862.07620552094, 4913.336699545515], "value": 4642.61389588047, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.045455657732, 580.1645630292379, 594.2304715393565, 598.3089531591013, 599.1163034524075, 26024.089156879512, 28565.0, 28595.571066433993, 40182.598174018254, 41250.79374603123, 41583.0, 41920.58079419205, 41961.580384196146, 41975.370369444405, 41998.58001419985, 7775.066991960958, 7931.405144614148, 7935.64289606969, 7944.245296696805, 7944.642491087915, 7868.409869259828, 7972.760817175494, 7975.680972761083, 7981.561014144219, 7983.600819959008, 7974.561399123046, 8025.23760242776, 8026.799330016738, 8027.719029833957, 8028.438009339348, 7960.681572737083, 7977.641006154737, 8000.399970002244, 8004.559749213791, 8005.399595030338, 7868.803279917991, 7916.208379162095, 7921.405894557931, 7926.24700653437, 7932.0, 37481.812590937145, 37717.24565508674, 37769.43345849787, 37874.810625946695, 37875.24249515022, 3339.666033396665, 3378.5101160331615, 3472.6006509251256, 3605.6214097519646, 3976.403539469074, 28252.03353647858, 28540.714592854012, 28907.421851562853, 29007.85496072506, 29150.708492915222, 3202.3755367703307, 3203.3112880730755, 3210.5184222366597, 3251.154699778051, 3332.216929021678, 248949.0, 301065.0, 301446.0, 303136.0, 438539.80730096466, 33761.83119084389, 57832.0, 57904.420955790745, 58176.70911645415, 58401.70799145977, 31866.681333186836, 33865.66134338625, 33871.49192762111, 33879.66120338815, 33921.66078339185, 13072.607821765363, 13154.4080516377, 13178.802317965237, 13195.538156164488, 13201.537946171838, 10766.192535559865, 10794.0, 10858.945705271422, 10872.130229581615, 10873.0, 8228.465149765247, 8245.422820402515, 8273.214044665747, 8330.750077497563, 8377.120402357787, 3160.2099475131217, 3192.824394658316, 3199.088259845933, 3248.13924310058, 3263.249452625862, 929.6420877961898, 944.5513381143902, 960.9375390599729, 1022.243539780572, 1040.552562398176, 26808.415063262866, 27043.729562704513, 27101.322466938484, 27521.17436476909, 27607.447851042867, 927.4945154890601, 949.1789601994225, 999.0509016434416, 1022.9181665466745, 1060.734816295926, 14906.70186596262, 15701.371945122295, 16419.343226271056, 16507.422240221775, 17434.302627894995, 347105.0, 382355.0, 384295.0, 384323.0, 385274.0, 50319.49680503148, 50978.23532647013, 51109.48890511122, 51197.74401128045, 51207.7439612807, 1169.1231576317762, 1251.8622951475331, 1272.2557303977092, 1301.0, 1313.5336955380894, 27705.307367315978, 28250.0, 28360.71639283663, 28892.0, 28894.855525722236, 40779.1844163121, 41270.1745965085, 41429.685625150516, 41473.37789933093, 41785.373219401125, 304774.0, 307690.0, 308571.0, 308847.0, 309814.0, 22219.333419997427, 24250.878745606864, 24935.75064249407, 24981.0, 25035.874820626508, 40959.59040409558, 40967.795161024005, 41680.1663966725, 41865.79067104645, 41974.0, 34805.84112381188, 34955.30089398249, 35433.64566354406, 35482.46776298306, 35529.0, 34678.82660586681, 34905.0, 35042.824785875906, 35659.82170089133, 35710.8214458926, 34610.48084278688, 34694.13264668303, 35069.47395789116, 35143.648563514034, 36903.44644830276, 28824.279393014505, 31065.378692425573, 33530.161745956546, 33744.662553375136, 33764.3247135051, 25251.494970100863, 25507.23478295654, 25591.265615861124, 26127.905058513406, 26399.73600263973], "value": 16660.3077866006, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.9079684680406, 380.90477380654835, 387.09999251739714, 390.24682363039324, 394.6546771574872, 16101.677966440664, 16141.919290403546, 17005.0, 17030.148492575383, 17073.40243091492, 11606.129540284492, 16378.590535236624, 17572.82427175728, 17582.032988185645, 17591.560210994732, 4702.741349225791, 4872.780724867372, 4909.116359055369, 4911.386076740408, 4916.803327866881, 4824.252240902666, 4845.781939812699, 4853.757312134379, 4862.0275944811, 4884.267359896008, 4784.330193772875, 4862.538058884418, 4863.27050942358, 4878.048780487807, 4897.951020489785, 4849.078675051746, 4880.951190488103, 4884.389451318603, 4894.559489645949, 4955.157623204064, 4763.237881938873, 4771.188897887368, 4787.712737235742, 4789.114013907439, 4802.4237091548885, 19890.50273743168, 20230.0, 20881.164753409845, 20948.895255523777, 20968.47578810527, 2036.684313931343, 2047.938561843147, 2054.096197673019, 2289.496310811619, 2423.3093568333115, 5379.300690910196, 5762.250907382014, 9399.436033837992, 10607.681769546925, 13441.798373024412, 1771.681097402467, 1838.1911958738247, 1852.231324000538, 1926.8747531410413, 2047.406252186864, 69037.0, 69482.30517694859, 69973.65013174902, 71835.26824146434, 72000.27999719988, 10279.229057820543, 10283.0, 10298.485075746332, 10337.534810933375, 10459.424731639681, 14228.502002429865, 14390.712185756227, 14415.279236038155, 14421.495247666282, 14428.567142985517, 7210.412960015053, 7218.530795498275, 7232.783016509513, 7278.1266248049515, 7332.0834895638045, 7097.0, 7136.928630713626, 7255.45584081196, 7266.45501587383, 7285.963570182115, 4434.490033646108, 4477.798499067485, 4509.12072145935, 4536.228841097021, 4561.589456948891, 1856.7400563921062, 1874.7187921811565, 1887.0941947865101, 1891.6027634196973, 1906.752122224102, 902.3953950852945, 929.7257309093834, 937.9822892162081, 975.5463709375175, 984.3011461862015, 16062.919685401499, 16435.83564164343, 16443.342266309453, 16968.23642936071, 17416.738748918775, 858.2361698088706, 901.553730903194, 924.542351535994, 933.2021121940778, 990.3513198854762, 8784.78038049054, 9519.476428796483, 9631.133198012212, 9724.513774311255, 9832.803343933081, 406271.0, 410273.0, 429873.0, 430257.0, 433028.0, 77700.0, 79348.20651793524, 80543.0, 81272.59363703143, 82673.0, 903.814717982812, 922.4557511068367, 938.3016739701163, 947.5735918836551, 955.5365647661018, 15019.549413517612, 15079.698406032037, 15279.465218717292, 15280.0, 15284.617884552976, 34564.30871382508, 34931.30137397187, 35234.8238258807, 35724.821375892956, 35780.64219357773, 44662.0, 45316.54683453255, 48246.517534824205, 48387.75806120947, 48734.26898596595, 6839.760608378683, 7246.492745507764, 7968.163342848918, 7994.2405471480115, 8044.3162331200165, 7419.554826710415, 10688.358698478116, 11317.320960742381, 12042.879571204176, 12155.939220303842, 10075.244356673133, 10516.737081573021, 10687.0, 10694.19793515505, 10753.408562529135, 5152.355955505562, 9620.037996200605, 9838.9016109838, 10787.838182427113, 10878.292910960763, 10824.891751082389, 10858.67423977282, 11023.228374013743, 11180.552777888794, 11239.887601123884, 7362.116546014298, 7439.070116235471, 7465.552066876005, 7566.167721550515, 7596.202398748052, 10139.797204056025, 10771.515281812493, 10851.728706782395, 10888.346699198073, 11051.502682379152], "value": 8189.809105236336, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1203.7411956429366, 1413.9363728632206, 1454.0185374871962, 1580.49424184261, 1775.4851093182976, 6266.9686651566735, 6855.485838562109, 7067.646617669109, 7096.82257943551, 7253.492255542114, 7028.789136325919, 7191.7842464726145, 7192.712291508346, 7194.7122115115335, 7200.423966082714, 2145.8927053647294, 2156.0944403350554, 2167.2631305356176, 2189.1462329691435, 2191.057845126595, 2086.926957556486, 2108.335874199622, 2130.1585873579925, 2130.5419334843004, 2133.871967681944, 2093.026742564707, 2095.413284280404, 2104.389726979182, 2109.2512158183854, 2120.978790212101, 2065.328768150357, 2079.9376018719463, 2082.937511874646, 2083.8228750556145, 2086.540960988588, 2038.714579958807, 2084.6351888419617, 2086.685388205421, 2087.3424871165535, 2088.0395018291606, 6979.965100174518, 7071.575705457638, 7115.608641524714, 7118.822029449253, 7198.7840364789145, 4194.790260486994, 4330.02574420756, 4343.522212556616, 4350.108227813291, 4360.324149756792, 2821.2241633550734, 2901.2166714987047, 2915.285754990041, 2961.526155815059, 2995.4009198160456, 967.6032826541084, 980.5489474841581, 987.5555999800118, 999.221385933033, 1002.3134153105074, 9104.271658267322, 9298.581563829577, 9349.485778282191, 9416.152546270869, 9536.141747242782, 4007.2586571484367, 4064.837406503707, 4115.691323150776, 4190.790460476964, 4196.118815048813, 8217.876731849026, 8222.588870556448, 8266.958665206635, 8276.503409795432, 8322.20939010793, 4477.485089214782, 4589.931151032737, 4593.379893714373, 4595.563421475022, 4601.309803529497, 3503.211777350127, 3984.561698213194, 4127.050778321003, 4144.316187829035, 4150.709450338508, 3484.756067075331, 3555.484454754046, 3623.836927338276, 3634.60019397866, 3663.249033948034, 1139.6979800352913, 1152.982705259422, 1159.4492616007328, 1186.0630102219322, 1191.1185722565413, 744.8063503489024, 826.7726375246855, 887.9023307436177, 904.5522466379184, 914.5290175559592, 5016.473270306638, 5058.291839142523, 5129.640925135204, 5145.408278047998, 5212.3223980883, 854.3976496569903, 897.4166791585391, 899.0, 906.5603182456504, 962.5331714118647, 3535.540379750616, 3553.9466907996402, 3741.382671859167, 3742.5883152853166, 3766.152615661509, 8488.872666910001, 8739.213470787532, 8834.469931804113, 8927.821443571092, 8934.195922366887, 8840.690575829814, 8851.46891186531, 8856.335774816915, 8862.0, 8864.20222180007, 6528.738850445929, 6788.694508747119, 7010.228874823765, 7016.824579385454, 7024.964875175591, 5200.011997720572, 5219.0, 5278.208268759717, 5362.410134885237, 5411.918821217763, 7856.528608283521, 8036.758897233092, 8239.95880020596, 8300.792480188044, 8332.50004999702, 8177.550234737147, 8340.332773377993, 8405.243528082501, 8429.704960326359, 8491.575421229038, 5634.267545219259, 6236.095766113979, 6270.7805226816845, 6401.29585745577, 6446.677666116581, 6977.33715297046, 7009.492959013836, 7042.471814614027, 7060.505764596429, 7075.82310442243, 6278.937210627835, 6434.099226108255, 6434.517411194086, 6493.8701225976165, 6549.148610680581, 6198.194234749454, 6289.150964619901, 6374.29882712892, 6433.324500927522, 6526.608403495806, 6087.634741915499, 6148.907766383597, 6166.568340216142, 6171.475424588781, 6179.752809887555, 4466.57567531084, 4584.633229341712, 4639.605633521189, 4648.511906249931, 4656.301554766812, 4389.582989615981, 4474.3959565459545, 4494.932576011428, 4510.909781804411, 4541.341505481752], "value": 3986.375811050487, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.2420509239632, 313.6142544670055, 317.9809211447313, 318.39504940612846, 323.2597352063774, 4852.441969173546, 4858.708477491344, 4876.366072410586, 4878.731669758162, 4880.804767809293, 4740.885891815421, 4743.4545027321865, 4772.3795906532105, 4778.928316075262, 4809.687370320936, 3596.9100772480765, 3696.9463702844696, 3728.5898551159353, 3801.448789925459, 3835.865744698936, 3753.3994560870265, 3774.67915227206, 3804.9239015219678, 3808.7714737115725, 3817.7973938209516, 3604.1530240393486, 3778.565464971522, 3784.6593806557403, 3789.924201515968, 3813.6949044076546, 3577.8568857245677, 3715.516982792233, 3721.106934335767, 3731.7014638828828, 3786.4320351947154, 3370.1237678203843, 3379.594448666151, 3384.627690953993, 3388.491726241059, 3404.931901361984, 4557.612602928755, 4577.9542204577865, 4581.152486789922, 4587.256842399866, 4590.288505281654, 4221.514525829508, 4243.92869960524, 4287.63555097814, 4310.275889644167, 4320.6327462165755, 4901.828436004758, 4944.975275123637, 4967.50324967504, 4968.90062198754, 4970.353853998993, 3703.4629978653215, 3716.925661486755, 3733.2720119576693, 3736.1406876418305, 3743.9142648631864, 4977.278294647292, 5199.818006369796, 5214.73159175756, 5222.608304377149, 5222.764975576109, 3756.417755247941, 3780.3006443807985, 3781.7331194050303, 3796.734228603971, 3800.657940785343, 3822.9235415291537, 3825.2731980923536, 3831.59768224338, 3854.419687927992, 3861.826217820205, 4272.380504826782, 4307.698461107755, 4319.373690814814, 4320.546342634041, 4329.956700433018, 4757.976210118927, 5008.670967999898, 5019.247112933089, 5027.220780778912, 5073.518015788494, 1246.3145270101588, 1246.9961680847005, 1247.5571172233908, 1248.2649117726367, 1259.5150866916304, 839.0518713853306, 871.2855458524076, 875.3566128895256, 879.9560021999002, 886.2821114896955, 4200.600942910419, 4297.763623000703, 4305.440292761984, 4337.587929146726, 4372.606465418127, 4931.3589233399425, 5180.818671346485, 5188.688678679291, 5223.059849227176, 5226.294450249244, 4424.690271680952, 4436.511983681792, 4439.801253661493, 4440.911181776346, 4460.933086003713, 2617.4164630398714, 2667.8799454024615, 2693.393986353055, 2693.8012584399753, 2705.7970652201166, 4752.691075080109, 4776.808927642855, 4818.277258411266, 4834.492378300298, 4834.613230941516, 5123.820666276662, 5130.51260130287, 5152.639315247897, 5156.20078887773, 5222.4255331913455, 4616.446026476844, 4912.852614421573, 4929.162042452864, 4939.827106051271, 4956.4547899731, 5171.63798534099, 5176.301199338041, 5178.119719647744, 5222.164453687392, 5235.450277720937, 4912.435069966999, 5131.897362052813, 5147.9227811583605, 5156.278121062979, 5169.638125331191, 4849.0, 4894.975525122351, 4920.40955085392, 4930.285108659153, 4961.652684312064, 3658.48781170631, 3696.3900956342977, 3712.5173727415263, 3712.9814350928073, 3715.9442608361437, 5231.372235331784, 5242.97378513105, 5245.423003469692, 5250.97374513125, 5252.89494210106, 4803.903921921612, 5032.370953630796, 5052.368453943257, 5069.695818250917, 5129.563987061141, 5003.674761140514, 5046.873828154326, 5055.090083784954, 5055.823046193365, 5061.569766569735, 4850.962595709881, 4935.544014515798, 4963.362090510051, 4985.177445721415, 4989.351384320015, 4845.927311090407, 4950.331705219749, 5067.618219436858, 5092.465291144376, 5097.337346144977, 4912.238603016538, 4931.309616653743, 4955.975220123876, 4965.45380008206, 4989.376327959005], "value": 3804.0090635623674, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.491561160353, 789.3132974312349, 799.7680672604943, 810.3881569415095, 818.8730746734251, 11014.559417623286, 11658.125640576949, 11669.824952625706, 11672.299662020274, 11678.883211167886, 11161.553537858475, 11257.211995160342, 11277.266977646468, 11313.547458101666, 11945.522179112824, 868.6916144768611, 880.3705350674298, 886.6896586194813, 886.6896586194845, 887.6360692116234, 868.3964644572025, 871.2942516561574, 872.3021582733819, 872.4765140915464, 872.5288344294073, 906.2885634776702, 915.7207051849183, 916.1022198245723, 916.445550441983, 916.7845556294266, 900.743288162877, 903.9909600903973, 905.9818803623923, 905.9818803623923, 906.0848542971613, 665.278173182098, 665.7769647168204, 666.0808084842935, 666.2704338749062, 666.2837449741547, 10801.40592267425, 10852.891471085268, 10885.891141088567, 10902.890971090346, 10919.454027298603, 10434.113100386476, 10592.41741704206, 10630.09644180238, 10795.5681772729, 10935.726606834813, 9311.487868167249, 9316.394434361744, 9326.860097098548, 9479.28905332096, 9524.333296669236, 3147.1817327494787, 3159.3207460396125, 3168.889088881901, 3195.1692559934354, 3333.4166520858994, 43006.0, 43073.56926430727, 43153.35269970953, 43223.567764322266, 43252.13495730068, 8138.959305203436, 8211.302039326605, 8326.958365208135, 8412.537310447862, 8470.195331443503, 15788.0, 15832.28754706041, 15858.127802970717, 15862.44481443144, 15871.841281587267, 6313.715882785285, 6542.214934207926, 6575.967120164369, 6586.604803711793, 6747.257801641816, 3331.9833400833327, 3398.218409765718, 3514.4728290756593, 3529.258855640293, 3622.7645203061716, 2793.622860913791, 2881.063654312357, 2894.1172942252815, 2894.768418526513, 2896.898608548691, 568.6247076929207, 592.1295695327861, 592.4638202426811, 603.2007589943343, 604.066716922356, 511.93600799900014, 526.2165033409772, 584.1354794903566, 634.2547506679633, 641.1024565608093, 7724.7682569523, 7845.333146682482, 7880.960595197102, 7881.0, 7987.3610111190965, 597.6503745308956, 599.5293694449836, 605.893968555501, 620.1534904854841, 620.8416853702277, 3759.323321802102, 3760.6239376062176, 3812.790296533717, 3829.6744776694295, 3852.1910398816563, 45066.32400513995, 45901.31148032782, 46598.5340146601, 52498.47501525012, 53876.73061634745, 34407.31185376278, 44323.77838110853, 46509.06981860411, 46964.0, 47078.29382559264, 42712.78643606762, 43264.56735432606, 43495.78252108719, 43559.78220108879, 44078.0, 7517.398608111229, 7538.170801211752, 7714.074311082706, 7716.961415192888, 7835.988613094759, 29101.85449072826, 29536.852315738284, 30054.549181761853, 30655.846720767146, 30737.231569210053, 36573.45139822851, 38012.80993595014, 38108.61891381162, 38230.808845955595, 40286.597134028285, 10623.521941512805, 10668.413237272025, 10794.784104318027, 10857.67426977192, 10953.45232738344, 11650.41747912618, 11862.881371186179, 11902.40487975615, 12383.62849114528, 12423.875761242272, 11066.833997490205, 11103.222774406036, 11183.049440797624, 11789.351585662527, 11805.0, 10966.670999870017, 11500.309981401142, 11512.884871151517, 11535.287039707402, 11719.238249513754, 10128.303169343284, 10428.634997775041, 10732.892671073188, 10882.29265097766, 11228.550857965916, 8439.620217090369, 8591.097934716765, 8730.91269087301, 8805.735827925173, 8939.150780675825, 8964.955175224082, 9034.322425817958, 9356.204722598655, 9367.250619950524, 9407.952960235156], "value": 5853.300919402799, "unit": "score"}], "name": "dromaeo_css", "value": 6189.631932489181, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 117.0, 115.0, 117.0, 114.0, 114.0, 115.0, 116.0, 115.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 129.0, 162.0, 216.0, 130.0, 167.0, 155.0, 131.0, 193.0, 132.0], "value": 157.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 161.0, 161.0, 163.0, 161.0, 161.0, 161.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 151.0, 76.0, 76.0, 78.0, 75.0, 129.0, 79.0], "value": 89.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 162.0, 93.0, 93.0, 96.0, 125.0, 92.0, 91.0, 124.0], "value": 106.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 145.0, 145.0, 147.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 65.0, 65.0, 65.0, 74.0, 119.0, 63.0, 63.0], "value": 70.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 89.0, 81.0, 84.0, 82.0, 81.0, 81.0, 82.0, 88.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 132.0, 142.0, 129.0, 133.0, 140.0, 129.0, 135.0, 272.0, 133.0], "value": 148.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 173.0, 173.0, 173.0, 172.0, 170.0, 171.0, 171.0, 173.0, 170.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 72.0, 68.0, 69.0, 70.0, 70.0, 68.0, 68.0, 67.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1593.1000000000001, "alertThreshold": 2.0}]} 04:54:33 INFO - Return code: 0 04:54:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:54:33 ERROR - # TBPL SUCCESS # 04:54:33 INFO - Running post-action listener: _resource_record_post_action 04:54:33 INFO - ##### 04:54:33 INFO - ##### Finished run-tests step (success) 04:54:33 INFO - ##### 04:54:33 INFO - Running post-run listener: _resource_record_post_run 04:54:35 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 534499328; Read time: 0; Write time: 479680 04:54:35 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234995712; Read time: 0; Write time: 285592 04:54:35 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 295620608; Read time: 0; Write time: 193564 04:54:35 INFO - Running post-run listener: _upload_blobber_files 04:54:35 INFO - Blob upload gear active. 04:54:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:54:35 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 04:54:35 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'] 04:54:35 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 04:54:35 INFO - (blobuploader) - INFO - Open directory for files ... 04:54:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:54:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:54:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:36 INFO - (blobuploader) - INFO - Done attempting. 04:54:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:54:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:54:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:36 INFO - (blobuploader) - INFO - Done attempting. 04:54:36 INFO - (blobuploader) - INFO - Iteration through files over. 04:54:37 INFO - Return code: 0 04:54:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:54:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:54:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d2582a40117f0ef96ae46b672dacdb6c861fc9ccb2c2a6f7e59b8df5d4a8179724912330499ee3232b7373ba6150365400d5754c4ea6611df3f1c76b5f2e145f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/10e1e1b7736adfc4b67673685fdcddc420aa5339e1a731bd3aae7f5ecf3b42629c1ca15c5d4dfbcd456ab04b57ad68075deb81dee1573390bfa03df2dca29c36"} 04:54:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:54:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:54:37 INFO - Contents: 04:54:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d2582a40117f0ef96ae46b672dacdb6c861fc9ccb2c2a6f7e59b8df5d4a8179724912330499ee3232b7373ba6150365400d5754c4ea6611df3f1c76b5f2e145f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/10e1e1b7736adfc4b67673685fdcddc420aa5339e1a731bd3aae7f5ecf3b42629c1ca15c5d4dfbcd456ab04b57ad68075deb81dee1573390bfa03df2dca29c36"} 04:54:37 INFO - Running post-run listener: copy_logs_to_upload_dir 04:54:37 INFO - Copying logs to upload dir... 04:54:37 INFO - mkdir: /builds/slave/test/build/upload/logs 04:54:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.432774 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-09 04:54:36.639988) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 04:54:36.643148) ========= 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=82e07478c745e68b1fe4678a000001bc-1462793631.798382-677419622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d2582a40117f0ef96ae46b672dacdb6c861fc9ccb2c2a6f7e59b8df5d4a8179724912330499ee3232b7373ba6150365400d5754c4ea6611df3f1c76b5f2e145f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/10e1e1b7736adfc4b67673685fdcddc420aa5339e1a731bd3aae7f5ecf3b42629c1ca15c5d4dfbcd456ab04b57ad68075deb81dee1573390bfa03df2dca29c36"} build_url:https://queue.taskcluster.net/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011461 build_url: 'https://queue.taskcluster.net/v1/task/Qo3ozMX8QbSKkdgJ6YbjSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d2582a40117f0ef96ae46b672dacdb6c861fc9ccb2c2a6f7e59b8df5d4a8179724912330499ee3232b7373ba6150365400d5754c4ea6611df3f1c76b5f2e145f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/10e1e1b7736adfc4b67673685fdcddc420aa5339e1a731bd3aae7f5ecf3b42629c1ca15c5d4dfbcd456ab04b57ad68075deb81dee1573390bfa03df2dca29c36"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 04:54:36.667926) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:54:36.668249) ========= 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=82e07478c745e68b1fe4678a000001bc-1462793631.798382-677419622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:54:36.752570) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 04:54:36.752895) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 04:54:36.753205) ========= ========= Total master_lag: 0.16 =========