builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-026 starttime: 1467015304.64 results: success (0) buildid: 20160627003524 builduid: c8792aa359c54ce0b6dc0a6ebc3b901a revision: 8f48d2f1fa58dbb978abc28051f3550724800b2f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 01:15:04.640908) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 01:15:04.641355) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 01:15:04.641976) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 01:15:04.688224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:15:04.688514) ========= 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=41bf3e9aed84707956354da8000001c5-1467004802.250994-1220753862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 01:15:05-- 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% 88.2M=0s 2016-06-27 01:15:05 (88.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117965 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:15:04.836720) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:15:04.837025) ========= 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=41bf3e9aed84707956354da8000001c5-1467004802.250994-1220753862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015272 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:15:04.901570) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 01:15:04.901904) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8f48d2f1fa58dbb978abc28051f3550724800b2f --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 8f48d2f1fa58dbb978abc28051f3550724800b2f --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=41bf3e9aed84707956354da8000001c5-1467004802.250994-1220753862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 01:15:05,753 truncating revision to first 12 chars 2016-06-27 01:15:05,753 Setting DEBUG logging. 2016-06-27 01:15:05,754 attempt 1/10 2016-06-27 01:15:05,754 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8f48d2f1fa58?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 01:15:06,557 unpacking tar archive at: fx-team-8f48d2f1fa58/testing/mozharness/ program finished with exit code 0 elapsedTime=1.187556 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 01:15:06.105162) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 01:15:06.105514) ========= script_repo_revision: 8f48d2f1fa58dbb978abc28051f3550724800b2f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 01:15:06.105943) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 01:15:06.106238) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 01:15:06.114336) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-27 01:15:06.114635) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1467004802.250994-1220753862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:15:07 INFO - MultiFileLogger online at 20160627 01:15:07 in /builds/slave/test 01:15:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 01:15:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:15:07 INFO - {'append_to_log': False, 01:15:07 INFO - 'base_work_dir': '/builds/slave/test', 01:15:07 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:15:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:15:07 INFO - 'branch': 'Fx-Team-Non-PGO', 01:15:07 INFO - 'buildbot_json_path': 'buildprops.json', 01:15:07 INFO - 'config_files': ('talos/linux_config.py',), 01:15:07 INFO - 'default_actions': ('clobber', 01:15:07 INFO - 'read-buildbot-config', 01:15:07 INFO - 'download-and-extract', 01:15:07 INFO - 'populate-webroot', 01:15:07 INFO - 'create-virtualenv', 01:15:07 INFO - 'install', 01:15:07 INFO - 'run-tests'), 01:15:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:15:07 INFO - 'download_minidump_stackwalk': True, 01:15:07 INFO - 'download_symbols': 'ondemand', 01:15:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:15:07 INFO - 'tooltool.py': '/tools/tooltool.py', 01:15:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:15:07 INFO - '/tools/misc-python/virtualenv.py')}, 01:15:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:15:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:15:07 INFO - 'installer_path': 'installer.exe', 01:15:07 INFO - 'log_level': 'info', 01:15:07 INFO - 'log_name': 'talos', 01:15:07 INFO - 'log_to_console': True, 01:15:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:15:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:15:07 INFO - 'opt_config_files': (), 01:15:07 INFO - 'pip_index': False, 01:15:07 INFO - 'sps_profile': False, 01:15:07 INFO - 'sps_profile_interval': 0, 01:15:07 INFO - 'suite': 'dromaeojs-e10s', 01:15:07 INFO - 'system_bits': '32', 01:15:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:15:07 INFO - 'title': 'talos-linux64-ix-026', 01:15:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:15:07 INFO - 'use_talos_json': True, 01:15:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:15:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:15:07 INFO - 'work_dir': 'build'} 01:15:07 INFO - ##### 01:15:07 INFO - ##### Running clobber step. 01:15:07 INFO - ##### 01:15:07 INFO - Running pre-action listener: _resource_record_pre_action 01:15:07 INFO - Running main action method: clobber 01:15:07 INFO - rmtree: /builds/slave/test/build 01:15:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:15:07 INFO - Running post-action listener: _resource_record_post_action 01:15:07 INFO - ##### 01:15:07 INFO - ##### Finished clobber step (success) 01:15:07 INFO - ##### 01:15:07 INFO - ##### 01:15:07 INFO - ##### Running read-buildbot-config step. 01:15:07 INFO - ##### 01:15:07 INFO - Running pre-action listener: _resource_record_pre_action 01:15:07 INFO - Running main action method: read_buildbot_config 01:15:07 INFO - Using buildbot properties: 01:15:07 INFO - { 01:15:07 INFO - "project": "", 01:15:07 INFO - "product": "firefox", 01:15:07 INFO - "script_repo_revision": "production", 01:15:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 01:15:07 INFO - "repository": "", 01:15:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 01:15:07 INFO - "buildid": "20160627003524", 01:15:07 INFO - "pgo_build": "False", 01:15:07 INFO - "basedir": "/builds/slave/test", 01:15:07 INFO - "buildnumber": 1435, 01:15:07 INFO - "slavename": "talos-linux64-ix-026", 01:15:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:15:07 INFO - "platform": "ubuntu64_hw", 01:15:07 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:15:07 INFO - "branch": "fx-team", 01:15:07 INFO - "repo_path": "integration/fx-team", 01:15:07 INFO - "revision": "8f48d2f1fa58dbb978abc28051f3550724800b2f", 01:15:07 INFO - "stage_platform": "linux64", 01:15:07 INFO - "builduid": "c8792aa359c54ce0b6dc0a6ebc3b901a", 01:15:07 INFO - "slavebuilddir": "test" 01:15:07 INFO - } 01:15:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:15:07 INFO - Running post-action listener: _resource_record_post_action 01:15:07 INFO - ##### 01:15:07 INFO - ##### Finished read-buildbot-config step (success) 01:15:07 INFO - ##### 01:15:07 INFO - ##### 01:15:07 INFO - ##### Running download-and-extract step. 01:15:07 INFO - ##### 01:15:07 INFO - Running pre-action listener: _resource_record_pre_action 01:15:07 INFO - Running main action method: download_and_extract 01:15:07 INFO - mkdir: /builds/slave/test/build/tests 01:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:15:07 INFO - https://queue.taskcluster.net/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:15:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:15:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:15:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:15:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:15:10 INFO - Downloaded 1361 bytes. 01:15:10 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:15:10 INFO - Using the following test package requirements: 01:15:10 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:15:10 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:15:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:15:10 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:15:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:15:10 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:15:10 INFO - u'jsshell-linux-x86_64.zip'], 01:15:10 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:15:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:15:10 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:15:10 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:15:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:15:10 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:15:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:15:10 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:15:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:15:10 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:15:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:15:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:15:10 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')]} 01:15:10 INFO - https://queue.taskcluster.net/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:15:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:15:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:15:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:15:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:15:11 INFO - Downloaded 22712973 bytes. 01:15:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:15:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:15:13 INFO - Return code: 0 01:15:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:15:13 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')]} 01:15:13 INFO - https://queue.taskcluster.net/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:15:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:15:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:15:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:15:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:15:15 INFO - Downloaded 22712973 bytes. 01:15:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:15:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:15:17 INFO - Return code: 0 01:15:17 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')]} 01:15:17 INFO - https://queue.taskcluster.net/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:15:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:15:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:15:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:15:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:15:18 INFO - Downloaded 14405240 bytes. 01:15:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:15:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:15:18 INFO - Return code: 0 01: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')]} 01:15:18 INFO - https://queue.taskcluster.net/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:15:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:15:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:15:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:15:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:15:20 INFO - Downloaded 56273143 bytes. 01:15:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:15:20 INFO - mkdir: /builds/slave/test/properties 01:15:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:15:20 INFO - Writing to file /builds/slave/test/properties/build_url 01:15:20 INFO - Contents: 01:15:20 INFO - build_url:https://queue.taskcluster.net/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:15:21 INFO - Running post-action listener: _resource_record_post_action 01:15:21 INFO - Running post-action listener: set_extra_try_arguments 01:15:21 INFO - ##### 01:15:21 INFO - ##### Finished download-and-extract step (success) 01:15:21 INFO - ##### 01:15:21 INFO - ##### 01:15:21 INFO - ##### Running populate-webroot step. 01:15:21 INFO - ##### 01:15:21 INFO - Running pre-action listener: _resource_record_pre_action 01:15:21 INFO - Running main action method: populate_webroot 01:15:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:15:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:15:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:15:21 INFO - '--tppagecycles', 01:15:21 INFO - '7'], 01:15:21 INFO - 'tests': ['tsvgm']}}, 01:15:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:15:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:15:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:15:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:15:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:15:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:15:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:15:21 INFO - 'talos_options': ['--disable-e10s'], 01:15:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:15:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:15:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:15:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:15:21 INFO - 'talos_options': ['--disable-e10s'], 01:15:21 INFO - 'tests': ['damp', 'tps']}, 01:15:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:15:21 INFO - 'tests': ['damp', 'tps']}, 01:15:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:15:21 INFO - 'tests': ['dromaeo_dom']}, 01:15:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:15:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:15:21 INFO - 'tests': ['basic_compositor_video']}, 01:15:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:15:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:15:21 INFO - 'tests': ['a11yr', 01:15:21 INFO - 'ts_paint', 01:15:21 INFO - 'tpaint', 01:15:21 INFO - 'sessionrestore', 01:15:21 INFO - 'sessionrestore_no_auto_restore', 01:15:21 INFO - 'tabpaint']}, 01:15:21 INFO - 'other-e10s': {'tests': ['a11yr', 01:15:21 INFO - 'ts_paint', 01:15:21 INFO - 'tpaint', 01:15:21 INFO - 'sessionrestore', 01:15:21 INFO - 'sessionrestore_no_auto_restore', 01:15:21 INFO - 'tabpaint']}, 01:15:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:15:21 INFO - 'ts_paint', 01:15:21 INFO - 'tpaint', 01:15:21 INFO - 'sessionrestore', 01:15:21 INFO - 'sessionrestore_no_auto_restore', 01:15:21 INFO - 'tabpaint']}, 01:15:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:15:21 INFO - 'ts_paint', 01:15:21 INFO - 'tpaint', 01:15:21 INFO - 'sessionrestore', 01:15:21 INFO - 'sessionrestore_no_auto_restore', 01:15:21 INFO - 'tabpaint']}, 01:15:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:15:21 INFO - 'tests': ['a11yr', 01:15:21 INFO - 'ts_paint', 01:15:21 INFO - 'tpaint', 01:15:21 INFO - 'sessionrestore', 01:15:21 INFO - 'sessionrestore_no_auto_restore', 01:15:21 INFO - 'tabpaint']}, 01:15:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:15:21 INFO - 'tests': ['a11yr', 01:15:21 INFO - 'ts_paint', 01:15:21 INFO - 'tpaint', 01:15:21 INFO - 'sessionrestore', 01:15:21 INFO - 'sessionrestore_no_auto_restore', 01:15:21 INFO - 'tabpaint']}, 01:15:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:15:21 INFO - 'tests': ['tsvgx', 01:15:21 INFO - 'tsvgr_opacity', 01:15:21 INFO - 'tart', 01:15:21 INFO - 'tscrollx', 01:15:21 INFO - 'cart']}, 01:15:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:15:21 INFO - 'tsvgr_opacity', 01:15:21 INFO - 'tart', 01:15:21 INFO - 'tscrollx', 01:15:21 INFO - 'cart']}, 01:15:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:15:21 INFO - 'talos_options': ['--disable-e10s'], 01:15:21 INFO - 'tests': ['tp5o']}, 01:15:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:15:21 INFO - 'tests': ['tp5o']}, 01:15:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:15:21 INFO - 'talos_options': ['--disable-e10s', 01:15:21 INFO - '--xperf_path', 01:15:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:15:21 INFO - 'tests': ['tp5n']}, 01:15:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:15:21 INFO - 'talos_options': ['--xperf_path', 01:15:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:15:21 INFO - 'tests': ['tp5n']}}, 01:15:21 INFO - 'talos.zip': {'path': '', 01:15:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:15:21 INFO - Running post-action listener: _resource_record_post_action 01:15:21 INFO - ##### 01:15:21 INFO - ##### Finished populate-webroot step (success) 01:15:21 INFO - ##### 01:15:21 INFO - ##### 01:15:21 INFO - ##### Running create-virtualenv step. 01:15:21 INFO - ##### 01:15:21 INFO - Running pre-action listener: _resource_record_pre_action 01:15:21 INFO - Running main action method: create_virtualenv 01:15:21 INFO - Creating virtualenv /builds/slave/test/build/venv 01:15:21 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 01:15:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:15:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:15:21 INFO - Using real prefix '/usr' 01:15:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:15:22 INFO - Installing distribute.............................................................................................................................................................................................done. 01:15:24 INFO - Installing pip.................done. 01:15:24 INFO - Return code: 0 01:15:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:15:24 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')]} 01:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:24 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')]} 01:15:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:24 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 0x7f5b91d12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd96f0>, '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 0xdda5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddaaa0>, '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': '41bf3e9aed84707956354da8000001c5-1467004802.250994-1220753862', '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 01:15:24 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 01:15:24 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 01:15:24 INFO - Using env: {'DISPLAY': ':0', 01:15:24 INFO - 'HOME': '/home/cltbld', 01:15:24 INFO - 'LANG': 'en_US.UTF-8', 01:15:24 INFO - 'LANGUAGE': 'en_US:en', 01:15:24 INFO - 'LOGNAME': 'cltbld', 01:15:24 INFO - 'MAIL': '/var/mail/cltbld', 01:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:24 INFO - 'MOZ_NO_REMOTE': '1', 01:15:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:24 INFO - 'NO_EM_RESTART': '1', 01:15:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:24 INFO - 'PWD': '/builds/slave/test', 01:15:24 INFO - 'SHELL': '/bin/bash', 01:15:24 INFO - 'SHLVL': '1', 01:15:24 INFO - 'TERM': 'linux', 01:15:24 INFO - 'TMOUT': '86400', 01:15:24 INFO - 'USER': 'cltbld', 01:15:24 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467004802.250994-1220753862', 01:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:24 INFO - '_': '/tools/buildbot/bin/python'} 01:15:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:24 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 01:15:24 INFO - Cleaning up... 01:15:24 INFO - Return code: 0 01:15:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:15:24 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')]} 01:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:24 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')]} 01:15:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:24 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5b91d12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd96f0>, '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 0xdda5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddaaa0>, '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': '41bf3e9aed84707956354da8000001c5-1467004802.250994-1220753862', '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 01:15:24 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>=3.1.1'] in /builds/slave/test/build 01:15:24 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>=3.1.1 01:15:24 INFO - Using env: {'DISPLAY': ':0', 01:15:24 INFO - 'HOME': '/home/cltbld', 01:15:24 INFO - 'LANG': 'en_US.UTF-8', 01:15:24 INFO - 'LANGUAGE': 'en_US:en', 01:15:24 INFO - 'LOGNAME': 'cltbld', 01:15:24 INFO - 'MAIL': '/var/mail/cltbld', 01:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:24 INFO - 'MOZ_NO_REMOTE': '1', 01:15:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:24 INFO - 'NO_EM_RESTART': '1', 01:15:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:24 INFO - 'PWD': '/builds/slave/test', 01:15:24 INFO - 'SHELL': '/bin/bash', 01:15:24 INFO - 'SHLVL': '1', 01:15:24 INFO - 'TERM': 'linux', 01:15:24 INFO - 'TMOUT': '86400', 01:15:24 INFO - 'USER': 'cltbld', 01:15:24 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467004802.250994-1220753862', 01:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:24 INFO - '_': '/tools/buildbot/bin/python'} 01:15:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:24 INFO - Downloading/unpacking psutil>=3.1.1 01:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:15:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:15:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:15:26 INFO - Installing collected packages: psutil 01:15:26 INFO - Running setup.py install for psutil 01:15:26 INFO - building 'psutil._psutil_linux' extension 01:15:26 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 01:15:26 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 01:15:26 INFO - building 'psutil._psutil_posix' extension 01:15:26 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 01:15:26 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 01:15:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:15:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:15:27 INFO - Successfully installed psutil 01:15:27 INFO - Cleaning up... 01:15:27 INFO - Return code: 0 01:15:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:15:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5b91d12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd96f0>, '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 0xdda5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddaaa0>, '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': '41bf3e9aed84707956354da8000001c5-1467004802.250994-1220753862', '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 01:15:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:15:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:15:27 INFO - Using env: {'DISPLAY': ':0', 01:15:27 INFO - 'HOME': '/home/cltbld', 01:15:27 INFO - 'LANG': 'en_US.UTF-8', 01:15:27 INFO - 'LANGUAGE': 'en_US:en', 01:15:27 INFO - 'LOGNAME': 'cltbld', 01:15:27 INFO - 'MAIL': '/var/mail/cltbld', 01:15:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:27 INFO - 'MOZ_NO_REMOTE': '1', 01:15:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:27 INFO - 'NO_EM_RESTART': '1', 01:15:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:27 INFO - 'PWD': '/builds/slave/test', 01:15:27 INFO - 'SHELL': '/bin/bash', 01:15:27 INFO - 'SHLVL': '1', 01:15:27 INFO - 'TERM': 'linux', 01:15:27 INFO - 'TMOUT': '86400', 01:15:27 INFO - 'USER': 'cltbld', 01:15:27 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467004802.250994-1220753862', 01:15:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:27 INFO - '_': '/tools/buildbot/bin/python'} 01:15:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 01: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 01: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 01: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 01: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 01: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 01: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 01:15:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:15:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:15:29 INFO - Installing collected packages: mozsystemmonitor 01:15:29 INFO - Running setup.py install for mozsystemmonitor 01:15:29 INFO - Successfully installed mozsystemmonitor 01:15:29 INFO - Cleaning up... 01:15:29 INFO - Return code: 0 01:15:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01: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')]} 01:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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')]} 01:15:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5b91d12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd96f0>, '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 0xdda5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddaaa0>, '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': '41bf3e9aed84707956354da8000001c5-1467004802.250994-1220753862', '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 01: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 01: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 jsonschema==2.5.1 01:15:29 INFO - Using env: {'DISPLAY': ':0', 01:15:29 INFO - 'HOME': '/home/cltbld', 01:15:29 INFO - 'LANG': 'en_US.UTF-8', 01:15:29 INFO - 'LANGUAGE': 'en_US:en', 01:15:29 INFO - 'LOGNAME': 'cltbld', 01:15:29 INFO - 'MAIL': '/var/mail/cltbld', 01:15:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:29 INFO - 'MOZ_NO_REMOTE': '1', 01:15:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:29 INFO - 'NO_EM_RESTART': '1', 01:15:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:29 INFO - 'PWD': '/builds/slave/test', 01:15:29 INFO - 'SHELL': '/bin/bash', 01:15:29 INFO - 'SHLVL': '1', 01:15:29 INFO - 'TERM': 'linux', 01:15:29 INFO - 'TMOUT': '86400', 01:15:29 INFO - 'USER': 'cltbld', 01:15:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467004802.250994-1220753862', 01:15:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:29 INFO - '_': '/tools/buildbot/bin/python'} 01:15:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:29 INFO - Downloading/unpacking jsonschema==2.5.1 01: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 01: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 01: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 01: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 01: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 01: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 01:15:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:15:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:15:31 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 01:15:31 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 01:15:31 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 01:15:31 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 01:15:31 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 01:15:31 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 01:15:31 INFO - Downloading functools32-3.2.3-2.tar.gz 01:15:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:15:31 INFO - warning: no files found matching '*.txt' 01:15:31 INFO - no previously-included directories found matching 'build' 01:15:31 INFO - no previously-included directories found matching 'dist' 01:15:31 INFO - no previously-included directories found matching '.git*' 01:15:31 INFO - Installing collected packages: jsonschema, functools32 01:15:31 INFO - Running setup.py install for functools32 01:15:31 INFO - warning: no files found matching '*.txt' 01:15:31 INFO - no previously-included directories found matching 'build' 01:15:31 INFO - no previously-included directories found matching 'dist' 01:15:31 INFO - no previously-included directories found matching '.git*' 01:15:31 INFO - Successfully installed jsonschema functools32 01:15:31 INFO - Cleaning up... 01:15:31 INFO - Return code: 0 01:15:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01: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')]} 01:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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')]} 01:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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 0x7f5b91d12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd96f0>, '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 0xdda5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddaaa0>, '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': '41bf3e9aed84707956354da8000001c5-1467004802.250994-1220753862', '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 01: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 01: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 01:15:31 INFO - Using env: {'DISPLAY': ':0', 01:15:31 INFO - 'HOME': '/home/cltbld', 01:15:31 INFO - 'LANG': 'en_US.UTF-8', 01:15:31 INFO - 'LANGUAGE': 'en_US:en', 01:15:31 INFO - 'LOGNAME': 'cltbld', 01:15:31 INFO - 'MAIL': '/var/mail/cltbld', 01:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:31 INFO - 'MOZ_NO_REMOTE': '1', 01:15:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:31 INFO - 'NO_EM_RESTART': '1', 01:15:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:31 INFO - 'PWD': '/builds/slave/test', 01:15:31 INFO - 'SHELL': '/bin/bash', 01:15:31 INFO - 'SHLVL': '1', 01:15:31 INFO - 'TERM': 'linux', 01:15:31 INFO - 'TMOUT': '86400', 01:15:31 INFO - 'USER': 'cltbld', 01:15:31 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467004802.250994-1220753862', 01:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:31 INFO - '_': '/tools/buildbot/bin/python'} 01:15:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:32 INFO - Downloading/unpacking blobuploader==1.2.4 01: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 01: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 01: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 01: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 01: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 01: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 01:15:33 INFO - Downloading blobuploader-1.2.4.tar.gz 01:15:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:15:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01: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 01: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 01: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 01: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 01: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 01: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 01:15:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:15:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01: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 01: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 01: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 01: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 01: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 01: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 01:15:34 INFO - Downloading docopt-0.6.1.tar.gz 01:15:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:15:34 INFO - Installing collected packages: blobuploader, requests, docopt 01:15:34 INFO - Running setup.py install for blobuploader 01:15:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:15:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:15:34 INFO - Running setup.py install for requests 01:15:35 INFO - Running setup.py install for docopt 01:15:35 INFO - Successfully installed blobuploader requests docopt 01:15:35 INFO - Cleaning up... 01:15:35 INFO - Return code: 0 01:15:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01: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')]} 01:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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')]} 01:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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 0x7f5b91d12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd96f0>, '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 0xdda5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddaaa0>, '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': '41bf3e9aed84707956354da8000001c5-1467004802.250994-1220753862', '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 01: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 01: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 01:15:35 INFO - Using env: {'DISPLAY': ':0', 01:15:35 INFO - 'HOME': '/home/cltbld', 01:15:35 INFO - 'LANG': 'en_US.UTF-8', 01:15:35 INFO - 'LANGUAGE': 'en_US:en', 01:15:35 INFO - 'LOGNAME': 'cltbld', 01:15:35 INFO - 'MAIL': '/var/mail/cltbld', 01:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:35 INFO - 'MOZ_NO_REMOTE': '1', 01:15:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:35 INFO - 'NO_EM_RESTART': '1', 01:15:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:35 INFO - 'PWD': '/builds/slave/test', 01:15:35 INFO - 'SHELL': '/bin/bash', 01:15:35 INFO - 'SHLVL': '1', 01:15:35 INFO - 'TERM': 'linux', 01:15:35 INFO - 'TMOUT': '86400', 01:15:35 INFO - 'USER': 'cltbld', 01:15:35 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467004802.250994-1220753862', 01:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:35 INFO - '_': '/tools/buildbot/bin/python'} 01:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:15:35 INFO - Running setup.py (path:/tmp/pip-Ykr8mc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:15:35 INFO - Running setup.py (path:/tmp/pip-1BoZeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:15:35 INFO - Running setup.py (path:/tmp/pip-IRhIZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:15:35 INFO - Running setup.py (path:/tmp/pip-s0wEj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:15:35 INFO - Running setup.py (path:/tmp/pip-CEMxQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:15:35 INFO - Running setup.py (path:/tmp/pip-N3KQ3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:15:36 INFO - Running setup.py (path:/tmp/pip-f8YkNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:15:36 INFO - Running setup.py (path:/tmp/pip-of_sQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:15:36 INFO - Running setup.py (path:/tmp/pip-BcDcLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:15:36 INFO - Running setup.py (path:/tmp/pip-VSAwYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:15:36 INFO - Running setup.py (path:/tmp/pip-fLZjys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:15:36 INFO - Running setup.py (path:/tmp/pip-2LLSlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:15:36 INFO - Running setup.py (path:/tmp/pip-eFB7Yc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:15:36 INFO - Running setup.py (path:/tmp/pip-8e2IV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:15:36 INFO - Running setup.py (path:/tmp/pip-gYBSBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:15:36 INFO - Running setup.py (path:/tmp/pip-x0IUXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:15:36 INFO - Running setup.py (path:/tmp/pip-W1HoWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:15:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:15:36 INFO - Running setup.py install for manifestparser 01:15:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:15:36 INFO - Running setup.py install for mozcrash 01:15:37 INFO - Running setup.py install for mozdebug 01:15:37 INFO - Running setup.py install for mozdevice 01:15:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:15:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:15:37 INFO - Running setup.py install for mozfile 01:15:37 INFO - Running setup.py install for mozhttpd 01:15:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:15:37 INFO - Running setup.py install for mozinfo 01:15:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:15:37 INFO - Running setup.py install for mozInstall 01:15:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:15:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:15:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:15:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:15:37 INFO - Running setup.py install for mozleak 01:15:37 INFO - Running setup.py install for mozlog 01:15:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:15:37 INFO - Running setup.py install for moznetwork 01:15:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:15:37 INFO - Running setup.py install for mozprocess 01:15:38 INFO - Running setup.py install for mozprofile 01:15:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:15:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:15:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:15:38 INFO - Running setup.py install for mozrunner 01:15:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:15:38 INFO - Running setup.py install for mozscreenshot 01:15:38 INFO - Running setup.py install for moztest 01:15:38 INFO - Running setup.py install for mozversion 01:15:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:15:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:15:38 INFO - Cleaning up... 01:15:38 INFO - Return code: 0 01:15:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01: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')]} 01:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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')]} 01:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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 0x7f5b91d12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd96f0>, '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 0xdda5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddaaa0>, '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': '41bf3e9aed84707956354da8000001c5-1467004802.250994-1220753862', '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 01: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 01: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 01:15:38 INFO - Using env: {'DISPLAY': ':0', 01:15:38 INFO - 'HOME': '/home/cltbld', 01:15:38 INFO - 'LANG': 'en_US.UTF-8', 01:15:38 INFO - 'LANGUAGE': 'en_US:en', 01:15:38 INFO - 'LOGNAME': 'cltbld', 01:15:38 INFO - 'MAIL': '/var/mail/cltbld', 01:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:38 INFO - 'MOZ_NO_REMOTE': '1', 01:15:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:38 INFO - 'NO_EM_RESTART': '1', 01:15:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:38 INFO - 'PWD': '/builds/slave/test', 01:15:38 INFO - 'SHELL': '/bin/bash', 01:15:38 INFO - 'SHLVL': '1', 01:15:38 INFO - 'TERM': 'linux', 01:15:38 INFO - 'TMOUT': '86400', 01:15:38 INFO - 'USER': 'cltbld', 01:15:38 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467004802.250994-1220753862', 01:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:38 INFO - '_': '/tools/buildbot/bin/python'} 01:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:15:38 INFO - Running setup.py (path:/tmp/pip-JmH7hs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01: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)) 01:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:15:38 INFO - Running setup.py (path:/tmp/pip-p1BoJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01: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)) 01:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:15:38 INFO - Running setup.py (path:/tmp/pip-v4SZlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:15:39 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)) 01:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:15:39 INFO - Running setup.py (path:/tmp/pip-aXu78N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01: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)) 01:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:15:39 INFO - Running setup.py (path:/tmp/pip-KmmI_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01: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)) 01:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:15:39 INFO - Running setup.py (path:/tmp/pip-7a5bJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01: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)) 01:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:15:39 INFO - Running setup.py (path:/tmp/pip-zxfNUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01: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)) 01:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:15:39 INFO - Running setup.py (path:/tmp/pip-A71141-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01: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)) 01:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:15:39 INFO - Running setup.py (path:/tmp/pip-H7nXj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01: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)) 01:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:15:39 INFO - Running setup.py (path:/tmp/pip-ChpzXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:15:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 01:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:15:39 INFO - Running setup.py (path:/tmp/pip-ZLdoEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01: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)) 01:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:15:39 INFO - Running setup.py (path:/tmp/pip-pBvaSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01: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)) 01:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:15:39 INFO - Running setup.py (path:/tmp/pip-W0dS9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01: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)) 01:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:15:39 INFO - Running setup.py (path:/tmp/pip-UW6OtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01: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)) 01:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:15:39 INFO - Running setup.py (path:/tmp/pip-ELL2Io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01: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)) 01:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:15:39 INFO - Running setup.py (path:/tmp/pip-9ymCWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01: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)) 01:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:15:39 INFO - Running setup.py (path:/tmp/pip-41WQaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:15:40 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)) 01:15:40 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)) 01:15:40 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)) 01:15:40 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)) 01:15:40 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)) 01:15:40 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)) 01:15:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:15:40 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 01:15:40 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 01:15:40 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 01:15:40 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 01:15:40 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 01:15:40 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 01:15:41 INFO - Downloading blessings-1.6.tar.gz 01:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:15:42 INFO - Installing collected packages: blessings 01:15:42 INFO - Running setup.py install for blessings 01:15:42 INFO - Successfully installed blessings 01:15:42 INFO - Cleaning up... 01:15:42 INFO - Return code: 0 01:15:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:15:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:15:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:15:42 INFO - Reading from file tmpfile_stdout 01:15:42 INFO - Current package versions: 01:15:42 INFO - argparse == 1.2.1 01:15:42 INFO - blessings == 1.6 01:15:42 INFO - blobuploader == 1.2.4 01:15:42 INFO - docopt == 0.6.1 01:15:42 INFO - functools32 == 3.2.3-2 01:15:42 INFO - jsonschema == 2.5.1 01:15:42 INFO - manifestparser == 1.1 01:15:42 INFO - mozInstall == 1.12 01:15:42 INFO - mozcrash == 0.17 01:15:42 INFO - mozdebug == 0.1 01:15:42 INFO - mozdevice == 0.48 01:15:42 INFO - mozfile == 1.2 01:15:42 INFO - mozhttpd == 0.7 01:15:42 INFO - mozinfo == 0.9 01:15:42 INFO - mozleak == 0.1 01:15:42 INFO - mozlog == 3.2 01:15:42 INFO - moznetwork == 0.27 01:15:42 INFO - mozprocess == 0.22 01:15:42 INFO - mozprofile == 0.28 01:15:42 INFO - mozrunner == 6.11 01:15:42 INFO - mozscreenshot == 0.1 01:15:42 INFO - mozsystemmonitor == 0.3 01:15:42 INFO - moztest == 0.7 01:15:42 INFO - mozversion == 1.4 01:15:42 INFO - psutil == 3.1.1 01:15:42 INFO - requests == 1.2.3 01:15:42 INFO - wsgiref == 0.1.2 01:15:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01: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')]} 01:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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')]} 01:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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 0x7f5b91d12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd96f0>, '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 0xdda5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddaaa0>, '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': '41bf3e9aed84707956354da8000001c5-1467004802.250994-1220753862', '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 01: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 01: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 01:15:42 INFO - Using env: {'DISPLAY': ':0', 01:15:42 INFO - 'HOME': '/home/cltbld', 01:15:42 INFO - 'LANG': 'en_US.UTF-8', 01:15:42 INFO - 'LANGUAGE': 'en_US:en', 01:15:42 INFO - 'LOGNAME': 'cltbld', 01:15:42 INFO - 'MAIL': '/var/mail/cltbld', 01:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:42 INFO - 'MOZ_NO_REMOTE': '1', 01:15:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:42 INFO - 'NO_EM_RESTART': '1', 01:15:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:42 INFO - 'PWD': '/builds/slave/test', 01:15:42 INFO - 'SHELL': '/bin/bash', 01:15:42 INFO - 'SHLVL': '1', 01:15:42 INFO - 'TERM': 'linux', 01:15:42 INFO - 'TMOUT': '86400', 01:15:42 INFO - 'USER': 'cltbld', 01:15:42 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467004802.250994-1220753862', 01:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:42 INFO - '_': '/tools/buildbot/bin/python'} 01:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01: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)) 01: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)) 01: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)) 01: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)) 01: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)) 01: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)) 01: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)) 01: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)) 01: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)) 01: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)) 01: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)) 01:15:42 INFO - Cleaning up... 01:15:42 INFO - Return code: 0 01:15:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01: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')]} 01:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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')]} 01:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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 0x7f5b91d12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd96f0>, '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 0xdda5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddaaa0>, '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': '41bf3e9aed84707956354da8000001c5-1467004802.250994-1220753862', '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 01: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 01: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 01:15:42 INFO - Using env: {'DISPLAY': ':0', 01:15:42 INFO - 'HOME': '/home/cltbld', 01:15:42 INFO - 'LANG': 'en_US.UTF-8', 01:15:42 INFO - 'LANGUAGE': 'en_US:en', 01:15:42 INFO - 'LOGNAME': 'cltbld', 01:15:42 INFO - 'MAIL': '/var/mail/cltbld', 01:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:42 INFO - 'MOZ_NO_REMOTE': '1', 01:15:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:42 INFO - 'NO_EM_RESTART': '1', 01:15:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:42 INFO - 'PWD': '/builds/slave/test', 01:15:42 INFO - 'SHELL': '/bin/bash', 01:15:42 INFO - 'SHLVL': '1', 01:15:42 INFO - 'TERM': 'linux', 01:15:42 INFO - 'TMOUT': '86400', 01:15:42 INFO - 'USER': 'cltbld', 01:15:42 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467004802.250994-1220753862', 01:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:42 INFO - '_': '/tools/buildbot/bin/python'} 01:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:15:42 INFO - Cleaning up... 01:15:42 INFO - Return code: 0 01:15:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01: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')]} 01:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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')]} 01:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5b91d12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd96f0>, '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 0xdda5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddaaa0>, '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': '41bf3e9aed84707956354da8000001c5-1467004802.250994-1220753862', '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 01: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', 'flake8'] in /builds/slave/test/build 01: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 flake8 01:15:42 INFO - Using env: {'DISPLAY': ':0', 01:15:42 INFO - 'HOME': '/home/cltbld', 01:15:42 INFO - 'LANG': 'en_US.UTF-8', 01:15:42 INFO - 'LANGUAGE': 'en_US:en', 01:15:42 INFO - 'LOGNAME': 'cltbld', 01:15:42 INFO - 'MAIL': '/var/mail/cltbld', 01:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:42 INFO - 'MOZ_NO_REMOTE': '1', 01:15:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:42 INFO - 'NO_EM_RESTART': '1', 01:15:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:42 INFO - 'PWD': '/builds/slave/test', 01:15:42 INFO - 'SHELL': '/bin/bash', 01:15:42 INFO - 'SHLVL': '1', 01:15:42 INFO - 'TERM': 'linux', 01:15:42 INFO - 'TMOUT': '86400', 01:15:42 INFO - 'USER': 'cltbld', 01:15:42 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467004802.250994-1220753862', 01:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:42 INFO - '_': '/tools/buildbot/bin/python'} 01:15:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:43 INFO - Downloading/unpacking flake8 01:15:43 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 01:15:43 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 01:15:43 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 01:15:43 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 01:15:43 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 01:15:43 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 01:15:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:15:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01: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 01: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 01: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 01: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 01: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 01: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 01:15:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:15:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01: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 01: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 01: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 01: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 01: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 01: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 01:15:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01: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 01: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 01: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 01: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 01: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 01: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 01:15:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:15:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:15:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:15:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:15:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:15:45 INFO - no previously-included directories found matching 'docs/_build' 01:15:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:15:45 INFO - Running setup.py install for pep8 01:15:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:15:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:15:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:15:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:15:45 INFO - no previously-included directories found matching 'docs/_build' 01:15:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:15:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:15:45 INFO - Cleaning up... 01:15:45 INFO - Return code: 0 01:15:45 INFO - Running post-action listener: _resource_record_post_action 01:15:45 INFO - Running post-action listener: _start_resource_monitoring 01:15:45 INFO - Starting resource monitoring. 01:15:45 INFO - ##### 01:15:45 INFO - ##### Finished create-virtualenv step (success) 01:15:45 INFO - ##### 01:15:45 INFO - ##### 01:15:45 INFO - ##### Running install step. 01:15:45 INFO - ##### 01:15:45 INFO - Running pre-action listener: _resource_record_pre_action 01:15:45 INFO - Running main action method: install 01:15:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:15:46 INFO - Reading from file tmpfile_stdout 01:15:46 INFO - Detecting whether we're running mozinstall >=1.0... 01:15:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:15:46 INFO - Reading from file tmpfile_stdout 01:15:46 INFO - Output received: 01:15:46 INFO - Usage: mozinstall [options] installer 01:15:46 INFO - Options: 01:15:46 INFO - -h, --help show this help message and exit 01:15:46 INFO - -d DEST, --destination=DEST 01:15:46 INFO - Directory to install application into. [default: 01:15:46 INFO - "/builds/slave/test"] 01:15:46 INFO - --app=APP Application being installed. [default: firefox] 01:15:46 INFO - mkdir: /builds/slave/test/build/application 01:15:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:16:02 INFO - Reading from file tmpfile_stdout 01:16:02 INFO - Output received: 01:16:02 INFO - /builds/slave/test/build/application/firefox/firefox 01:16:02 INFO - Running post-action listener: _resource_record_post_action 01:16:02 INFO - ##### 01:16:02 INFO - ##### Finished install step (success) 01:16:02 INFO - ##### 01:16:02 INFO - ##### 01:16:02 INFO - ##### Running run-tests step. 01:16:02 INFO - ##### 01:16:02 INFO - Running pre-action listener: _resource_record_pre_action 01:16:02 INFO - Running main action method: run_tests 01:16:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:16:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:16:02 INFO - Python 2.7.3 01:16:02 INFO - Return code: 0 01:16:02 INFO - grabbing minidump binary from tooltool 01:16:02 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')]} 01:16:02 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 0xdd96f0>, '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 0xdda5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddaaa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:16:02 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 01:16:02 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 01:16:02 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 01:16:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:16:02 INFO - Return code: 0 01:16:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:16:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:16:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:16:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:16:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:16:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:16:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:16:03 INFO - Return code: 0 01:16:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:16:03 INFO - Using env: {'DISPLAY': ':0', 01:16:03 INFO - 'HOME': '/home/cltbld', 01:16:03 INFO - 'LANG': 'en_US.UTF-8', 01:16:03 INFO - 'LANGUAGE': 'en_US:en', 01:16:03 INFO - 'LOGNAME': 'cltbld', 01:16:03 INFO - 'MAIL': '/var/mail/cltbld', 01:16:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:16:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:03 INFO - 'MOZ_NO_REMOTE': '1', 01:16:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:16:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:03 INFO - 'NO_EM_RESTART': '1', 01:16:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:16:03 INFO - 'PWD': '/builds/slave/test', 01:16:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:16:03 INFO - 'SHELL': '/bin/bash', 01:16:03 INFO - 'SHLVL': '1', 01:16:03 INFO - 'TERM': 'linux', 01:16:03 INFO - 'TMOUT': '86400', 01:16:03 INFO - 'USER': 'cltbld', 01:16:03 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467004802.250994-1220753862', 01:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:03 INFO - '_': '/tools/buildbot/bin/python'} 01:16:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:16:03 INFO - mozversion application_buildid: 20160627003524 01:16:03 INFO - mozversion application_changeset: 8f48d2f1fa58dbb978abc28051f3550724800b2f 01:16:03 INFO - mozversion application_display_name: Nightly 01:16:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:16:03 INFO - mozversion application_name: Firefox 01:16:03 INFO - mozversion application_remotingname: firefox 01:16:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:16:03 INFO - mozversion application_vendor: Mozilla 01:16:03 INFO - mozversion application_version: 50.0a1 01:16:03 INFO - mozversion platform_buildid: 20160627003524 01:16:03 INFO - mozversion platform_changeset: 8f48d2f1fa58dbb978abc28051f3550724800b2f 01:16:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:16:03 INFO - mozversion platform_version: 50.0a1 01:16:03 INFO - using testdate: 1467015363 01:16:03 INFO - actual date: 1467015363 01:16:03 INFO - starting webserver on 'localhost:48001' 01:16:03 INFO - SUITE-START | Running 2 tests 01:16:03 INFO - TEST-START | dromaeo_css 01:16:03 INFO - operating with platform_type : linux_ 01:16:03 INFO - Initialising browser for dromaeo_css test... 01:16:03 INFO - TEST-INFO | started process 22169 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp848Bz1/profile http://localhost:48001/getInfo.html) 01:16:08 INFO - PROCESS | 22169 | __metrics Screen width/height:1600/1200 01:16:08 INFO - PROCESS | 22169 | colorDepth:24 01:16:08 INFO - PROCESS | 22169 | Browser inner width/height: 1024/697 01:16:08 INFO - PROCESS | 22169 | __metrics 01:16:09 ERROR - PROCESS | 22169 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 01:16:10 INFO - TEST-INFO | 22169: exit 0 01:16:10 INFO - Browser initialized. 01:16:10 INFO - Running cycle 1/1 for dromaeo_css test... 01:16:10 INFO - TEST-INFO | started process 22288 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp848Bz1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:16:22 INFO - PROCESS | 22288 | RSS: Main: 185929728 01:16:22 INFO - PROCESS | 22288 | 01:17:12 INFO - PROCESS | 22288 | 1467015432034 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] 01:19:24 INFO - PROCESS | 22288 | Cycle 1(1): loaded http://localhost:48001/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48001/tests/dromaeo/cssquery-ext.html) 01:19:25 INFO - PROCESS | 22288 | RSS: Main: 189542400 01:19:25 INFO - PROCESS | 22288 | 01:22:27 INFO - PROCESS | 22288 | Cycle 1(1): loaded http://localhost:48001/tests/dromaeo/cssquery-ext.html (next: http://localhost:48001/tests/dromaeo/cssquery-jquery.html) 01:22:28 INFO - PROCESS | 22288 | RSS: Main: 187564032 01:22:28 INFO - PROCESS | 22288 | 01:25:30 INFO - PROCESS | 22288 | Cycle 1(1): loaded http://localhost:48001/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48001/tests/dromaeo/cssquery-mootools.html) 01:25:30 INFO - PROCESS | 22288 | RSS: Main: 189218816 01:25:30 INFO - PROCESS | 22288 | 01:28:32 INFO - PROCESS | 22288 | Cycle 1(1): loaded http://localhost:48001/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48001/tests/dromaeo/cssquery-prototype.html) 01:28:33 INFO - PROCESS | 22288 | RSS: Main: 186793984 01:28:33 INFO - PROCESS | 22288 | 01:31:36 INFO - PROCESS | 22288 | Cycle 1(1): loaded http://localhost:48001/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48001/tests/dromaeo/cssquery-yui.html) 01:31:36 INFO - PROCESS | 22288 | RSS: Main: 188850176 01:31:36 INFO - PROCESS | 22288 | 01:34:39 INFO - PROCESS | 22288 | Cycle 1(1): loaded http://localhost:48001/tests/dromaeo/cssquery-yui.html (next: http://localhost:48001/tests/dromaeo/cssquery-dojo.html) 01:34:39 INFO - PROCESS | 22288 | RSS: Main: 189857792 01:34:39 INFO - PROCESS | 22288 | 01:34:39 INFO - PROCESS | 22288 | __start_tp_report 01:34:39 INFO - PROCESS | 22288 | _x_x_mozilla_page_load 01:34:39 INFO - PROCESS | 22288 | _x_x_mozilla_page_load_details 01:34:39 INFO - PROCESS | 22288 | |i|pagename|runs| 01:34:39 INFO - PROCESS | 22288 | |0;dojo.html;2584.5993870950006;2624.527585034693;2650.1651979626404;2661.1085286429056;2672.893084276629;4782.163121453745;4806.447258565266;4879.194932836087;4887.560119589236;4887.633427492939;4713.882152946169;4875.561199492054;4893.8287159949405;4896.387951506062;4898.828541001066;4464.933026004613;4480.171168333869;4582.024824285932;4599.632029437654;4639.188142075141;4283.593058659422;4590.05903789724;4628.560286772768;4665.346851440801;4689.812407503696;4432.689711720181;4465.397171381855;4488.842890498817;4497.257952437843;4505.374267876687;4467.285234362486;4492.7528985905765;4496.55034496551;4497.460304763416;4513.864584062483;4397.164538737629;4463.973286144205;4471.686981911267;4472.127935052666;4523.592876641118;4841.757912104381;4875.098106850209;4888.071266459361;4897.1674815281485;4917.213245880677;5178.974105129488;5203.089459344637;5237.083510385667;5241.606879484054;5245.554127899133;5247.47525247476;5271.209318602202;5278.973605131988;5304.098303288411;5310.787568497255;4934.062528119682;4943.8516844494725;4951.777170027393;4959.876003099951;5005.89988200234;5439.864003399946;5443.455654434525;5450.972745136249;5459.344878614592;5460.481254280837;5015.423226328946;5081.339425874687;5110.207917772751;5134;5145.665531740499;5103.132467480537;5220.660657057279;5243.134882744304;5247.868803279872;5253.343332083489;5110.71891045996;5115.0025744979375;5156.20078887773;5180.274761533388;5196.142636464941;5072.51811077947;5118.744062796845;5123.513266239701;5167.173252279617;5176.611754118456;4448.532904045029;4449.555044495589;4450.1767173073085;4463.531329210451;4477.037436951071;3851.557070936822;3868.2456920900718;3884.962174306334;3906.687465002793;3928.332183528807;4393.692441529062;4480.820767169342;4521.932171017437;4528.728276303433;4549.135664223787;5268.025415298105;5305.336832895888;5308.150695888717;5315.973420132875;5354.598405119632;4448.666350023761;4538.092381523708;4548.818047278138;4551.0442807010895;4593.839215627504;4671.579557839743;4689.976550117228;4705.788239529229;4718.8584342469785;4727.669063165614;4877.707337559757;4878.268259761065;4884.0476107158765;4886.29148773433;4928.260760885896;5085.389753229636;5170.741462926914;5171.974140129426;5194;5220.477952204901;4866.1727506323305;4902.926456103232;4907.828226012215;4908.141075311734;4957.35554377943;5161.741912904265;5172;5176.352955880515;5179.093658609803;5233.371995360429;5085.796568137233;5140.640155189101;5174.9482505174465;5239.214117882349;5255.3168088148295;4954.058728841508;5018.046571151615;5035.874103147451;5083.771230294572;5116.539511443988;5075.2387141929;5102.974485127699;5108.463611320758;5112.207607820794;5162.716050617102;4920.188168952082;4985.775640096277;5006.048850718352;5024.145895197898;5032.043911656773;5101.744912754421;5157.690538567698;5161.483851614808;5163.767630456714;5209.296744939536;5018.172001619838;5042.420121686053;5055.165897626997;5056.873578160576;5083.440821509705 01:34:39 INFO - PROCESS | 22288 | |1;ext.html;557.0008832856296;577.1948132355363;593.4065934065934;594.1444320178942;595.1905408644243;39332.41001384978;40495.39256911145;40624.99999999996;44574.55425445745;45006;40350.59649403505;40613.39079913804;41089.178216435655;41154.58845411545;41497;7869.33110685591;7937.285644292013;7984.361251099927;7992.280694737473;8007.199280071975;7829.49108307961;7884;7895;7900.683972641087;7906.367490600738;7866.095399029127;7911.248431399008;7940.2059794020715;7950.880736788953;7983.481073730189;7874.409419293547;7903.486273392211;7915.802104947365;7923.366130709529;7935.920640793576;7807.453478256524;7825.843483130306;7854.528728276322;7856.7250146244605;7870.527768333918;37866;38145.61854381448;38306;38330.616693832984;38482.23035539302;2981.299394642279;3008.9398212035635;3046.6800985896384;3088.428640701455;3346.665333466658;28739.28151796201;28750.568741468895;29010;29299.121026369245;30002;3479.2345683949743;3490.4240800267926;3493.2664140530264;3531.5055892175114;3537.5224344713647;179661;179842;179955.10022449936;180232;181797.09101454407;51379.22931156035;51691.22463163055;51691.7415412928;51934;51939.740301298254;33357.499637505454;34004;34208.14479637979;35975;49443;14418.42326306957;14543.490977815725;14636.560903172922;14660.340284687214;14714;11094.722631934104;11100.222984391177;11191.888081119247;11219.94390028061;11222.887771122347;18315.633687326444;18420.631587368447;18466.815331846778;18570.81429185718;18574.349897753513;6949.791506254821;7025.138338340344;7040.148739760405;7088.610126442992;7195.92804071963;787.3976408047848;787.6258777080956;869.9347548933855;937.161240689579;949.9192568631605;26723.06469273605;27552.586711199347;27620.44759104847;27745.24377225947;27820.582691259242;899.604174163366;914.6250037484599;942.9387089839139;970.0638883477478;1001.62439085343;14939;15117.244137793066;15122.243887805565;15448.691026179413;15451;423638;426530;428999;430022;433123;49926;49937.50062499401;50016;50313.99372012539;50398.244026339635;1156.8264760286024;1184.549871049013;1184.727512672073;1186.4067966017165;1192.898603618702;26979.86510067437;27647.44705105927;28325;28739.425211496073;28849.71150288554;44517.55482445134;44832.32751508665;45552.08895822131;45570.772146139054;45616.771916140206;354977.2251138728;358746;361457;362092;364491;25078.12226572134;25116.62325065162;25786.484270314115;25837.224883253533;25856.48287034211;43107.56892431161;43511.78244108759;43631.78184109059;44388.112237754416;44490.55509444864;37044;37081.629183708894;37218.441723374715;37543.24913501769;38114.61885381111;37424.43863341997;37485.62514374821;37521.437178441796;37547;37691.81154094212;31180.688193117778;36597.45103823498;36786;38943;40265;32102;32995.505067423524;33174;33630.66369336275;33633.15917101994;25158.874205628854;25824.612630810178;25970.74029259683;25986.090486833626;26231.60652590251 01:34:39 INFO - PROCESS | 22288 | |2;jquery.html;358.3961025671742;359.91901822090034;373.15666593498696;374.8331992263443;394.2037085088122;16169.43406980756;16675.41636042739;17183.140842957866;17271.136443177824;17506.56233594159;15807.84192158078;16398.7540186897;16992.830071699278;17027.233774480148;17034.914825425887;5047.747612619363;5187.273781670569;5259.789608415659;5261.947380526184;5262.657927234736;3671.9816400917957;5115.923261151086;5776.711164441782;5962.25471816023;6084.878302433949;6042.516598672118;6045.516358691294;6069.817905462821;6082.391760823926;6137.969310153443;4978.77595508203;5297.47025297471;5298.92051619226;5307.946920530784;5335.199720042025;5007.2489126630935;5144.356955380577;5151.484851514856;5179.249008893727;5215.452377500384;12354.0734444917;12454.941329986961;12463.314517701523;16054.5986350341;20189.293374731962;1870.990645046766;1911.2259534888392;2082.9062692178886;2345.2260753951155;2419.588669926117;8756.956215218883;8859.734207973772;9065.728028159167;9083.18251357381;9141.725748227498;1650.3563610192034;1813.4559632110445;1849.3619701203063;1870.3453791173117;1989.1148438944676;67196;68714;68986.31013689899;69348.6532567339;69460.30539694589;9955.352902061342;10045.497725113715;10148.238882083726;10166.135878450414;10179.898201018043;13902.860971390359;13937.860621393858;13962.511312104027;13976.231307278198;13978;7286.562806231643;7289.125304963438;7342.15565209997;7406.7037318506655;7417.147028091838;6832.145981752281;6895.793126206222;6922.41159501438;6963.338482844122;7046.577205367695;4418.293073108287;4431.534688857688;4452.710573812692;4459.375687403766;4553.271476563734;1726.844583987422;1761.0842361971702;1840.5214644192606;1860.6464771693336;1872.382113902409;758.5448730761609;846.0566468387703;889.226373055446;904.9502277374808;943.7923656795494;15658.68682626341;16253.268602912662;16295;16447.424340148278;16896.40862569829;831;880.5773228850188;888.7822483491586;919.3932004876749;962.7304354780673;8099;9372.625094996123;9403;9619.374740641835;9625.422474651543;407469;412952;413324;414091;416409;71323.6433817838;74774.6261268701;76767;77812.22187778163;77831.22168778353;910.4764760262875;920.282179899666;923.736735030513;926.4580220570907;933.1927882381826;14785;14851.702965940405;14988.175650339335;15052.3226454812;15057.397704091714;34681.82659086688;35003.29993400168;35476.113097172776;35731.642683572834;35790.64209357873;44953.32570011387;47466.28800568063;49952;50134.749326253135;50346.74826625844;6790.219124800514;7005.194402643761;7174.928250717635;7312.744053958086;7614.885776713464;8587.141285871363;11548.94225528867;11771.117166212398;11894.583689570823;12018;10087.344322619007;10100.444475553915;10331.586736530455;10357.896421035693;10698.14414846826;10303.072723454925;10602.787944241227;10718.785624287626;10739.570417183537;10771.353718776898;10369.222308326755;10634.840477393;10652.89347106519;10723;10903.618373357212;7206.639668016683;7237.601931893796;7293.744718934812;7295.781126566211;7311.23232060626;10306.845397318897;10327.586896524355;10554.894451055392;10573.418461984666;10596.47017649099 01:34:39 INFO - PROCESS | 22288 | |3;mootools.html;1363.815884855545;1412.5762271318604;1483.792269082328;1665.1091665958716;1682.0664531185187;6903.654817259142;7543.773686789392;7794.688212471501;8143.1042585315645;8159.796005099868;7596.278353556417;7817.765467035998;7837.960810195956;7855.607219639024;7914.841703165933;2228.220122956968;2263.4567703751145;2263.660450932357;2266.7506574276817;2271.6024695678275;2188.321620297713;2189.890505474728;2255.436140964759;2255.605269077913;2261;2208.094681180716;2222.3777342344088;2224;2238.104758096766;2248.6739422783685;2139.9786002140013;2162.524244666171;2189.704389907358;2194.2868567715395;2205.2722601541454;2197.2419515267206;2248.4828489447355;2250.9437264068365;2250.988745056264;2258.9887050564807;7928.127905930343;7962.203779622049;7976;8004.079530853968;8027.117017128111;4606.424196975378;4726.0784147091335;4732.266498692708;4735.289706544046;4742.739149346785;2892.754115900151;2926.4293462774767;3012;3023.1988523041414;3029.7727670424806;894.9373543851868;921.5484412637826;944.8629948657406;946.9431834089977;949.188443880486;10480.423576703355;10517.52671129801;10615.09771669409;10631.734206644896;10669.679909602724;4162.250794856895;4229.090745489734;4303.462067241595;4316.525182229952;4358;8988.55057247135;9010.369274150746;9029.548522573845;9085.727428177166;9237.168654821098;4688.835890743808;4698.8120475181295;4716.95283047172;4727.858164255078;4734.573888349996;3680.5583330000572;4113.773742444135;4131.462909821704;4206.158768246363;4282.379055037002;3579.069441945061;3617.1318883468302;3683.889483315505;3696.8706095286534;3719.367707489733;1171.3557543351124;1196.4556126962211;1223.7797196504714;1224.3510939202058;1229.440604524939;655.8786624474487;783.6591082878851;803.2609998801117;805.6334367862726;822.1696086952221;4836.492168322276;4960.727160006162;4964.67729597575;5002.499750025041;5004.3994720633755;409.1550947293829;413.88618130014487;414.2646801926544;414.53779036374226;418.3933296719708;3417.5044618530173;3457.377672019061;3469.670381313771;3537.20412907099;3560.181158333598;9558.808823823485;9735.26985476078;9799.657012004545;9831.705048848546;9872;9610.135087842127;9661.758456038515;9677.225821934227;9686.854697179548;9765.218782497383;7266.527675701168;7356.190819009905;7383.2985866342615;7431.665575049135;7499.587522686195;4959.181735013683;4993.101241776515;5005.574526165171;5074.847754567369;5132.589392848488;8836.381453298465;9003.909960900308;9061.864072039056;9099.727008189764;9163.312751543794;9150.130737579919;9190.172884440433;9191.310651701015;9205.723828285161;9411.905880941104;6190.628562286277;6417.679116044273;6559.836004099936;6877.552959057645;6972.337627925339;7298.087739032621;7434.36807871337;7460.66427010775;7469.290417410337;7502.887456688045;6496.382843629847;6641.833954151185;6697.7655782047395;6727.360900714424;6741.73033078691;6596.637184954873;6635.900461493178;6667.966660166668;6706.865862682622;6784.219814721173;6088.847778805565;6192.81421557354;6194.039923811636;6199.535034872312;6204.81385558434;4357.302831546937;4600.2869555218995;4604.3323718061365;4614.353990441274;4745.217039188496;4485.327200919888;4554.043650833362;4562.224421848227;4608.539146085364;4629.537046295478 01:34:39 INFO - PROCESS | 22288 | |4;prototype.html;295.67328102446794;309.55115083129454;310.6055309756609;312.09959267513216;313.45458901511375;4888.780004899779;5009.774560144793;5108.182690769478;5187.014467251224;5204.479552044789;5048.6465947383695;5083.220872694565;5094.210397388401;5094.261332106842;5140.583925554993;3973.7019723520707;4016.959830401702;4017.216642754664;4045.4336392905016;4093.406456063869;3991.8203680834285;4045.0494133878515;4070.287699652564;4076.8980775480554;4092.631663150316;3979.4428779970826;3989.3218152914073;3996.520417549898;4003.939940900889;4009.719319647626;4009.5789942056103;4033.495813023372;4052.8986775330704;4076.5719599441927;4100.894386488811;3576.535050443426;3583.050491619723;3584.5698516178227;3593.1556084320164;3607.549056367954;4762.9523704763205;4958.9008219835405;4973.5772459341;5009.872778624816;5010.198368261097;4569.474510431276;4592.7933243004145;4593.955689718076;4594.609458196057;4606.447226332828;5343.679379237258;5352.839414817562;5379.784808607651;5387.4612538746205;5421.990795108713;3615.7288203384587;3812.5996770338993;3839.6928245740273;3848.191879705237;3947.940780888289;5631.436856314377;5648.406917273668;5687.914681279784;5696.458836410535;5714.571407144481;3864.574896761354;3869.4195870619633;3878.864239751595;3887.261420330128;3889.658067966547;3836;3884.7863367515056;3914.4715463412645;3943.5859234779937;3965.7620542767527;4426.18115648606;4432.312991486325;4435.223835828717;4450.2434586120435;4461.776911154429;5287.603429742785;5349.732513374393;5356.651817631841;5379.041527160046;5399.676019438846;1256.2462522486435;1311.8819306262292;1328.435414948643;1329.6476433745065;1345.9125156864773;833.791552111972;847.7329641163137;853.6585365853584;863.7561910848358;869.5347988825948;4166.562510936369;4184.539700632928;4201.70588058833;4242.893927651833;4263.360495925574;4819.855404337875;4820.6143508519235;4837;4869.9269510957365;4881.95118048822;4139.627433530936;4192.664586833046;4219.38818871262;4248.426462427595;4268.59448352406;2499.4001439654717;2616.6916541729133;2626.2797867396885;2652.416468376954;2666.05355098941;4591.678582499193;4605.700629459075;4610;4611.9077618447445;4616.492185859553;4930.383702037246;4979.90040199194;4983.750812459362;5034.194528875362;5084.796608135707;4368.60682538573;4534.7052441591195;4534.909301813946;4552.817887284537;4591.03588246472;4810.518948105161;4852.5979640078385;4867.9269810952155;4876.536729010738;4895.534924182197;4755;4787.3776409066595;4824.179889418737;4825.30033145199;4833.73414462208;4363.934540981824;4568.428946381702;4581.862544123682;4610.193216187086;4610.585047345755;3485.8605655773486;3486.372452958492;3489.1333136771705;3495.807730574843;3504.1940353719297;4789.880252993703;4817.084753896748;4832.855014349575;4868.537488938545;5276.992114494701;5193;5317.521423071942;5337.226102215234;5374.919376209282;5395.865103372447;5299.973500132474;5354.3574771027725;5356.0626890294825;5377.139657654757;5399.649022813504;5010.649254552146;5263.6052296078715;5265;5269.841904742864;5289.233061206027;5358.169483730028;5377.489138531833;5381.919271211013;5401.837944861661;5407.242985982044;5319.388270348804;5347.331583552056;5349.331333583302;5353.323338330834;5359.517643412111 01:34:39 INFO - PROCESS | 22288 | |5;yui.html;575.7812031428058;608.5861614102408;691.3121444163058;691.4468425259794;700.414196780674;10907.945460272687;13949.02356835022;14211.502597409093;14733.999999999987;14794.038387504805;13503.324833758323;13659.521916732916;14108.224047677399;14136.22250776207;14136.50522231722;810.5055915891302;813.1705660226565;813.5037627047496;816.1838161838161;817.5544328341039;799.312591171592;799.3525244551903;801.3869389916719;805.9879101813448;807.4953154278576;841.032812265896;846.2299307630058;848.2111636178352;850.090403268503;851.902031266403;832.2842355574202;836.6987884361625;841.2092632925062;844.4637655089001;847.8134810341746;613.089562000429;615.9076138579204;616.5252755378334;618.1099217127368;618.3692633513836;11986.52053917851;12400.62798116058;12428.378581071001;12431.12982091254;12436.75126497465;13073.673158171026;13239.536616218385;13266.3366831659;13917.095388799797;13970;10113;10378.06597406237;10417.322874013165;10517;10847.566097356175;3350.5644266245477;3360.3996258483016;3382.7970321780526;3412.7269818414716;3413.4026545354463;57931.710341448445;58553.12170317449;59468.810623787715;59556.70221648907;60236.39763602352;10721.785564288826;10771.89228107709;10818.242723009314;10831.566737330577;10918.1811364148;19865.30471433493;20189.192432302836;20214.49463763388;20302.593948120953;20332.08505617251;6574.178227721535;6766.15423072116;6904.3095690431555;6967.477439192081;7067.43460523157;3585.5697316322207;3605.387084195693;3631.8728844490315;3664.120611053328;3756.1736417988545;3016.441958237733;3092.747437287902;3102.4260511805387;3143.764217683637;3168.1446009577285;520.5549255386666;540.783686525393;543.1147230015129;547.0672503381725;580.1269090019578;555.0370107862855;560.7364538666901;571.2801869644278;580.3297191743543;589.3782059926818;7694.884576731353;7816.41376896735;7900.881486777703;8073.2734053934255;8127;534.5322842512801;550.6833570696786;561.7696744334803;590.0117303516593;607.4441885674559;3668.779873207616;3688.7602305850032;3745.9438108428394;3818.6563209311294;3888.51393575803;90150.09849901548;93968;95080;96987;97108.51445742867;81207;83325;83700.16299836924;83989;84734.7975422096;72240.63879680568;73206.63396682983;73846.26153738501;74805.6259718698;75215;6719.160104986877;6741.561798483083;6860.108185935796;6926.965365173141;6948.722051117898;39911.40132897951;41002.79498602488;41147.7942610285;41394.58605413907;42402;58514.70742646259;60720.39279607324;61343.38656613377;61344.38655613565;62288;10039.297249192487;10075.395476271155;10145.137663298703;10183.236257280882;10237;10686.145108391465;11114.44427778624;12058.216215945935;12340.876591233973;12848.678783030498;12070.577529786415;12148.757024859276;12324.691882702646;12451.564195253122;13300.334983250605;10503.632372866912;10844.349339039683;11114.16643751738;11138.108951283715;11611;11149.944250278697;11329.093672506344;11630;12025.518979240733;12235.082368822195;9453.43279403238;10251.333663311862;10276.486175691334;10433.53049112807;10485.895141048797;9964.186231595875;9985.201183905125;10389.896101038892;10625.043746062891;10734.838977415502 01:34:39 INFO - PROCESS | 22288 | __end_tp_report 01:34:39 INFO - PROCESS | 22288 | __start_cc_report 01:34:39 INFO - PROCESS | 22288 | _x_x_mozilla_cycle_collect,378 01:34:39 INFO - PROCESS | 22288 | __end_cc_report 01:34:39 INFO - PROCESS | 22288 | __startTimestamp1467016479539__endTimestamp 01:34:39 INFO - PROCESS | 22288 | 01:34:39 INFO - PROCESS | 22288 | ------- Summary: start ------- 01:34:39 INFO - PROCESS | 22288 | Number of tests: 6 01:34:39 INFO - PROCESS | 22288 | 01:34:39 INFO - PROCESS | 22288 | [#0] dojo.html Cycles:165 Average:4829.57 Median:4951.78 stddev:515.44 (10.4%) stddev-sans-first:486.01 01:34:39 INFO - PROCESS | 22288 | Values: 2584.6 2624.5 2650.2 2661.1 2672.9 4782.2 4806.4 4879.2 4887.6 4887.6 4713.9 4875.6 4893.8 4896.4 4898.8 4464.9 4480.2 4582.0 4599.6 4639.2 4283.6 4590.1 4628.6 4665.3 4689.8 4432.7 4465.4 4488.8 4497.3 4505.4 4467.3 4492.8 4496.6 4497.5 4513.9 4397.2 4464.0 4471.7 4472.1 4523.6 4841.8 4875.1 4888.1 4897.2 4917.2 5179.0 5203.1 5237.1 5241.6 5245.6 5247.5 5271.2 5279.0 5304.1 5310.8 4934.1 4943.9 4951.8 4959.9 5005.9 5439.9 5443.5 5451.0 5459.3 5460.5 5015.4 5081.3 5110.2 5134.0 5145.7 5103.1 5220.7 5243.1 5247.9 5253.3 5110.7 5115.0 5156.2 5180.3 5196.1 5072.5 5118.7 5123.5 5167.2 5176.6 4448.5 4449.6 4450.2 4463.5 4477.0 3851.6 3868.2 3885.0 3906.7 3928.3 4393.7 4480.8 4521.9 4528.7 4549.1 5268.0 5305.3 5308.2 5316.0 5354.6 4448.7 4538.1 4548.8 4551.0 4593.8 4671.6 4690.0 4705.8 4718.9 4727.7 4877.7 4878.3 4884.0 4886.3 4928.3 5085.4 5170.7 5172.0 5194.0 5220.5 4866.2 4902.9 4907.8 4908.1 4957.4 5161.7 5172.0 5176.4 5179.1 5233.4 5085.8 5140.6 5174.9 5239.2 5255.3 4954.1 5018.0 5035.9 5083.8 5116.5 5075.2 5103.0 5108.5 5112.2 5162.7 4920.2 4985.8 5006.0 5024.1 5032.0 5101.7 5157.7 5161.5 5163.8 5209.3 5018.2 5042.4 5055.2 5056.9 5083.4 01:34:39 INFO - PROCESS | 22288 | 01:34:39 INFO - PROCESS | 22288 | [#1] ext.html Cycles:180 Average:47658.55 Median:37619.41 stddev:89998.55 (239.2%) stddev-sans-first:90181.54 01:34:39 INFO - PROCESS | 22288 | Values: 557.0 577.2 593.4 594.1 595.2 39332.4 40495.4 40625.0 44574.6 45006.0 40350.6 40613.4 41089.2 41154.6 41497.0 7869.3 7937.3 7984.4 7992.3 8007.2 7829.5 7884.0 7895.0 7900.7 7906.4 7866.1 7911.2 7940.2 7950.9 7983.5 7874.4 7903.5 7915.8 7923.4 7935.9 7807.5 7825.8 7854.5 7856.7 7870.5 37866.0 38145.6 38306.0 38330.6 38482.2 2981.3 3008.9 3046.7 3088.4 3346.7 28739.3 28750.6 29010.0 29299.1 30002.0 3479.2 3490.4 3493.3 3531.5 3537.5 179661.0 179842.0 179955.1 180232.0 181797.1 51379.2 51691.2 51691.7 51934.0 51939.7 33357.5 34004.0 34208.1 35975.0 49443.0 14418.4 14543.5 14636.6 14660.3 14714.0 11094.7 11100.2 11191.9 11219.9 11222.9 18315.6 18420.6 18466.8 18570.8 18574.3 6949.8 7025.1 7040.1 7088.6 7195.9 787.4 787.6 869.9 937.2 949.9 26723.1 27552.6 27620.4 27745.2 27820.6 899.6 914.6 942.9 970.1 1001.6 14939.0 15117.2 15122.2 15448.7 15451.0 423638.0 426530.0 428999.0 430022.0 433123.0 49926.0 49937.5 50016.0 50314.0 50398.2 1156.8 1184.5 1184.7 1186.4 1192.9 26979.9 27647.4 28325.0 28739.4 28849.7 44517.6 44832.3 45552.1 45570.8 45616.8 354977.2 358746.0 361457.0 362092.0 364491.0 25078.1 25116.6 25786.5 25837.2 25856.5 43107.6 43511.8 43631.8 44388.1 44490.6 37044.0 37081.6 37218.4 37543.2 38114.6 37424.4 37485.6 37521.4 37547.0 37691.8 31180.7 36597.5 36786.0 38943.0 40265.0 32102.0 32995.5 33174.0 33630.7 33633.2 25158.9 25824.6 25970.7 25986.1 26231.6 01:34:39 INFO - PROCESS | 22288 | 01:34:39 INFO - PROCESS | 22288 | [#2] jquery.html Cycles:180 Average:24590.93 Median:4442.12 stddev:67983.36 (1530.4%) stddev-sans-first:68149.72 01:34:39 INFO - PROCESS | 22288 | Values: 358.4 359.9 373.2 374.8 394.2 16169.4 16675.4 17183.1 17271.1 17506.6 15807.8 16398.8 16992.8 17027.2 17034.9 5047.7 5187.3 5259.8 5261.9 5262.7 3672.0 5115.9 5776.7 5962.3 6084.9 6042.5 6045.5 6069.8 6082.4 6138.0 4978.8 5297.5 5298.9 5307.9 5335.2 5007.2 5144.4 5151.5 5179.2 5215.5 12354.1 12454.9 12463.3 16054.6 20189.3 1871.0 1911.2 2082.9 2345.2 2419.6 8757.0 8859.7 9065.7 9083.2 9141.7 1650.4 1813.5 1849.4 1870.3 1989.1 67196.0 68714.0 68986.3 69348.7 69460.3 9955.4 10045.5 10148.2 10166.1 10179.9 13902.9 13937.9 13962.5 13976.2 13978.0 7286.6 7289.1 7342.2 7406.7 7417.1 6832.1 6895.8 6922.4 6963.3 7046.6 4418.3 4431.5 4452.7 4459.4 4553.3 1726.8 1761.1 1840.5 1860.6 1872.4 758.5 846.1 889.2 905.0 943.8 15658.7 16253.3 16295.0 16447.4 16896.4 831.0 880.6 888.8 919.4 962.7 8099.0 9372.6 9403.0 9619.4 9625.4 407469.0 412952.0 413324.0 414091.0 416409.0 71323.6 74774.6 76767.0 77812.2 77831.2 910.5 920.3 923.7 926.5 933.2 14785.0 14851.7 14988.2 15052.3 15057.4 34681.8 35003.3 35476.1 35731.6 35790.6 44953.3 47466.3 49952.0 50134.7 50346.7 6790.2 7005.2 7174.9 7312.7 7614.9 8587.1 11548.9 11771.1 11894.6 12018.0 10087.3 10100.4 10331.6 10357.9 10698.1 10303.1 10602.8 10718.8 10739.6 10771.4 10369.2 10634.8 10652.9 10723.0 10903.6 7206.6 7237.6 7293.7 7295.8 7311.2 10306.8 10327.6 10554.9 10573.4 10596.5 01:34:39 INFO - PROCESS | 22288 | 01:34:39 INFO - PROCESS | 22288 | [#3] mootools.html Cycles:180 Average:5133.82 Median:4897.84 stddev:2904.25 (59.3%) stddev-sans-first:2898.58 01:34:39 INFO - PROCESS | 22288 | Values: 1363.8 1412.6 1483.8 1665.1 1682.1 6903.7 7543.8 7794.7 8143.1 8159.8 7596.3 7817.8 7838.0 7855.6 7914.8 2228.2 2263.5 2263.7 2266.8 2271.6 2188.3 2189.9 2255.4 2255.6 2261.0 2208.1 2222.4 2224.0 2238.1 2248.7 2140.0 2162.5 2189.7 2194.3 2205.3 2197.2 2248.5 2250.9 2251.0 2259.0 7928.1 7962.2 7976.0 8004.1 8027.1 4606.4 4726.1 4732.3 4735.3 4742.7 2892.8 2926.4 3012.0 3023.2 3029.8 894.9 921.5 944.9 946.9 949.2 10480.4 10517.5 10615.1 10631.7 10669.7 4162.3 4229.1 4303.5 4316.5 4358.0 8988.6 9010.4 9029.5 9085.7 9237.2 4688.8 4698.8 4717.0 4727.9 4734.6 3680.6 4113.8 4131.5 4206.2 4282.4 3579.1 3617.1 3683.9 3696.9 3719.4 1171.4 1196.5 1223.8 1224.4 1229.4 655.9 783.7 803.3 805.6 822.2 4836.5 4960.7 4964.7 5002.5 5004.4 409.2 413.9 414.3 414.5 418.4 3417.5 3457.4 3469.7 3537.2 3560.2 9558.8 9735.3 9799.7 9831.7 9872.0 9610.1 9661.8 9677.2 9686.9 9765.2 7266.5 7356.2 7383.3 7431.7 7499.6 4959.2 4993.1 5005.6 5074.8 5132.6 8836.4 9003.9 9061.9 9099.7 9163.3 9150.1 9190.2 9191.3 9205.7 9411.9 6190.6 6417.7 6559.8 6877.6 6972.3 7298.1 7434.4 7460.7 7469.3 7502.9 6496.4 6641.8 6697.8 6727.4 6741.7 6596.6 6635.9 6668.0 6706.9 6784.2 6088.8 6192.8 6194.0 6199.5 6204.8 4357.3 4600.3 4604.3 4614.4 4745.2 4485.3 4554.0 4562.2 4608.5 4629.5 01:34:39 INFO - PROCESS | 22288 | 01:34:39 INFO - PROCESS | 22288 | [#4] prototype.html Cycles:180 Average:4267.19 Median:4610.10 stddev:1237.58 (26.8%) stddev-sans-first:1204.62 01:34:39 INFO - PROCESS | 22288 | Values: 295.7 309.6 310.6 312.1 313.5 4888.8 5009.8 5108.2 5187.0 5204.5 5048.6 5083.2 5094.2 5094.3 5140.6 3973.7 4017.0 4017.2 4045.4 4093.4 3991.8 4045.0 4070.3 4076.9 4092.6 3979.4 3989.3 3996.5 4003.9 4009.7 4009.6 4033.5 4052.9 4076.6 4100.9 3576.5 3583.1 3584.6 3593.2 3607.5 4763.0 4958.9 4973.6 5009.9 5010.2 4569.5 4592.8 4594.0 4594.6 4606.4 5343.7 5352.8 5379.8 5387.5 5422.0 3615.7 3812.6 3839.7 3848.2 3947.9 5631.4 5648.4 5687.9 5696.5 5714.6 3864.6 3869.4 3878.9 3887.3 3889.7 3836.0 3884.8 3914.5 3943.6 3965.8 4426.2 4432.3 4435.2 4450.2 4461.8 5287.6 5349.7 5356.7 5379.0 5399.7 1256.2 1311.9 1328.4 1329.6 1345.9 833.8 847.7 853.7 863.8 869.5 4166.6 4184.5 4201.7 4242.9 4263.4 4819.9 4820.6 4837.0 4869.9 4882.0 4139.6 4192.7 4219.4 4248.4 4268.6 2499.4 2616.7 2626.3 2652.4 2666.1 4591.7 4605.7 4610.0 4611.9 4616.5 4930.4 4979.9 4983.8 5034.2 5084.8 4368.6 4534.7 4534.9 4552.8 4591.0 4810.5 4852.6 4867.9 4876.5 4895.5 4755.0 4787.4 4824.2 4825.3 4833.7 4363.9 4568.4 4581.9 4610.2 4610.6 3485.9 3486.4 3489.1 3495.8 3504.2 4789.9 4817.1 4832.9 4868.5 5277.0 5193.0 5317.5 5337.2 5374.9 5395.9 5300.0 5354.4 5356.1 5377.1 5399.6 5010.6 5263.6 5265.0 5269.8 5289.2 5358.2 5377.5 5381.9 5401.8 5407.2 5319.4 5347.3 5349.3 5353.3 5359.5 01:34:39 INFO - PROCESS | 22288 | 01:34:39 INFO - PROCESS | 22288 | [#5] yui.html Cycles:180 Average:17427.81 Median:41898.29 stddev:24661.04 (58.9%) stddev-sans-first:24697.76 01:34:39 INFO - PROCESS | 22288 | Values: 575.8 608.6 691.3 691.4 700.4 10907.9 13949.0 14211.5 14734.0 14794.0 13503.3 13659.5 14108.2 14136.2 14136.5 810.5 813.2 813.5 816.2 817.6 799.3 799.4 801.4 806.0 807.5 841.0 846.2 848.2 850.1 851.9 832.3 836.7 841.2 844.5 847.8 613.1 615.9 616.5 618.1 618.4 11986.5 12400.6 12428.4 12431.1 12436.8 13073.7 13239.5 13266.3 13917.1 13970.0 10113.0 10378.1 10417.3 10517.0 10847.6 3350.6 3360.4 3382.8 3412.7 3413.4 57931.7 58553.1 59468.8 59556.7 60236.4 10721.8 10771.9 10818.2 10831.6 10918.2 19865.3 20189.2 20214.5 20302.6 20332.1 6574.2 6766.2 6904.3 6967.5 7067.4 3585.6 3605.4 3631.9 3664.1 3756.2 3016.4 3092.7 3102.4 3143.8 3168.1 520.6 540.8 543.1 547.1 580.1 555.0 560.7 571.3 580.3 589.4 7694.9 7816.4 7900.9 8073.3 8127.0 534.5 550.7 561.8 590.0 607.4 3668.8 3688.8 3745.9 3818.7 3888.5 90150.1 93968.0 95080.0 96987.0 97108.5 81207.0 83325.0 83700.2 83989.0 84734.8 72240.6 73206.6 73846.3 74805.6 75215.0 6719.2 6741.6 6860.1 6927.0 6948.7 39911.4 41002.8 41147.8 41394.6 42402.0 58514.7 60720.4 61343.4 61344.4 62288.0 10039.3 10075.4 10145.1 10183.2 10237.0 10686.1 11114.4 12058.2 12340.9 12848.7 12070.6 12148.8 12324.7 12451.6 13300.3 10503.6 10844.3 11114.2 11138.1 11611.0 11149.9 11329.1 11630.0 12025.5 12235.1 9453.4 10251.3 10276.5 10433.5 10485.9 9964.2 9985.2 10389.9 10625.0 10734.8 01:34:39 INFO - PROCESS | 22288 | -------- Summary: end -------- 01:34:39 INFO - PROCESS | 22288 | 01:34:40 INFO - TEST-INFO | 22288: exit 0 01:34:40 INFO - TEST-OK | dromaeo_css | took 1116693ms 01:34:40 INFO - TEST-START | kraken 01:34:40 INFO - operating with platform_type : linux_ 01:34:40 INFO - Initialising browser for kraken test... 01:34:40 INFO - TEST-INFO | started process 22525 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAI1K0M/profile http://localhost:48001/getInfo.html) 01:34:45 INFO - PROCESS | 22525 | __metrics Screen width/height:1600/1200 01:34:45 INFO - PROCESS | 22525 | colorDepth:24 01:34:45 INFO - PROCESS | 22525 | Browser inner width/height: 1024/697 01:34:45 INFO - PROCESS | 22525 | __metrics 01:34:45 ERROR - PROCESS | 22525 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 01:34:46 INFO - TEST-INFO | 22525: exit 0 01:34:46 INFO - Browser initialized. 01:34:46 INFO - Running cycle 1/1 for kraken test... 01:34:46 INFO - TEST-INFO | started process 22641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAI1K0M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:34:58 INFO - PROCESS | 22641 | RSS: Main: 186019840 01:34:58 INFO - PROCESS | 22641 | 01:35:01 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:48001/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48001/tests/kraken/driver.html?testName=audio-beat-detection) 01:35:02 INFO - PROCESS | 22641 | RSS: Main: 190754816 01:35:02 INFO - PROCESS | 22641 | 01:35:05 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:48001/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48001/tests/kraken/driver.html?testName=audio-dft) 01:35:05 INFO - PROCESS | 22641 | RSS: Main: 190128128 01:35:05 INFO - PROCESS | 22641 | 01:35:08 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:48001/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48001/tests/kraken/driver.html?testName=audio-fft) 01:35:09 INFO - PROCESS | 22641 | RSS: Main: 185921536 01:35:09 INFO - PROCESS | 22641 | 01:35:11 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:48001/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48001/tests/kraken/driver.html?testName=audio-oscillator) 01:35:12 INFO - PROCESS | 22641 | RSS: Main: 186494976 01:35:12 INFO - PROCESS | 22641 | 01:35:14 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:48001/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48001/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:35:14 INFO - PROCESS | 22641 | RSS: Main: 186642432 01:35:14 INFO - PROCESS | 22641 | 01:35:18 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:48001/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48001/tests/kraken/driver.html?testName=imaging-darkroom) 01:35:18 INFO - PROCESS | 22641 | RSS: Main: 187805696 01:35:18 INFO - PROCESS | 22641 | 01:35:22 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:48001/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48001/tests/kraken/driver.html?testName=imaging-desaturate) 01:35:22 INFO - PROCESS | 22641 | RSS: Main: 184725504 01:35:22 INFO - PROCESS | 22641 | 01:35:25 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:48001/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48001/tests/kraken/driver.html?testName=json-parse-financial) 01:35:26 INFO - PROCESS | 22641 | RSS: Main: 186167296 01:35:26 INFO - PROCESS | 22641 | 01:35:28 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:48001/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48001/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:35:28 INFO - PROCESS | 22641 | RSS: Main: 186773504 01:35:28 INFO - PROCESS | 22641 | 01:35:30 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:48001/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48001/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:35:31 INFO - PROCESS | 22641 | RSS: Main: 186880000 01:35:31 INFO - PROCESS | 22641 | 01:35:33 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:48001/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48001/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:35:34 INFO - PROCESS | 22641 | RSS: Main: 187387904 01:35:34 INFO - PROCESS | 22641 | 01:35:37 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:48001/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48001/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:35:37 INFO - PROCESS | 22641 | RSS: Main: 187658240 01:35:37 INFO - PROCESS | 22641 | 01:35:40 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:48001/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48001/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:35:41 INFO - PROCESS | 22641 | RSS: Main: 187412480 01:35:41 INFO - PROCESS | 22641 | 01:35:42 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:48001/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48001/tests/kraken/driver.html?testName=ai-astar) 01:35:43 INFO - PROCESS | 22641 | RSS: Main: 188534784 01:35:43 INFO - PROCESS | 22641 | 01:35:43 INFO - PROCESS | 22641 | __start_tp_report 01:35:43 INFO - PROCESS | 22641 | _x_x_mozilla_page_load 01:35:43 INFO - PROCESS | 22641 | _x_x_mozilla_page_load_details 01:35:43 INFO - PROCESS | 22641 | |i|pagename|runs| 01:35:43 INFO - PROCESS | 22641 | |0;ai-astar;105;114;110;113;113;114;114;113;112;112 01:35:43 INFO - PROCESS | 22641 | |1;audio-beat-detection;166;132;156;184;132;152;157;136;184;131 01:35:43 INFO - PROCESS | 22641 | |2;audio-dft;164;164;170;177;166;164;164;163;162;162 01:35:43 INFO - PROCESS | 22641 | |3;audio-fft;76;76;78;153;77;76;75;76;158;76 01:35:43 INFO - PROCESS | 22641 | |4;audio-oscillator;89;86;147;87;88;88;132;88;86;140 01:35:43 INFO - PROCESS | 22641 | |5;imaging-gaussian-blur;118;117;118;117;117;118;118;119;118;119 01:35:43 INFO - PROCESS | 22641 | |6;imaging-darkroom;147;149;148;148;148;148;149;149;149;148 01:35:43 INFO - PROCESS | 22641 | |7;imaging-desaturate;95;96;97;96;95;96;96;95;96;95 01:35:43 INFO - PROCESS | 22641 | |8;json-parse-financial;67;62;65;63;63;64;63;62;64;64 01:35:43 INFO - PROCESS | 22641 | |9;json-stringify-tinderbox;69;65;65;65;65;67;66;64;66;65 01:35:43 INFO - PROCESS | 22641 | |10;stanford-crypto-aes;84;83;81;84;86;89;85;83;100;84 01:35:43 INFO - PROCESS | 22641 | |11;stanford-crypto-ccm;144;149;142;140;134;132;130;138;139;131 01:35:43 INFO - PROCESS | 22641 | |12;stanford-crypto-pbkdf2;166;170;171;165;172;165;166;163;177;167 01:35:43 INFO - PROCESS | 22641 | |13;stanford-crypto-sha256-iterative;67;66;73;67;66;67;64;65;67;65 01:35:43 INFO - PROCESS | 22641 | __end_tp_report 01:35:43 INFO - PROCESS | 22641 | __start_cc_report 01:35:43 INFO - PROCESS | 22641 | _x_x_mozilla_cycle_collect,987 01:35:43 INFO - PROCESS | 22641 | __end_cc_report 01:35:43 INFO - PROCESS | 22641 | __startTimestamp1467016543159__endTimestamp 01:35:43 INFO - PROCESS | 22641 | 01:35:43 INFO - PROCESS | 22641 | ------- Summary: start ------- 01:35:43 INFO - PROCESS | 22641 | Number of tests: 14 01:35:43 INFO - PROCESS | 22641 | 01:35:43 INFO - PROCESS | 22641 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:2.75 (2.4%) stddev-sans-first:1.30 01:35:43 INFO - PROCESS | 22641 | Values: 105.0 114.0 110.0 113.0 113.0 114.0 114.0 113.0 112.0 112.0 01:35:43 INFO - PROCESS | 22641 | 01:35:43 INFO - PROCESS | 22641 | [#1] audio-beat-detection Cycles:10 Average:153.00 Median:156.50 stddev:20.47 (13.1%) stddev-sans-first:21.17 01:35:43 INFO - PROCESS | 22641 | Values: 166.0 132.0 156.0 184.0 132.0 152.0 157.0 136.0 184.0 131.0 01:35:43 INFO - PROCESS | 22641 | 01:35:43 INFO - PROCESS | 22641 | [#2] audio-dft Cycles:10 Average:165.60 Median:164.00 stddev:4.62 (2.8%) stddev-sans-first:4.87 01:35:43 INFO - PROCESS | 22641 | Values: 164.0 164.0 170.0 177.0 166.0 164.0 164.0 163.0 162.0 162.0 01:35:43 INFO - PROCESS | 22641 | 01:35:43 INFO - PROCESS | 22641 | [#3] audio-fft Cycles:10 Average:92.10 Median:76.00 stddev:33.44 (44.0%) stddev-sans-first:34.96 01:35:43 INFO - PROCESS | 22641 | Values: 76.0 76.0 78.0 153.0 77.0 76.0 75.0 76.0 158.0 76.0 01:35:43 INFO - PROCESS | 22641 | 01:35:43 INFO - PROCESS | 22641 | [#4] audio-oscillator Cycles:10 Average:103.10 Median:87.50 stddev:25.50 (29.1%) stddev-sans-first:26.53 01:35:43 INFO - PROCESS | 22641 | Values: 89.0 86.0 147.0 87.0 88.0 88.0 132.0 88.0 86.0 140.0 01:35:43 INFO - PROCESS | 22641 | 01:35:43 INFO - PROCESS | 22641 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 01:35:43 INFO - PROCESS | 22641 | Values: 118.0 117.0 118.0 117.0 117.0 118.0 118.0 119.0 118.0 119.0 01:35:43 INFO - PROCESS | 22641 | 01:35:43 INFO - PROCESS | 22641 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:0.67 (0.5%) stddev-sans-first:0.53 01:35:43 INFO - PROCESS | 22641 | Values: 147.0 149.0 148.0 148.0 148.0 148.0 149.0 149.0 149.0 148.0 01:35:43 INFO - PROCESS | 22641 | 01:35:43 INFO - PROCESS | 22641 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 01:35:43 INFO - PROCESS | 22641 | Values: 95.0 96.0 97.0 96.0 95.0 96.0 96.0 95.0 96.0 95.0 01:35:43 INFO - PROCESS | 22641 | 01:35:43 INFO - PROCESS | 22641 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:64.00 stddev:1.49 (2.3%) stddev-sans-first:1.00 01:35:43 INFO - PROCESS | 22641 | Values: 67.0 62.0 65.0 63.0 63.0 64.0 63.0 62.0 64.0 64.0 01:35:43 INFO - PROCESS | 22641 | 01:35:43 INFO - PROCESS | 22641 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:65.50 stddev:1.42 (2.2%) stddev-sans-first:0.87 01:35:43 INFO - PROCESS | 22641 | Values: 69.0 65.0 65.0 65.0 65.0 67.0 66.0 64.0 66.0 65.0 01:35:43 INFO - PROCESS | 22641 | 01:35:43 INFO - PROCESS | 22641 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:84.00 stddev:5.38 (6.4%) stddev-sans-first:5.67 01:35:43 INFO - PROCESS | 22641 | Values: 84.0 83.0 81.0 84.0 86.0 89.0 85.0 83.0 100.0 84.0 01:35:43 INFO - PROCESS | 22641 | 01:35:43 INFO - PROCESS | 22641 | [#11] stanford-crypto-ccm Cycles:10 Average:137.90 Median:139.50 stddev:6.17 (4.4%) stddev-sans-first:6.14 01:35:43 INFO - PROCESS | 22641 | Values: 144.0 149.0 142.0 140.0 134.0 132.0 130.0 138.0 139.0 131.0 01:35:43 INFO - PROCESS | 22641 | 01:35:43 INFO - PROCESS | 22641 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.20 Median:168.50 stddev:4.24 (2.5%) stddev-sans-first:4.42 01:35:43 INFO - PROCESS | 22641 | Values: 166.0 170.0 171.0 165.0 172.0 165.0 166.0 163.0 177.0 167.0 01:35:43 INFO - PROCESS | 22641 | 01:35:43 INFO - PROCESS | 22641 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:2.45 (3.7%) stddev-sans-first:2.60 01:35:43 INFO - PROCESS | 22641 | Values: 67.0 66.0 73.0 67.0 66.0 67.0 64.0 65.0 67.0 65.0 01:35:43 INFO - PROCESS | 22641 | -------- Summary: end -------- 01:35:43 INFO - PROCESS | 22641 | 01:35:44 INFO - TEST-INFO | 22641: exit 0 01:35:44 INFO - TEST-OK | kraken | took 63930ms 01:35:44 INFO - SUITE-END | took 1180s 01:35:44 INFO - Completed test suite (00:19:40) 01:35:44 INFO - javascript benchmark 01:35:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6424.229989137443, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2584.5993870950006, 2624.527585034693, 2650.1651979626404, 2661.1085286429056, 2672.893084276629, 4782.163121453745, 4806.447258565266, 4879.194932836087, 4887.560119589236, 4887.633427492939, 4713.882152946169, 4875.561199492054, 4893.8287159949405, 4896.387951506062, 4898.828541001066, 4464.933026004613, 4480.171168333869, 4582.024824285932, 4599.632029437654, 4639.188142075141, 4283.593058659422, 4590.05903789724, 4628.560286772768, 4665.346851440801, 4689.812407503696, 4432.689711720181, 4465.397171381855, 4488.842890498817, 4497.257952437843, 4505.374267876687, 4467.285234362486, 4492.7528985905765, 4496.55034496551, 4497.460304763416, 4513.864584062483, 4397.164538737629, 4463.973286144205, 4471.686981911267, 4472.127935052666, 4523.592876641118, 4841.757912104381, 4875.098106850209, 4888.071266459361, 4897.1674815281485, 4917.213245880677, 5178.974105129488, 5203.089459344637, 5237.083510385667, 5241.606879484054, 5245.554127899133, 5247.47525247476, 5271.209318602202, 5278.973605131988, 5304.098303288411, 5310.787568497255, 4934.062528119682, 4943.8516844494725, 4951.777170027393, 4959.876003099951, 5005.89988200234, 5439.864003399946, 5443.455654434525, 5450.972745136249, 5459.344878614592, 5460.481254280837, 5015.423226328946, 5081.339425874687, 5110.207917772751, 5134.0, 5145.665531740499, 5103.132467480537, 5220.660657057279, 5243.134882744304, 5247.868803279872, 5253.343332083489, 5110.71891045996, 5115.0025744979375, 5156.20078887773, 5180.274761533388, 5196.142636464941, 5072.51811077947, 5118.744062796845, 5123.513266239701, 5167.173252279617, 5176.611754118456, 4448.532904045029, 4449.555044495589, 4450.1767173073085, 4463.531329210451, 4477.037436951071, 3851.557070936822, 3868.2456920900718, 3884.962174306334, 3906.687465002793, 3928.332183528807, 4393.692441529062, 4480.820767169342, 4521.932171017437, 4528.728276303433, 4549.135664223787, 5268.025415298105, 5305.336832895888, 5308.150695888717, 5315.973420132875, 5354.598405119632, 4448.666350023761, 4538.092381523708, 4548.818047278138, 4551.0442807010895, 4593.839215627504, 4671.579557839743, 4689.976550117228, 4705.788239529229, 4718.8584342469785, 4727.669063165614, 4877.707337559757, 4878.268259761065, 4884.0476107158765, 4886.29148773433, 4928.260760885896, 5085.389753229636, 5170.741462926914, 5171.974140129426, 5194.0, 5220.477952204901, 4866.1727506323305, 4902.926456103232, 4907.828226012215, 4908.141075311734, 4957.35554377943, 5161.741912904265, 5172.0, 5176.352955880515, 5179.093658609803, 5233.371995360429, 5085.796568137233, 5140.640155189101, 5174.9482505174465, 5239.214117882349, 5255.3168088148295, 4954.058728841508, 5018.046571151615, 5035.874103147451, 5083.771230294572, 5116.539511443988, 5075.2387141929, 5102.974485127699, 5108.463611320758, 5112.207607820794, 5162.716050617102, 4920.188168952082, 4985.775640096277, 5006.048850718352, 5024.145895197898, 5032.043911656773, 5101.744912754421, 5157.690538567698, 5161.483851614808, 5163.767630456714, 5209.296744939536, 5018.172001619838, 5042.420121686053, 5055.165897626997, 5056.873578160576, 5083.440821509705], "value": 4795.35709664586, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.0008832856296, 577.1948132355363, 593.4065934065934, 594.1444320178942, 595.1905408644243, 39332.41001384978, 40495.39256911145, 40624.99999999996, 44574.55425445745, 45006.0, 40350.59649403505, 40613.39079913804, 41089.178216435655, 41154.58845411545, 41497.0, 7869.33110685591, 7937.285644292013, 7984.361251099927, 7992.280694737473, 8007.199280071975, 7829.49108307961, 7884.0, 7895.0, 7900.683972641087, 7906.367490600738, 7866.095399029127, 7911.248431399008, 7940.2059794020715, 7950.880736788953, 7983.481073730189, 7874.409419293547, 7903.486273392211, 7915.802104947365, 7923.366130709529, 7935.920640793576, 7807.453478256524, 7825.843483130306, 7854.528728276322, 7856.7250146244605, 7870.527768333918, 37866.0, 38145.61854381448, 38306.0, 38330.616693832984, 38482.23035539302, 2981.299394642279, 3008.9398212035635, 3046.6800985896384, 3088.428640701455, 3346.665333466658, 28739.28151796201, 28750.568741468895, 29010.0, 29299.121026369245, 30002.0, 3479.2345683949743, 3490.4240800267926, 3493.2664140530264, 3531.5055892175114, 3537.5224344713647, 179661.0, 179842.0, 179955.10022449936, 180232.0, 181797.09101454407, 51379.22931156035, 51691.22463163055, 51691.7415412928, 51934.0, 51939.740301298254, 33357.499637505454, 34004.0, 34208.14479637979, 35975.0, 49443.0, 14418.42326306957, 14543.490977815725, 14636.560903172922, 14660.340284687214, 14714.0, 11094.722631934104, 11100.222984391177, 11191.888081119247, 11219.94390028061, 11222.887771122347, 18315.633687326444, 18420.631587368447, 18466.815331846778, 18570.81429185718, 18574.349897753513, 6949.791506254821, 7025.138338340344, 7040.148739760405, 7088.610126442992, 7195.92804071963, 787.3976408047848, 787.6258777080956, 869.9347548933855, 937.161240689579, 949.9192568631605, 26723.06469273605, 27552.586711199347, 27620.44759104847, 27745.24377225947, 27820.582691259242, 899.604174163366, 914.6250037484599, 942.9387089839139, 970.0638883477478, 1001.62439085343, 14939.0, 15117.244137793066, 15122.243887805565, 15448.691026179413, 15451.0, 423638.0, 426530.0, 428999.0, 430022.0, 433123.0, 49926.0, 49937.50062499401, 50016.0, 50313.99372012539, 50398.244026339635, 1156.8264760286024, 1184.549871049013, 1184.727512672073, 1186.4067966017165, 1192.898603618702, 26979.86510067437, 27647.44705105927, 28325.0, 28739.425211496073, 28849.71150288554, 44517.55482445134, 44832.32751508665, 45552.08895822131, 45570.772146139054, 45616.771916140206, 354977.2251138728, 358746.0, 361457.0, 362092.0, 364491.0, 25078.12226572134, 25116.62325065162, 25786.484270314115, 25837.224883253533, 25856.48287034211, 43107.56892431161, 43511.78244108759, 43631.78184109059, 44388.112237754416, 44490.55509444864, 37044.0, 37081.629183708894, 37218.441723374715, 37543.24913501769, 38114.61885381111, 37424.43863341997, 37485.62514374821, 37521.437178441796, 37547.0, 37691.81154094212, 31180.688193117778, 36597.45103823498, 36786.0, 38943.0, 40265.0, 32102.0, 32995.505067423524, 33174.0, 33630.66369336275, 33633.15917101994, 25158.874205628854, 25824.612630810178, 25970.74029259683, 25986.090486833626, 26231.60652590251], "value": 17488.6110502452, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.3961025671742, 359.91901822090034, 373.15666593498696, 374.8331992263443, 394.2037085088122, 16169.43406980756, 16675.41636042739, 17183.140842957866, 17271.136443177824, 17506.56233594159, 15807.84192158078, 16398.7540186897, 16992.830071699278, 17027.233774480148, 17034.914825425887, 5047.747612619363, 5187.273781670569, 5259.789608415659, 5261.947380526184, 5262.657927234736, 3671.9816400917957, 5115.923261151086, 5776.711164441782, 5962.25471816023, 6084.878302433949, 6042.516598672118, 6045.516358691294, 6069.817905462821, 6082.391760823926, 6137.969310153443, 4978.77595508203, 5297.47025297471, 5298.92051619226, 5307.946920530784, 5335.199720042025, 5007.2489126630935, 5144.356955380577, 5151.484851514856, 5179.249008893727, 5215.452377500384, 12354.0734444917, 12454.941329986961, 12463.314517701523, 16054.5986350341, 20189.293374731962, 1870.990645046766, 1911.2259534888392, 2082.9062692178886, 2345.2260753951155, 2419.588669926117, 8756.956215218883, 8859.734207973772, 9065.728028159167, 9083.18251357381, 9141.725748227498, 1650.3563610192034, 1813.4559632110445, 1849.3619701203063, 1870.3453791173117, 1989.1148438944676, 67196.0, 68714.0, 68986.31013689899, 69348.6532567339, 69460.30539694589, 9955.352902061342, 10045.497725113715, 10148.238882083726, 10166.135878450414, 10179.898201018043, 13902.860971390359, 13937.860621393858, 13962.511312104027, 13976.231307278198, 13978.0, 7286.562806231643, 7289.125304963438, 7342.15565209997, 7406.7037318506655, 7417.147028091838, 6832.145981752281, 6895.793126206222, 6922.41159501438, 6963.338482844122, 7046.577205367695, 4418.293073108287, 4431.534688857688, 4452.710573812692, 4459.375687403766, 4553.271476563734, 1726.844583987422, 1761.0842361971702, 1840.5214644192606, 1860.6464771693336, 1872.382113902409, 758.5448730761609, 846.0566468387703, 889.226373055446, 904.9502277374808, 943.7923656795494, 15658.68682626341, 16253.268602912662, 16295.0, 16447.424340148278, 16896.40862569829, 831.0, 880.5773228850188, 888.7822483491586, 919.3932004876749, 962.7304354780673, 8099.0, 9372.625094996123, 9403.0, 9619.374740641835, 9625.422474651543, 407469.0, 412952.0, 413324.0, 414091.0, 416409.0, 71323.6433817838, 74774.6261268701, 76767.0, 77812.22187778163, 77831.22168778353, 910.4764760262875, 920.282179899666, 923.736735030513, 926.4580220570907, 933.1927882381826, 14785.0, 14851.702965940405, 14988.175650339335, 15052.3226454812, 15057.397704091714, 34681.82659086688, 35003.29993400168, 35476.113097172776, 35731.642683572834, 35790.64209357873, 44953.32570011387, 47466.28800568063, 49952.0, 50134.749326253135, 50346.74826625844, 6790.219124800514, 7005.194402643761, 7174.928250717635, 7312.744053958086, 7614.885776713464, 8587.141285871363, 11548.94225528867, 11771.117166212398, 11894.583689570823, 12018.0, 10087.344322619007, 10100.444475553915, 10331.586736530455, 10357.896421035693, 10698.14414846826, 10303.072723454925, 10602.787944241227, 10718.785624287626, 10739.570417183537, 10771.353718776898, 10369.222308326755, 10634.840477393, 10652.89347106519, 10723.0, 10903.618373357212, 7206.639668016683, 7237.601931893796, 7293.744718934812, 7295.781126566211, 7311.23232060626, 10306.845397318897, 10327.586896524355, 10554.894451055392, 10573.418461984666, 10596.47017649099], "value": 8141.0576045514945, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1363.815884855545, 1412.5762271318604, 1483.792269082328, 1665.1091665958716, 1682.0664531185187, 6903.654817259142, 7543.773686789392, 7794.688212471501, 8143.1042585315645, 8159.796005099868, 7596.278353556417, 7817.765467035998, 7837.960810195956, 7855.607219639024, 7914.841703165933, 2228.220122956968, 2263.4567703751145, 2263.660450932357, 2266.7506574276817, 2271.6024695678275, 2188.321620297713, 2189.890505474728, 2255.436140964759, 2255.605269077913, 2261.0, 2208.094681180716, 2222.3777342344088, 2224.0, 2238.104758096766, 2248.6739422783685, 2139.9786002140013, 2162.524244666171, 2189.704389907358, 2194.2868567715395, 2205.2722601541454, 2197.2419515267206, 2248.4828489447355, 2250.9437264068365, 2250.988745056264, 2258.9887050564807, 7928.127905930343, 7962.203779622049, 7976.0, 8004.079530853968, 8027.117017128111, 4606.424196975378, 4726.0784147091335, 4732.266498692708, 4735.289706544046, 4742.739149346785, 2892.754115900151, 2926.4293462774767, 3012.0, 3023.1988523041414, 3029.7727670424806, 894.9373543851868, 921.5484412637826, 944.8629948657406, 946.9431834089977, 949.188443880486, 10480.423576703355, 10517.52671129801, 10615.09771669409, 10631.734206644896, 10669.679909602724, 4162.250794856895, 4229.090745489734, 4303.462067241595, 4316.525182229952, 4358.0, 8988.55057247135, 9010.369274150746, 9029.548522573845, 9085.727428177166, 9237.168654821098, 4688.835890743808, 4698.8120475181295, 4716.95283047172, 4727.858164255078, 4734.573888349996, 3680.5583330000572, 4113.773742444135, 4131.462909821704, 4206.158768246363, 4282.379055037002, 3579.069441945061, 3617.1318883468302, 3683.889483315505, 3696.8706095286534, 3719.367707489733, 1171.3557543351124, 1196.4556126962211, 1223.7797196504714, 1224.3510939202058, 1229.440604524939, 655.8786624474487, 783.6591082878851, 803.2609998801117, 805.6334367862726, 822.1696086952221, 4836.492168322276, 4960.727160006162, 4964.67729597575, 5002.499750025041, 5004.3994720633755, 409.1550947293829, 413.88618130014487, 414.2646801926544, 414.53779036374226, 418.3933296719708, 3417.5044618530173, 3457.377672019061, 3469.670381313771, 3537.20412907099, 3560.181158333598, 9558.808823823485, 9735.26985476078, 9799.657012004545, 9831.705048848546, 9872.0, 9610.135087842127, 9661.758456038515, 9677.225821934227, 9686.854697179548, 9765.218782497383, 7266.527675701168, 7356.190819009905, 7383.2985866342615, 7431.665575049135, 7499.587522686195, 4959.181735013683, 4993.101241776515, 5005.574526165171, 5074.847754567369, 5132.589392848488, 8836.381453298465, 9003.909960900308, 9061.864072039056, 9099.727008189764, 9163.312751543794, 9150.130737579919, 9190.172884440433, 9191.310651701015, 9205.723828285161, 9411.905880941104, 6190.628562286277, 6417.679116044273, 6559.836004099936, 6877.552959057645, 6972.337627925339, 7298.087739032621, 7434.36807871337, 7460.66427010775, 7469.290417410337, 7502.887456688045, 6496.382843629847, 6641.833954151185, 6697.7655782047395, 6727.360900714424, 6741.73033078691, 6596.637184954873, 6635.900461493178, 6667.966660166668, 6706.865862682622, 6784.219814721173, 6088.847778805565, 6192.81421557354, 6194.039923811636, 6199.535034872312, 6204.81385558434, 4357.302831546937, 4600.2869555218995, 4604.3323718061365, 4614.353990441274, 4745.217039188496, 4485.327200919888, 4554.043650833362, 4562.224421848227, 4608.539146085364, 4629.537046295478], "value": 4064.469001259679, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.67328102446794, 309.55115083129454, 310.6055309756609, 312.09959267513216, 313.45458901511375, 4888.780004899779, 5009.774560144793, 5108.182690769478, 5187.014467251224, 5204.479552044789, 5048.6465947383695, 5083.220872694565, 5094.210397388401, 5094.261332106842, 5140.583925554993, 3973.7019723520707, 4016.959830401702, 4017.216642754664, 4045.4336392905016, 4093.406456063869, 3991.8203680834285, 4045.0494133878515, 4070.287699652564, 4076.8980775480554, 4092.631663150316, 3979.4428779970826, 3989.3218152914073, 3996.520417549898, 4003.939940900889, 4009.719319647626, 4009.5789942056103, 4033.495813023372, 4052.8986775330704, 4076.5719599441927, 4100.894386488811, 3576.535050443426, 3583.050491619723, 3584.5698516178227, 3593.1556084320164, 3607.549056367954, 4762.9523704763205, 4958.9008219835405, 4973.5772459341, 5009.872778624816, 5010.198368261097, 4569.474510431276, 4592.7933243004145, 4593.955689718076, 4594.609458196057, 4606.447226332828, 5343.679379237258, 5352.839414817562, 5379.784808607651, 5387.4612538746205, 5421.990795108713, 3615.7288203384587, 3812.5996770338993, 3839.6928245740273, 3848.191879705237, 3947.940780888289, 5631.436856314377, 5648.406917273668, 5687.914681279784, 5696.458836410535, 5714.571407144481, 3864.574896761354, 3869.4195870619633, 3878.864239751595, 3887.261420330128, 3889.658067966547, 3836.0, 3884.7863367515056, 3914.4715463412645, 3943.5859234779937, 3965.7620542767527, 4426.18115648606, 4432.312991486325, 4435.223835828717, 4450.2434586120435, 4461.776911154429, 5287.603429742785, 5349.732513374393, 5356.651817631841, 5379.041527160046, 5399.676019438846, 1256.2462522486435, 1311.8819306262292, 1328.435414948643, 1329.6476433745065, 1345.9125156864773, 833.791552111972, 847.7329641163137, 853.6585365853584, 863.7561910848358, 869.5347988825948, 4166.562510936369, 4184.539700632928, 4201.70588058833, 4242.893927651833, 4263.360495925574, 4819.855404337875, 4820.6143508519235, 4837.0, 4869.9269510957365, 4881.95118048822, 4139.627433530936, 4192.664586833046, 4219.38818871262, 4248.426462427595, 4268.59448352406, 2499.4001439654717, 2616.6916541729133, 2626.2797867396885, 2652.416468376954, 2666.05355098941, 4591.678582499193, 4605.700629459075, 4610.0, 4611.9077618447445, 4616.492185859553, 4930.383702037246, 4979.90040199194, 4983.750812459362, 5034.194528875362, 5084.796608135707, 4368.60682538573, 4534.7052441591195, 4534.909301813946, 4552.817887284537, 4591.03588246472, 4810.518948105161, 4852.5979640078385, 4867.9269810952155, 4876.536729010738, 4895.534924182197, 4755.0, 4787.3776409066595, 4824.179889418737, 4825.30033145199, 4833.73414462208, 4363.934540981824, 4568.428946381702, 4581.862544123682, 4610.193216187086, 4610.585047345755, 3485.8605655773486, 3486.372452958492, 3489.1333136771705, 3495.807730574843, 3504.1940353719297, 4789.880252993703, 4817.084753896748, 4832.855014349575, 4868.537488938545, 5276.992114494701, 5193.0, 5317.521423071942, 5337.226102215234, 5374.919376209282, 5395.865103372447, 5299.973500132474, 5354.3574771027725, 5356.0626890294825, 5377.139657654757, 5399.649022813504, 5010.649254552146, 5263.6052296078715, 5265.0, 5269.841904742864, 5289.233061206027, 5358.169483730028, 5377.489138531833, 5381.919271211013, 5401.837944861661, 5407.242985982044, 5319.388270348804, 5347.331583552056, 5349.331333583302, 5353.323338330834, 5359.517643412111], "value": 3873.440143552741, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.7812031428058, 608.5861614102408, 691.3121444163058, 691.4468425259794, 700.414196780674, 10907.945460272687, 13949.02356835022, 14211.502597409093, 14733.999999999987, 14794.038387504805, 13503.324833758323, 13659.521916732916, 14108.224047677399, 14136.22250776207, 14136.50522231722, 810.5055915891302, 813.1705660226565, 813.5037627047496, 816.1838161838161, 817.5544328341039, 799.312591171592, 799.3525244551903, 801.3869389916719, 805.9879101813448, 807.4953154278576, 841.032812265896, 846.2299307630058, 848.2111636178352, 850.090403268503, 851.902031266403, 832.2842355574202, 836.6987884361625, 841.2092632925062, 844.4637655089001, 847.8134810341746, 613.089562000429, 615.9076138579204, 616.5252755378334, 618.1099217127368, 618.3692633513836, 11986.52053917851, 12400.62798116058, 12428.378581071001, 12431.12982091254, 12436.75126497465, 13073.673158171026, 13239.536616218385, 13266.3366831659, 13917.095388799797, 13970.0, 10113.0, 10378.06597406237, 10417.322874013165, 10517.0, 10847.566097356175, 3350.5644266245477, 3360.3996258483016, 3382.7970321780526, 3412.7269818414716, 3413.4026545354463, 57931.710341448445, 58553.12170317449, 59468.810623787715, 59556.70221648907, 60236.39763602352, 10721.785564288826, 10771.89228107709, 10818.242723009314, 10831.566737330577, 10918.1811364148, 19865.30471433493, 20189.192432302836, 20214.49463763388, 20302.593948120953, 20332.08505617251, 6574.178227721535, 6766.15423072116, 6904.3095690431555, 6967.477439192081, 7067.43460523157, 3585.5697316322207, 3605.387084195693, 3631.8728844490315, 3664.120611053328, 3756.1736417988545, 3016.441958237733, 3092.747437287902, 3102.4260511805387, 3143.764217683637, 3168.1446009577285, 520.5549255386666, 540.783686525393, 543.1147230015129, 547.0672503381725, 580.1269090019578, 555.0370107862855, 560.7364538666901, 571.2801869644278, 580.3297191743543, 589.3782059926818, 7694.884576731353, 7816.41376896735, 7900.881486777703, 8073.2734053934255, 8127.0, 534.5322842512801, 550.6833570696786, 561.7696744334803, 590.0117303516593, 607.4441885674559, 3668.779873207616, 3688.7602305850032, 3745.9438108428394, 3818.6563209311294, 3888.51393575803, 90150.09849901548, 93968.0, 95080.0, 96987.0, 97108.51445742867, 81207.0, 83325.0, 83700.16299836924, 83989.0, 84734.7975422096, 72240.63879680568, 73206.63396682983, 73846.26153738501, 74805.6259718698, 75215.0, 6719.160104986877, 6741.561798483083, 6860.108185935796, 6926.965365173141, 6948.722051117898, 39911.40132897951, 41002.79498602488, 41147.7942610285, 41394.58605413907, 42402.0, 58514.70742646259, 60720.39279607324, 61343.38656613377, 61344.38655613565, 62288.0, 10039.297249192487, 10075.395476271155, 10145.137663298703, 10183.236257280882, 10237.0, 10686.145108391465, 11114.44427778624, 12058.216215945935, 12340.876591233973, 12848.678783030498, 12070.577529786415, 12148.757024859276, 12324.691882702646, 12451.564195253122, 13300.334983250605, 10503.632372866912, 10844.349339039683, 11114.16643751738, 11138.108951283715, 11611.0, 11149.944250278697, 11329.093672506344, 11630.0, 12025.518979240733, 12235.082368822195, 9453.43279403238, 10251.333663311862, 10276.486175691334, 10433.53049112807, 10485.895141048797, 9964.186231595875, 9985.201183905125, 10389.896101038892, 10625.043746062891, 10734.838977415502], "value": 6539.1336733153685, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1575.8000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 110.0, 113.0, 113.0, 114.0, 114.0, 113.0, 112.0, 112.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 132.0, 156.0, 184.0, 132.0, 152.0, 157.0, 136.0, 184.0, 131.0], "value": 153.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 170.0, 177.0, 166.0, 164.0, 164.0, 163.0, 162.0, 162.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 153.0, 77.0, 76.0, 75.0, 76.0, 158.0, 76.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 147.0, 87.0, 88.0, 88.0, 132.0, 88.0, 86.0, 140.0], "value": 103.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 119.0, 118.0, 119.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 148.0, 148.0, 148.0, 148.0, 149.0, 149.0, 149.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 62.0, 65.0, 63.0, 63.0, 64.0, 63.0, 62.0, 64.0, 64.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 65.0, 65.0, 65.0, 67.0, 66.0, 64.0, 66.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 81.0, 84.0, 86.0, 89.0, 85.0, 83.0, 100.0, 84.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 149.0, 142.0, 140.0, 134.0, 132.0, 130.0, 138.0, 139.0, 131.0], "value": 137.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 170.0, 171.0, 165.0, 172.0, 165.0, 166.0, 163.0, 177.0, 167.0], "value": 168.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 73.0, 67.0, 66.0, 67.0, 64.0, 65.0, 67.0, 65.0], "value": 66.7, "unit": "score"}]}]} 01:35:44 INFO - Return code: 0 01:35:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:35:44 ERROR - # TBPL SUCCESS # 01:35:44 INFO - Running post-action listener: _resource_record_post_action 01:35:44 INFO - ##### 01:35:44 INFO - ##### Finished run-tests step (success) 01:35:44 INFO - ##### 01:35:44 INFO - Running post-run listener: _resource_record_post_run 01:35:44 INFO - Total resource usage - Wall time: 1198s; CPU: 14.0%; Read bytes: 4096; Write bytes: 534908928; Read time: 12; Write time: 413048 01:35:44 INFO - TinderboxPrint: CPU usage
13.5% 01:35:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 01:35:44 INFO - TinderboxPrint: I/O write bytes / time
534,908,928 / 413,048 01:35:44 INFO - TinderboxPrint: CPU idle
8,263.0 (86.5%) 01:35:44 INFO - TinderboxPrint: CPU user
1,238.7 (13.0%) 01:35:44 INFO - TinderboxPrint: Swap in / out
0 / 0 01:35:44 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 246722560; Read time: 0; Write time: 248312 01:35:44 INFO - run-tests - Wall time: 1182s; CPU: 14.0%; Read bytes: 4096; Write bytes: 288186368; Read time: 12; Write time: 164736 01:35:45 INFO - Running post-run listener: _upload_blobber_files 01:35:45 INFO - Blob upload gear active. 01:35:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:35:45 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 01:35:45 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'] 01:35:45 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 01:35:45 INFO - (blobuploader) - INFO - Open directory for files ... 01:35:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:35:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:35:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:35:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:35:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:35:46 INFO - (blobuploader) - INFO - Done attempting. 01:35:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:35:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:35:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:35:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:35:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:35:47 INFO - (blobuploader) - INFO - Done attempting. 01:35:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:35:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:35:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:35:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:35:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:35:50 INFO - (blobuploader) - INFO - Done attempting. 01:35:50 INFO - (blobuploader) - INFO - Iteration through files over. 01:35:50 INFO - Return code: 0 01:35:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:35:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:35:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8225a57b93a2fd4a6aa4ffbbce942b5c0073894e8bb8582a4a619ed857a4fec71e172dc952528af4541d8a86a9bd79d5e0149cac48a50d37291d5769d0b04fc4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7908596894a31685df0bbf743165dcb0345fc60402ad12d9785ffd201279f417979764b7946afa37065d0f33de6f20631cca50926215debfc25d1cb20e8a65a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1c52452b9faa98d234a662de1284461a5cd4ff0f6bb5d7406b840be0e9e245ca37ecf3761c3d77f52ed54ba6c7b97776bb7b5c0c46ffba342a63e30e7480e9d5"} 01:35:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:35:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:35:50 INFO - Contents: 01:35:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8225a57b93a2fd4a6aa4ffbbce942b5c0073894e8bb8582a4a619ed857a4fec71e172dc952528af4541d8a86a9bd79d5e0149cac48a50d37291d5769d0b04fc4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7908596894a31685df0bbf743165dcb0345fc60402ad12d9785ffd201279f417979764b7946afa37065d0f33de6f20631cca50926215debfc25d1cb20e8a65a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1c52452b9faa98d234a662de1284461a5cd4ff0f6bb5d7406b840be0e9e245ca37ecf3761c3d77f52ed54ba6c7b97776bb7b5c0c46ffba342a63e30e7480e9d5"} 01:35:50 INFO - Running post-run listener: copy_logs_to_upload_dir 01:35:50 INFO - Copying logs to upload dir... 01:35:50 INFO - mkdir: /builds/slave/test/build/upload/logs 01:35:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.357578 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-27 01:35:49.492279) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 01:35:49.495748) ========= 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=41bf3e9aed84707956354da8000001c5-1467004802.250994-1220753862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8225a57b93a2fd4a6aa4ffbbce942b5c0073894e8bb8582a4a619ed857a4fec71e172dc952528af4541d8a86a9bd79d5e0149cac48a50d37291d5769d0b04fc4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7908596894a31685df0bbf743165dcb0345fc60402ad12d9785ffd201279f417979764b7946afa37065d0f33de6f20631cca50926215debfc25d1cb20e8a65a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1c52452b9faa98d234a662de1284461a5cd4ff0f6bb5d7406b840be0e9e245ca37ecf3761c3d77f52ed54ba6c7b97776bb7b5c0c46ffba342a63e30e7480e9d5"} build_url:https://queue.taskcluster.net/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011214 build_url: 'https://queue.taskcluster.net/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8225a57b93a2fd4a6aa4ffbbce942b5c0073894e8bb8582a4a619ed857a4fec71e172dc952528af4541d8a86a9bd79d5e0149cac48a50d37291d5769d0b04fc4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7908596894a31685df0bbf743165dcb0345fc60402ad12d9785ffd201279f417979764b7946afa37065d0f33de6f20631cca50926215debfc25d1cb20e8a65a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1c52452b9faa98d234a662de1284461a5cd4ff0f6bb5d7406b840be0e9e245ca37ecf3761c3d77f52ed54ba6c7b97776bb7b5c0c46ffba342a63e30e7480e9d5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 01:35:49.522151) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:35:49.522563) ========= 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=41bf3e9aed84707956354da8000001c5-1467004802.250994-1220753862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004392 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:35:49.604302) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 01:35:49.604619) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 01:35:49.604934) ========= ========= Total master_lag: 0.21 =========