builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-020 starttime: 1462925712.49 results: success (0) buildid: 20160510162116 builduid: c3404a01b02e4442a7ff3c7e95d92257 revision: d8df7fcffeb14796b272feb5cb24b1c15dcf67cb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 17:15:12.491378) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 17:15:12.491844) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 17:15:12.492119) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 17:15:12.505930) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 17:15:12.506253) ========= 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=af724c981e2a0f424dbabf99000001e7-1462925712.532339-811817722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 17:15:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 60.1M=0s 2016-05-10 17:15:13 (60.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084430 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 17:15:12.600652) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 17:15:12.600998) ========= 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=af724c981e2a0f424dbabf99000001e7-1462925712.532339-811817722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013687 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 17:15:12.650698) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 17:15:12.651072) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d8df7fcffeb14796b272feb5cb24b1c15dcf67cb --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 d8df7fcffeb14796b272feb5cb24b1c15dcf67cb --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=af724c981e2a0f424dbabf99000001e7-1462925712.532339-811817722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 17:15:13,359 truncating revision to first 12 chars 2016-05-10 17:15:13,359 Setting DEBUG logging. 2016-05-10 17:15:13,359 attempt 1/10 2016-05-10 17:15:13,360 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d8df7fcffeb1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 17:15:13,635 unpacking tar archive at: fx-team-d8df7fcffeb1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.569918 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 17:15:13.233600) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 17:15:13.233930) ========= script_repo_revision: d8df7fcffeb14796b272feb5cb24b1c15dcf67cb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 17:15:13.234323) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 17:15:13.234599) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 17:15:13.243608) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-10 17:15:13.243886) ========= /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=af724c981e2a0f424dbabf99000001e7-1462925712.532339-811817722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:15:14 INFO - MultiFileLogger online at 20160510 17:15:14 in /builds/slave/test 17:15:14 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 17:15:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:15:14 INFO - {'append_to_log': False, 17:15:14 INFO - 'base_work_dir': '/builds/slave/test', 17:15:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:15:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:15:14 INFO - 'branch': 'Fx-Team-Non-PGO', 17:15:14 INFO - 'buildbot_json_path': 'buildprops.json', 17:15:14 INFO - 'config_files': ('talos/linux_config.py',), 17:15:14 INFO - 'default_actions': ('clobber', 17:15:14 INFO - 'read-buildbot-config', 17:15:14 INFO - 'download-and-extract', 17:15:14 INFO - 'populate-webroot', 17:15:14 INFO - 'create-virtualenv', 17:15:14 INFO - 'install', 17:15:14 INFO - 'run-tests'), 17:15:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:15:14 INFO - 'download_minidump_stackwalk': True, 17:15:14 INFO - 'download_symbols': 'ondemand', 17:15:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:15:14 INFO - 'tooltool.py': '/tools/tooltool.py', 17:15:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:15:14 INFO - '/tools/misc-python/virtualenv.py')}, 17:15:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:15:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:15:14 INFO - 'installer_path': 'installer.exe', 17:15:14 INFO - 'log_level': 'info', 17:15:14 INFO - 'log_name': 'talos', 17:15:14 INFO - 'log_to_console': True, 17:15:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:15:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:15:14 INFO - 'opt_config_files': (), 17:15:14 INFO - 'pip_index': False, 17:15:14 INFO - 'sps_profile': False, 17:15:14 INFO - 'sps_profile_interval': 0, 17:15:14 INFO - 'suite': 'dromaeojs', 17:15:14 INFO - 'system_bits': '32', 17:15:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:15:14 INFO - 'title': 'talos-linux64-ix-020', 17:15:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:15:14 INFO - 'use_talos_json': True, 17:15:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:15:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:15:14 INFO - 'work_dir': 'build'} 17:15:14 INFO - ##### 17:15:14 INFO - ##### Running clobber step. 17:15:14 INFO - ##### 17:15:14 INFO - Running pre-action listener: _resource_record_pre_action 17:15:14 INFO - Running main action method: clobber 17:15:14 INFO - rmtree: /builds/slave/test/build 17:15:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:15:15 INFO - Running post-action listener: _resource_record_post_action 17:15:15 INFO - ##### 17:15:15 INFO - ##### Finished clobber step (success) 17:15:15 INFO - ##### 17:15:15 INFO - ##### 17:15:15 INFO - ##### Running read-buildbot-config step. 17:15:15 INFO - ##### 17:15:15 INFO - Running pre-action listener: _resource_record_pre_action 17:15:15 INFO - Running main action method: read_buildbot_config 17:15:15 INFO - Using buildbot properties: 17:15:15 INFO - { 17:15:15 INFO - "project": "", 17:15:15 INFO - "product": "firefox", 17:15:15 INFO - "script_repo_revision": "production", 17:15:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:15:15 INFO - "repository": "", 17:15:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 17:15:15 INFO - "buildid": "20160510162116", 17:15:15 INFO - "pgo_build": "False", 17:15:15 INFO - "basedir": "/builds/slave/test", 17:15:15 INFO - "buildnumber": 2955, 17:15:15 INFO - "slavename": "talos-linux64-ix-020", 17:15:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:15:15 INFO - "platform": "ubuntu64_hw", 17:15:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:15:15 INFO - "branch": "fx-team", 17:15:15 INFO - "repo_path": "integration/fx-team", 17:15:15 INFO - "revision": "d8df7fcffeb14796b272feb5cb24b1c15dcf67cb", 17:15:15 INFO - "stage_platform": "linux64", 17:15:15 INFO - "builduid": "c3404a01b02e4442a7ff3c7e95d92257", 17:15:15 INFO - "slavebuilddir": "test" 17:15:15 INFO - } 17:15:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:15:15 INFO - Running post-action listener: _resource_record_post_action 17:15:15 INFO - ##### 17:15:15 INFO - ##### Finished read-buildbot-config step (success) 17:15:15 INFO - ##### 17:15:15 INFO - ##### 17:15:15 INFO - ##### Running download-and-extract step. 17:15:15 INFO - ##### 17:15:15 INFO - Running pre-action listener: _resource_record_pre_action 17:15:15 INFO - Running main action method: download_and_extract 17:15:15 INFO - mkdir: /builds/slave/test/build/tests 17:15:15 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')]} 17:15:15 INFO - https://queue.taskcluster.net/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:15:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:15:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:15:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/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 17:15:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/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 17:15:15 INFO - Downloaded 1361 bytes. 17:15:15 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:15:15 INFO - Using the following test package requirements: 17:15:15 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:15:15 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:15:15 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:15:15 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:15 INFO - u'jsshell-linux-x86_64.zip'], 17:15:15 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:15:15 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:15:15 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:15:15 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:15:15 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:15:15 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:15:15 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:15:15 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')]} 17:15:15 INFO - https://queue.taskcluster.net/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:15:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:15:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:15:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/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 17:15:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/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 17:15:16 INFO - Downloaded 22329023 bytes. 17:15:16 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'] 17:15:16 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 17:15:18 INFO - Return code: 0 17:15:18 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 17:15:18 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')]} 17:15:18 INFO - https://queue.taskcluster.net/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:15:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:15:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:15:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/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 17:15:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/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 17:15:19 INFO - Downloaded 22329023 bytes. 17:15:19 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'] 17:15:19 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 17:15:20 INFO - Return code: 0 17:15: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')]} 17:15:20 INFO - https://queue.taskcluster.net/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:15:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:15:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:15:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/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 17:15:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/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 17:15:21 INFO - Downloaded 10840152 bytes. 17:15:21 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'] 17:15:21 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 17:15:21 INFO - Return code: 0 17:15:21 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')]} 17:15:21 INFO - https://queue.taskcluster.net/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:15:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:15:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:15:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/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 17:15:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/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 17:15:23 INFO - Downloaded 54681779 bytes. 17:15:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:15:23 INFO - mkdir: /builds/slave/test/properties 17:15:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:15:23 INFO - Writing to file /builds/slave/test/properties/build_url 17:15:23 INFO - Contents: 17:15:23 INFO - build_url:https://queue.taskcluster.net/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:15:23 INFO - Running post-action listener: _resource_record_post_action 17:15:23 INFO - Running post-action listener: set_extra_try_arguments 17:15:23 INFO - ##### 17:15:23 INFO - ##### Finished download-and-extract step (success) 17:15:23 INFO - ##### 17:15:23 INFO - ##### 17:15:23 INFO - ##### Running populate-webroot step. 17:15:23 INFO - ##### 17:15:23 INFO - Running pre-action listener: _resource_record_pre_action 17:15:23 INFO - Running main action method: populate_webroot 17:15:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:15:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:15:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:15:23 INFO - '--tppagecycles', 17:15:23 INFO - '7'], 17:15:23 INFO - 'tests': ['tsvgm']}}, 17:15:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:15:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:15:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:15:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:15:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:15:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:15:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:23 INFO - 'talos_options': ['--disable-e10s'], 17:15:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:23 INFO - 'talos_options': ['--disable-e10s'], 17:15:23 INFO - 'tests': ['damp', 'tps']}, 17:15:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:23 INFO - 'tests': ['damp', 'tps']}, 17:15:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:15:23 INFO - 'tests': ['dromaeo_dom']}, 17:15:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:15:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:15:23 INFO - 'tests': ['a11yr', 17:15:23 INFO - 'ts_paint', 17:15:23 INFO - 'tpaint', 17:15:23 INFO - 'sessionrestore', 17:15:23 INFO - 'sessionrestore_no_auto_restore', 17:15:23 INFO - 'tabpaint']}, 17:15:23 INFO - 'other-e10s': {'tests': ['a11yr', 17:15:23 INFO - 'ts_paint', 17:15:23 INFO - 'tpaint', 17:15:23 INFO - 'sessionrestore', 17:15:23 INFO - 'sessionrestore_no_auto_restore', 17:15:23 INFO - 'tabpaint']}, 17:15:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:15:24 INFO - 'ts_paint', 17:15:24 INFO - 'tpaint', 17:15:24 INFO - 'sessionrestore', 17:15:24 INFO - 'sessionrestore_no_auto_restore', 17:15:24 INFO - 'tabpaint']}, 17:15:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:15:24 INFO - 'ts_paint', 17:15:24 INFO - 'tpaint', 17:15:24 INFO - 'sessionrestore', 17:15:24 INFO - 'sessionrestore_no_auto_restore', 17:15:24 INFO - 'tabpaint']}, 17:15:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:15:24 INFO - 'tests': ['a11yr', 17:15:24 INFO - 'ts_paint', 17:15:24 INFO - 'tpaint', 17:15:24 INFO - 'sessionrestore', 17:15:24 INFO - 'sessionrestore_no_auto_restore', 17:15:24 INFO - 'tabpaint']}, 17:15:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:15:24 INFO - 'tests': ['a11yr', 17:15:24 INFO - 'ts_paint', 17:15:24 INFO - 'tpaint', 17:15:24 INFO - 'sessionrestore', 17:15:24 INFO - 'sessionrestore_no_auto_restore', 17:15:24 INFO - 'tabpaint']}, 17:15:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:15:24 INFO - 'tests': ['tsvgx', 17:15:24 INFO - 'tsvgr_opacity', 17:15:24 INFO - 'tart', 17:15:24 INFO - 'tscrollx', 17:15:24 INFO - 'cart']}, 17:15:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:15:24 INFO - 'tsvgr_opacity', 17:15:24 INFO - 'tart', 17:15:24 INFO - 'tscrollx', 17:15:24 INFO - 'cart']}, 17:15:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:24 INFO - 'talos_options': ['--disable-e10s'], 17:15:24 INFO - 'tests': ['tp5o']}, 17:15:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:24 INFO - 'tests': ['tp5o']}, 17:15:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:24 INFO - 'talos_options': ['--disable-e10s', 17:15:24 INFO - '--xperf_path', 17:15:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:24 INFO - 'tests': ['tp5n']}, 17:15:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:24 INFO - 'talos_options': ['--xperf_path', 17:15:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:24 INFO - 'tests': ['tp5n']}}, 17:15:24 INFO - 'talos.zip': {'path': '', 17:15:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:15:24 INFO - Running post-action listener: _resource_record_post_action 17:15:24 INFO - ##### 17:15:24 INFO - ##### Finished populate-webroot step (success) 17:15:24 INFO - ##### 17:15:24 INFO - ##### 17:15:24 INFO - ##### Running create-virtualenv step. 17:15:24 INFO - ##### 17:15:24 INFO - Running pre-action listener: _resource_record_pre_action 17:15:24 INFO - Running main action method: create_virtualenv 17:15:24 INFO - Creating virtualenv /builds/slave/test/build/venv 17:15:24 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 17:15:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:15:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:15:24 INFO - Using real prefix '/usr' 17:15:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:15:24 INFO - Installing distribute.............................................................................................................................................................................................done. 17:15:26 INFO - Installing pip.................done. 17:15:26 INFO - Return code: 0 17:15:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:26 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 0x7f26cec7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250c9c0>, '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 0x250d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250dd50>, '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': 'af724c981e2a0f424dbabf99000001e7-1462925712.532339-811817722', '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 17:15:26 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 17:15:26 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 17:15:26 INFO - Using env: {'DISPLAY': ':0', 17:15:26 INFO - 'HOME': '/home/cltbld', 17:15:26 INFO - 'LANG': 'en_US.UTF-8', 17:15:26 INFO - 'LANGUAGE': 'en_US:en', 17:15:26 INFO - 'LOGNAME': 'cltbld', 17:15:26 INFO - 'MAIL': '/var/mail/cltbld', 17:15:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:26 INFO - 'MOZ_NO_REMOTE': '1', 17:15:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:26 INFO - 'NO_EM_RESTART': '1', 17:15:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:26 INFO - 'PWD': '/builds/slave/test', 17:15:26 INFO - 'SHELL': '/bin/bash', 17:15:26 INFO - 'SHLVL': '1', 17:15:26 INFO - 'TERM': 'linux', 17:15:26 INFO - 'TMOUT': '86400', 17:15:26 INFO - 'USER': 'cltbld', 17:15:26 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462925712.532339-811817722', 17:15:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:26 INFO - '_': '/tools/buildbot/bin/python'} 17:15:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:26 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 17:15:26 INFO - Cleaning up... 17:15:26 INFO - Return code: 0 17:15:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:26 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 0x7f26cec7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250c9c0>, '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 0x250d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250dd50>, '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': 'af724c981e2a0f424dbabf99000001e7-1462925712.532339-811817722', '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 17:15:26 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 17:15:26 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 17:15:26 INFO - Using env: {'DISPLAY': ':0', 17:15:26 INFO - 'HOME': '/home/cltbld', 17:15:26 INFO - 'LANG': 'en_US.UTF-8', 17:15:26 INFO - 'LANGUAGE': 'en_US:en', 17:15:26 INFO - 'LOGNAME': 'cltbld', 17:15:26 INFO - 'MAIL': '/var/mail/cltbld', 17:15:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:26 INFO - 'MOZ_NO_REMOTE': '1', 17:15:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:26 INFO - 'NO_EM_RESTART': '1', 17:15:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:26 INFO - 'PWD': '/builds/slave/test', 17:15:26 INFO - 'SHELL': '/bin/bash', 17:15:26 INFO - 'SHLVL': '1', 17:15:26 INFO - 'TERM': 'linux', 17:15:26 INFO - 'TMOUT': '86400', 17:15:26 INFO - 'USER': 'cltbld', 17:15:26 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462925712.532339-811817722', 17:15:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:26 INFO - '_': '/tools/buildbot/bin/python'} 17:15:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:27 INFO - Downloading/unpacking psutil>=0.7.1 17:15: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 17:15: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 17:15: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 17:15: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 17:15: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 17:15: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 17:15:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:15:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:15:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:15:29 INFO - Installing collected packages: psutil 17:15:29 INFO - Running setup.py install for psutil 17:15:29 INFO - building 'psutil._psutil_linux' extension 17:15:29 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 17:15:29 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 17:15:29 INFO - building 'psutil._psutil_posix' extension 17:15:29 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 17:15:29 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 17:15:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:15:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:15:29 INFO - Successfully installed psutil 17:15:29 INFO - Cleaning up... 17:15:29 INFO - Return code: 0 17:15:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:29 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 0x7f26cec7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250c9c0>, '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 0x250d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250dd50>, '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': 'af724c981e2a0f424dbabf99000001e7-1462925712.532339-811817722', '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 17:15:29 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 17:15:29 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 17:15:29 INFO - Using env: {'DISPLAY': ':0', 17:15:29 INFO - 'HOME': '/home/cltbld', 17:15:29 INFO - 'LANG': 'en_US.UTF-8', 17:15:29 INFO - 'LANGUAGE': 'en_US:en', 17:15:29 INFO - 'LOGNAME': 'cltbld', 17:15:29 INFO - 'MAIL': '/var/mail/cltbld', 17:15:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:29 INFO - 'MOZ_NO_REMOTE': '1', 17:15:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:29 INFO - 'NO_EM_RESTART': '1', 17:15:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:29 INFO - 'PWD': '/builds/slave/test', 17:15:29 INFO - 'SHELL': '/bin/bash', 17:15:29 INFO - 'SHLVL': '1', 17:15:29 INFO - 'TERM': 'linux', 17:15:29 INFO - 'TMOUT': '86400', 17:15:29 INFO - 'USER': 'cltbld', 17:15:29 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462925712.532339-811817722', 17:15:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:29 INFO - '_': '/tools/buildbot/bin/python'} 17:15:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:15: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 17:15: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 17:15: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 17:15: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 17:15: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 17:15: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 17:15:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:15:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:15:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:15:31 INFO - Installing collected packages: mozsystemmonitor 17:15:31 INFO - Running setup.py install for mozsystemmonitor 17:15:31 INFO - Successfully installed mozsystemmonitor 17:15:31 INFO - Cleaning up... 17:15:31 INFO - Return code: 0 17:15:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:15:31 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')]} 17:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:31 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')]} 17:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:31 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 0x7f26cec7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250c9c0>, '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 0x250d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250dd50>, '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': 'af724c981e2a0f424dbabf99000001e7-1462925712.532339-811817722', '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 17:15:31 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 17:15:31 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 17:15:31 INFO - Using env: {'DISPLAY': ':0', 17:15:31 INFO - 'HOME': '/home/cltbld', 17:15:31 INFO - 'LANG': 'en_US.UTF-8', 17:15:31 INFO - 'LANGUAGE': 'en_US:en', 17:15:31 INFO - 'LOGNAME': 'cltbld', 17:15:31 INFO - 'MAIL': '/var/mail/cltbld', 17:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:31 INFO - 'MOZ_NO_REMOTE': '1', 17:15:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:31 INFO - 'NO_EM_RESTART': '1', 17:15:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:31 INFO - 'PWD': '/builds/slave/test', 17:15:31 INFO - 'SHELL': '/bin/bash', 17:15:31 INFO - 'SHLVL': '1', 17:15:31 INFO - 'TERM': 'linux', 17:15:31 INFO - 'TMOUT': '86400', 17:15:31 INFO - 'USER': 'cltbld', 17:15:31 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462925712.532339-811817722', 17:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:31 INFO - '_': '/tools/buildbot/bin/python'} 17:15:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:32 INFO - Downloading/unpacking blobuploader==1.2.4 17:15: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 17:15: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 17:15: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 17:15: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 17:15: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 17:15: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 17:15:33 INFO - Downloading blobuploader-1.2.4.tar.gz 17:15:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:15:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:15:34 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 17:15:34 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 17:15:34 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 17:15:34 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 17:15:34 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 17:15:34 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 17:15:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:15:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:15:34 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 17:15:34 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 17:15:34 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 17:15:34 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 17:15:34 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 17:15:34 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 17:15:34 INFO - Downloading docopt-0.6.1.tar.gz 17:15:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:15:34 INFO - Installing collected packages: blobuploader, requests, docopt 17:15:34 INFO - Running setup.py install for blobuploader 17:15:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:15:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:15:34 INFO - Running setup.py install for requests 17:15:35 INFO - Running setup.py install for docopt 17:15:35 INFO - Successfully installed blobuploader requests docopt 17:15:35 INFO - Cleaning up... 17:15:35 INFO - Return code: 0 17:15:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15:35 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')]} 17:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:35 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')]} 17:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:35 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 0x7f26cec7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250c9c0>, '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 0x250d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250dd50>, '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': 'af724c981e2a0f424dbabf99000001e7-1462925712.532339-811817722', '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 17:15:35 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 17:15:35 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 17:15:35 INFO - Using env: {'DISPLAY': ':0', 17:15:35 INFO - 'HOME': '/home/cltbld', 17:15:35 INFO - 'LANG': 'en_US.UTF-8', 17:15:35 INFO - 'LANGUAGE': 'en_US:en', 17:15:35 INFO - 'LOGNAME': 'cltbld', 17:15:35 INFO - 'MAIL': '/var/mail/cltbld', 17:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:35 INFO - 'MOZ_NO_REMOTE': '1', 17:15:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:35 INFO - 'NO_EM_RESTART': '1', 17:15:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:35 INFO - 'PWD': '/builds/slave/test', 17:15:35 INFO - 'SHELL': '/bin/bash', 17:15:35 INFO - 'SHLVL': '1', 17:15:35 INFO - 'TERM': 'linux', 17:15:35 INFO - 'TMOUT': '86400', 17:15:35 INFO - 'USER': 'cltbld', 17:15:35 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462925712.532339-811817722', 17:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:35 INFO - '_': '/tools/buildbot/bin/python'} 17:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:15:35 INFO - Running setup.py (path:/tmp/pip-cOBr_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:15:35 INFO - Running setup.py (path:/tmp/pip-WgqPNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:15:35 INFO - Running setup.py (path:/tmp/pip-e4zvKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:15:35 INFO - Running setup.py (path:/tmp/pip-nU99cD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:15:35 INFO - Running setup.py (path:/tmp/pip-kNRD8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:15:35 INFO - Running setup.py (path:/tmp/pip-Tkt9EX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:15:35 INFO - Running setup.py (path:/tmp/pip-HVczUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:15:36 INFO - Running setup.py (path:/tmp/pip-4HuwN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:15:36 INFO - Running setup.py (path:/tmp/pip-QXXtBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:15:36 INFO - Running setup.py (path:/tmp/pip-KIr3ab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:15:36 INFO - Running setup.py (path:/tmp/pip-xebdOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:15:36 INFO - Running setup.py (path:/tmp/pip-nS_8Yj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:15:36 INFO - Running setup.py (path:/tmp/pip-Kb2Vpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:15:36 INFO - Running setup.py (path:/tmp/pip-B6cFk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:36 INFO - Running setup.py (path:/tmp/pip-QJF9Eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:15:36 INFO - Running setup.py (path:/tmp/pip-wOlsc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:15:36 INFO - Running setup.py (path:/tmp/pip-UQ8JV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:15:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:15:36 INFO - Running setup.py install for manifestparser 17:15:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:15:36 INFO - Running setup.py install for mozcrash 17:15:36 INFO - Running setup.py install for mozdebug 17:15:37 INFO - Running setup.py install for mozdevice 17:15:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:15:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:15:37 INFO - Running setup.py install for mozfile 17:15:37 INFO - Running setup.py install for mozhttpd 17:15:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:15:37 INFO - Running setup.py install for mozinfo 17:15:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:15:37 INFO - Running setup.py install for mozInstall 17:15:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:15:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:15:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:15:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:15:37 INFO - Running setup.py install for mozleak 17:15:37 INFO - Running setup.py install for mozlog 17:15:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:15:37 INFO - Running setup.py install for moznetwork 17:15:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:15:37 INFO - Running setup.py install for mozprocess 17:15:37 INFO - Running setup.py install for mozprofile 17:15:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:15:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:15:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:15:38 INFO - Running setup.py install for mozrunner 17:15:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:15:38 INFO - Running setup.py install for mozscreenshot 17:15:38 INFO - Running setup.py install for moztest 17:15:38 INFO - Running setup.py install for mozversion 17:15:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:15:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:15:38 INFO - Cleaning up... 17:15:38 INFO - Return code: 0 17:15:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15:38 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')]} 17:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:38 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')]} 17:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:38 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 0x7f26cec7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250c9c0>, '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 0x250d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250dd50>, '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': 'af724c981e2a0f424dbabf99000001e7-1462925712.532339-811817722', '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 17:15:38 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 17:15:38 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 17:15:38 INFO - Using env: {'DISPLAY': ':0', 17:15:38 INFO - 'HOME': '/home/cltbld', 17:15:38 INFO - 'LANG': 'en_US.UTF-8', 17:15:38 INFO - 'LANGUAGE': 'en_US:en', 17:15:38 INFO - 'LOGNAME': 'cltbld', 17:15:38 INFO - 'MAIL': '/var/mail/cltbld', 17:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:38 INFO - 'MOZ_NO_REMOTE': '1', 17:15:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:38 INFO - 'NO_EM_RESTART': '1', 17:15:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:38 INFO - 'PWD': '/builds/slave/test', 17:15:38 INFO - 'SHELL': '/bin/bash', 17:15:38 INFO - 'SHLVL': '1', 17:15:38 INFO - 'TERM': 'linux', 17:15:38 INFO - 'TMOUT': '86400', 17:15:38 INFO - 'USER': 'cltbld', 17:15:38 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462925712.532339-811817722', 17:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:38 INFO - '_': '/tools/buildbot/bin/python'} 17:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:15:38 INFO - Running setup.py (path:/tmp/pip-sJR3DH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:15:38 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)) 17:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:15:38 INFO - Running setup.py (path:/tmp/pip-amutD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:15:38 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)) 17:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:15:38 INFO - Running setup.py (path:/tmp/pip-b4jr4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:15:38 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)) 17:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:15:38 INFO - Running setup.py (path:/tmp/pip-QSisaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:15:39 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)) 17:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:15:39 INFO - Running setup.py (path:/tmp/pip-LpGaeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:15:39 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)) 17:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:15:39 INFO - Running setup.py (path:/tmp/pip-QT5wpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:15:39 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)) 17:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:15:39 INFO - Running setup.py (path:/tmp/pip-9uTLhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:15:39 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)) 17:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:15:39 INFO - Running setup.py (path:/tmp/pip-OW9V40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:15:39 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)) 17:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:15:39 INFO - Running setup.py (path:/tmp/pip-vYufLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:15:39 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)) 17:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:15:39 INFO - Running setup.py (path:/tmp/pip-pheJ5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:15:39 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)) 17:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:15:39 INFO - Running setup.py (path:/tmp/pip-QUAM8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:15:39 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)) 17:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:15:39 INFO - Running setup.py (path:/tmp/pip-PsQyf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:15:39 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)) 17:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:15:39 INFO - Running setup.py (path:/tmp/pip-CGbnxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:15:39 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)) 17:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:15:39 INFO - Running setup.py (path:/tmp/pip-o5LD5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:15:39 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)) 17:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:39 INFO - Running setup.py (path:/tmp/pip-X3RS9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:39 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)) 17:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:15:39 INFO - Running setup.py (path:/tmp/pip-mf1SFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:15:39 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)) 17:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:15:39 INFO - Running setup.py (path:/tmp/pip-ufX4kq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:15:39 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)) 17:15:39 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)) 17:15:39 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)) 17:15:39 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)) 17:15:39 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)) 17:15:39 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)) 17:15:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:15:39 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 17:15:39 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 17:15:39 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 17:15:39 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 17:15:39 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 17:15:39 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 17:15:41 INFO - Downloading blessings-1.6.tar.gz 17:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:15:41 INFO - Installing collected packages: blessings 17:15:41 INFO - Running setup.py install for blessings 17:15:42 INFO - Successfully installed blessings 17:15:42 INFO - Cleaning up... 17:15:42 INFO - Return code: 0 17:15:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:15:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:15:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:15:42 INFO - Reading from file tmpfile_stdout 17:15:42 INFO - Current package versions: 17:15:42 INFO - argparse == 1.2.1 17:15:42 INFO - blessings == 1.6 17:15:42 INFO - blobuploader == 1.2.4 17:15:42 INFO - docopt == 0.6.1 17:15:42 INFO - manifestparser == 1.1 17:15:42 INFO - mozInstall == 1.12 17:15:42 INFO - mozcrash == 0.17 17:15:42 INFO - mozdebug == 0.1 17:15:42 INFO - mozdevice == 0.48 17:15:42 INFO - mozfile == 1.2 17:15:42 INFO - mozhttpd == 0.7 17:15:42 INFO - mozinfo == 0.9 17:15:42 INFO - mozleak == 0.1 17:15:42 INFO - mozlog == 3.1 17:15:42 INFO - moznetwork == 0.27 17:15:42 INFO - mozprocess == 0.22 17:15:42 INFO - mozprofile == 0.28 17:15:42 INFO - mozrunner == 6.11 17:15:42 INFO - mozscreenshot == 0.1 17:15:42 INFO - mozsystemmonitor == 0.0 17:15:42 INFO - moztest == 0.7 17:15:42 INFO - mozversion == 1.4 17:15:42 INFO - psutil == 3.1.1 17:15:42 INFO - requests == 1.2.3 17:15:42 INFO - wsgiref == 0.1.2 17:15:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:42 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 0x7f26cec7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250c9c0>, '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 0x250d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250dd50>, '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': 'af724c981e2a0f424dbabf99000001e7-1462925712.532339-811817722', '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 17:15:42 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 17:15:42 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 17:15:42 INFO - Using env: {'DISPLAY': ':0', 17:15:42 INFO - 'HOME': '/home/cltbld', 17:15:42 INFO - 'LANG': 'en_US.UTF-8', 17:15:42 INFO - 'LANGUAGE': 'en_US:en', 17:15:42 INFO - 'LOGNAME': 'cltbld', 17:15:42 INFO - 'MAIL': '/var/mail/cltbld', 17:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:42 INFO - 'MOZ_NO_REMOTE': '1', 17:15:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:42 INFO - 'NO_EM_RESTART': '1', 17:15:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:42 INFO - 'PWD': '/builds/slave/test', 17:15:42 INFO - 'SHELL': '/bin/bash', 17:15:42 INFO - 'SHLVL': '1', 17:15:42 INFO - 'TERM': 'linux', 17:15:42 INFO - 'TMOUT': '86400', 17:15:42 INFO - 'USER': 'cltbld', 17:15:42 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462925712.532339-811817722', 17:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:42 INFO - '_': '/tools/buildbot/bin/python'} 17:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:42 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)) 17:15:42 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)) 17:15:42 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)) 17:15:42 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)) 17:15:42 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)) 17:15:42 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)) 17:15:42 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)) 17:15:42 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)) 17:15:42 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)) 17:15:42 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)) 17:15:42 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)) 17:15:42 INFO - Cleaning up... 17:15:42 INFO - Return code: 0 17:15:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:42 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 0x7f26cec7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250c9c0>, '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 0x250d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250dd50>, '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': 'af724c981e2a0f424dbabf99000001e7-1462925712.532339-811817722', '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 17:15:42 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 17:15:42 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 17:15:42 INFO - Using env: {'DISPLAY': ':0', 17:15:42 INFO - 'HOME': '/home/cltbld', 17:15:42 INFO - 'LANG': 'en_US.UTF-8', 17:15:42 INFO - 'LANGUAGE': 'en_US:en', 17:15:42 INFO - 'LOGNAME': 'cltbld', 17:15:42 INFO - 'MAIL': '/var/mail/cltbld', 17:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:42 INFO - 'MOZ_NO_REMOTE': '1', 17:15:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:42 INFO - 'NO_EM_RESTART': '1', 17:15:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:42 INFO - 'PWD': '/builds/slave/test', 17:15:42 INFO - 'SHELL': '/bin/bash', 17:15:42 INFO - 'SHLVL': '1', 17:15:42 INFO - 'TERM': 'linux', 17:15:42 INFO - 'TMOUT': '86400', 17:15:42 INFO - 'USER': 'cltbld', 17:15:42 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462925712.532339-811817722', 17:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:42 INFO - '_': '/tools/buildbot/bin/python'} 17:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:42 INFO - Downloading/unpacking jsonschema 17:15:42 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 17:15:42 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 17:15:42 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 17:15:42 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 17:15:42 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 17:15:42 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 17:15:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:15:44 INFO - Downloading/unpacking functools32 (from jsonschema) 17:15:44 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 17:15:44 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 17:15:44 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 17:15:44 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 17:15:44 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 17:15:44 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 17:15:44 INFO - Downloading functools32-3.2.3-2.tar.gz 17:15:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:15:44 INFO - warning: no files found matching '*.txt' 17:15:44 INFO - no previously-included directories found matching 'build' 17:15:44 INFO - no previously-included directories found matching 'dist' 17:15:44 INFO - no previously-included directories found matching '.git*' 17:15:44 INFO - Installing collected packages: jsonschema, functools32 17:15:44 INFO - Running setup.py install for functools32 17:15:45 INFO - warning: no files found matching '*.txt' 17:15:45 INFO - no previously-included directories found matching 'build' 17:15:45 INFO - no previously-included directories found matching 'dist' 17:15:45 INFO - no previously-included directories found matching '.git*' 17:15:45 INFO - Successfully installed jsonschema functools32 17:15:45 INFO - Cleaning up... 17:15:45 INFO - Return code: 0 17:15:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:15:45 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')]} 17:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:45 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')]} 17:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:45 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 0x7f26cec7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250c9c0>, '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 0x250d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250dd50>, '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': 'af724c981e2a0f424dbabf99000001e7-1462925712.532339-811817722', '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 17:15:45 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 17:15:45 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 17:15:45 INFO - Using env: {'DISPLAY': ':0', 17:15:45 INFO - 'HOME': '/home/cltbld', 17:15:45 INFO - 'LANG': 'en_US.UTF-8', 17:15:45 INFO - 'LANGUAGE': 'en_US:en', 17:15:45 INFO - 'LOGNAME': 'cltbld', 17:15:45 INFO - 'MAIL': '/var/mail/cltbld', 17:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:45 INFO - 'MOZ_NO_REMOTE': '1', 17:15:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:45 INFO - 'NO_EM_RESTART': '1', 17:15:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:45 INFO - 'PWD': '/builds/slave/test', 17:15:45 INFO - 'SHELL': '/bin/bash', 17:15:45 INFO - 'SHLVL': '1', 17:15:45 INFO - 'TERM': 'linux', 17:15:45 INFO - 'TMOUT': '86400', 17:15:45 INFO - 'USER': 'cltbld', 17:15:45 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462925712.532339-811817722', 17:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:45 INFO - '_': '/tools/buildbot/bin/python'} 17:15:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:45 INFO - Downloading/unpacking flake8 17:15:45 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 17:15:45 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 17:15:45 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 17:15:45 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 17:15:45 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 17:15:45 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 17:15:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:15:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:15:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:15:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:15:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:15:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:15:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:15:47 INFO - no previously-included directories found matching 'docs/_build' 17:15:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:15:48 INFO - Running setup.py install for pep8 17:15:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:15:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:15:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:15:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:15:48 INFO - no previously-included directories found matching 'docs/_build' 17:15:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:15:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:15:48 INFO - Cleaning up... 17:15:48 INFO - Return code: 0 17:15:48 INFO - Running post-action listener: _resource_record_post_action 17:15:48 INFO - Running post-action listener: _start_resource_monitoring 17:15:48 INFO - Starting resource monitoring. 17:15:48 INFO - ##### 17:15:48 INFO - ##### Finished create-virtualenv step (success) 17:15:48 INFO - ##### 17:15:48 INFO - ##### 17:15:48 INFO - ##### Running install step. 17:15:48 INFO - ##### 17:15:48 INFO - Running pre-action listener: _resource_record_pre_action 17:15:48 INFO - Running main action method: install 17:15:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:15:48 INFO - Reading from file tmpfile_stdout 17:15:48 INFO - Detecting whether we're running mozinstall >=1.0... 17:15:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:15:48 INFO - Reading from file tmpfile_stdout 17:15:48 INFO - Output received: 17:15:48 INFO - Usage: mozinstall [options] installer 17:15:48 INFO - Options: 17:15:48 INFO - -h, --help show this help message and exit 17:15:48 INFO - -d DEST, --destination=DEST 17:15:48 INFO - Directory to install application into. [default: 17:15:48 INFO - "/builds/slave/test"] 17:15:48 INFO - --app=APP Application being installed. [default: firefox] 17:15:48 INFO - mkdir: /builds/slave/test/build/application 17:15:48 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'] 17:15:48 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 17:16:04 INFO - Reading from file tmpfile_stdout 17:16:04 INFO - Output received: 17:16:04 INFO - /builds/slave/test/build/application/firefox/firefox 17:16:04 INFO - Running post-action listener: _resource_record_post_action 17:16:04 INFO - ##### 17:16:04 INFO - ##### Finished install step (success) 17:16:04 INFO - ##### 17:16:04 INFO - ##### 17:16:04 INFO - ##### Running run-tests step. 17:16:04 INFO - ##### 17:16:04 INFO - Running pre-action listener: _resource_record_pre_action 17:16:04 INFO - Running main action method: run_tests 17:16:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:16:04 INFO - Python 2.7.3 17:16:04 INFO - Return code: 0 17:16:04 INFO - grabbing minidump binary from tooltool 17:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:04 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250c9c0>, '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 0x250d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250dd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:16:04 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 17:16:04 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 17:16:04 INFO - Calling ['/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'] with output_timeout 600 17:16:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:16:04 INFO - Return code: 0 17:16:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:16:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:16:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:16:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:16:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:16:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:16:05 INFO - Return code: 0 17:16:05 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/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 17:16:05 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/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 17:16:05 INFO - Using env: {'DISPLAY': ':0', 17:16:05 INFO - 'HOME': '/home/cltbld', 17:16:05 INFO - 'LANG': 'en_US.UTF-8', 17:16:05 INFO - 'LANGUAGE': 'en_US:en', 17:16:05 INFO - 'LOGNAME': 'cltbld', 17:16:05 INFO - 'MAIL': '/var/mail/cltbld', 17:16:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:16:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:16:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:05 INFO - 'MOZ_NO_REMOTE': '1', 17:16:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:16:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:05 INFO - 'NO_EM_RESTART': '1', 17:16:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:05 INFO - 'PWD': '/builds/slave/test', 17:16:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:16:05 INFO - 'SHELL': '/bin/bash', 17:16:05 INFO - 'SHLVL': '1', 17:16:05 INFO - 'TERM': 'linux', 17:16:05 INFO - 'TMOUT': '86400', 17:16:05 INFO - 'USER': 'cltbld', 17:16:05 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462925712.532339-811817722', 17:16:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:05 INFO - '_': '/tools/buildbot/bin/python'} 17:16:05 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/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 17:16:05 INFO - mozversion application_buildid: 20160510162116 17:16:05 INFO - mozversion application_changeset: d8df7fcffeb14796b272feb5cb24b1c15dcf67cb 17:16:05 INFO - mozversion application_display_name: Nightly 17:16:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:16:05 INFO - mozversion application_name: Firefox 17:16:05 INFO - mozversion application_remotingname: firefox 17:16:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:16:05 INFO - mozversion application_vendor: Mozilla 17:16:05 INFO - mozversion application_version: 49.0a1 17:16:05 INFO - mozversion platform_buildid: 20160510162116 17:16:05 INFO - mozversion platform_changeset: d8df7fcffeb14796b272feb5cb24b1c15dcf67cb 17:16:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:16:05 INFO - mozversion platform_version: 49.0a1 17:16:05 INFO - using testdate: 1462925765 17:16:05 INFO - actual date: 1462925765 17:16:05 INFO - starting webserver on 'localhost:42861' 17:16:05 INFO - SUITE-START | Running 2 tests 17:16:05 INFO - TEST-START | dromaeo_css 17:16:05 INFO - operating with platform_type : linux_ 17:16:05 INFO - Initialising browser for dromaeo_css test... 17:16:05 INFO - TEST-INFO | started process 30081 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGIBLJz/profile http://localhost:42861/getInfo.html) 17:16:10 INFO - PROCESS | 30081 | __metrics Screen width/height:1600/1200 17:16:10 INFO - PROCESS | 30081 | colorDepth:24 17:16:10 INFO - PROCESS | 30081 | Browser inner width/height: 1024/697 17:16:10 INFO - PROCESS | 30081 | __metrics 17:16:11 ERROR - PROCESS | 30081 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:16:12 INFO - TEST-INFO | 30081: exit 0 17:16:12 INFO - Browser initialized. 17:16:12 INFO - Running cycle 1/1 for dromaeo_css test... 17:16:12 INFO - TEST-INFO | started process 30165 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGIBLJz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:16:24 INFO - PROCESS | 30165 | RSS: Main: 154677248 17:16:24 INFO - PROCESS | 30165 | 17:17:16 INFO - PROCESS | 30165 | 1462925836287 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] 17:19:27 INFO - PROCESS | 30165 | Cycle 1(1): loaded http://localhost:42861/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42861/tests/dromaeo/cssquery-ext.html) 17:19:29 INFO - PROCESS | 30165 | RSS: Main: 329969664 17:19:29 INFO - PROCESS | 30165 | 17:22:32 INFO - PROCESS | 30165 | Cycle 1(1): loaded http://localhost:42861/tests/dromaeo/cssquery-ext.html (next: http://localhost:42861/tests/dromaeo/cssquery-jquery.html) 17:22:32 INFO - PROCESS | 30165 | RSS: Main: 238833664 17:22:32 INFO - PROCESS | 30165 | 17:25:34 INFO - PROCESS | 30165 | Cycle 1(1): loaded http://localhost:42861/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42861/tests/dromaeo/cssquery-mootools.html) 17:25:35 INFO - PROCESS | 30165 | RSS: Main: 244060160 17:25:35 INFO - PROCESS | 30165 | 17:28:37 INFO - PROCESS | 30165 | Cycle 1(1): loaded http://localhost:42861/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42861/tests/dromaeo/cssquery-prototype.html) 17:28:38 INFO - PROCESS | 30165 | RSS: Main: 236367872 17:28:38 INFO - PROCESS | 30165 | 17:31:41 INFO - PROCESS | 30165 | Cycle 1(1): loaded http://localhost:42861/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42861/tests/dromaeo/cssquery-yui.html) 17:31:41 INFO - PROCESS | 30165 | RSS: Main: 216690688 17:31:41 INFO - PROCESS | 30165 | 17:34:44 INFO - PROCESS | 30165 | Cycle 1(1): loaded http://localhost:42861/tests/dromaeo/cssquery-yui.html (next: http://localhost:42861/tests/dromaeo/cssquery-dojo.html) 17:34:45 INFO - PROCESS | 30165 | RSS: Main: 270778368 17:34:45 INFO - PROCESS | 30165 | 17:34:45 INFO - PROCESS | 30165 | __start_tp_report 17:34:45 INFO - PROCESS | 30165 | _x_x_mozilla_page_load 17:34:45 INFO - PROCESS | 30165 | _x_x_mozilla_page_load_details 17:34:45 INFO - PROCESS | 30165 | |i|pagename|runs| 17:34:45 INFO - PROCESS | 30165 | |0;dojo.html;2607.817452778306;2611.490759301937;2649.2449651849215;2654;2657.348949507371;4664.2770370592525;4665.743384113876;4728.17256980028;4741.122892264933;4786.904261914764;4751.857444276678;4794.328793968847;4804.207305794548;4841.7337046462435;4868.391451068616;4348.7390756554705;4361.738295702268;4383.802728877208;4439.334099885019;4494.752788596626;4425.048614547872;4428.933565996513;4461.375407442961;4462.5537446255275;4476.350929115276;4263.765492897889;4404.779761011969;4421.358902959069;4447.155040542287;4455.198064348416;4281.48622165339;4294.892627684333;4330.198913201037;4381.277089280265;4400.801963911632;4237.194932962758;4296.076343586144;4308.504521979981;4309.82760689572;4360.738355698637;4520.028193938286;4633.328167415706;4647.581717645395;4647.976760116211;4664.5335466453425;5100.234964755279;5150.072986862363;5151.227315902607;5168.870778230536;5220.347456567929;5173.870653233662;5182.274481572583;5199.428062913076;5220.556252718524;5235.633505654568;4721.527847215251;4723.0789995951145;4784.0192760484015;4829.975850120797;4838.927416088797;5175.171972484384;5175.223716442489;5244.763985620656;5246.97376513115;5257.842264732064;5037.244413338029;5043.4956504349275;5044.823431179964;5046.823361182341;5051.747412629354;5021.72380519075;5059.392872855281;5075.416327122354;5108.66793658411;5150.871228219249;5109.38687357512;5124.846254612367;5128.8717782055;5134.666246693953;5163.277141200235;5105;5110.948890511122;5113.744312784346;5116.155834287301;5137.357830271216;4246.851360202378;4280.357946308017;4317.892052698708;4342.82628694855;4346.195953748566;3767.9246415071543;3779.905502362463;3785.413260944558;3807.676347510437;3834.2906562286066;4327.935080973788;4331.5451877552405;4333.71830830995;4363.650907927358;4377.146456440963;4984.352034235526;5094.5669618082875;5108.412532558729;5132.204508301219;5141.614378921596;4325.221460137205;4342.609165175149;4349.26062569364;4351.108022855307;4391.297392417198;4632.5830675239395;4640.303954406799;4641.396618439581;4650.116477869194;4689.413823272091;4666.0901124280435;4769.284607308862;4807.375041244616;4825.710457372569;4832.275158726219;5142.922856157086;5144.819931302386;5153.7165455900285;5168.3539557555305;5216.817411390583;4820.831270905502;4828.468868424541;4834.8791280218275;4840.975795121002;4892.90214195707;4857.611391088775;4925.827596034122;4946.826861059845;4974.17926042199;5004.699718016931;5053.36832895888;5055.494450554915;5056.140456122394;5059.494050594911;5059.671121377099;4894.559489645949;4894.657373983787;4906.435759887516;4914.557689807792;4915.926261106158;4840.056189043103;4864.635152363516;4898.608111351155;4906.681065730716;4911.50884911506;4818.518148185293;4830.492798256132;4842.539958703917;4880.194767863263;4890.657653964188;4845.733484658378;4959.107360675113;4959.504049595012;4999.600031997505;5003.899922001467;4803.207470767285;4891.6575839692305;4897.90204195907;4907.533784290486;4907.730074845775 17:34:45 INFO - PROCESS | 30165 | |1;ext.html;530.0695344024059;595.7081030295155;602.3885755957706;603.931042055562;613.2303958532042;40919.59080409199;42760.144797104076;42871;47091;47102.29346559804;40953.7952310238;41527.792361038155;41577.37633935493;41661;41831.37252941208;7622.237776222389;7861.371090312789;7993.1607181246;9886.110250077492;10142.087212150906;10114.645987390442;10215.284930054862;10222.131118854906;10222.846657300146;10231.795364092713;10168.44073575953;10205.591776328938;10212.846807297896;10216.48917554123;10222.642207522738;7658.195889431613;10027.398356098658;10346.379217246915;10361.89638103617;10681.786364272748;10071.647492337806;10137.797244055078;10138.847917281246;10142.442165680959;10142.9492852536;38804.80597597022;39110;39150.60849391498;39208;39229.21541569181;3218.5494030835703;3223.1458663454205;3249.5125731140283;3270.117068391521;3284.080457471912;28620.284492887637;28926.566101508495;29162.125136245948;29535.261618459495;29878;3042.3915216956475;3132.201288671397;3151.795133316327;3187.729043031322;3237.7733558650903;192821;252043;252173;252626.99999999817;252835;56459.71770141205;57264.14103788447;57264.713676432184;57343.13985290224;57458.42541574614;35048.47427288593;35888.82055589705;35942.46086308707;37289.81355093207;37589.24821503554;13005.089643725038;13102.344882755824;13180;13237;13408.932955335356;9701.51492425376;9883.604655813688;9983.950080249697;10308.845367319496;10353.482325883675;18478.61410394226;18481.815181848277;18490.35283765062;18526.16632251552;18870.15084321209;7179.246179151219;7249.565026098451;7352.264773522712;7394.55632662042;7452.962735186289;872.5288344294137;955.06880791228;957.5355952363099;978.500964508106;1051.9789604208027;28437.43125137527;28906.855465722536;29038.27404314909;29042.129909290197;29719.554206686917;1010.3382284603597;1015.4364327797995;1027.814993301213;1029.9382037077798;1059.761553650438;15203.391864325524;15465.458708945358;15649.765253521206;15732.19079805837;15907.840921590867;352669;354378;355676;356150;356415;50366.748166258934;50667.493325067015;50824.491755081974;50985.23522147097;50995.23507147396;1154.872963973979;1235.5304984106162;1274.8470183577845;1278.9296588687525;1287.1633438265203;29097.563536546546;30243.69756302409;30301.393972120874;30335.848320758254;30741.23146921345;41036.179276413706;41300.760977170736;41654;41818.37272440855;41903.37144942767;259273;259574;260469;261249;261605;23148.652770208122;25133;26480.735192648597;26498.602520961816;27606.3098422533;42637.786811065744;49695;50050;50351;55308;37334;37421.81289093537;38039;41034.589654103074;41304.38043429291;39896.80051599723;40521.594784051784;40542.1891562173;40830.59169408268;41047.38428923509;39481.2103757929;39829.40255896106;40580.3912941312;40607.59392406156;40638.79680601578;33791;36313.818430907675;36557.63442365542;36874.63125368712;36920.26159476849;27440.313992150357;27630.723692762815;27703.445931080863;27819.582706259018;28077.57883631706 17:34:45 INFO - PROCESS | 30165 | |2;jquery.html;382.4015415874157;382.74738672476155;385.24684242306296;400.7935913004805;406.8555662739727;15810.683786324282;17041.318347266093;18208.180631871564;18235.635287294244;18244.726329105073;16786.244618992143;16993.83006169938;17254.654906901855;17454.30182792687;17477.475675729747;5130.461301563329;5202.089634313998;5263.710495922723;5313.282706834586;5320.388155362144;3620.619834917335;4647.117047760915;5947.702614869261;5954.374790646984;6056.545759068065;5999.940000599981;6011;6017.308009578911;6025.487833534155;6026.63840169589;5873;5925.407459254083;6028.969855150718;6035.969820150893;6086.026235802295;4770;5333.626646134772;5334.946650533484;5341.706206158659;5353.785848566053;12362.25826450407;12460.314682692448;12554.372281385895;12566.623001309976;12575.559855405108;1892.0634286028503;1899.8290153886078;1908.809119088094;1952.2581419060666;2019.2528764357135;8930.642774289021;8961.775955601097;9562.85655715158;9869.407835529892;13466;1672.9330826766916;1694.7034269002997;1715.631139305043;1770.725537541683;1772.76953995981;62124;67777.66111169412;67980.3201967979;72763;76759.6162019192;10265.640702575374;10499.68500944973;10530.57877684884;10573.4713264338;10767;14693.265336733335;14799.112053276838;14815.111093334219;14819.851801482062;14820.851791482162;7401.888971665429;7471.178170401252;7472.29013243741;7623.656935437919;7668.348190403878;6972.267911869282;7002.3697867192195;7051.858962820715;7131.500794944304;7140.7500737474975;4461.371599366208;4470.642348612103;4544.750038747835;4555.794989225426;4603.746793926366;1839.7700287464068;1846.1230915315118;1853.5273505256073;1870.7942126366088;1890.5368184794538;891.6121487153109;913.8949020862686;925.0703043441433;927.1423932862076;953.4946478366338;16819.32722691103;17107;17175;17177.14114294305;17496.47510574685;861.3849033063007;887.0375642428038;896.7040876510736;969.4958621516772;1020.4030642074321;9407.29445291606;9582.520873956275;9700.708978730649;9743.707688769347;9875.209983201326;409483;415522;418746;420888;424597;53582;72685.63657181786;77184;78904.75080700664;80758;919.9916273784687;933.1228645073609;946.1910066892846;967.5210770668564;968.9806203875883;15365.308561115;15405.614859628151;15478.613034674223;15728.05631662104;15883.28525216391;34293.65706342905;34361.140971475914;34712.30575388529;34855.65144348524;36597.817010914776;46376.53623463722;46421.535784641725;47730.28404574004;47947.52052479431;50067.248991265886;7483.214262502359;7722.53664780115;7790.649420775965;7887.526748395115;8001.359891208573;8364.121767214356;11024.779504410028;12153.08851836098;12251.877481225074;12266.386680665753;10458.320209186379;10681.839772403264;10690.679279621623;10722.356658600509;10816.026557609854;10318.587256509956;10385.948070259601;10442.63450779219;10752.946235268773;10755.193360497837;10256.743581410525;10316.845247321446;10380.117689996436;10610.257281990187;10741.140708743438;7552.13150487679;7562.357199638092;7631.3131818136635;7687;7737.613119343898;10318.948405257926;10374.325668831501;10576;10855.294405863593;10913.18151138652 17:34:45 INFO - PROCESS | 30165 | |3;mootools.html;1309.3060677840747;1519.7188520123775;1556.9688606227874;1742.1985886492214;1905.2093381246784;7431.925680743191;7779.416543759219;7782.766517004492;8002.8799568006525;8042.316403105729;7735.110462296838;7919.683212671501;7970.242826931432;7973.720919767809;7978.76063718088;1911.1304356517821;2169.913203471859;2211.7677643847405;2240.417491452226;2244.5735310291075;2312.7687231276823;2323.047550504285;2324.662923876037;2325.244295603927;2328.499372634883;2229.665550167472;2231.3752149398197;2272.5114100468395;2273.6816845641624;2275.4083938176027;1837.5222442165;2077.5117847306024;2142.5714857028656;2150.7526634437086;2193.649016157415;2158.212252527832;2158.3848603148026;2180.1170525937023;2182.8362872784605;2184.726909136358;7655.119661238973;7666.8849967250535;7711.768646940601;7725.420593455513;7738.303552680286;4677.345171675968;4785.401824771903;4806.327114203979;4819.542143496397;4819.879503012417;2855.700151484106;2907.7964542482036;2956.3791603763234;2964.2589352661835;2980.2996295870453;839.4459656626658;867.9479231246082;874.3835595904935;907.3512438606363;909.1136142261308;10854.511546980326;10867.891321086767;10871.83692244617;10891.183161262938;10910.890891091147;4262.25410553152;4333.544977777288;4438.644908407319;4441.4892287387365;4461;9256.583453744597;9321.114494123047;9326.160645541933;9329.30030247734;9334.626614935461;4848.200046992278;4913.926291105637;4934.185859333242;4951.702897826142;4952.554270115635;3811.923761524754;4250.723702959298;4328.632066274339;4352.7823608819435;4382.970002049516;3607.9278414431565;3630.7821530708243;3719.7210209234418;3723.590405055442;3743.2139250757646;1198.3648666206925;1233.340163012784;1238.0219626495148;1239.8388209532702;1249.4002878618132;903.8553831386946;944.4710961861242;944.9102335278137;947.0955237747934;970.0590427285522;5488.039593071197;5575.135853942646;5645.5483561314995;5725.627834190765;5760.567957403212;858.390542714667;883.2271762208068;909.4770506958525;948.8434408322549;970.3886551472668;3702.129999450127;3758.473813666089;3801.1447424329303;3816.198598294334;3828.0812604974603;9565.713028609152;9905.900940990641;10046.29675922693;10062.396256224503;10068.09387155145;9853.458059806779;9880;9896.307258491837;9935.155511781579;9966.103050725469;7094.432445404355;7454.403647708279;7532.585707786125;7660.161561225265;7695.230476952372;5395.271638328933;5468.371137319259;5486.506214440719;5488.451154884639;5597.916031259453;8520.531370774666;8603.483790972561;8725.171108744658;8823.073577274294;8830.072842351461;8345.916540834756;8511.829763404821;8527.530985795593;8748.212660860552;8826.205641492297;6234.781782637768;6396.968015159894;6444.742210311535;6525.771597994048;6541.8691626168165;7216.097987751531;7231.674574644048;7289.744858929912;7309.451791115581;7313.414926805736;6436.517261205335;6610.603363798187;6611.636360000246;6669.399754022162;6729.327067293231;6550.6069635822005;6598.571092878948;6605.504587156079;6638;6679.599224046573;5991.7902873399225;6037.63774173551;6056.425329414295;6068.089786531879;6081.665508397081;4502.122086193292;4584.610308123847;4735.550122738335;4736.981548966989;4756.7145971241835;4532.954670453253;4614.953850461587;4620.976895115503;4713.646476514344;4722.220833562424 17:34:45 INFO - PROCESS | 30165 | |4;prototype.html;292.11926042980417;314.3665513989312;316.36726546906186;317.0867900446713;322.64831333846104;4680.134175177594;4841.9589788195535;4845.903081938359;4915.459299477059;4923.990581930704;4637.698549594274;4769.236922092466;4785.353977213075;4813.831515896944;4825.396825396825;3793.563740169888;3837.175007373421;3840.7119466040017;3857.556381016177;3865;3624.4744512045736;3708.740388172829;3843.461915331856;3851.1912498375236;3866.2074274773745;3806.847726090953;3815.67566756826;3817.0838998640265;3826.081740382302;3829.7127715421316;3820.637039481259;3821.5796262411113;3824.4836947012354;3828.1386687994977;3851.749636273661;3441.2429265561536;3449.8275086245585;3453.706434953032;3463.6536346365415;3468.150303175738;4536.954630453686;4600.5629465200755;4611;4613.538646135393;4622.676412651116;4350.369196466526;4361.367601697768;4375;4377.846775362847;4415.845445409427;5005.349304590416;5021.748912554358;5024.371953505812;5034.924476132861;5047.4447810740785;3588.3361578108133;3736.290104880064;3744.138848064933;3753.8310776015146;3759.548854137521;5200.167973124319;5206.661566998133;5232.345956755444;5243.097703647102;5253.185756207794;3806.8477260909253;3817.1602247505502;3836.290286296988;3844.7308688392104;3864.516935383077;3817.84728610858;3818.243607940323;3908.905506458196;3914.3345631242755;3923.3330333843314;4326.805293761789;4349.847755328548;4360.738355698668;4362.1493808707;4386.969062270364;5001.399832020181;5040.571551418097;5050.898982020339;5089.8727531812;5095.490450954875;1263.5009171377255;1293.5925183567147;1316.2628927800463;1332.5735764555443;1332.700142467937;867.2758246863813;878.5563290538237;881.7751473374377;883.5891310540501;894.8970868350093;3893.7079719021185;3930.7248492605813;3945.585713500041;3945.940810887839;3951.1900060487533;4567.406237189144;4589.682210483751;4592.265237561974;4612.723236605814;4615.930761038587;3897.824597893102;3918.2555314490155;3930.6069393060466;3953.367461206193;3964.286428442908;2352.8235382346393;2397.8419422519523;2425.357280320716;2439.524292762894;2457.82795204334;4302.376155457441;4306.083792712276;4331.306990881444;4349.804258808361;4378.693491455568;4626.976865115653;4648.814047438064;4691.296305554194;4709.458412282563;4721.5750582447745;3984.7237377244664;4343.891402714958;4349.369341445473;4368.645719826864;4370.366296886998;4493.752843593634;4539.97730011361;4584.670445570747;4621.584057434847;4647.953520464887;4489.708168969007;4493.955060449484;4503.301988191835;4509.278515437645;4532.5694059064335;4120.690948178839;4330.9133817322845;4354.433923589913;4362.7818609070055;4365.236083685406;3440.638732933006;3445.1903802606867;3473.947890781691;3479.94780078294;3480.164760457523;4569.634429245719;4593.356930029865;4600.217962946374;4611.193041217706;4955.950440495549;4844.539768721966;5021.472745361684;5030.8239211627415;5042.168042272984;5055.562217692005;5022.673526220784;5051.292819005415;5054.241863720471;5059.077550530775;5060.51925067118;4755.904881902412;4974.228994505857;4980.701157930535;4997.575206107522;5001.924971125509;5047.949520504748;5067.6199285053035;5089.414717307557;5110.821121260738;5118.667286626357;4992.850214493571;4996.225585034325;5012.147934851011;5014.222795466709;5061.266116413173 17:34:45 INFO - PROCESS | 30165 | |5;yui.html;699.5522865366166;714.5962531169889;722.1226210154662;728.8870225115103;735.2280105888817;10910.345379277249;10954.39750813705;10956.28784129031;10973.83539246912;11006.724831879197;10740;12133.090018248622;12385.752284954295;12509.437075331609;13081.28052957087;689.9275576064516;880.5773228850139;883.5493898111977;889.0842432294746;889.1153302464057;839.4627438439373;867.5445391169624;868.5483548554748;871.7384784564637;872.1845074855031;891.4740303221098;894.8076163624819;895.9641614335419;896.6816780043089;896.6861598440527;713.3009650542446;724.1635910523302;889.8754174415587;890.1943740914483;890.1943740914483;544.7358031354789;545.2747845365654;646.5668002438377;658.8781075501;663.515633587479;11032.779344413148;11115.833262500988;11129.387883666395;11138.721531961684;11202.551897924073;11675.182737208399;11924.940375298154;11996.58011969577;12290.20113692607;12608.81086783699;11112.944435277852;11343.773124537463;11370.772584548346;11471.483783229774;11782.293062416196;4038.4749982502085;4042.3532234842282;4135.6898232632375;4153.605407486284;4178.415021896937;38747.61252387497;39201;39560.80219598913;39636.60363396358;39876.4018539725;9897.901020989842;10245.334053286513;10308.639197628047;10309.639162629423;10379.896201037893;17452.389166379115;17485.30058797659;17522.91238543799;17538.912305438393;17541.64916701659;6946.131733533309;7118.60847653384;7210;7231.962238705415;7253.492255542167;3792.791396473165;3809.504764380613;3892.5718171001167;3924.2151569686175;3992.8003599819895;2788.121741651373;2899.7825163112852;2906.491364011332;2907.767378609706;2908.607338009384;481.7061592428616;488.36024807501576;489.1586471269411;493.543472288132;520.053502625226;579.2151634535144;589.5401586762332;614.3365165621118;623.513659345702;628.538024551954;8176.550289734122;8391.118932512121;8464.661413543512;8516.361272904556;8646.683927504506;603.667982609563;609.1106983803608;620.824482770625;634.3339493531773;665.4776000839317;3817.751846129993;3929.587393323717;4033.4756481657196;4037;4053.6959728020515;46478.30282545764;47682.761586191846;49046;49707.50292497101;49979.25031124536;42078.36882446766;43893;44104.558954410684;45049;45093.09813803706;38746.806265969055;40006;42311.57688423138;45272.3209151863;45343.773281133384;8362.540060296498;8517.44636598619;8535.231829135408;8546.915402676957;8581.313494920516;28979.377577802774;29356.266093347836;29732.851335743184;30207.69792302049;30530.236744081576;35604;37431.43852842155;37609.43585846269;37647.81176094102;38132.80933595314;10322.432266225429;10358.637447689294;10369.481525923824;10758;11130.610428635282;11747.941260293645;11923.642290731292;12120.151589388659;12471.251724896536;12519.812202816784;11036.448177591248;11743.647690569296;11811;11812;11861.822072668745;11218.775624487627;11266.267692599955;11350.148738844455;12017.879821201675;12040.75918481608;11260.94369528147;11283.717907052389;11750.529978800752;11896.107791915469;11935.641930742091;8936.821263574822;9030.051844556227;9114.179723824887;9253.120953509406;9354.95322523383;9045.864312035194;9206.17144457002;9298.302627303116;9353.362514922295;9491.098345657152 17:34:45 INFO - PROCESS | 30165 | __end_tp_report 17:34:45 INFO - PROCESS | 30165 | __start_cc_report 17:34:45 INFO - PROCESS | 30165 | _x_x_mozilla_cycle_collect,1774 17:34:45 INFO - PROCESS | 30165 | __end_cc_report 17:34:45 INFO - PROCESS | 30165 | __startTimestamp1462926885128__endTimestamp 17:34:45 INFO - PROCESS | 30165 | 17:34:45 INFO - PROCESS | 30165 | ------- Summary: start ------- 17:34:45 INFO - PROCESS | 30165 | Number of tests: 6 17:34:45 INFO - PROCESS | 30165 | 17:34:45 INFO - PROCESS | 30165 | [#0] dojo.html Cycles:165 Average:4703.90 Median:4834.88 stddev:500.67 (10.4%) stddev-sans-first:474.44 17:34:45 INFO - PROCESS | 30165 | Values: 2607.8 2611.5 2649.2 2654.0 2657.3 4664.3 4665.7 4728.2 4741.1 4786.9 4751.9 4794.3 4804.2 4841.7 4868.4 4348.7 4361.7 4383.8 4439.3 4494.8 4425.0 4428.9 4461.4 4462.6 4476.4 4263.8 4404.8 4421.4 4447.2 4455.2 4281.5 4294.9 4330.2 4381.3 4400.8 4237.2 4296.1 4308.5 4309.8 4360.7 4520.0 4633.3 4647.6 4648.0 4664.5 5100.2 5150.1 5151.2 5168.9 5220.3 5173.9 5182.3 5199.4 5220.6 5235.6 4721.5 4723.1 4784.0 4830.0 4838.9 5175.2 5175.2 5244.8 5247.0 5257.8 5037.2 5043.5 5044.8 5046.8 5051.7 5021.7 5059.4 5075.4 5108.7 5150.9 5109.4 5124.8 5128.9 5134.7 5163.3 5105.0 5110.9 5113.7 5116.2 5137.4 4246.9 4280.4 4317.9 4342.8 4346.2 3767.9 3779.9 3785.4 3807.7 3834.3 4327.9 4331.5 4333.7 4363.7 4377.1 4984.4 5094.6 5108.4 5132.2 5141.6 4325.2 4342.6 4349.3 4351.1 4391.3 4632.6 4640.3 4641.4 4650.1 4689.4 4666.1 4769.3 4807.4 4825.7 4832.3 5142.9 5144.8 5153.7 5168.4 5216.8 4820.8 4828.5 4834.9 4841.0 4892.9 4857.6 4925.8 4946.8 4974.2 5004.7 5053.4 5055.5 5056.1 5059.5 5059.7 4894.6 4894.7 4906.4 4914.6 4915.9 4840.1 4864.6 4898.6 4906.7 4911.5 4818.5 4830.5 4842.5 4880.2 4890.7 4845.7 4959.1 4959.5 4999.6 5003.9 4803.2 4891.7 4897.9 4907.5 4907.7 17:34:45 INFO - PROCESS | 30165 | 17:34:45 INFO - PROCESS | 30165 | [#1] ext.html Cycles:180 Average:45499.83 Median:3259.81 stddev:75840.70 (2326.5%) stddev-sans-first:75978.30 17:34:45 INFO - PROCESS | 30165 | Values: 530.1 595.7 602.4 603.9 613.2 40919.6 42760.1 42871.0 47091.0 47102.3 40953.8 41527.8 41577.4 41661.0 41831.4 7622.2 7861.4 7993.2 9886.1 10142.1 10114.6 10215.3 10222.1 10222.8 10231.8 10168.4 10205.6 10212.8 10216.5 10222.6 7658.2 10027.4 10346.4 10361.9 10681.8 10071.6 10137.8 10138.8 10142.4 10142.9 38804.8 39110.0 39150.6 39208.0 39229.2 3218.5 3223.1 3249.5 3270.1 3284.1 28620.3 28926.6 29162.1 29535.3 29878.0 3042.4 3132.2 3151.8 3187.7 3237.8 192821.0 252043.0 252173.0 252627.0 252835.0 56459.7 57264.1 57264.7 57343.1 57458.4 35048.5 35888.8 35942.5 37289.8 37589.2 13005.1 13102.3 13180.0 13237.0 13408.9 9701.5 9883.6 9984.0 10308.8 10353.5 18478.6 18481.8 18490.4 18526.2 18870.2 7179.2 7249.6 7352.3 7394.6 7453.0 872.5 955.1 957.5 978.5 1052.0 28437.4 28906.9 29038.3 29042.1 29719.6 1010.3 1015.4 1027.8 1029.9 1059.8 15203.4 15465.5 15649.8 15732.2 15907.8 352669.0 354378.0 355676.0 356150.0 356415.0 50366.7 50667.5 50824.5 50985.2 50995.2 1154.9 1235.5 1274.8 1278.9 1287.2 29097.6 30243.7 30301.4 30335.8 30741.2 41036.2 41300.8 41654.0 41818.4 41903.4 259273.0 259574.0 260469.0 261249.0 261605.0 23148.7 25133.0 26480.7 26498.6 27606.3 42637.8 49695.0 50050.0 50351.0 55308.0 37334.0 37421.8 38039.0 41034.6 41304.4 39896.8 40521.6 40542.2 40830.6 41047.4 39481.2 39829.4 40580.4 40607.6 40638.8 33791.0 36313.8 36557.6 36874.6 36920.3 27440.3 27630.7 27703.4 27819.6 28077.6 17:34:45 INFO - PROCESS | 30165 | 17:34:45 INFO - PROCESS | 30165 | [#2] jquery.html Cycles:180 Average:24781.56 Median:422742.50 stddev:68718.03 (16.3%) stddev-sans-first:68886.38 17:34:45 INFO - PROCESS | 30165 | Values: 382.4 382.7 385.2 400.8 406.9 15810.7 17041.3 18208.2 18235.6 18244.7 16786.2 16993.8 17254.7 17454.3 17477.5 5130.5 5202.1 5263.7 5313.3 5320.4 3620.6 4647.1 5947.7 5954.4 6056.5 5999.9 6011.0 6017.3 6025.5 6026.6 5873.0 5925.4 6029.0 6036.0 6086.0 4770.0 5333.6 5334.9 5341.7 5353.8 12362.3 12460.3 12554.4 12566.6 12575.6 1892.1 1899.8 1908.8 1952.3 2019.3 8930.6 8961.8 9562.9 9869.4 13466.0 1672.9 1694.7 1715.6 1770.7 1772.8 62124.0 67777.7 67980.3 72763.0 76759.6 10265.6 10499.7 10530.6 10573.5 10767.0 14693.3 14799.1 14815.1 14819.9 14820.9 7401.9 7471.2 7472.3 7623.7 7668.3 6972.3 7002.4 7051.9 7131.5 7140.8 4461.4 4470.6 4544.8 4555.8 4603.7 1839.8 1846.1 1853.5 1870.8 1890.5 891.6 913.9 925.1 927.1 953.5 16819.3 17107.0 17175.0 17177.1 17496.5 861.4 887.0 896.7 969.5 1020.4 9407.3 9582.5 9700.7 9743.7 9875.2 409483.0 415522.0 418746.0 420888.0 424597.0 53582.0 72685.6 77184.0 78904.8 80758.0 920.0 933.1 946.2 967.5 969.0 15365.3 15405.6 15478.6 15728.1 15883.3 34293.7 34361.1 34712.3 34855.7 36597.8 46376.5 46421.5 47730.3 47947.5 50067.2 7483.2 7722.5 7790.6 7887.5 8001.4 8364.1 11024.8 12153.1 12251.9 12266.4 10458.3 10681.8 10690.7 10722.4 10816.0 10318.6 10385.9 10442.6 10752.9 10755.2 10256.7 10316.8 10380.1 10610.3 10741.1 7552.1 7562.4 7631.3 7687.0 7737.6 10318.9 10374.3 10576.0 10855.3 10913.2 17:34:45 INFO - PROCESS | 30165 | 17:34:45 INFO - PROCESS | 30165 | [#3] mootools.html Cycles:180 Average:5192.00 Median:5487.27 stddev:2871.15 (52.3%) stddev-sans-first:2864.37 17:34:45 INFO - PROCESS | 30165 | Values: 1309.3 1519.7 1557.0 1742.2 1905.2 7431.9 7779.4 7782.8 8002.9 8042.3 7735.1 7919.7 7970.2 7973.7 7978.8 1911.1 2169.9 2211.8 2240.4 2244.6 2312.8 2323.0 2324.7 2325.2 2328.5 2229.7 2231.4 2272.5 2273.7 2275.4 1837.5 2077.5 2142.6 2150.8 2193.6 2158.2 2158.4 2180.1 2182.8 2184.7 7655.1 7666.9 7711.8 7725.4 7738.3 4677.3 4785.4 4806.3 4819.5 4819.9 2855.7 2907.8 2956.4 2964.3 2980.3 839.4 867.9 874.4 907.4 909.1 10854.5 10867.9 10871.8 10891.2 10910.9 4262.3 4333.5 4438.6 4441.5 4461.0 9256.6 9321.1 9326.2 9329.3 9334.6 4848.2 4913.9 4934.2 4951.7 4952.6 3811.9 4250.7 4328.6 4352.8 4383.0 3607.9 3630.8 3719.7 3723.6 3743.2 1198.4 1233.3 1238.0 1239.8 1249.4 903.9 944.5 944.9 947.1 970.1 5488.0 5575.1 5645.5 5725.6 5760.6 858.4 883.2 909.5 948.8 970.4 3702.1 3758.5 3801.1 3816.2 3828.1 9565.7 9905.9 10046.3 10062.4 10068.1 9853.5 9880.0 9896.3 9935.2 9966.1 7094.4 7454.4 7532.6 7660.2 7695.2 5395.3 5468.4 5486.5 5488.5 5597.9 8520.5 8603.5 8725.2 8823.1 8830.1 8345.9 8511.8 8527.5 8748.2 8826.2 6234.8 6397.0 6444.7 6525.8 6541.9 7216.1 7231.7 7289.7 7309.5 7313.4 6436.5 6610.6 6611.6 6669.4 6729.3 6550.6 6598.6 6605.5 6638.0 6679.6 5991.8 6037.6 6056.4 6068.1 6081.7 4502.1 4584.6 4735.6 4737.0 4756.7 4533.0 4615.0 4621.0 4713.6 4722.2 17:34:45 INFO - PROCESS | 30165 | 17:34:45 INFO - PROCESS | 30165 | [#4] prototype.html Cycles:180 Average:4046.76 Median:4376.42 stddev:1144.59 (26.2%) stddev-sans-first:1112.56 17:34:45 INFO - PROCESS | 30165 | Values: 292.1 314.4 316.4 317.1 322.6 4680.1 4842.0 4845.9 4915.5 4924.0 4637.7 4769.2 4785.4 4813.8 4825.4 3793.6 3837.2 3840.7 3857.6 3865.0 3624.5 3708.7 3843.5 3851.2 3866.2 3806.8 3815.7 3817.1 3826.1 3829.7 3820.6 3821.6 3824.5 3828.1 3851.7 3441.2 3449.8 3453.7 3463.7 3468.2 4537.0 4600.6 4611.0 4613.5 4622.7 4350.4 4361.4 4375.0 4377.8 4415.8 5005.3 5021.7 5024.4 5034.9 5047.4 3588.3 3736.3 3744.1 3753.8 3759.5 5200.2 5206.7 5232.3 5243.1 5253.2 3806.8 3817.2 3836.3 3844.7 3864.5 3817.8 3818.2 3908.9 3914.3 3923.3 4326.8 4349.8 4360.7 4362.1 4387.0 5001.4 5040.6 5050.9 5089.9 5095.5 1263.5 1293.6 1316.3 1332.6 1332.7 867.3 878.6 881.8 883.6 894.9 3893.7 3930.7 3945.6 3945.9 3951.2 4567.4 4589.7 4592.3 4612.7 4615.9 3897.8 3918.3 3930.6 3953.4 3964.3 2352.8 2397.8 2425.4 2439.5 2457.8 4302.4 4306.1 4331.3 4349.8 4378.7 4627.0 4648.8 4691.3 4709.5 4721.6 3984.7 4343.9 4349.4 4368.6 4370.4 4493.8 4540.0 4584.7 4621.6 4648.0 4489.7 4494.0 4503.3 4509.3 4532.6 4120.7 4330.9 4354.4 4362.8 4365.2 3440.6 3445.2 3473.9 3479.9 3480.2 4569.6 4593.4 4600.2 4611.2 4956.0 4844.5 5021.5 5030.8 5042.2 5055.6 5022.7 5051.3 5054.2 5059.1 5060.5 4755.9 4974.2 4980.7 4997.6 5001.9 5047.9 5067.6 5089.4 5110.8 5118.7 4992.9 4996.2 5012.1 5014.2 5061.3 17:34:45 INFO - PROCESS | 30165 | 17:34:45 INFO - PROCESS | 30165 | [#5] yui.html Cycles:180 Average:12454.70 Median:4040.41 stddev:13494.47 (334.0%) stddev-sans-first:13503.45 17:34:45 INFO - PROCESS | 30165 | Values: 699.6 714.6 722.1 728.9 735.2 10910.3 10954.4 10956.3 10973.8 11006.7 10740.0 12133.1 12385.8 12509.4 13081.3 689.9 880.6 883.5 889.1 889.1 839.5 867.5 868.5 871.7 872.2 891.5 894.8 896.0 896.7 896.7 713.3 724.2 889.9 890.2 890.2 544.7 545.3 646.6 658.9 663.5 11032.8 11115.8 11129.4 11138.7 11202.6 11675.2 11924.9 11996.6 12290.2 12608.8 11112.9 11343.8 11370.8 11471.5 11782.3 4038.5 4042.4 4135.7 4153.6 4178.4 38747.6 39201.0 39560.8 39636.6 39876.4 9897.9 10245.3 10308.6 10309.6 10379.9 17452.4 17485.3 17522.9 17538.9 17541.6 6946.1 7118.6 7210.0 7232.0 7253.5 3792.8 3809.5 3892.6 3924.2 3992.8 2788.1 2899.8 2906.5 2907.8 2908.6 481.7 488.4 489.2 493.5 520.1 579.2 589.5 614.3 623.5 628.5 8176.6 8391.1 8464.7 8516.4 8646.7 603.7 609.1 620.8 634.3 665.5 3817.8 3929.6 4033.5 4037.0 4053.7 46478.3 47682.8 49046.0 49707.5 49979.3 42078.4 43893.0 44104.6 45049.0 45093.1 38746.8 40006.0 42311.6 45272.3 45343.8 8362.5 8517.4 8535.2 8546.9 8581.3 28979.4 29356.3 29732.9 30207.7 30530.2 35604.0 37431.4 37609.4 37647.8 38132.8 10322.4 10358.6 10369.5 10758.0 11130.6 11747.9 11923.6 12120.2 12471.3 12519.8 11036.4 11743.6 11811.0 11812.0 11861.8 11218.8 11266.3 11350.1 12017.9 12040.8 11260.9 11283.7 11750.5 11896.1 11935.6 8936.8 9030.1 9114.2 9253.1 9355.0 9045.9 9206.2 9298.3 9353.4 9491.1 17:34:45 INFO - PROCESS | 30165 | -------- Summary: end -------- 17:34:45 INFO - PROCESS | 30165 | 17:34:45 INFO - TEST-INFO | 30165: exit 0 17:34:45 INFO - TEST-OK | dromaeo_css | took 1120506ms 17:34:45 INFO - TEST-START | kraken 17:34:45 INFO - operating with platform_type : linux_ 17:34:45 INFO - Initialising browser for kraken test... 17:34:45 INFO - TEST-INFO | started process 30341 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBPLqnW/profile http://localhost:42861/getInfo.html) 17:34:50 INFO - PROCESS | 30341 | __metrics Screen width/height:1600/1200 17:34:50 INFO - PROCESS | 30341 | colorDepth:24 17:34:50 INFO - PROCESS | 30341 | Browser inner width/height: 1024/697 17:34:50 INFO - PROCESS | 30341 | __metrics 17:34:51 ERROR - PROCESS | 30341 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:34:51 INFO - PROCESS | 30341 | console.error: PushService: 17:34:51 INFO - PROCESS | 30341 | stateChangeProcessEnqueue: Error transitioning state 17:34:51 INFO - PROCESS | 30341 | UnknownError 17:34:52 INFO - TEST-INFO | 30341: exit 0 17:34:52 INFO - Browser initialized. 17:34:52 INFO - Running cycle 1/1 for kraken test... 17:34:52 INFO - TEST-INFO | started process 30423 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBPLqnW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:35:04 INFO - PROCESS | 30423 | RSS: Main: 154087424 17:35:04 INFO - PROCESS | 30423 | 17:35:06 INFO - PROCESS | 30423 | Cycle 1(1): loaded http://localhost:42861/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42861/tests/kraken/driver.html?testName=audio-beat-detection) 17:35:07 INFO - PROCESS | 30423 | RSS: Main: 209604608 17:35:07 INFO - PROCESS | 30423 | 17:35:10 INFO - PROCESS | 30423 | Cycle 1(1): loaded http://localhost:42861/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42861/tests/kraken/driver.html?testName=audio-dft) 17:35:11 INFO - PROCESS | 30423 | RSS: Main: 198230016 17:35:11 INFO - PROCESS | 30423 | 17:35:14 INFO - PROCESS | 30423 | Cycle 1(1): loaded http://localhost:42861/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42861/tests/kraken/driver.html?testName=audio-fft) 17:35:15 INFO - PROCESS | 30423 | RSS: Main: 266821632 17:35:15 INFO - PROCESS | 30423 | 17:35:17 INFO - PROCESS | 30423 | Cycle 1(1): loaded http://localhost:42861/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42861/tests/kraken/driver.html?testName=audio-oscillator) 17:35:18 INFO - PROCESS | 30423 | RSS: Main: 175628288 17:35:18 INFO - PROCESS | 30423 | 17:35:20 INFO - PROCESS | 30423 | Cycle 1(1): loaded http://localhost:42861/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42861/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:35:21 INFO - PROCESS | 30423 | RSS: Main: 179707904 17:35:21 INFO - PROCESS | 30423 | 17:35:24 INFO - PROCESS | 30423 | Cycle 1(1): loaded http://localhost:42861/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42861/tests/kraken/driver.html?testName=imaging-darkroom) 17:35:25 INFO - PROCESS | 30423 | RSS: Main: 216313856 17:35:25 INFO - PROCESS | 30423 | 17:35:28 INFO - PROCESS | 30423 | Cycle 1(1): loaded http://localhost:42861/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42861/tests/kraken/driver.html?testName=imaging-desaturate) 17:35:29 INFO - PROCESS | 30423 | RSS: Main: 214564864 17:35:29 INFO - PROCESS | 30423 | 17:35:32 INFO - PROCESS | 30423 | Cycle 1(1): loaded http://localhost:42861/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42861/tests/kraken/driver.html?testName=json-parse-financial) 17:35:33 INFO - PROCESS | 30423 | RSS: Main: 214159360 17:35:33 INFO - PROCESS | 30423 | 17:35:34 INFO - PROCESS | 30423 | Cycle 1(1): loaded http://localhost:42861/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42861/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:35:35 INFO - PROCESS | 30423 | RSS: Main: 209342464 17:35:35 INFO - PROCESS | 30423 | 17:35:37 INFO - PROCESS | 30423 | Cycle 1(1): loaded http://localhost:42861/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42861/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:35:38 INFO - PROCESS | 30423 | RSS: Main: 210378752 17:35:38 INFO - PROCESS | 30423 | 17:35:40 INFO - PROCESS | 30423 | Cycle 1(1): loaded http://localhost:42861/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42861/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:35:41 INFO - PROCESS | 30423 | RSS: Main: 213209088 17:35:41 INFO - PROCESS | 30423 | 17:35:43 INFO - PROCESS | 30423 | Cycle 1(1): loaded http://localhost:42861/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42861/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:35:44 INFO - PROCESS | 30423 | RSS: Main: 219119616 17:35:44 INFO - PROCESS | 30423 | 17:35:47 INFO - PROCESS | 30423 | Cycle 1(1): loaded http://localhost:42861/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42861/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:35:48 INFO - PROCESS | 30423 | RSS: Main: 218427392 17:35:48 INFO - PROCESS | 30423 | 17:35:49 INFO - PROCESS | 30423 | Cycle 1(1): loaded http://localhost:42861/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42861/tests/kraken/driver.html?testName=ai-astar) 17:35:50 INFO - PROCESS | 30423 | RSS: Main: 265715712 17:35:50 INFO - PROCESS | 30423 | 17:35:50 INFO - PROCESS | 30423 | __start_tp_report 17:35:50 INFO - PROCESS | 30423 | _x_x_mozilla_page_load 17:35:50 INFO - PROCESS | 30423 | _x_x_mozilla_page_load_details 17:35:50 INFO - PROCESS | 30423 | |i|pagename|runs| 17:35:50 INFO - PROCESS | 30423 | |0;ai-astar;114;108;113;116;112;113;115;115;113;114 17:35:50 INFO - PROCESS | 30423 | |1;audio-beat-detection;157;130;154;225;131;161;159;133;195;137 17:35:50 INFO - PROCESS | 30423 | |2;audio-dft;160;161;159;162;163;164;163;161;161;160 17:35:50 INFO - PROCESS | 30423 | |3;audio-fft;77;77;77;149;76;75;77;75;133;76 17:35:50 INFO - PROCESS | 30423 | |4;audio-oscillator;93;95;149;93;92;93;131;94;95;121 17:35:50 INFO - PROCESS | 30423 | |5;imaging-gaussian-blur;117;117;116;116;118;117;117;117;117;117 17:35:50 INFO - PROCESS | 30423 | |6;imaging-darkroom;147;146;146;147;147;146;146;146;146;145 17:35:50 INFO - PROCESS | 30423 | |7;imaging-desaturate;94;94;95;94;95;94;94;95;94;95 17:35:50 INFO - PROCESS | 30423 | |8;json-parse-financial;69;82;68;68;68;68;67;67;69;68 17:35:50 INFO - PROCESS | 30423 | |9;json-stringify-tinderbox;63;63;64;65;64;65;64;72;64;65 17:35:50 INFO - PROCESS | 30423 | |10;stanford-crypto-aes;83;82;81;87;87;85;81;83;159;83 17:35:50 INFO - PROCESS | 30423 | |11;stanford-crypto-ccm;140;133;138;129;129;129;130;131;151;134 17:35:50 INFO - PROCESS | 30423 | |12;stanford-crypto-pbkdf2;180;172;186;181;182;173;172;173;176;172 17:35:50 INFO - PROCESS | 30423 | |13;stanford-crypto-sha256-iterative;68;69;68;71;67;66;72;67;70;69 17:35:50 INFO - PROCESS | 30423 | __end_tp_report 17:35:50 INFO - PROCESS | 30423 | __start_cc_report 17:35:50 INFO - PROCESS | 30423 | _x_x_mozilla_cycle_collect,2111 17:35:50 INFO - PROCESS | 30423 | __end_cc_report 17:35:50 INFO - PROCESS | 30423 | __startTimestamp1462926950208__endTimestamp 17:35:50 INFO - PROCESS | 30423 | 17:35:50 INFO - PROCESS | 30423 | ------- Summary: start ------- 17:35:50 INFO - PROCESS | 30423 | Number of tests: 14 17:35:50 INFO - PROCESS | 30423 | 17:35:50 INFO - PROCESS | 30423 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:2.21 (1.9%) stddev-sans-first:2.33 17:35:50 INFO - PROCESS | 30423 | Values: 114.0 108.0 113.0 116.0 112.0 113.0 115.0 115.0 113.0 114.0 17:35:50 INFO - PROCESS | 30423 | 17:35:50 INFO - PROCESS | 30423 | [#1] audio-beat-detection Cycles:10 Average:158.20 Median:158.00 stddev:30.67 (19.4%) stddev-sans-first:32.52 17:35:50 INFO - PROCESS | 30423 | Values: 157.0 130.0 154.0 225.0 131.0 161.0 159.0 133.0 195.0 137.0 17:35:50 INFO - PROCESS | 30423 | 17:35:50 INFO - PROCESS | 30423 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.58 (1.0%) stddev-sans-first:1.59 17:35:50 INFO - PROCESS | 30423 | Values: 160.0 161.0 159.0 162.0 163.0 164.0 163.0 161.0 161.0 160.0 17:35:50 INFO - PROCESS | 30423 | 17:35:50 INFO - PROCESS | 30423 | [#3] audio-fft Cycles:10 Average:89.20 Median:76.50 stddev:27.57 (36.0%) stddev-sans-first:28.89 17:35:50 INFO - PROCESS | 30423 | Values: 77.0 77.0 77.0 149.0 76.0 75.0 77.0 75.0 133.0 76.0 17:35:50 INFO - PROCESS | 30423 | 17:35:50 INFO - PROCESS | 30423 | [#4] audio-oscillator Cycles:10 Average:105.60 Median:93.00 stddev:20.51 (22.1%) stddev-sans-first:21.24 17:35:50 INFO - PROCESS | 30423 | Values: 93.0 95.0 149.0 93.0 92.0 93.0 131.0 94.0 95.0 121.0 17:35:50 INFO - PROCESS | 30423 | 17:35:50 INFO - PROCESS | 30423 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 17:35:50 INFO - PROCESS | 30423 | Values: 117.0 117.0 116.0 116.0 118.0 117.0 117.0 117.0 117.0 117.0 17:35:50 INFO - PROCESS | 30423 | 17:35:50 INFO - PROCESS | 30423 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 17:35:50 INFO - PROCESS | 30423 | Values: 147.0 146.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 145.0 17:35:50 INFO - PROCESS | 30423 | 17:35:50 INFO - PROCESS | 30423 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:35:50 INFO - PROCESS | 30423 | Values: 94.0 94.0 95.0 94.0 95.0 94.0 94.0 95.0 94.0 95.0 17:35:50 INFO - PROCESS | 30423 | 17:35:50 INFO - PROCESS | 30423 | [#8] json-parse-financial Cycles:10 Average:69.40 Median:68.00 stddev:4.48 (6.6%) stddev-sans-first:4.75 17:35:50 INFO - PROCESS | 30423 | Values: 69.0 82.0 68.0 68.0 68.0 68.0 67.0 67.0 69.0 68.0 17:35:50 INFO - PROCESS | 30423 | 17:35:50 INFO - PROCESS | 30423 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:64.50 stddev:2.60 (4.0%) stddev-sans-first:2.67 17:35:50 INFO - PROCESS | 30423 | Values: 63.0 63.0 64.0 65.0 64.0 65.0 64.0 72.0 64.0 65.0 17:35:50 INFO - PROCESS | 30423 | 17:35:50 INFO - PROCESS | 30423 | [#10] stanford-crypto-aes Cycles:10 Average:91.10 Median:83.00 stddev:23.96 (28.9%) stddev-sans-first:25.23 17:35:50 INFO - PROCESS | 30423 | Values: 83.0 82.0 81.0 87.0 87.0 85.0 81.0 83.0 159.0 83.0 17:35:50 INFO - PROCESS | 30423 | 17:35:50 INFO - PROCESS | 30423 | [#11] stanford-crypto-ccm Cycles:10 Average:134.40 Median:133.50 stddev:7.00 (5.2%) stddev-sans-first:7.12 17:35:50 INFO - PROCESS | 30423 | Values: 140.0 133.0 138.0 129.0 129.0 129.0 130.0 131.0 151.0 134.0 17:35:50 INFO - PROCESS | 30423 | 17:35:50 INFO - PROCESS | 30423 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.70 Median:178.00 stddev:5.14 (2.9%) stddev-sans-first:5.32 17:35:50 INFO - PROCESS | 30423 | Values: 180.0 172.0 186.0 181.0 182.0 173.0 172.0 173.0 176.0 172.0 17:35:50 INFO - PROCESS | 30423 | 17:35:50 INFO - PROCESS | 30423 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.89 (2.7%) stddev-sans-first:1.99 17:35:50 INFO - PROCESS | 30423 | Values: 68.0 69.0 68.0 71.0 67.0 66.0 72.0 67.0 70.0 69.0 17:35:50 INFO - PROCESS | 30423 | -------- Summary: end -------- 17:35:50 INFO - PROCESS | 30423 | 17:35:51 INFO - TEST-INFO | 30423: exit 0 17:35:51 INFO - TEST-OK | kraken | took 65244ms 17:35:51 INFO - SUITE-END | took 1185s 17:35:51 INFO - Completed test suite (00:19:45) 17:35:51 INFO - javascript benchmark 17:35:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2607.817452778306, 2611.490759301937, 2649.2449651849215, 2654.0, 2657.348949507371, 4664.2770370592525, 4665.743384113876, 4728.17256980028, 4741.122892264933, 4786.904261914764, 4751.857444276678, 4794.328793968847, 4804.207305794548, 4841.7337046462435, 4868.391451068616, 4348.7390756554705, 4361.738295702268, 4383.802728877208, 4439.334099885019, 4494.752788596626, 4425.048614547872, 4428.933565996513, 4461.375407442961, 4462.5537446255275, 4476.350929115276, 4263.765492897889, 4404.779761011969, 4421.358902959069, 4447.155040542287, 4455.198064348416, 4281.48622165339, 4294.892627684333, 4330.198913201037, 4381.277089280265, 4400.801963911632, 4237.194932962758, 4296.076343586144, 4308.504521979981, 4309.82760689572, 4360.738355698637, 4520.028193938286, 4633.328167415706, 4647.581717645395, 4647.976760116211, 4664.5335466453425, 5100.234964755279, 5150.072986862363, 5151.227315902607, 5168.870778230536, 5220.347456567929, 5173.870653233662, 5182.274481572583, 5199.428062913076, 5220.556252718524, 5235.633505654568, 4721.527847215251, 4723.0789995951145, 4784.0192760484015, 4829.975850120797, 4838.927416088797, 5175.171972484384, 5175.223716442489, 5244.763985620656, 5246.97376513115, 5257.842264732064, 5037.244413338029, 5043.4956504349275, 5044.823431179964, 5046.823361182341, 5051.747412629354, 5021.72380519075, 5059.392872855281, 5075.416327122354, 5108.66793658411, 5150.871228219249, 5109.38687357512, 5124.846254612367, 5128.8717782055, 5134.666246693953, 5163.277141200235, 5105.0, 5110.948890511122, 5113.744312784346, 5116.155834287301, 5137.357830271216, 4246.851360202378, 4280.357946308017, 4317.892052698708, 4342.82628694855, 4346.195953748566, 3767.9246415071543, 3779.905502362463, 3785.413260944558, 3807.676347510437, 3834.2906562286066, 4327.935080973788, 4331.5451877552405, 4333.71830830995, 4363.650907927358, 4377.146456440963, 4984.352034235526, 5094.5669618082875, 5108.412532558729, 5132.204508301219, 5141.614378921596, 4325.221460137205, 4342.609165175149, 4349.26062569364, 4351.108022855307, 4391.297392417198, 4632.5830675239395, 4640.303954406799, 4641.396618439581, 4650.116477869194, 4689.413823272091, 4666.0901124280435, 4769.284607308862, 4807.375041244616, 4825.710457372569, 4832.275158726219, 5142.922856157086, 5144.819931302386, 5153.7165455900285, 5168.3539557555305, 5216.817411390583, 4820.831270905502, 4828.468868424541, 4834.8791280218275, 4840.975795121002, 4892.90214195707, 4857.611391088775, 4925.827596034122, 4946.826861059845, 4974.17926042199, 5004.699718016931, 5053.36832895888, 5055.494450554915, 5056.140456122394, 5059.494050594911, 5059.671121377099, 4894.559489645949, 4894.657373983787, 4906.435759887516, 4914.557689807792, 4915.926261106158, 4840.056189043103, 4864.635152363516, 4898.608111351155, 4906.681065730716, 4911.50884911506, 4818.518148185293, 4830.492798256132, 4842.539958703917, 4880.194767863263, 4890.657653964188, 4845.733484658378, 4959.107360675113, 4959.504049595012, 4999.600031997505, 5003.899922001467, 4803.207470767285, 4891.6575839692305, 4897.90204195907, 4907.533784290486, 4907.730074845775], "value": 4671.376036426608, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [530.0695344024059, 595.7081030295155, 602.3885755957706, 603.931042055562, 613.2303958532042, 40919.59080409199, 42760.144797104076, 42871.0, 47091.0, 47102.29346559804, 40953.7952310238, 41527.792361038155, 41577.37633935493, 41661.0, 41831.37252941208, 7622.237776222389, 7861.371090312789, 7993.1607181246, 9886.110250077492, 10142.087212150906, 10114.645987390442, 10215.284930054862, 10222.131118854906, 10222.846657300146, 10231.795364092713, 10168.44073575953, 10205.591776328938, 10212.846807297896, 10216.48917554123, 10222.642207522738, 7658.195889431613, 10027.398356098658, 10346.379217246915, 10361.89638103617, 10681.786364272748, 10071.647492337806, 10137.797244055078, 10138.847917281246, 10142.442165680959, 10142.9492852536, 38804.80597597022, 39110.0, 39150.60849391498, 39208.0, 39229.21541569181, 3218.5494030835703, 3223.1458663454205, 3249.5125731140283, 3270.117068391521, 3284.080457471912, 28620.284492887637, 28926.566101508495, 29162.125136245948, 29535.261618459495, 29878.0, 3042.3915216956475, 3132.201288671397, 3151.795133316327, 3187.729043031322, 3237.7733558650903, 192821.0, 252043.0, 252173.0, 252626.99999999817, 252835.0, 56459.71770141205, 57264.14103788447, 57264.713676432184, 57343.13985290224, 57458.42541574614, 35048.47427288593, 35888.82055589705, 35942.46086308707, 37289.81355093207, 37589.24821503554, 13005.089643725038, 13102.344882755824, 13180.0, 13237.0, 13408.932955335356, 9701.51492425376, 9883.604655813688, 9983.950080249697, 10308.845367319496, 10353.482325883675, 18478.61410394226, 18481.815181848277, 18490.35283765062, 18526.16632251552, 18870.15084321209, 7179.246179151219, 7249.565026098451, 7352.264773522712, 7394.55632662042, 7452.962735186289, 872.5288344294137, 955.06880791228, 957.5355952363099, 978.500964508106, 1051.9789604208027, 28437.43125137527, 28906.855465722536, 29038.27404314909, 29042.129909290197, 29719.554206686917, 1010.3382284603597, 1015.4364327797995, 1027.814993301213, 1029.9382037077798, 1059.761553650438, 15203.391864325524, 15465.458708945358, 15649.765253521206, 15732.19079805837, 15907.840921590867, 352669.0, 354378.0, 355676.0, 356150.0, 356415.0, 50366.748166258934, 50667.493325067015, 50824.491755081974, 50985.23522147097, 50995.23507147396, 1154.872963973979, 1235.5304984106162, 1274.8470183577845, 1278.9296588687525, 1287.1633438265203, 29097.563536546546, 30243.69756302409, 30301.393972120874, 30335.848320758254, 30741.23146921345, 41036.179276413706, 41300.760977170736, 41654.0, 41818.37272440855, 41903.37144942767, 259273.0, 259574.0, 260469.0, 261249.0, 261605.0, 23148.652770208122, 25133.0, 26480.735192648597, 26498.602520961816, 27606.3098422533, 42637.786811065744, 49695.0, 50050.0, 50351.0, 55308.0, 37334.0, 37421.81289093537, 38039.0, 41034.589654103074, 41304.38043429291, 39896.80051599723, 40521.594784051784, 40542.1891562173, 40830.59169408268, 41047.38428923509, 39481.2103757929, 39829.40255896106, 40580.3912941312, 40607.59392406156, 40638.79680601578, 33791.0, 36313.818430907675, 36557.63442365542, 36874.63125368712, 36920.26159476849, 27440.313992150357, 27630.723692762815, 27703.445931080863, 27819.582706259018, 28077.57883631706], "value": 18290.33571247619, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.4015415874157, 382.74738672476155, 385.24684242306296, 400.7935913004805, 406.8555662739727, 15810.683786324282, 17041.318347266093, 18208.180631871564, 18235.635287294244, 18244.726329105073, 16786.244618992143, 16993.83006169938, 17254.654906901855, 17454.30182792687, 17477.475675729747, 5130.461301563329, 5202.089634313998, 5263.710495922723, 5313.282706834586, 5320.388155362144, 3620.619834917335, 4647.117047760915, 5947.702614869261, 5954.374790646984, 6056.545759068065, 5999.940000599981, 6011.0, 6017.308009578911, 6025.487833534155, 6026.63840169589, 5873.0, 5925.407459254083, 6028.969855150718, 6035.969820150893, 6086.026235802295, 4770.0, 5333.626646134772, 5334.946650533484, 5341.706206158659, 5353.785848566053, 12362.25826450407, 12460.314682692448, 12554.372281385895, 12566.623001309976, 12575.559855405108, 1892.0634286028503, 1899.8290153886078, 1908.809119088094, 1952.2581419060666, 2019.2528764357135, 8930.642774289021, 8961.775955601097, 9562.85655715158, 9869.407835529892, 13466.0, 1672.9330826766916, 1694.7034269002997, 1715.631139305043, 1770.725537541683, 1772.76953995981, 62124.0, 67777.66111169412, 67980.3201967979, 72763.0, 76759.6162019192, 10265.640702575374, 10499.68500944973, 10530.57877684884, 10573.4713264338, 10767.0, 14693.265336733335, 14799.112053276838, 14815.111093334219, 14819.851801482062, 14820.851791482162, 7401.888971665429, 7471.178170401252, 7472.29013243741, 7623.656935437919, 7668.348190403878, 6972.267911869282, 7002.3697867192195, 7051.858962820715, 7131.500794944304, 7140.7500737474975, 4461.371599366208, 4470.642348612103, 4544.750038747835, 4555.794989225426, 4603.746793926366, 1839.7700287464068, 1846.1230915315118, 1853.5273505256073, 1870.7942126366088, 1890.5368184794538, 891.6121487153109, 913.8949020862686, 925.0703043441433, 927.1423932862076, 953.4946478366338, 16819.32722691103, 17107.0, 17175.0, 17177.14114294305, 17496.47510574685, 861.3849033063007, 887.0375642428038, 896.7040876510736, 969.4958621516772, 1020.4030642074321, 9407.29445291606, 9582.520873956275, 9700.708978730649, 9743.707688769347, 9875.209983201326, 409483.0, 415522.0, 418746.0, 420888.0, 424597.0, 53582.0, 72685.63657181786, 77184.0, 78904.75080700664, 80758.0, 919.9916273784687, 933.1228645073609, 946.1910066892846, 967.5210770668564, 968.9806203875883, 15365.308561115, 15405.614859628151, 15478.613034674223, 15728.05631662104, 15883.28525216391, 34293.65706342905, 34361.140971475914, 34712.30575388529, 34855.65144348524, 36597.817010914776, 46376.53623463722, 46421.535784641725, 47730.28404574004, 47947.52052479431, 50067.248991265886, 7483.214262502359, 7722.53664780115, 7790.649420775965, 7887.526748395115, 8001.359891208573, 8364.121767214356, 11024.779504410028, 12153.08851836098, 12251.877481225074, 12266.386680665753, 10458.320209186379, 10681.839772403264, 10690.679279621623, 10722.356658600509, 10816.026557609854, 10318.587256509956, 10385.948070259601, 10442.63450779219, 10752.946235268773, 10755.193360497837, 10256.743581410525, 10316.845247321446, 10380.117689996436, 10610.257281990187, 10741.140708743438, 7552.13150487679, 7562.357199638092, 7631.3131818136635, 7687.0, 7737.613119343898, 10318.948405257926, 10374.325668831501, 10576.0, 10855.294405863593, 10913.18151138652], "value": 8277.594886082341, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.3060677840747, 1519.7188520123775, 1556.9688606227874, 1742.1985886492214, 1905.2093381246784, 7431.925680743191, 7779.416543759219, 7782.766517004492, 8002.8799568006525, 8042.316403105729, 7735.110462296838, 7919.683212671501, 7970.242826931432, 7973.720919767809, 7978.76063718088, 1911.1304356517821, 2169.913203471859, 2211.7677643847405, 2240.417491452226, 2244.5735310291075, 2312.7687231276823, 2323.047550504285, 2324.662923876037, 2325.244295603927, 2328.499372634883, 2229.665550167472, 2231.3752149398197, 2272.5114100468395, 2273.6816845641624, 2275.4083938176027, 1837.5222442165, 2077.5117847306024, 2142.5714857028656, 2150.7526634437086, 2193.649016157415, 2158.212252527832, 2158.3848603148026, 2180.1170525937023, 2182.8362872784605, 2184.726909136358, 7655.119661238973, 7666.8849967250535, 7711.768646940601, 7725.420593455513, 7738.303552680286, 4677.345171675968, 4785.401824771903, 4806.327114203979, 4819.542143496397, 4819.879503012417, 2855.700151484106, 2907.7964542482036, 2956.3791603763234, 2964.2589352661835, 2980.2996295870453, 839.4459656626658, 867.9479231246082, 874.3835595904935, 907.3512438606363, 909.1136142261308, 10854.511546980326, 10867.891321086767, 10871.83692244617, 10891.183161262938, 10910.890891091147, 4262.25410553152, 4333.544977777288, 4438.644908407319, 4441.4892287387365, 4461.0, 9256.583453744597, 9321.114494123047, 9326.160645541933, 9329.30030247734, 9334.626614935461, 4848.200046992278, 4913.926291105637, 4934.185859333242, 4951.702897826142, 4952.554270115635, 3811.923761524754, 4250.723702959298, 4328.632066274339, 4352.7823608819435, 4382.970002049516, 3607.9278414431565, 3630.7821530708243, 3719.7210209234418, 3723.590405055442, 3743.2139250757646, 1198.3648666206925, 1233.340163012784, 1238.0219626495148, 1239.8388209532702, 1249.4002878618132, 903.8553831386946, 944.4710961861242, 944.9102335278137, 947.0955237747934, 970.0590427285522, 5488.039593071197, 5575.135853942646, 5645.5483561314995, 5725.627834190765, 5760.567957403212, 858.390542714667, 883.2271762208068, 909.4770506958525, 948.8434408322549, 970.3886551472668, 3702.129999450127, 3758.473813666089, 3801.1447424329303, 3816.198598294334, 3828.0812604974603, 9565.713028609152, 9905.900940990641, 10046.29675922693, 10062.396256224503, 10068.09387155145, 9853.458059806779, 9880.0, 9896.307258491837, 9935.155511781579, 9966.103050725469, 7094.432445404355, 7454.403647708279, 7532.585707786125, 7660.161561225265, 7695.230476952372, 5395.271638328933, 5468.371137319259, 5486.506214440719, 5488.451154884639, 5597.916031259453, 8520.531370774666, 8603.483790972561, 8725.171108744658, 8823.073577274294, 8830.072842351461, 8345.916540834756, 8511.829763404821, 8527.530985795593, 8748.212660860552, 8826.205641492297, 6234.781782637768, 6396.968015159894, 6444.742210311535, 6525.771597994048, 6541.8691626168165, 7216.097987751531, 7231.674574644048, 7289.744858929912, 7309.451791115581, 7313.414926805736, 6436.517261205335, 6610.603363798187, 6611.636360000246, 6669.399754022162, 6729.327067293231, 6550.6069635822005, 6598.571092878948, 6605.504587156079, 6638.0, 6679.599224046573, 5991.7902873399225, 6037.63774173551, 6056.425329414295, 6068.089786531879, 6081.665508397081, 4502.122086193292, 4584.610308123847, 4735.550122738335, 4736.981548966989, 4756.7145971241835, 4532.954670453253, 4614.953850461587, 4620.976895115503, 4713.646476514344, 4722.220833562424], "value": 4211.110743929905, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.11926042980417, 314.3665513989312, 316.36726546906186, 317.0867900446713, 322.64831333846104, 4680.134175177594, 4841.9589788195535, 4845.903081938359, 4915.459299477059, 4923.990581930704, 4637.698549594274, 4769.236922092466, 4785.353977213075, 4813.831515896944, 4825.396825396825, 3793.563740169888, 3837.175007373421, 3840.7119466040017, 3857.556381016177, 3865.0, 3624.4744512045736, 3708.740388172829, 3843.461915331856, 3851.1912498375236, 3866.2074274773745, 3806.847726090953, 3815.67566756826, 3817.0838998640265, 3826.081740382302, 3829.7127715421316, 3820.637039481259, 3821.5796262411113, 3824.4836947012354, 3828.1386687994977, 3851.749636273661, 3441.2429265561536, 3449.8275086245585, 3453.706434953032, 3463.6536346365415, 3468.150303175738, 4536.954630453686, 4600.5629465200755, 4611.0, 4613.538646135393, 4622.676412651116, 4350.369196466526, 4361.367601697768, 4375.0, 4377.846775362847, 4415.845445409427, 5005.349304590416, 5021.748912554358, 5024.371953505812, 5034.924476132861, 5047.4447810740785, 3588.3361578108133, 3736.290104880064, 3744.138848064933, 3753.8310776015146, 3759.548854137521, 5200.167973124319, 5206.661566998133, 5232.345956755444, 5243.097703647102, 5253.185756207794, 3806.8477260909253, 3817.1602247505502, 3836.290286296988, 3844.7308688392104, 3864.516935383077, 3817.84728610858, 3818.243607940323, 3908.905506458196, 3914.3345631242755, 3923.3330333843314, 4326.805293761789, 4349.847755328548, 4360.738355698668, 4362.1493808707, 4386.969062270364, 5001.399832020181, 5040.571551418097, 5050.898982020339, 5089.8727531812, 5095.490450954875, 1263.5009171377255, 1293.5925183567147, 1316.2628927800463, 1332.5735764555443, 1332.700142467937, 867.2758246863813, 878.5563290538237, 881.7751473374377, 883.5891310540501, 894.8970868350093, 3893.7079719021185, 3930.7248492605813, 3945.585713500041, 3945.940810887839, 3951.1900060487533, 4567.406237189144, 4589.682210483751, 4592.265237561974, 4612.723236605814, 4615.930761038587, 3897.824597893102, 3918.2555314490155, 3930.6069393060466, 3953.367461206193, 3964.286428442908, 2352.8235382346393, 2397.8419422519523, 2425.357280320716, 2439.524292762894, 2457.82795204334, 4302.376155457441, 4306.083792712276, 4331.306990881444, 4349.804258808361, 4378.693491455568, 4626.976865115653, 4648.814047438064, 4691.296305554194, 4709.458412282563, 4721.5750582447745, 3984.7237377244664, 4343.891402714958, 4349.369341445473, 4368.645719826864, 4370.366296886998, 4493.752843593634, 4539.97730011361, 4584.670445570747, 4621.584057434847, 4647.953520464887, 4489.708168969007, 4493.955060449484, 4503.301988191835, 4509.278515437645, 4532.5694059064335, 4120.690948178839, 4330.9133817322845, 4354.433923589913, 4362.7818609070055, 4365.236083685406, 3440.638732933006, 3445.1903802606867, 3473.947890781691, 3479.94780078294, 3480.164760457523, 4569.634429245719, 4593.356930029865, 4600.217962946374, 4611.193041217706, 4955.950440495549, 4844.539768721966, 5021.472745361684, 5030.8239211627415, 5042.168042272984, 5055.562217692005, 5022.673526220784, 5051.292819005415, 5054.241863720471, 5059.077550530775, 5060.51925067118, 4755.904881902412, 4974.228994505857, 4980.701157930535, 4997.575206107522, 5001.924971125509, 5047.949520504748, 5067.6199285053035, 5089.414717307557, 5110.821121260738, 5118.667286626357, 4992.850214493571, 4996.225585034325, 5012.147934851011, 5014.222795466709, 5061.266116413173], "value": 3693.516910216627, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.5522865366166, 714.5962531169889, 722.1226210154662, 728.8870225115103, 735.2280105888817, 10910.345379277249, 10954.39750813705, 10956.28784129031, 10973.83539246912, 11006.724831879197, 10740.0, 12133.090018248622, 12385.752284954295, 12509.437075331609, 13081.28052957087, 689.9275576064516, 880.5773228850139, 883.5493898111977, 889.0842432294746, 889.1153302464057, 839.4627438439373, 867.5445391169624, 868.5483548554748, 871.7384784564637, 872.1845074855031, 891.4740303221098, 894.8076163624819, 895.9641614335419, 896.6816780043089, 896.6861598440527, 713.3009650542446, 724.1635910523302, 889.8754174415587, 890.1943740914483, 890.1943740914483, 544.7358031354789, 545.2747845365654, 646.5668002438377, 658.8781075501, 663.515633587479, 11032.779344413148, 11115.833262500988, 11129.387883666395, 11138.721531961684, 11202.551897924073, 11675.182737208399, 11924.940375298154, 11996.58011969577, 12290.20113692607, 12608.81086783699, 11112.944435277852, 11343.773124537463, 11370.772584548346, 11471.483783229774, 11782.293062416196, 4038.4749982502085, 4042.3532234842282, 4135.6898232632375, 4153.605407486284, 4178.415021896937, 38747.61252387497, 39201.0, 39560.80219598913, 39636.60363396358, 39876.4018539725, 9897.901020989842, 10245.334053286513, 10308.639197628047, 10309.639162629423, 10379.896201037893, 17452.389166379115, 17485.30058797659, 17522.91238543799, 17538.912305438393, 17541.64916701659, 6946.131733533309, 7118.60847653384, 7210.0, 7231.962238705415, 7253.492255542167, 3792.791396473165, 3809.504764380613, 3892.5718171001167, 3924.2151569686175, 3992.8003599819895, 2788.121741651373, 2899.7825163112852, 2906.491364011332, 2907.767378609706, 2908.607338009384, 481.7061592428616, 488.36024807501576, 489.1586471269411, 493.543472288132, 520.053502625226, 579.2151634535144, 589.5401586762332, 614.3365165621118, 623.513659345702, 628.538024551954, 8176.550289734122, 8391.118932512121, 8464.661413543512, 8516.361272904556, 8646.683927504506, 603.667982609563, 609.1106983803608, 620.824482770625, 634.3339493531773, 665.4776000839317, 3817.751846129993, 3929.587393323717, 4033.4756481657196, 4037.0, 4053.6959728020515, 46478.30282545764, 47682.761586191846, 49046.0, 49707.50292497101, 49979.25031124536, 42078.36882446766, 43893.0, 44104.558954410684, 45049.0, 45093.09813803706, 38746.806265969055, 40006.0, 42311.57688423138, 45272.3209151863, 45343.773281133384, 8362.540060296498, 8517.44636598619, 8535.231829135408, 8546.915402676957, 8581.313494920516, 28979.377577802774, 29356.266093347836, 29732.851335743184, 30207.69792302049, 30530.236744081576, 35604.0, 37431.43852842155, 37609.43585846269, 37647.81176094102, 38132.80933595314, 10322.432266225429, 10358.637447689294, 10369.481525923824, 10758.0, 11130.610428635282, 11747.941260293645, 11923.642290731292, 12120.151589388659, 12471.251724896536, 12519.812202816784, 11036.448177591248, 11743.647690569296, 11811.0, 11812.0, 11861.822072668745, 11218.775624487627, 11266.267692599955, 11350.148738844455, 12017.879821201675, 12040.75918481608, 11260.94369528147, 11283.717907052389, 11750.529978800752, 11896.107791915469, 11935.641930742091, 8936.821263574822, 9030.051844556227, 9114.179723824887, 9253.120953509406, 9354.95322523383, 9045.864312035194, 9206.17144457002, 9298.302627303116, 9353.362514922295, 9491.098345657152], "value": 6003.173037656246, "unit": "score"}], "name": "dromaeo_css", "value": 6357.798745069611, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 113.0, 116.0, 112.0, 113.0, 115.0, 115.0, 113.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 130.0, 154.0, 225.0, 131.0, 161.0, 159.0, 133.0, 195.0, 137.0], "value": 158.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 159.0, 162.0, 163.0, 164.0, 163.0, 161.0, 161.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 149.0, 76.0, 75.0, 77.0, 75.0, 133.0, 76.0], "value": 89.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 149.0, 93.0, 92.0, 93.0, 131.0, 94.0, 95.0, 121.0], "value": 105.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 82.0, 68.0, 68.0, 68.0, 68.0, 67.0, 67.0, 69.0, 68.0], "value": 69.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 65.0, 64.0, 65.0, 64.0, 72.0, 64.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 81.0, 87.0, 87.0, 85.0, 81.0, 83.0, 159.0, 83.0], "value": 91.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 133.0, 138.0, 129.0, 129.0, 129.0, 130.0, 131.0, 151.0, 134.0], "value": 134.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 172.0, 186.0, 181.0, 182.0, 173.0, 172.0, 173.0, 176.0, 172.0], "value": 176.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 71.0, 67.0, 66.0, 72.0, 67.0, 70.0, 69.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1590.4, "alertThreshold": 2.0}]} 17:35:51 INFO - Return code: 0 17:35:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:35:51 ERROR - # TBPL SUCCESS # 17:35:51 INFO - Running post-action listener: _resource_record_post_action 17:35:51 INFO - ##### 17:35:51 INFO - ##### Finished run-tests step (success) 17:35:51 INFO - ##### 17:35:51 INFO - Running post-run listener: _resource_record_post_run 17:35:52 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 8192; Write bytes: 528420864; Read time: 372; Write time: 782612 17:35:52 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 4096; Write bytes: 234893312; Read time: 352; Write time: 513560 17:35:52 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293527552; Read time: 20; Write time: 269052 17:35:52 INFO - Running post-run listener: _upload_blobber_files 17:35:52 INFO - Blob upload gear active. 17:35:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:35:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:35:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:35:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:35:53 INFO - (blobuploader) - INFO - Open directory for files ... 17:35:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:35:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:35:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:35:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:35:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:35:53 INFO - (blobuploader) - INFO - Done attempting. 17:35:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:35:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:35:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:35:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:35:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:35:54 INFO - (blobuploader) - INFO - Done attempting. 17:35:54 INFO - (blobuploader) - INFO - Iteration through files over. 17:35:54 INFO - Return code: 0 17:35:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:35:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:35:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c3e47c21478d2952f5e9a4bb9eb736a8988b0c337c2291143d471ce2682b4a98fcfb288428ec3aedbd6ce430bf40c7e4afead7e57e941424b6f282eca24351af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05f871c9da1b27f52e732adcb2d92a3034ca8ec0a17bad6ab9ef19b81fbc11a407a1c3faf64dcfdd3c453eb902742fc5d58eb487647ea7737ed716e1129eeb71"} 17:35:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:35:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:35:54 INFO - Contents: 17:35:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c3e47c21478d2952f5e9a4bb9eb736a8988b0c337c2291143d471ce2682b4a98fcfb288428ec3aedbd6ce430bf40c7e4afead7e57e941424b6f282eca24351af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05f871c9da1b27f52e732adcb2d92a3034ca8ec0a17bad6ab9ef19b81fbc11a407a1c3faf64dcfdd3c453eb902742fc5d58eb487647ea7737ed716e1129eeb71"} 17:35:54 INFO - Running post-run listener: copy_logs_to_upload_dir 17:35:54 INFO - Copying logs to upload dir... 17:35:54 INFO - mkdir: /builds/slave/test/build/upload/logs 17:35:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.755758 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-10 17:35:54.014755) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 17:35:54.018121) ========= 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=af724c981e2a0f424dbabf99000001e7-1462925712.532339-811817722 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/c3e47c21478d2952f5e9a4bb9eb736a8988b0c337c2291143d471ce2682b4a98fcfb288428ec3aedbd6ce430bf40c7e4afead7e57e941424b6f282eca24351af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05f871c9da1b27f52e732adcb2d92a3034ca8ec0a17bad6ab9ef19b81fbc11a407a1c3faf64dcfdd3c453eb902742fc5d58eb487647ea7737ed716e1129eeb71"} build_url:https://queue.taskcluster.net/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011149 build_url: 'https://queue.taskcluster.net/v1/task/SaS-PAYrS9qHyL0A2DmcKg/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/c3e47c21478d2952f5e9a4bb9eb736a8988b0c337c2291143d471ce2682b4a98fcfb288428ec3aedbd6ce430bf40c7e4afead7e57e941424b6f282eca24351af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05f871c9da1b27f52e732adcb2d92a3034ca8ec0a17bad6ab9ef19b81fbc11a407a1c3faf64dcfdd3c453eb902742fc5d58eb487647ea7737ed716e1129eeb71"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 17:35:54.042553) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 17:35:54.042887) ========= 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=af724c981e2a0f424dbabf99000001e7-1462925712.532339-811817722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004750 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 17:35:54.125590) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 17:35:54.125963) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 17:35:54.126257) ========= ========= Total master_lag: 0.16 =========