builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0110 starttime: 1467669182.42 results: success (0) buildid: 20160704123423 builduid: d7e35e47782f46f38f97cd8767282f9c revision: a7105b09ae0c18b858c33b1020bdded6a6d66c9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 14:53:02.418084) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 14:53:02.418574) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 14:53:02.418884) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 14:53:02.442221) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 14:53:02.442522) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ld28rmPtAA/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.mEs1n2pohs/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-04 14:53:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.35M=0.001s 2016-07-04 14:53:03 (8.35 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.569728 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 14:53:03.034047) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 14:53:03.034367) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ld28rmPtAA/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.mEs1n2pohs/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.020814 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 14:53:03.083770) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 14:53:03.084100) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a7105b09ae0c18b858c33b1020bdded6a6d66c9b --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 a7105b09ae0c18b858c33b1020bdded6a6d66c9b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ld28rmPtAA/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.mEs1n2pohs/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-04 14:53:03,157 truncating revision to first 12 chars 2016-07-04 14:53:03,157 Setting DEBUG logging. 2016-07-04 14:53:03,157 attempt 1/10 2016-07-04 14:53:03,157 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a7105b09ae0c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 14:53:04,043 unpacking tar archive at: fx-team-a7105b09ae0c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.161723 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 14:53:04.269931) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 14:53:04.270236) ========= script_repo_revision: a7105b09ae0c18b858c33b1020bdded6a6d66c9b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 14:53:04.270620) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 14:53:04.270896) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 14:53:04.288520) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-07-04 14:53:04.288899) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ld28rmPtAA/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.mEs1n2pohs/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 14:53:04 INFO - MultiFileLogger online at 20160704 14:53:04 in /builds/slave/test 14:53:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:53:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:53:04 INFO - {'append_to_log': False, 14:53:04 INFO - 'base_work_dir': '/builds/slave/test', 14:53:04 INFO - 'blob_upload_branch': 'Fx-Team', 14:53:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:53:04 INFO - 'branch': 'Fx-Team', 14:53:04 INFO - 'buildbot_json_path': 'buildprops.json', 14:53:04 INFO - 'config_files': ('talos/mac_config.py',), 14:53:04 INFO - 'default_actions': ('clobber', 14:53:04 INFO - 'read-buildbot-config', 14:53:04 INFO - 'download-and-extract', 14:53:04 INFO - 'populate-webroot', 14:53:04 INFO - 'create-virtualenv', 14:53:04 INFO - 'install', 14:53:04 INFO - 'run-tests'), 14:53:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:53:04 INFO - 'download_minidump_stackwalk': True, 14:53:04 INFO - 'download_symbols': 'ondemand', 14:53:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:53:04 INFO - 'tooltool.py': '/tools/tooltool.py', 14:53:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:53:04 INFO - '/tools/misc-python/virtualenv.py')}, 14:53:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:53:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:53:04 INFO - 'installer_path': 'installer.exe', 14:53:04 INFO - 'log_level': 'info', 14:53:04 INFO - 'log_name': 'talos', 14:53:04 INFO - 'log_to_console': True, 14:53:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:53:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:53:04 INFO - 'opt_config_files': (), 14:53:04 INFO - 'pip_index': False, 14:53:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:53:04 INFO - 'cmd': ('bash', 14:53:04 INFO - '-c', 14:53:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:53:04 INFO - 'enabled': True, 14:53:04 INFO - 'halt_on_failure': False, 14:53:04 INFO - 'name': 'check_screen_resolution'},), 14:53:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:53:04 INFO - 'cmd': ('bash', 14:53:04 INFO - '-c', 14:53:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:53:04 INFO - 'enabled': True, 14:53:04 INFO - 'halt_on_failure': False, 14:53:04 INFO - 'name': 'check_screen_resolution'},), 14:53:04 INFO - 'run_cmd_checks_enabled': True, 14:53:04 INFO - 'sps_profile': False, 14:53:04 INFO - 'sps_profile_interval': 0, 14:53:04 INFO - 'suite': 'dromaeojs', 14:53:04 INFO - 'system_bits': '32', 14:53:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:53:04 INFO - 'title': 't-yosemite-r7-0110', 14:53:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:53:04 INFO - 'use_talos_json': True, 14:53:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:53:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:53:04 INFO - 'work_dir': 'build'} 14:53:04 INFO - ##### 14:53:04 INFO - ##### Running clobber step. 14:53:04 INFO - ##### 14:53:04 INFO - Running pre-action listener: _resource_record_pre_action 14:53:04 INFO - Running main action method: clobber 14:53:04 INFO - rmtree: /builds/slave/test/build 14:53:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:53:06 INFO - Running post-action listener: _resource_record_post_action 14:53:06 INFO - ##### 14:53:06 INFO - ##### Finished clobber step (success) 14:53:06 INFO - ##### 14:53:06 INFO - ##### 14:53:06 INFO - ##### Running read-buildbot-config step. 14:53:06 INFO - ##### 14:53:06 INFO - Running pre-action listener: _resource_record_pre_action 14:53:06 INFO - Running main action method: read_buildbot_config 14:53:06 INFO - Using buildbot properties: 14:53:06 INFO - { 14:53:06 INFO - "project": "", 14:53:06 INFO - "product": "firefox", 14:53:06 INFO - "script_repo_revision": "production", 14:53:06 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 14:53:06 INFO - "repository": "", 14:53:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 14:53:06 INFO - "buildid": "20160704123423", 14:53:06 INFO - "pgo_build": "False", 14:53:06 INFO - "basedir": "/builds/slave/test", 14:53:06 INFO - "buildnumber": 80, 14:53:06 INFO - "slavename": "t-yosemite-r7-0110", 14:53:06 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 14:53:06 INFO - "platform": "yosemite_r7", 14:53:06 INFO - "scheduler": "tests-fx-team-macosx64-talos", 14:53:06 INFO - "branch": "fx-team", 14:53:06 INFO - "repo_path": "integration/fx-team", 14:53:06 INFO - "revision": "a7105b09ae0c18b858c33b1020bdded6a6d66c9b", 14:53:06 INFO - "stage_platform": "macosx64", 14:53:06 INFO - "builduid": "d7e35e47782f46f38f97cd8767282f9c", 14:53:06 INFO - "slavebuilddir": "test" 14:53:06 INFO - } 14:53:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 14:53:06 INFO - Running post-action listener: _resource_record_post_action 14:53:06 INFO - ##### 14:53:06 INFO - ##### Finished read-buildbot-config step (success) 14:53:06 INFO - ##### 14:53:06 INFO - ##### 14:53:06 INFO - ##### Running download-and-extract step. 14:53:06 INFO - ##### 14:53:06 INFO - Running pre-action listener: _resource_record_pre_action 14:53:06 INFO - Running main action method: download_and_extract 14:53:06 INFO - mkdir: /builds/slave/test/build/tests 14:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:06 INFO - https://queue.taskcluster.net/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:53:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 14:53:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 14:53:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 14:53:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 14:53:07 INFO - Downloaded 1199 bytes. 14:53:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 14:53:07 INFO - Using the following test package requirements: 14:53:07 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 14:53:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:53:07 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 14:53:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:53:07 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 14:53:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:53:07 INFO - u'jsshell-mac.zip'], 14:53:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:53:07 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 14:53:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 14:53:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:53:07 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 14:53:07 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:53:07 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 14:53:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:53:07 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 14:53:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:53:07 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 14:53:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:53: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')]} 14:53:07 INFO - https://queue.taskcluster.net/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:53:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 14:53:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 14:53:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 14:53:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:53:09 INFO - Downloaded 18795272 bytes. 14:53:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:53:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:53:12 INFO - Return code: 0 14:53:12 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:53:12 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')]} 14:53:12 INFO - https://queue.taskcluster.net/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:53:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 14:53:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 14:53:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 14:53:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:53:14 INFO - Downloaded 18795272 bytes. 14:53:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:53:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:53:18 INFO - Return code: 0 14:53: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')]} 14:53:18 INFO - https://queue.taskcluster.net/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:53:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 14:53:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 14:53:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 14:53:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:53:22 INFO - Downloaded 14403333 bytes. 14:53:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:53:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 14:53:23 INFO - Return code: 0 14:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:23 INFO - https://queue.taskcluster.net/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:53:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 14:53:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 14:53:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 14:53:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 14:53:26 INFO - Downloaded 112427392 bytes. 14:53:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 14:53:26 INFO - mkdir: /builds/slave/test/properties 14:53:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:53:26 INFO - Writing to file /builds/slave/test/properties/build_url 14:53:26 INFO - Contents: 14:53:26 INFO - build_url:https://queue.taskcluster.net/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 14:53:27 INFO - Running post-action listener: _resource_record_post_action 14:53:27 INFO - Running post-action listener: set_extra_try_arguments 14:53:27 INFO - ##### 14:53:27 INFO - ##### Finished download-and-extract step (success) 14:53:27 INFO - ##### 14:53:27 INFO - ##### 14:53:27 INFO - ##### Running populate-webroot step. 14:53:27 INFO - ##### 14:53:27 INFO - Running pre-action listener: _resource_record_pre_action 14:53:27 INFO - Running main action method: populate_webroot 14:53:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:53:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:53:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:53:27 INFO - '--tppagecycles', 14:53:27 INFO - '7'], 14:53:27 INFO - 'tests': ['tsvgm']}}, 14:53:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:53:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:53:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:53:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:53:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:53:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:53:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:27 INFO - 'talos_options': ['--disable-e10s'], 14:53:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:53:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:53:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:27 INFO - 'talos_options': ['--disable-e10s'], 14:53:27 INFO - 'tests': ['damp', 'tps']}, 14:53:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:27 INFO - 'tests': ['damp', 'tps']}, 14:53:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:53:27 INFO - 'tests': ['dromaeo_dom']}, 14:53:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:53:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:53:27 INFO - 'tests': ['basic_compositor_video']}, 14:53:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:53:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:53:27 INFO - 'tests': ['a11yr', 14:53:27 INFO - 'ts_paint', 14:53:27 INFO - 'tpaint', 14:53:27 INFO - 'sessionrestore', 14:53:27 INFO - 'sessionrestore_no_auto_restore', 14:53:27 INFO - 'tabpaint']}, 14:53:27 INFO - 'other-e10s': {'tests': ['a11yr', 14:53:27 INFO - 'ts_paint', 14:53:27 INFO - 'tpaint', 14:53:27 INFO - 'sessionrestore', 14:53:27 INFO - 'sessionrestore_no_auto_restore', 14:53:27 INFO - 'tabpaint']}, 14:53:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:53:27 INFO - 'ts_paint', 14:53:27 INFO - 'tpaint', 14:53:27 INFO - 'sessionrestore', 14:53:27 INFO - 'sessionrestore_no_auto_restore', 14:53:27 INFO - 'tabpaint']}, 14:53:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:53:27 INFO - 'ts_paint', 14:53:27 INFO - 'tpaint', 14:53:27 INFO - 'sessionrestore', 14:53:27 INFO - 'sessionrestore_no_auto_restore', 14:53:27 INFO - 'tabpaint']}, 14:53:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:53:27 INFO - 'tests': ['a11yr', 14:53:27 INFO - 'ts_paint', 14:53:27 INFO - 'tpaint', 14:53:27 INFO - 'sessionrestore', 14:53:27 INFO - 'sessionrestore_no_auto_restore', 14:53:27 INFO - 'tabpaint']}, 14:53:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:53:27 INFO - 'tests': ['a11yr', 14:53:27 INFO - 'ts_paint', 14:53:27 INFO - 'tpaint', 14:53:27 INFO - 'sessionrestore', 14:53:27 INFO - 'sessionrestore_no_auto_restore', 14:53:27 INFO - 'tabpaint']}, 14:53:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:53:27 INFO - 'tests': ['tsvgx', 14:53:27 INFO - 'tsvgr_opacity', 14:53:27 INFO - 'tart', 14:53:27 INFO - 'tscrollx', 14:53:27 INFO - 'cart']}, 14:53:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:53:27 INFO - 'tsvgr_opacity', 14:53:27 INFO - 'tart', 14:53:27 INFO - 'tscrollx', 14:53:27 INFO - 'cart']}, 14:53:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:27 INFO - 'talos_options': ['--disable-e10s'], 14:53:27 INFO - 'tests': ['tp5o']}, 14:53:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:27 INFO - 'tests': ['tp5o']}, 14:53:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:27 INFO - 'talos_options': ['--disable-e10s', 14:53:27 INFO - '--xperf_path', 14:53:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:53:27 INFO - 'tests': ['tp5n']}, 14:53:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:27 INFO - 'talos_options': ['--xperf_path', 14:53:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:53:27 INFO - 'tests': ['tp5n']}}, 14:53:27 INFO - 'talos.zip': {'path': '', 14:53:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:53:27 INFO - Running post-action listener: _resource_record_post_action 14:53:27 INFO - ##### 14:53:27 INFO - ##### Finished populate-webroot step (success) 14:53:27 INFO - ##### 14:53:27 INFO - ##### 14:53:27 INFO - ##### Running create-virtualenv step. 14:53:27 INFO - ##### 14:53:27 INFO - Running pre-action listener: _resource_record_pre_action 14:53:27 INFO - Running main action method: create_virtualenv 14:53:27 INFO - Creating virtualenv /builds/slave/test/build/venv 14:53:27 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 14:53:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:53:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:53:27 INFO - Using real prefix '/tools/python27' 14:53:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:53:28 INFO - Installing distribute.............................................................................................................................................................................................done. 14:53:31 INFO - Installing pip.................done. 14:53:31 INFO - Return code: 0 14:53:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:53: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')]} 14:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53: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')]} 14:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1095fda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109692618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1ad722d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109561d30>, '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 0x1092c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109559b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ld28rmPtAA/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mEs1n2pohs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:53: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', 'pip>=1.5'] in /builds/slave/test/build 14:53: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 pip>=1.5 14:53:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ld28rmPtAA/Render', 14:53:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:31 INFO - 'HOME': '/Users/cltbld', 14:53:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:31 INFO - 'LOGNAME': 'cltbld', 14:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:31 INFO - 'MOZ_NO_REMOTE': '1', 14:53:31 INFO - 'NO_EM_RESTART': '1', 14:53:31 INFO - 'PAGER': '/bin/cat', 14:53:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:31 INFO - 'PWD': '/builds/slave/test', 14:53:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:31 INFO - 'SHELL': '/bin/bash', 14:53:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mEs1n2pohs/Listeners', 14:53:31 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 14:53:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:31 INFO - 'USER': 'cltbld', 14:53:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:31 INFO - 'XPC_FLAGS': '0x0', 14:53:31 INFO - 'XPC_SERVICE_NAME': '0', 14:53:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:31 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 14:53:31 INFO - Cleaning up... 14:53:31 INFO - Return code: 0 14:53:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:53: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')]} 14:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53: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')]} 14:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53: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', '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 0x1095fda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109692618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1ad722d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109561d30>, '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 0x1092c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109559b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ld28rmPtAA/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mEs1n2pohs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:53: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', 'psutil>=3.1.1'] in /builds/slave/test/build 14:53: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 psutil>=3.1.1 14:53:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ld28rmPtAA/Render', 14:53:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:31 INFO - 'HOME': '/Users/cltbld', 14:53:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:31 INFO - 'LOGNAME': 'cltbld', 14:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:31 INFO - 'MOZ_NO_REMOTE': '1', 14:53:31 INFO - 'NO_EM_RESTART': '1', 14:53:31 INFO - 'PAGER': '/bin/cat', 14:53:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:31 INFO - 'PWD': '/builds/slave/test', 14:53:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:31 INFO - 'SHELL': '/bin/bash', 14:53:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mEs1n2pohs/Listeners', 14:53:31 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 14:53:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:31 INFO - 'USER': 'cltbld', 14:53:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:31 INFO - 'XPC_FLAGS': '0x0', 14:53:31 INFO - 'XPC_SERVICE_NAME': '0', 14:53:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:31 INFO - Downloading/unpacking psutil>=3.1.1 14:53: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 14:53: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 14:53: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 14:53: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 14:53: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 14:53: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 14:53:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:53:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:53:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:53:34 INFO - Installing collected packages: psutil 14:53:34 INFO - Running setup.py install for psutil 14:53:34 INFO - building 'psutil._psutil_osx' extension 14:53:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:53:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:53:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:53:35 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:53:35 INFO - building 'psutil._psutil_posix' extension 14:53:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:53:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:53:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:53:35 INFO - ^ 14:53:35 INFO - 1 warning generated. 14:53:35 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:53:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:53:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:53:35 INFO - Successfully installed psutil 14:53:35 INFO - Cleaning up... 14:53:35 INFO - Return code: 0 14:53:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:53: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')]} 14:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53: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')]} 14:53:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:35 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 0x1095fda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109692618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1ad722d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109561d30>, '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 0x1092c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109559b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ld28rmPtAA/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mEs1n2pohs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:53:35 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 14:53:35 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 14:53:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ld28rmPtAA/Render', 14:53:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:35 INFO - 'HOME': '/Users/cltbld', 14:53:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:35 INFO - 'LOGNAME': 'cltbld', 14:53:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:35 INFO - 'MOZ_NO_REMOTE': '1', 14:53:35 INFO - 'NO_EM_RESTART': '1', 14:53:35 INFO - 'PAGER': '/bin/cat', 14:53:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:35 INFO - 'PWD': '/builds/slave/test', 14:53:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:35 INFO - 'SHELL': '/bin/bash', 14:53:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mEs1n2pohs/Listeners', 14:53:35 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 14:53:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:35 INFO - 'USER': 'cltbld', 14:53:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:35 INFO - 'XPC_FLAGS': '0x0', 14:53:35 INFO - 'XPC_SERVICE_NAME': '0', 14:53:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:53:35 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 14:53:35 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 14:53:35 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 14:53:35 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 14:53:35 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 14:53:35 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 14:53:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:53:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:53:38 INFO - Installing collected packages: mozsystemmonitor 14:53:38 INFO - Running setup.py install for mozsystemmonitor 14:53:38 INFO - Successfully installed mozsystemmonitor 14:53:38 INFO - Cleaning up... 14:53:38 INFO - Return code: 0 14:53:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:53: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')]} 14:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53: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')]} 14:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:38 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 0x1095fda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109692618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1ad722d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109561d30>, '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 0x1092c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109559b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ld28rmPtAA/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mEs1n2pohs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:53:38 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 14:53:38 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 14:53:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ld28rmPtAA/Render', 14:53:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:38 INFO - 'HOME': '/Users/cltbld', 14:53:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:38 INFO - 'LOGNAME': 'cltbld', 14:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:38 INFO - 'MOZ_NO_REMOTE': '1', 14:53:38 INFO - 'NO_EM_RESTART': '1', 14:53:38 INFO - 'PAGER': '/bin/cat', 14:53:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:38 INFO - 'PWD': '/builds/slave/test', 14:53:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:38 INFO - 'SHELL': '/bin/bash', 14:53:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mEs1n2pohs/Listeners', 14:53:38 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 14:53:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:38 INFO - 'USER': 'cltbld', 14:53:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:38 INFO - 'XPC_FLAGS': '0x0', 14:53:38 INFO - 'XPC_SERVICE_NAME': '0', 14:53:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:38 INFO - Downloading/unpacking jsonschema==2.5.1 14:53:38 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 14:53:38 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 14:53:38 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 14:53:38 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 14:53:38 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 14:53:38 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 14:53:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:53:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:53:41 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 14:53:41 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 14:53:41 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 14:53:41 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 14:53:41 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 14:53:41 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 14:53:41 INFO - Downloading functools32-3.2.3-2.tar.gz 14:53:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:53:41 INFO - warning: no files found matching '*.txt' 14:53:41 INFO - no previously-included directories found matching 'build' 14:53:41 INFO - no previously-included directories found matching 'dist' 14:53:41 INFO - no previously-included directories found matching '.git*' 14:53:41 INFO - Installing collected packages: jsonschema, functools32 14:53:41 INFO - Running setup.py install for functools32 14:53:41 INFO - warning: no files found matching '*.txt' 14:53:41 INFO - no previously-included directories found matching 'build' 14:53:41 INFO - no previously-included directories found matching 'dist' 14:53:41 INFO - no previously-included directories found matching '.git*' 14:53:42 INFO - Successfully installed jsonschema functools32 14:53:42 INFO - Cleaning up... 14:53:42 INFO - Return code: 0 14:53:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:53: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')]} 14:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53: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')]} 14:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53: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', '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 0x1095fda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109692618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1ad722d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109561d30>, '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 0x1092c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109559b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ld28rmPtAA/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mEs1n2pohs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:53: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:53: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 blobuploader==1.2.4 14:53:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ld28rmPtAA/Render', 14:53:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:42 INFO - 'HOME': '/Users/cltbld', 14:53:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:42 INFO - 'LOGNAME': 'cltbld', 14:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:42 INFO - 'MOZ_NO_REMOTE': '1', 14:53:42 INFO - 'NO_EM_RESTART': '1', 14:53:42 INFO - 'PAGER': '/bin/cat', 14:53:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:42 INFO - 'PWD': '/builds/slave/test', 14:53:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:42 INFO - 'SHELL': '/bin/bash', 14:53:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mEs1n2pohs/Listeners', 14:53:42 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 14:53:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:42 INFO - 'USER': 'cltbld', 14:53:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:42 INFO - 'XPC_FLAGS': '0x0', 14:53:42 INFO - 'XPC_SERVICE_NAME': '0', 14:53:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:42 INFO - Downloading/unpacking blobuploader==1.2.4 14:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:44 INFO - Downloading blobuploader-1.2.4.tar.gz 14:53:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:53:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:53: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 14:53: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 14:53: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 14:53: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 14:53: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 14:53: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 14:53:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:53:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:53: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 14:53: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 14:53: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 14:53: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 14:53: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 14:53: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 14:53:45 INFO - Downloading docopt-0.6.1.tar.gz 14:53:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:53:46 INFO - Installing collected packages: blobuploader, requests, docopt 14:53:46 INFO - Running setup.py install for blobuploader 14:53:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:53:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:53:46 INFO - Running setup.py install for requests 14:53:46 INFO - Running setup.py install for docopt 14:53:46 INFO - Successfully installed blobuploader requests docopt 14:53:46 INFO - Cleaning up... 14:53:46 INFO - Return code: 0 14:53:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:53:46 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')]} 14:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:46 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')]} 14:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:46 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 0x1095fda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109692618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1ad722d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109561d30>, '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 0x1092c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109559b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ld28rmPtAA/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mEs1n2pohs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:53:46 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 14:53:46 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 14:53:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ld28rmPtAA/Render', 14:53:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:46 INFO - 'HOME': '/Users/cltbld', 14:53:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:46 INFO - 'LOGNAME': 'cltbld', 14:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:46 INFO - 'MOZ_NO_REMOTE': '1', 14:53:46 INFO - 'NO_EM_RESTART': '1', 14:53:46 INFO - 'PAGER': '/bin/cat', 14:53:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:46 INFO - 'PWD': '/builds/slave/test', 14:53:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:46 INFO - 'SHELL': '/bin/bash', 14:53:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mEs1n2pohs/Listeners', 14:53:46 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 14:53:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:46 INFO - 'USER': 'cltbld', 14:53:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:46 INFO - 'XPC_FLAGS': '0x0', 14:53:46 INFO - 'XPC_SERVICE_NAME': '0', 14:53:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:53:47 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-3RsOAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:53:47 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-9vHrUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:53:47 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-79UWm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:53:47 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-FbABXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:53:47 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-pIDj0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:53:47 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-dM4_bb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:53:47 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-Fc7MSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:53:47 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-82QRUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:53:48 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-gLUACZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:53:48 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-ey6SVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:53:48 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-yQcMSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:53:48 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-D83C6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:53:48 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-xmrK0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:53:48 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-GTm9bM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:53:48 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-YK22ch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:53:48 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-gk1g3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:53:48 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-Yltnaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:53:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:53:48 INFO - Running setup.py install for manifestparser 14:53:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:53:49 INFO - Running setup.py install for mozcrash 14:53:49 INFO - Running setup.py install for mozdebug 14:53:49 INFO - Running setup.py install for mozdevice 14:53:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:53:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:53:49 INFO - Running setup.py install for mozfile 14:53:49 INFO - Running setup.py install for mozhttpd 14:53:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:53:49 INFO - Running setup.py install for mozinfo 14:53:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:53:49 INFO - Running setup.py install for mozInstall 14:53:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:53:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:53:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:53:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:53:50 INFO - Running setup.py install for mozleak 14:53:50 INFO - Running setup.py install for mozlog 14:53:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:53:50 INFO - Running setup.py install for moznetwork 14:53:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:53:50 INFO - Running setup.py install for mozprocess 14:53:50 INFO - Running setup.py install for mozprofile 14:53:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:53:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:53:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:53:50 INFO - Running setup.py install for mozrunner 14:53:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:53:51 INFO - Running setup.py install for mozscreenshot 14:53:51 INFO - Running setup.py install for moztest 14:53:51 INFO - Running setup.py install for mozversion 14:53:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:53:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:53:51 INFO - Cleaning up... 14:53:51 INFO - Return code: 0 14:53:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:53:51 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')]} 14:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:51 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')]} 14:53:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:51 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 0x1095fda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109692618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1ad722d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109561d30>, '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 0x1092c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109559b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ld28rmPtAA/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mEs1n2pohs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:53:51 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 14:53:51 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 14:53:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ld28rmPtAA/Render', 14:53:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:51 INFO - 'HOME': '/Users/cltbld', 14:53:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:51 INFO - 'LOGNAME': 'cltbld', 14:53:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:51 INFO - 'MOZ_NO_REMOTE': '1', 14:53:51 INFO - 'NO_EM_RESTART': '1', 14:53:51 INFO - 'PAGER': '/bin/cat', 14:53:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:51 INFO - 'PWD': '/builds/slave/test', 14:53:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:51 INFO - 'SHELL': '/bin/bash', 14:53:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mEs1n2pohs/Listeners', 14:53:51 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 14:53:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:51 INFO - 'USER': 'cltbld', 14:53:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:51 INFO - 'XPC_FLAGS': '0x0', 14:53:51 INFO - 'XPC_SERVICE_NAME': '0', 14:53:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:53:51 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-T_358t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:53:51 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)) 14:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:53:51 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-llOFg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:53:52 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)) 14:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:53:52 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-kpYD_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:53:52 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)) 14:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:53:52 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-NfYd39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:53:52 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)) 14:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:53:52 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-JY4qYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:53:52 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)) 14:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:53:52 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-L3eXop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:53:52 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)) 14:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:53:52 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-MRXm6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:53:52 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)) 14:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:53:52 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-RJ4UQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:53:52 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)) 14:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:53:52 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-5CBxRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:53:52 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)) 14:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:53:52 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-9oWQtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:53:52 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)) 14:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:53:52 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-h46YIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:53:52 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)) 14:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:53:52 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-IIsfzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:53:53 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)) 14:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:53:53 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-Z5WW1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:53:53 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)) 14:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:53:53 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-qwH4kY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:53:53 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)) 14:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:53:53 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-8628hl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:53:53 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)) 14:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:53:53 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-V3fHQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:53:53 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)) 14:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:53:53 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-XTA27p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:53:53 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)) 14:53:53 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)) 14:53:53 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)) 14:53:53 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)) 14:53:53 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)) 14:53:53 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)) 14:53:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:53:53 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 14:53:53 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 14:53:53 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 14:53:53 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 14:53:53 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 14:53:53 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 14:53:55 INFO - Downloading blessings-1.6.tar.gz 14:53:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:53:56 INFO - Installing collected packages: blessings 14:53:56 INFO - Running setup.py install for blessings 14:53:56 INFO - Successfully installed blessings 14:53:56 INFO - Cleaning up... 14:53:56 INFO - Return code: 0 14:53:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:53:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:53:56 INFO - Reading from file tmpfile_stdout 14:53:56 INFO - Current package versions: 14:53:56 INFO - blessings == 1.6 14:53:56 INFO - blobuploader == 1.2.4 14:53:56 INFO - docopt == 0.6.1 14:53:56 INFO - functools32 == 3.2.3-2 14:53:56 INFO - jsonschema == 2.5.1 14:53:56 INFO - manifestparser == 1.1 14:53:56 INFO - mozInstall == 1.12 14:53:56 INFO - mozcrash == 0.17 14:53:56 INFO - mozdebug == 0.1 14:53:56 INFO - mozdevice == 0.48 14:53:56 INFO - mozfile == 1.2 14:53:56 INFO - mozhttpd == 0.7 14:53:56 INFO - mozinfo == 0.9 14:53:56 INFO - mozleak == 0.1 14:53:56 INFO - mozlog == 3.2 14:53:56 INFO - moznetwork == 0.27 14:53:56 INFO - mozprocess == 0.22 14:53:56 INFO - mozprofile == 0.28 14:53:56 INFO - mozrunner == 6.11 14:53:56 INFO - mozscreenshot == 0.1 14:53:56 INFO - mozsystemmonitor == 0.3 14:53:56 INFO - moztest == 0.7 14:53:56 INFO - mozversion == 1.4 14:53:56 INFO - psutil == 3.1.1 14:53:56 INFO - requests == 1.2.3 14:53:56 INFO - wsgiref == 0.1.2 14:53:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:53:56 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')]} 14:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:56 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')]} 14:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:56 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 0x1095fda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109692618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1ad722d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109561d30>, '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 0x1092c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109559b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ld28rmPtAA/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mEs1n2pohs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:53:56 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 14:53:56 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 14:53:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ld28rmPtAA/Render', 14:53:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:56 INFO - 'HOME': '/Users/cltbld', 14:53:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:56 INFO - 'LOGNAME': 'cltbld', 14:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:56 INFO - 'MOZ_NO_REMOTE': '1', 14:53:56 INFO - 'NO_EM_RESTART': '1', 14:53:56 INFO - 'PAGER': '/bin/cat', 14:53:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:56 INFO - 'PWD': '/builds/slave/test', 14:53:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:56 INFO - 'SHELL': '/bin/bash', 14:53:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mEs1n2pohs/Listeners', 14:53:56 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 14:53:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:56 INFO - 'USER': 'cltbld', 14:53:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:56 INFO - 'XPC_FLAGS': '0x0', 14:53:56 INFO - 'XPC_SERVICE_NAME': '0', 14:53:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:56 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)) 14:53:56 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)) 14:53:56 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)) 14:53:56 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)) 14:53:56 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)) 14:53:56 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)) 14:53:56 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)) 14:53:56 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)) 14:53:56 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)) 14:53:56 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)) 14:53:56 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)) 14:53:56 INFO - Cleaning up... 14:53:56 INFO - Return code: 0 14:53:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:53:56 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')]} 14:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:56 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')]} 14:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:56 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 0x1095fda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109692618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1ad722d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109561d30>, '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 0x1092c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109559b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ld28rmPtAA/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mEs1n2pohs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:53:56 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 14:53:56 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 14:53:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ld28rmPtAA/Render', 14:53:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:56 INFO - 'HOME': '/Users/cltbld', 14:53:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:56 INFO - 'LOGNAME': 'cltbld', 14:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:56 INFO - 'MOZ_NO_REMOTE': '1', 14:53:56 INFO - 'NO_EM_RESTART': '1', 14:53:56 INFO - 'PAGER': '/bin/cat', 14:53:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:56 INFO - 'PWD': '/builds/slave/test', 14:53:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:56 INFO - 'SHELL': '/bin/bash', 14:53:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mEs1n2pohs/Listeners', 14:53:56 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 14:53:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:56 INFO - 'USER': 'cltbld', 14:53:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:56 INFO - 'XPC_FLAGS': '0x0', 14:53:56 INFO - 'XPC_SERVICE_NAME': '0', 14:53:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:53:57 INFO - Cleaning up... 14:53:57 INFO - Return code: 0 14:53:57 INFO - Running post-action listener: _resource_record_post_action 14:53:57 INFO - Running post-action listener: _start_resource_monitoring 14:53:57 INFO - Starting resource monitoring. 14:53:57 INFO - ##### 14:53:57 INFO - ##### Finished create-virtualenv step (success) 14:53:57 INFO - ##### 14:53:57 INFO - ##### 14:53:57 INFO - ##### Running install step. 14:53:57 INFO - ##### 14:53:57 INFO - Running pre-action listener: _resource_record_pre_action 14:53:57 INFO - Running main action method: install 14:53:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:53:57 INFO - Reading from file tmpfile_stdout 14:53:57 INFO - Detecting whether we're running mozinstall >=1.0... 14:53:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:53:57 INFO - Reading from file tmpfile_stdout 14:53:57 INFO - Output received: 14:53:57 INFO - Usage: mozinstall [options] installer 14:53:57 INFO - Options: 14:53:57 INFO - -h, --help show this help message and exit 14:53:57 INFO - -d DEST, --destination=DEST 14:53:57 INFO - Directory to install application into. [default: 14:53:57 INFO - "/builds/slave/test"] 14:53:57 INFO - --app=APP Application being installed. [default: firefox] 14:53:57 INFO - mkdir: /builds/slave/test/build/application 14:53:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:54:31 INFO - Reading from file tmpfile_stdout 14:54:31 INFO - Output received: 14:54:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:54:31 INFO - Running post-action listener: _resource_record_post_action 14:54:31 INFO - ##### 14:54:31 INFO - ##### Finished install step (success) 14:54:31 INFO - ##### 14:54:31 INFO - ##### 14:54:31 INFO - ##### Running run-tests step. 14:54:31 INFO - ##### 14:54:31 INFO - Running pre-action listener: _resource_record_pre_action 14:54:31 INFO - Running main action method: run_tests 14:54:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:54:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:54:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:54:31 INFO - 2016-07-04 14:54:31.946 screenresolution[1922:16447] starting screenresolution argv=screenresolution get 14:54:31 INFO - 2016-07-04 14:54:31.949 screenresolution[1922:16447] Display 0: 1600x1200x32@60 14:54:31 INFO - 2016-07-04 14:54:31.955 screenresolution[1923:16449] starting screenresolution argv=screenresolution list 14:54:31 INFO - Available Modes on Display 0 14:54:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:54:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:54:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:54:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:54:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:54:32 INFO - Intel Iris: 14:54:32 INFO - Chipset Model: Intel Iris 14:54:32 INFO - Type: GPU 14:54:32 INFO - Bus: Built-In 14:54:32 INFO - VRAM (Dynamic, Max): 1536 MB 14:54:32 INFO - Vendor: Intel (0x8086) 14:54:32 INFO - Device ID: 0x0a2e 14:54:32 INFO - Revision ID: 0x0009 14:54:32 INFO - Displays: 14:54:32 INFO - Display: 14:54:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:54:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:54:32 INFO - Display Serial Number: 1600x1200 60 14:54:32 INFO - Main Display: Yes 14:54:32 INFO - Mirror: Off 14:54:32 INFO - Online: Yes 14:54:32 INFO - Rotation: Supported 14:54:32 INFO - Return code: 0 14:54:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:54:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:54:32 INFO - Python 2.7.3 14:54:32 INFO - Return code: 0 14:54:32 INFO - grabbing minidump binary from tooltool 14:54:32 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')]} 14:54:32 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/macosx64/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 0x109561d30>, '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 0x1092c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109559b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:54:32 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:54:32 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:54:32 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:54:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:54:32 INFO - Return code: 0 14:54:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:54:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:54:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:54:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:54:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:54:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0110', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:54:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0110 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:54:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ld28rmPtAA/Render', 14:54:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:32 INFO - 'HOME': '/Users/cltbld', 14:54:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:32 INFO - 'LOGNAME': 'cltbld', 14:54:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:54:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:54:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:32 INFO - 'MOZ_NO_REMOTE': '1', 14:54:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:54:32 INFO - 'NO_EM_RESTART': '1', 14:54:32 INFO - 'PAGER': '/bin/cat', 14:54:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:32 INFO - 'PWD': '/builds/slave/test', 14:54:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:54:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:32 INFO - 'SHELL': '/bin/bash', 14:54:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mEs1n2pohs/Listeners', 14:54:32 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 14:54:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:32 INFO - 'USER': 'cltbld', 14:54:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:32 INFO - 'XPC_FLAGS': '0x0', 14:54:32 INFO - 'XPC_SERVICE_NAME': '0', 14:54:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0110', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:54:32 INFO - mozversion application_buildid: 20160704123423 14:54:32 INFO - mozversion application_changeset: a7105b09ae0c18b858c33b1020bdded6a6d66c9b 14:54:32 INFO - mozversion application_display_name: Nightly 14:54:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:54:32 INFO - mozversion application_name: Firefox 14:54:32 INFO - mozversion application_remotingname: firefox 14:54:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:54:32 INFO - mozversion application_vendor: Mozilla 14:54:32 INFO - mozversion application_version: 50.0a1 14:54:32 INFO - mozversion platform_buildid: 20160704123423 14:54:32 INFO - mozversion platform_changeset: a7105b09ae0c18b858c33b1020bdded6a6d66c9b 14:54:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:54:32 INFO - mozversion platform_version: 50.0a1 14:54:32 INFO - using testdate: 1467669272 14:54:32 INFO - actual date: 1467669272 14:54:32 INFO - starting webserver on 'localhost:54488' 14:54:32 INFO - SUITE-START | Running 2 tests 14:54:32 INFO - TEST-START | dromaeo_css 14:54:32 INFO - operating with platform_type : mac_ 14:54:32 INFO - Initialising browser for dromaeo_css test... 14:54:32 INFO - TEST-INFO | started process 1933 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/tmpL_84pA/profile http://localhost:54488/getInfo.html) 14:54:34 INFO - PROCESS | 1933 | __metrics Screen width/height:1600/1200 14:54:34 INFO - PROCESS | 1933 | colorDepth:24 14:54:34 INFO - PROCESS | 1933 | Browser inner width/height: 1024/689 14:54:34 INFO - PROCESS | 1933 | __metrics 14:54:34 INFO - PROCESS | 1933 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:54:34 INFO - PROCESS | 1933 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:54:35 INFO - TEST-INFO | 1933: exit 0 14:54:35 INFO - Browser initialized. 14:54:35 INFO - Running cycle 1/1 for dromaeo_css test... 14:54:35 INFO - TEST-INFO | started process 1935 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/tmpL_84pA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:54:47 INFO - PROCESS | 1935 | RSS: Main: 243560448 14:54:47 INFO - PROCESS | 1935 | 14:55:38 INFO - PROCESS | 1935 | 1467669338678 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] 14:57:49 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:54488/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54488/tests/dromaeo/cssquery-ext.html) 14:57:51 INFO - PROCESS | 1935 | RSS: Main: 393302016 14:57:51 INFO - PROCESS | 1935 | 15:00:54 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:54488/tests/dromaeo/cssquery-ext.html (next: http://localhost:54488/tests/dromaeo/cssquery-jquery.html) 15:00:55 INFO - PROCESS | 1935 | RSS: Main: 372531200 15:00:55 INFO - PROCESS | 1935 | 15:03:57 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:54488/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54488/tests/dromaeo/cssquery-mootools.html) 15:03:58 INFO - PROCESS | 1935 | RSS: Main: 367480832 15:03:58 INFO - PROCESS | 1935 | 15:07:00 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:54488/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54488/tests/dromaeo/cssquery-prototype.html) 15:07:01 INFO - PROCESS | 1935 | RSS: Main: 373809152 15:07:01 INFO - PROCESS | 1935 | 15:10:04 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:54488/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54488/tests/dromaeo/cssquery-yui.html) 15:10:05 INFO - PROCESS | 1935 | RSS: Main: 337453056 15:10:05 INFO - PROCESS | 1935 | 15:13:08 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:54488/tests/dromaeo/cssquery-yui.html (next: http://localhost:54488/tests/dromaeo/cssquery-dojo.html) 15:13:09 INFO - PROCESS | 1935 | RSS: Main: 381390848 15:13:09 INFO - PROCESS | 1935 | 15:13:09 INFO - PROCESS | 1935 | __start_tp_report 15:13:09 INFO - PROCESS | 1935 | _x_x_mozilla_page_load 15:13:09 INFO - PROCESS | 1935 | _x_x_mozilla_page_load_details 15:13:09 INFO - PROCESS | 1935 | |i|pagename|runs| 15:13:09 INFO - PROCESS | 1935 | |0;dojo.html;3043.604331436913;3356.32873425315;3378.0879162626093;3383.475561288;3387.5934887813464;5621.718914054301;5685.090385538315;5714.485696287334;5757.68332741699;5787.305523337205;5766.798162064318;5810.82567522975;5817.127430885369;5817.854553636162;5828.970855145718;5203.661761985469;5262.710550919698;5292.682439053649;5293.68237905725;5368.62419630626;5302.92045619316;5316.415194328621;5331.853651464934;5363.678179309254;5366.812161574346;5255.0803609368395;5272.077386457374;5308.389535203443;5320.494553017457;5364.624476286662;5359.062164121283;5364.249005139283;5368.597355198376;5376.489233522848;5397.379301380352;4560.247559152735;5143.074246635604;5149.742512874342;5240.135377662681;5323.281357016792;5648.887022259573;5721.427857214246;5769.336526299488;5787.768489260425;5801.361850196475;6283.057541368786;6306.968465157691;6319.905201421982;6321.841953951188;6325.14610527582;6152.6308421494405;6265.498760099181;6302.621842689453;6335.809925702236;6349.809505714836;5911.586188966774;5932.228810254639;5941.673207973517;5967.46292833647;5977.940220597825;6299.937000630027;6315.905261421082;6323.177986861679;6328.050792381087;6329.620222786648;6084.178635884099;6097.282711138064;6114.296855861544;6175.660338681326;6246.250449945945;5555.666660000413;6308.27454842699;6320.936790632127;6343.619382837044;6346.460550853137;5335.199720041947;6185.876282474325;6215.564910456224;6253.218347706536;6304.684765761694;6130.061839217998;6152.98475751496;6185;6185.8144255672405;6286.5599408041;5010.549050585465;5033.899322013539;5042.39491261051;5043.571296439771;5051.090803655304;4481.462224533012;4484.2376795944765;4491.30384790358;4513.142502924499;4552.6130278926;5632.746526406321;5694.345150307768;5715.685637289906;5780.421957804186;5802.767889284381;6299.464545513682;6326.873462530723;6331;6336.778212762623;6413.518986076063;5784.363719990798;5786.537077033827;5813.849590469099;5815.854603634858;5843.970780146157;5378.91931621026;5455.072637651609;5502.394736578973;5526.557875370041;5532.225488431623;6350.841228969312;6358.078078678658;6395.840103997437;6400.871982560416;6403.3276505966205;5193.610479213999;6242.781502647385;6292.27638821523;6295.653739044396;6318.6840657965995;6211.503079753699;6243.8126856194385;6289.905651415141;6407.3592640737415;6512.218533775977;6276.403741644536;6281.214848143982;6282;6283.308836027942;6293;6159.19930409044;6310.936890631035;6316.968415157895;6333;6356.586821856565;5885.558583106199;6120.357362476876;6121.4490695837585;6145.4161854623735;6232.968835155795;6146.51780542848;6181.876362472815;6194.318624951342;6200.0389939557635;6218.19163508741;5846.210761547137;6005.549583781147;6089.357855890828;6090.330063693079;6132.601380910227;6034.00438927572;6092.786752463642;6098.115773212948;6122.2761798032625;6123.404636889863;6011.819645410645;6014.699265036818;6019.789307374221;6024.487918526799;6024.668643224665 15:13:09 INFO - PROCESS | 1935 | |1;ext.html;478.81326282749734;490.56339857526797;535.5314100162357;544.4854612391289;552.3454706173183;32242;32782.99999999997;32861.83569082154;42769;43865;45620.771896140475;46038;46071;46120.53879461213;46228.306575401395;9781.31530792843;9971.601135954554;9978.90021099787;9983.201343892508;9988.1510071644;8838.911610883906;9005.324600654943;9724.416535007887;11849.348285844275;12085.516579336816;12131.93934030333;12142.575009874656;12222.93888530556;12226.14416990811;12229.143959922809;12057.155999080069;12131.93934030333;12155.513779448811;12158.78412158777;12161.270323780513;8872.201501864798;10390.168786497063;11659.475323610457;11822.822657660143;11948.641540753792;42994.78502607467;43215.35176972348;43339.133217335475;43385.13229735388;43521.129577408276;3586.28274345132;3731.458938453909;3769.0765762388114;3866.729328946975;3873.8783401913806;31013;31443.270620115884;32207.51688724671;32310.35379292401;33880.49179262313;3282.0646115857103;3320.6015278166533;3325.235195904931;3326.96673033269;3399.5070714746225;567685;571384;571740;571874;574477;35640;36431;67361.66319168372;68033.3196668027;68207.3179268211;36468.635313646526;36470.8176459116;36626;36674.8166259167;36720.63279367226;15134.545963621109;15282.235888205545;15301.234938253043;15309.6172595686;15313.387464501518;9698.903010969942;12016.819747703792;13005.21968681882;13053.934730326288;13097.279649619171;7550.622468876644;7774.766756997299;7783.571903545246;7801.765947021485;7975.082865470429;3265.7877237979455;3284.8521816518314;3308.2225676965895;3308.2721801203697;3322.152851023022;935.9766005849908;946.1390134977138;986.6398764450923;1014.3204053284318;1049.3053718245133;31668.208294792814;31670.683293167232;31892.681073189437;32319.676803231665;32383;925.3846192282057;1072.5120070367964;1097.6926460591046;1177.328922514176;1274.1717883375695;16069.27688254008;16350.591235219215;16387.508374748777;16427.425040123537;16992.405265815636;693416;702749;709442;713403;713890;64176.03735943871;64837.351626483134;64861.351386485534;64924;65074;1238.8327575777514;1241.050596293836;1274.0762946863636;1279.3027799849106;1393.8745512903888;31823.363532728752;32715.672843271263;32951.67048329486;32994.505082423304;33223.07791936044;53631.6592085201;54152.72923635357;54226;54227.64430889102;54298.45701542934;522141;525454;525856;526943;527273.0909036291;24879.253622391356;27501.72498275072;27856.44287114287;27990.860045699643;28755.28111797222;49599.50400495949;49743;50289.4913152606;51204.71988200176;51315.23027154521;41819;42028.57971420369;42189.1562168761;43495.9126021852;43733.34399983939;41598.58401416068;41669.16661666689;41779.164416712105;43014;43159.78420107879;36699.53201871895;39210.2157956845;40862.38706419346;41259.38110928398;41395.793021034704;33278.83360583182;33756;35373;36216.91349259527;36448.08879778027;21866.45333866666;22574.548509030057;26095.608565871906;26317.342066447727;26584.580943052595 15:13:09 INFO - PROCESS | 1935 | |2;jquery.html;352.9964700352996;373.95699494558124;384.69993405144;384.93263678856204;402.18758108620585;13782.724345513083;15805.130717810516;21115.894420527875;21488.677669834964;21511.032003559856;21124.366269011953;21230.787692123075;21528.8923555382;21641.783582164175;21654;5553;5722.942770572283;5748.885022299562;6035.849103772397;6055.122007308938;5971.283445986466;6049.758009679607;6063.484603808682;6077.997130473489;6080.513558915276;4757.64317676174;4950.752462376885;5727.398623144572;5986.640801551921;6007.068904319837;5836.883262334772;5897.646141231497;5898.675572843492;5914.645121292736;5964.105384192362;4960.826371076995;5292.391374991887;5295.152775555931;5316.9734151329385;5320.148776195829;13070.346482675828;13348.933255333759;15798.842011579853;25852.87073564639;25926;2229.921952731647;2406.855588664686;2641.537730897085;2747.3543717226435;2911.4613796447725;9779.559919803625;9809.509524523744;9985.251106167067;10199.949000255025;10330.12193963514;1800.5055803682912;1806.205269681336;1822.2710915633852;1830.1581272614612;1887.8206570375792;79079;97069;114578.42710786393;125306;131685;9631.699720537637;10777.946110269399;10863;11546.364949927834;11689.064874809996;12523.373831308398;13178.275194864184;14342.784858227134;14347.78478322826;14359.210243436712;8158.224968627971;8484.830303394021;8663.263622592025;8673.349498787617;8759.912400876037;7614.390848732088;8335.87465692136;8687.913120868838;8696.17386348296;8798.29613630908;4434.955650443454;4513.81944722214;4521.638268938543;4566.26939689648;4568.931466028012;1882.3317722208692;1886.4246404846378;1902.5148587110198;1907.160849226336;1953.5116220944765;875.4528419737663;875.7591662292793;882.3646974178581;921.8893732752113;963.6097380560884;15702.921485392728;18491.98294093838;21523.246686366216;21545.30683664542;21637.242696505546;888.138505649519;929.2101713543569;995.6365926436798;1014.7158795537262;1043.2644985285356;8160.877586836202;8947.507887066144;11025.6141035065;11171.273867198606;11175;601536.9923150357;610074;616297;618115;619412;119280.8071919287;125477;132823.67176328306;135141.97287040701;136670;961.2118063188259;983.9262055345878;998.7752755629925;1002.5588740954103;1002.6590959073804;15736.940670200009;17740.40336369733;18066.36767713124;18116.00361980051;19608.313709020687;53552.66118347072;58142.7092864533;58240.25279241629;58571;58706;79896.20103798888;81639;83382.5830870866;84072.57963710143;84476;5762.279715035621;7504.061992250969;7504.587247701429;7537.924620753723;7720.652570634223;7356.77929662111;10297.691069267934;12415.93792031034;12738.6178414644;13299.335033248492;9981.850272246067;11136.721581960515;11461.197716159788;11791.82081791814;11946.223495472766;11416.486258118572;11426.371549564521;11435.828462572901;11699.2980421175;11771.11716621274;11415.315081095161;11482.196246262682;11647.359395233005;11867.703307417383;12012.579559715368;7106.857862842611;7420.035395398563;7453.4782565222085;7693.1922148173635;8431.494110353398;10477.738056548647;11568.363739994382;11668.416579171177;11837.82243266369;11867.228630139014 15:13:09 INFO - PROCESS | 1935 | |3;mootools.html;1387.6877702516929;1532.4023630783997;1571.2850652952907;1789.588394669226;1950.7268982342475;6668.966655166723;7683.346915512181;9075.36472446929;9087.636494540218;9249.075092490748;8956.55217239137;9041.638334466614;9113.908860911406;9114.043025482328;9159.725208243763;2113.355426594888;2198.2525941179997;2345.94135146621;2383.761623837611;2387.283814855545;2341.812654987597;2409.8915548800346;2421.406755344934;2422.103821586016;2428.659987601737;2036.389083275019;2355.9293221203393;2376.3465047112095;2412.662227288181;2417.613181890898;2104.3686893931913;2184.530325979906;2187.6937228787983;2390.4501964548163;2403.6995375578053;2164.426426996847;2322.3149170994598;2413.083028449178;2417.601095819188;2426.2114812685772;9112.908870911273;9164.633414663405;9178.128077832594;9184.12750788674;9185.12741289583;5341.1988201769655;5503.559715222773;5523.143912693539;5523.922835047168;5527.50252477275;3605.963940360589;3607.2965771674535;3672.173760903802;3675.1363429594026;3676.981615091934;1084.701707030565;1086.5436516663021;1102.8676558812995;1106.2145876427746;1798.3885478937093;12134.029277657855;12229.694257643541;12233.69415764613;12262.448189831479;12267.263964162179;4440.555944405533;4646.140464014101;4705.082508910798;4732.692374995614;4757.619390448755;9415.105564971316;9451.291153163404;9455.574499147555;9477.147056764787;9483.952580237055;5356.7857285708915;5358;5358.303420555303;5361.356637203483;5376.220448035013;4461.486929003141;4613.400257966443;4799.18413869643;4946.703197808143;5005.62457815658;3815.4849095372324;3822.636849499293;3914.2954268231993;3922.843086276517;3936.0553467168247;1174.7591743692694;1182.7930112230326;1187.4715751490503;1193.7373777768878;1197.736497970445;629.5058379172327;783.177663453383;934.56075644447;958.3100167879115;976.5605477535138;5919.704014799329;6055.878882422415;6106.786262480792;6163.905193550766;6203.2245969253845;482.12494322803997;496.7640370823902;497.9103761322997;505.0379027951758;641.355437785023;3887.5723670396233;4076.9388459173138;4152.314868046798;4152.43942067817;4158.896027599334;10513.369197848153;10898.945505272422;11061.668149955514;11063.557457701763;11067.72330691723;11022.118230541537;11025.724356890982;11029;11038.00657940773;11052.723681908017;8126.10612832588;8377.6230069647;8493.745187644257;8496.872546911802;8499.277561407349;5970.000049983304;6040.214772079602;6051;6101.542384321282;6153.800008998382;9816.361936474106;10265.794684106128;10288;10322.845157322496;10355.637552685619;10143.695689129338;10512.26414151002;10514.947425262824;10539.26225164231;10549.103326217357;7117.644117794193;7136.036635054201;7192.100987376578;7193.424526038009;7197.892031619425;8326.958365208378;8438;8467.237948584658;8470.49177049379;8485.066642669179;6751.291114432914;7571.129320128035;7571.772846814604;7712.884306735291;7739;6722.966385168239;7295.197528271992;7529.058867641545;7613.276738709814;7650.885236721565;7063.117110361205;7163.3552980232025;7266.346028857428;7284.854302913806;7361.079865016873;5112;5157.432682405008;5169.095408303607;5178.8964220716125;5238.580913526833;4306.41863348444;4728.905421891612;5159.251908473326;5371.355437347387;5394.109971854757 15:13:09 INFO - PROCESS | 1935 | |4;prototype.html;240.40859485665266;305.1699377692675;307.61701681406646;311.49848743522926;317.2876891378855;5245.711485868275;5267.4469180736;5267.841964741055;5287.28621636079;5292.576593872491;4758.2862570614425;4964.907720301528;5237.47625237476;5263.26314315996;5335.7865685372635;3782.3380908341;3797.2025874566234;3938.133610605662;3977.5028121484816;3984.1234928315725;3495.7028652564563;3941.940870886939;3989.760614363133;3990;4066.2274167908004;3964.2071585682834;4021.1957608478274;4028.47629808126;4034.435179074932;4049.7367671101283;3344.331133773243;3499.427920478446;4035.2131334389805;4039.192161567669;4064.898377540585;2778.597103419993;2939.470895238856;3329.5338652588657;3522.2427178156818;3566.7146628269675;3756.4740936268945;4960.503949605047;5081.314022606938;5090.236464530313;5127.0777854941;4581.4502259728715;4601.332806743037;4604.58558729716;4609.239475486541;4640.491840151964;4669.556392142741;5459.253039027512;5500.779968801243;5511.972440137773;5541.944580554183;3207.470767323389;3422.691957723817;3683.797391143486;3877.612238776128;3902.492675952108;4420.563316921981;4795.664303498756;4872.366592342973;4938.925916111261;5591.329040515164;3829.8276577554075;3942.901427464279;3951.0122469382654;3963.3856752203455;3992.3830848505822;4021.778802165909;4059.4722686050623;4089.2843752343815;4111;4111.48606424197;4248.723832950848;4541.5231400703115;4544.409226800561;4561.5666511682;4566.862994110182;4581.289900065495;5545.639533430314;5557.360903496069;5569;5580.460890294906;1316.407616572527;1331.6271443995697;1331.8668133186798;1332.726791007841;1336.1715736243398;734.7869117955732;790.1584812175015;818.6643476174739;827.7542298840207;833.5123952487742;4237.96985155609;4297.808117859914;4332.941852620043;4357.738535687806;4418.078136010781;3953.327934251184;4231.407602935591;4294.463192100988;4697.81208751653;4722;3869.2648396804516;4219.83954412539;4237.766922819274;4262.46719160105;4342.153280110411;2543.465872166829;2740.725927407283;3003.05403797803;3010.71398217169;3036.681148479422;5141.614378921596;5157.936825269922;5198.9861976914135;5900.524868782804;5926.977241606725;5113.079645663742;5237;5805.82582522525;5832.650040997553;5841.649501029951;5903.907777061343;5909.172715819875;5932.525397968238;5966.046806830646;5994.130851026664;5713.428657134254;5717.256756621779;5722;5753.223314852441;5770.913436298375;4680.836170734008;5415.350157981067;5472.98749731301;5670.319561652463;5741.97129014369;5867.442592953663;5872.148538461814;5882.5293976482635;5889.699270656272;5895.67573783446;3808.2383523294898;3847.769133851978;3849.82675779585;3854.7879866606486;3864.652181303696;4569.588737013684;5338.359396872245;5561.249231353715;5714.342850572238;5764.521255860021;4590.380298659638;4858.5384388483035;5560.944390556043;5579.4978451937895;5579.963313390665;4671.929921051119;5309.309789727466;5553.8333849984565;5556.749946252347;5558.194061861089;4636.976815115903;5367.504110588595;5443.8094666686475;5454.863628409322;5480.506754392124;4839;5539.9169012464035;5541.639793413416;5554.50009499147;5580.609357344947;4983.127952608206;5117.769700363418;5144.536991670768;5435.972820135874;5464.672119672673 15:13:09 INFO - PROCESS | 1935 | |5;yui.html;664.5713514782965;806.1495122645606;810.4691427115238;828.3331917806164;837.7403005068429;15267.770983435243;16533.421330253444;16548.420805271817;16586.08776517291;16600.750988735163;14500.129992200475;14871;14925.701485970274;15342.84657153431;15390.538283851502;715.9570425774444;742.4505865659401;902.4044130873625;902.9390466202219;910.6767097680328;893.7810236492069;922.8385032619299;923.0584803500426;923.6166990698852;930.5207817973749;976.9023097690246;977.5796407544752;979.2851218610418;981.3719219699362;985.069109691342;753.408574269196;940.8635747816528;967.5549247346194;969.8254314223437;971.6453494474466;709.7764204275637;714.9964250178716;715.0204220218334;715.8031541326125;718.81310859177;15687;15687.450939217073;15692.372305107781;15709;15721.213939303103;14586.92706536471;14620.70758584833;14684.779728304084;14700.926495367561;14745.557633271019;11536.942315288454;13517.256550889697;13632.591022269347;13735.931320343334;13841.723165536734;3523.312953973976;4709.175894218532;4735.408073990751;4763.190257656172;4773.188557945157;88552;112096.31855522255;112104.51581936712;112288.4385578075;113019;11259.887401126047;11477.885221147682;11524.481398337095;11563.959243667941;11633.185677002528;23586.7641323588;23693.05227790869;23702.28893133209;23705.170319038752;23905.402364941016;8118.837623247502;8122.796930076677;8241.134680858424;8355.248027677417;8390.496570205807;4473.888152796206;4608.5621865922685;4698.718076915396;4721.811127554859;4756.952430475721;3613.9819300903328;3734.7198960078103;3737.1404576947452;3740.121071548184;3740.551133863954;670.9127813384229;685.8628274345151;696.2758730919787;701.0640794539245;701.386286998876;504.83088165464983;518.6058595467397;577.3302968556454;636.1952130554852;657.3886285754198;8889.422187557788;9008.189262966365;9087.136722011399;9117.680881169128;9306.627734890528;599.12228585123;599.5203836930439;627.3170780126378;641.8908785506475;662.2251965200727;4249.192653395845;4413.337999300131;4466.330050492452;4482.551744825491;4537.523560026216;132333;135359;140747;149288;149783;85686.57156714177;101628.49185754024;111018;114464;119426;75763.62118189374;76569;95331;103924.99999999849;106413.40379894462;9688;9793.608255669978;9817.901820981699;9974.301798874008;10126.392416455037;48722.75638621784;58539.70730146322;58755;58820.4117958815;59597;96780;99677;99760.50119749355;104581.43127852936;105541;11697.824532631847;11881.5841445549;12013.579524716943;12072.275663460221;13287.867121328663;10953.34279943174;13173.93413032967;15613.609659758597;16122.193890305673;16198.433054843024;14146.646333841736;14301.928490357897;14658.340374682952;14714.337854796346;15038.097714137186;14202.28988550589;14549.781753273497;14624.561263162122;14742.96799224044;15006;13845.307734613027;13922.234277114856;14118.43526258938;14220.431182752574;14537.563873083824;10439.217058720475;11006.834897476705;11181.440927953732;11263.171961848871;11760.235584686969;10549.736256593647;11535.908734772816;11714.531418743154;11862.584809531625;11864 15:13:09 INFO - PROCESS | 1935 | __end_tp_report 15:13:09 INFO - PROCESS | 1935 | __start_cc_report 15:13:09 INFO - PROCESS | 1935 | _x_x_mozilla_cycle_collect,1570 15:13:09 INFO - PROCESS | 1935 | __end_cc_report 15:13:09 INFO - PROCESS | 1935 | __startTimestamp1467670389006__endTimestamp 15:13:09 INFO - PROCESS | 1935 | 15:13:09 INFO - PROCESS | 1935 | ------- Summary: start ------- 15:13:09 INFO - PROCESS | 1935 | Number of tests: 6 15:13:09 INFO - PROCESS | 1935 | 15:13:09 INFO - PROCESS | 1935 | [#0] dojo.html Cycles:165 Average:5790.15 Median:6014.70 stddev:647.40 (10.8%) stddev-sans-first:612.48 15:13:09 INFO - PROCESS | 1935 | Values: 3043.6 3356.3 3378.1 3383.5 3387.6 5621.7 5685.1 5714.5 5757.7 5787.3 5766.8 5810.8 5817.1 5817.9 5829.0 5203.7 5262.7 5292.7 5293.7 5368.6 5302.9 5316.4 5331.9 5363.7 5366.8 5255.1 5272.1 5308.4 5320.5 5364.6 5359.1 5364.2 5368.6 5376.5 5397.4 4560.2 5143.1 5149.7 5240.1 5323.3 5648.9 5721.4 5769.3 5787.8 5801.4 6283.1 6307.0 6319.9 6321.8 6325.1 6152.6 6265.5 6302.6 6335.8 6349.8 5911.6 5932.2 5941.7 5967.5 5977.9 6299.9 6315.9 6323.2 6328.1 6329.6 6084.2 6097.3 6114.3 6175.7 6246.3 5555.7 6308.3 6320.9 6343.6 6346.5 5335.2 6185.9 6215.6 6253.2 6304.7 6130.1 6153.0 6185.0 6185.8 6286.6 5010.5 5033.9 5042.4 5043.6 5051.1 4481.5 4484.2 4491.3 4513.1 4552.6 5632.7 5694.3 5715.7 5780.4 5802.8 6299.5 6326.9 6331.0 6336.8 6413.5 5784.4 5786.5 5813.8 5815.9 5844.0 5378.9 5455.1 5502.4 5526.6 5532.2 6350.8 6358.1 6395.8 6400.9 6403.3 5193.6 6242.8 6292.3 6295.7 6318.7 6211.5 6243.8 6289.9 6407.4 6512.2 6276.4 6281.2 6282.0 6283.3 6293.0 6159.2 6310.9 6317.0 6333.0 6356.6 5885.6 6120.4 6121.4 6145.4 6233.0 6146.5 6181.9 6194.3 6200.0 6218.2 5846.2 6005.5 6089.4 6090.3 6132.6 6034.0 6092.8 6098.1 6122.3 6123.4 6011.8 6014.7 6019.8 6024.5 6024.7 15:13:09 INFO - PROCESS | 1935 | 15:13:09 INFO - PROCESS | 1935 | [#1] ext.html Cycles:180 Average:72806.70 Median:36687.17 stddev:162314.42 (442.4%) stddev-sans-first:162678.91 15:13:09 INFO - PROCESS | 1935 | Values: 478.8 490.6 535.5 544.5 552.3 32242.0 32783.0 32861.8 42769.0 43865.0 45620.8 46038.0 46071.0 46120.5 46228.3 9781.3 9971.6 9978.9 9983.2 9988.2 8838.9 9005.3 9724.4 11849.3 12085.5 12131.9 12142.6 12222.9 12226.1 12229.1 12057.2 12131.9 12155.5 12158.8 12161.3 8872.2 10390.2 11659.5 11822.8 11948.6 42994.8 43215.4 43339.1 43385.1 43521.1 3586.3 3731.5 3769.1 3866.7 3873.9 31013.0 31443.3 32207.5 32310.4 33880.5 3282.1 3320.6 3325.2 3327.0 3399.5 567685.0 571384.0 571740.0 571874.0 574477.0 35640.0 36431.0 67361.7 68033.3 68207.3 36468.6 36470.8 36626.0 36674.8 36720.6 15134.5 15282.2 15301.2 15309.6 15313.4 9698.9 12016.8 13005.2 13053.9 13097.3 7550.6 7774.8 7783.6 7801.8 7975.1 3265.8 3284.9 3308.2 3308.3 3322.2 936.0 946.1 986.6 1014.3 1049.3 31668.2 31670.7 31892.7 32319.7 32383.0 925.4 1072.5 1097.7 1177.3 1274.2 16069.3 16350.6 16387.5 16427.4 16992.4 693416.0 702749.0 709442.0 713403.0 713890.0 64176.0 64837.4 64861.4 64924.0 65074.0 1238.8 1241.1 1274.1 1279.3 1393.9 31823.4 32715.7 32951.7 32994.5 33223.1 53631.7 54152.7 54226.0 54227.6 54298.5 522141.0 525454.0 525856.0 526943.0 527273.1 24879.3 27501.7 27856.4 27990.9 28755.3 49599.5 49743.0 50289.5 51204.7 51315.2 41819.0 42028.6 42189.2 43495.9 43733.3 41598.6 41669.2 41779.2 43014.0 43159.8 36699.5 39210.2 40862.4 41259.4 41395.8 33278.8 33756.0 35373.0 36216.9 36448.1 21866.5 22574.5 26095.6 26317.3 26584.6 15:13:09 INFO - PROCESS | 1935 | 15:13:09 INFO - PROCESS | 1935 | [#2] jquery.html Cycles:180 Average:35156.06 Median:379.33 stddev:102265.60 (26959.6%) stddev-sans-first:102519.09 15:13:09 INFO - PROCESS | 1935 | Values: 353.0 374.0 384.7 384.9 402.2 13782.7 15805.1 21115.9 21488.7 21511.0 21124.4 21230.8 21528.9 21641.8 21654.0 5553.0 5722.9 5748.9 6035.8 6055.1 5971.3 6049.8 6063.5 6078.0 6080.5 4757.6 4950.8 5727.4 5986.6 6007.1 5836.9 5897.6 5898.7 5914.6 5964.1 4960.8 5292.4 5295.2 5317.0 5320.1 13070.3 13348.9 15798.8 25852.9 25926.0 2229.9 2406.9 2641.5 2747.4 2911.5 9779.6 9809.5 9985.3 10199.9 10330.1 1800.5 1806.2 1822.3 1830.2 1887.8 79079.0 97069.0 114578.4 125306.0 131685.0 9631.7 10777.9 10863.0 11546.4 11689.1 12523.4 13178.3 14342.8 14347.8 14359.2 8158.2 8484.8 8663.3 8673.3 8759.9 7614.4 8335.9 8687.9 8696.2 8798.3 4435.0 4513.8 4521.6 4566.3 4568.9 1882.3 1886.4 1902.5 1907.2 1953.5 875.5 875.8 882.4 921.9 963.6 15702.9 18492.0 21523.2 21545.3 21637.2 888.1 929.2 995.6 1014.7 1043.3 8160.9 8947.5 11025.6 11171.3 11175.0 601537.0 610074.0 616297.0 618115.0 619412.0 119280.8 125477.0 132823.7 135142.0 136670.0 961.2 983.9 998.8 1002.6 1002.7 15736.9 17740.4 18066.4 18116.0 19608.3 53552.7 58142.7 58240.3 58571.0 58706.0 79896.2 81639.0 83382.6 84072.6 84476.0 5762.3 7504.1 7504.6 7537.9 7720.7 7356.8 10297.7 12415.9 12738.6 13299.3 9981.9 11136.7 11461.2 11791.8 11946.2 11416.5 11426.4 11435.8 11699.3 11771.1 11415.3 11482.2 11647.4 11867.7 12012.6 7106.9 7420.0 7453.5 7693.2 8431.5 10477.7 11568.4 11668.4 11837.8 11867.2 15:13:09 INFO - PROCESS | 1935 | 15:13:09 INFO - PROCESS | 1935 | [#3] mootools.html Cycles:180 Average:5783.87 Median:2721.73 stddev:3300.15 (121.3%) stddev-sans-first:3292.87 15:13:09 INFO - PROCESS | 1935 | Values: 1387.7 1532.4 1571.3 1789.6 1950.7 6669.0 7683.3 9075.4 9087.6 9249.1 8956.6 9041.6 9113.9 9114.0 9159.7 2113.4 2198.3 2345.9 2383.8 2387.3 2341.8 2409.9 2421.4 2422.1 2428.7 2036.4 2355.9 2376.3 2412.7 2417.6 2104.4 2184.5 2187.7 2390.5 2403.7 2164.4 2322.3 2413.1 2417.6 2426.2 9112.9 9164.6 9178.1 9184.1 9185.1 5341.2 5503.6 5523.1 5523.9 5527.5 3606.0 3607.3 3672.2 3675.1 3677.0 1084.7 1086.5 1102.9 1106.2 1798.4 12134.0 12229.7 12233.7 12262.4 12267.3 4440.6 4646.1 4705.1 4732.7 4757.6 9415.1 9451.3 9455.6 9477.1 9484.0 5356.8 5358.0 5358.3 5361.4 5376.2 4461.5 4613.4 4799.2 4946.7 5005.6 3815.5 3822.6 3914.3 3922.8 3936.1 1174.8 1182.8 1187.5 1193.7 1197.7 629.5 783.2 934.6 958.3 976.6 5919.7 6055.9 6106.8 6163.9 6203.2 482.1 496.8 497.9 505.0 641.4 3887.6 4076.9 4152.3 4152.4 4158.9 10513.4 10898.9 11061.7 11063.6 11067.7 11022.1 11025.7 11029.0 11038.0 11052.7 8126.1 8377.6 8493.7 8496.9 8499.3 5970.0 6040.2 6051.0 6101.5 6153.8 9816.4 10265.8 10288.0 10322.8 10355.6 10143.7 10512.3 10514.9 10539.3 10549.1 7117.6 7136.0 7192.1 7193.4 7197.9 8327.0 8438.0 8467.2 8470.5 8485.1 6751.3 7571.1 7571.8 7712.9 7739.0 6723.0 7295.2 7529.1 7613.3 7650.9 7063.1 7163.4 7266.3 7284.9 7361.1 5112.0 5157.4 5169.1 5178.9 5238.6 4306.4 4728.9 5159.3 5371.4 5394.1 15:13:09 INFO - PROCESS | 1935 | 15:13:09 INFO - PROCESS | 1935 | [#4] prototype.html Cycles:180 Average:4396.51 Median:4676.38 stddev:1357.73 (29.0%) stddev-sans-first:1325.22 15:13:09 INFO - PROCESS | 1935 | Values: 240.4 305.2 307.6 311.5 317.3 5245.7 5267.4 5267.8 5287.3 5292.6 4758.3 4964.9 5237.5 5263.3 5335.8 3782.3 3797.2 3938.1 3977.5 3984.1 3495.7 3941.9 3989.8 3990.0 4066.2 3964.2 4021.2 4028.5 4034.4 4049.7 3344.3 3499.4 4035.2 4039.2 4064.9 2778.6 2939.5 3329.5 3522.2 3566.7 3756.5 4960.5 5081.3 5090.2 5127.1 4581.5 4601.3 4604.6 4609.2 4640.5 4669.6 5459.3 5500.8 5512.0 5541.9 3207.5 3422.7 3683.8 3877.6 3902.5 4420.6 4795.7 4872.4 4938.9 5591.3 3829.8 3942.9 3951.0 3963.4 3992.4 4021.8 4059.5 4089.3 4111.0 4111.5 4248.7 4541.5 4544.4 4561.6 4566.9 4581.3 5545.6 5557.4 5569.0 5580.5 1316.4 1331.6 1331.9 1332.7 1336.2 734.8 790.2 818.7 827.8 833.5 4238.0 4297.8 4332.9 4357.7 4418.1 3953.3 4231.4 4294.5 4697.8 4722.0 3869.3 4219.8 4237.8 4262.5 4342.2 2543.5 2740.7 3003.1 3010.7 3036.7 5141.6 5157.9 5199.0 5900.5 5927.0 5113.1 5237.0 5805.8 5832.7 5841.6 5903.9 5909.2 5932.5 5966.0 5994.1 5713.4 5717.3 5722.0 5753.2 5770.9 4680.8 5415.4 5473.0 5670.3 5742.0 5867.4 5872.1 5882.5 5889.7 5895.7 3808.2 3847.8 3849.8 3854.8 3864.7 4569.6 5338.4 5561.2 5714.3 5764.5 4590.4 4858.5 5560.9 5579.5 5580.0 4671.9 5309.3 5553.8 5556.7 5558.2 4637.0 5367.5 5443.8 5454.9 5480.5 4839.0 5539.9 5541.6 5554.5 5580.6 4983.1 5117.8 5144.5 5436.0 5464.7 15:13:09 INFO - PROCESS | 1935 | 15:13:09 INFO - PROCESS | 1935 | [#5] yui.html Cycles:180 Average:23877.23 Median:3735.93 stddev:36681.95 (981.9%) stddev-sans-first:36743.44 15:13:09 INFO - PROCESS | 1935 | Values: 664.6 806.1 810.5 828.3 837.7 15267.8 16533.4 16548.4 16586.1 16600.8 14500.1 14871.0 14925.7 15342.8 15390.5 716.0 742.5 902.4 902.9 910.7 893.8 922.8 923.1 923.6 930.5 976.9 977.6 979.3 981.4 985.1 753.4 940.9 967.6 969.8 971.6 709.8 715.0 715.0 715.8 718.8 15687.0 15687.5 15692.4 15709.0 15721.2 14586.9 14620.7 14684.8 14700.9 14745.6 11536.9 13517.3 13632.6 13735.9 13841.7 3523.3 4709.2 4735.4 4763.2 4773.2 88552.0 112096.3 112104.5 112288.4 113019.0 11259.9 11477.9 11524.5 11564.0 11633.2 23586.8 23693.1 23702.3 23705.2 23905.4 8118.8 8122.8 8241.1 8355.2 8390.5 4473.9 4608.6 4698.7 4721.8 4757.0 3614.0 3734.7 3737.1 3740.1 3740.6 670.9 685.9 696.3 701.1 701.4 504.8 518.6 577.3 636.2 657.4 8889.4 9008.2 9087.1 9117.7 9306.6 599.1 599.5 627.3 641.9 662.2 4249.2 4413.3 4466.3 4482.6 4537.5 132333.0 135359.0 140747.0 149288.0 149783.0 85686.6 101628.5 111018.0 114464.0 119426.0 75763.6 76569.0 95331.0 103925.0 106413.4 9688.0 9793.6 9817.9 9974.3 10126.4 48722.8 58539.7 58755.0 58820.4 59597.0 96780.0 99677.0 99760.5 104581.4 105541.0 11697.8 11881.6 12013.6 12072.3 13287.9 10953.3 13173.9 15613.6 16122.2 16198.4 14146.6 14301.9 14658.3 14714.3 15038.1 14202.3 14549.8 14624.6 14743.0 15006.0 13845.3 13922.2 14118.4 14220.4 14537.6 10439.2 11006.8 11181.4 11263.2 11760.2 10549.7 11535.9 11714.5 11862.6 11864.0 15:13:09 INFO - PROCESS | 1935 | -------- Summary: end -------- 15:13:09 INFO - PROCESS | 1935 | 15:13:09 INFO - TEST-INFO | 1935: exit 0 15:13:09 INFO - TEST-OK | dromaeo_css | took 1117063ms 15:13:09 INFO - TEST-START | kraken 15:13:09 INFO - operating with platform_type : mac_ 15:13:09 INFO - Initialising browser for kraken test... 15:13:09 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/tmpd_9FuT/profile http://localhost:54488/getInfo.html) 15:13:11 INFO - PROCESS | 1939 | __metrics Screen width/height:1600/1200 15:13:11 INFO - PROCESS | 1939 | colorDepth:24 15:13:11 INFO - PROCESS | 1939 | Browser inner width/height: 1024/689 15:13:11 INFO - PROCESS | 1939 | __metrics 15:13:11 INFO - PROCESS | 1939 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:13:11 INFO - PROCESS | 1939 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:13:12 INFO - TEST-INFO | 1939: exit 0 15:13:12 INFO - Browser initialized. 15:13:12 INFO - Running cycle 1/1 for kraken test... 15:13:12 INFO - TEST-INFO | started process 1940 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/tmpd_9FuT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:13:24 INFO - PROCESS | 1940 | RSS: Main: 243814400 15:13:24 INFO - PROCESS | 1940 | 15:13:27 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:54488/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54488/tests/kraken/driver.html?testName=audio-beat-detection) 15:13:28 INFO - PROCESS | 1940 | RSS: Main: 294285312 15:13:28 INFO - PROCESS | 1940 | 15:13:30 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:54488/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54488/tests/kraken/driver.html?testName=audio-dft) 15:13:31 INFO - PROCESS | 1940 | RSS: Main: 304353280 15:13:31 INFO - PROCESS | 1940 | 15:13:34 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:54488/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54488/tests/kraken/driver.html?testName=audio-fft) 15:13:35 INFO - PROCESS | 1940 | RSS: Main: 387596288 15:13:35 INFO - PROCESS | 1940 | 15:13:37 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:54488/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54488/tests/kraken/driver.html?testName=audio-oscillator) 15:13:38 INFO - PROCESS | 1940 | RSS: Main: 289226752 15:13:38 INFO - PROCESS | 1940 | 15:13:40 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:54488/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54488/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:13:40 INFO - PROCESS | 1940 | RSS: Main: 292986880 15:13:40 INFO - PROCESS | 1940 | 15:13:43 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:54488/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54488/tests/kraken/driver.html?testName=imaging-darkroom) 15:13:44 INFO - PROCESS | 1940 | RSS: Main: 329433088 15:13:44 INFO - PROCESS | 1940 | 15:13:47 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:54488/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54488/tests/kraken/driver.html?testName=imaging-desaturate) 15:13:47 INFO - PROCESS | 1940 | RSS: Main: 332750848 15:13:47 INFO - PROCESS | 1940 | 15:13:50 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:54488/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54488/tests/kraken/driver.html?testName=json-parse-financial) 15:13:51 INFO - PROCESS | 1940 | RSS: Main: 332414976 15:13:51 INFO - PROCESS | 1940 | 15:13:52 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:54488/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54488/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:13:53 INFO - PROCESS | 1940 | RSS: Main: 311808000 15:13:53 INFO - PROCESS | 1940 | 15:13:55 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:54488/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54488/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:13:56 INFO - PROCESS | 1940 | RSS: Main: 317747200 15:13:56 INFO - PROCESS | 1940 | 15:13:58 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:54488/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54488/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:13:58 INFO - PROCESS | 1940 | RSS: Main: 315940864 15:13:58 INFO - PROCESS | 1940 | 15:14:01 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:54488/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:14:02 INFO - PROCESS | 1940 | RSS: Main: 324587520 15:14:02 INFO - PROCESS | 1940 | 15:14:05 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:54488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:14:05 INFO - PROCESS | 1940 | RSS: Main: 327204864 15:14:05 INFO - PROCESS | 1940 | 15:14:07 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:54488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54488/tests/kraken/driver.html?testName=ai-astar) 15:14:07 INFO - PROCESS | 1940 | RSS: Main: 370892800 15:14:07 INFO - PROCESS | 1940 | 15:14:07 INFO - PROCESS | 1940 | __start_tp_report 15:14:07 INFO - PROCESS | 1940 | _x_x_mozilla_page_load 15:14:07 INFO - PROCESS | 1940 | _x_x_mozilla_page_load_details 15:14:07 INFO - PROCESS | 1940 | |i|pagename|runs| 15:14:07 INFO - PROCESS | 1940 | |0;ai-astar;101;113;112;112;112;113;112;113;112;112 15:14:07 INFO - PROCESS | 1940 | |1;audio-beat-detection;151;114;136;173;138;135;129;104;137;108 15:14:07 INFO - PROCESS | 1940 | |2;audio-dft;183;183;184;182;183;202;260;187;185;184 15:14:07 INFO - PROCESS | 1940 | |3;audio-fft;76;73;58;109;59;76;51;60;131;78 15:14:07 INFO - PROCESS | 1940 | |4;audio-oscillator;82;88;91;67;73;67;96;70;67;101 15:14:07 INFO - PROCESS | 1940 | |5;imaging-gaussian-blur;87;84;88;84;88;84;89;85;87;84 15:14:07 INFO - PROCESS | 1940 | |6;imaging-darkroom;93;93;93;92;92;94;93;93;93;93 15:14:07 INFO - PROCESS | 1940 | |7;imaging-desaturate;126;131;93;85;85;83;84;84;86;86 15:14:07 INFO - PROCESS | 1940 | |8;json-parse-financial;54;55;55;57;54;56;53;53;55;53 15:14:07 INFO - PROCESS | 1940 | |9;json-stringify-tinderbox;68;67;80;76;72;70;71;70;69;73 15:14:07 INFO - PROCESS | 1940 | |10;stanford-crypto-aes;84;84;81;85;82;91;82;99;76;86 15:14:07 INFO - PROCESS | 1940 | |11;stanford-crypto-ccm;138;136;135;136;129;134;137;134;224;138 15:14:07 INFO - PROCESS | 1940 | |12;stanford-crypto-pbkdf2;175;164;160;162;161;164;161;207;160;163 15:14:07 INFO - PROCESS | 1940 | |13;stanford-crypto-sha256-iterative;66;66;66;66;66;66;66;66;65;67 15:14:07 INFO - PROCESS | 1940 | __end_tp_report 15:14:07 INFO - PROCESS | 1940 | __start_cc_report 15:14:07 INFO - PROCESS | 1940 | _x_x_mozilla_cycle_collect,2004 15:14:07 INFO - PROCESS | 1940 | __end_cc_report 15:14:07 INFO - PROCESS | 1940 | __startTimestamp1467670447915__endTimestamp 15:14:07 INFO - PROCESS | 1940 | 15:14:07 INFO - PROCESS | 1940 | ------- Summary: start ------- 15:14:07 INFO - PROCESS | 1940 | Number of tests: 14 15:14:07 INFO - PROCESS | 1940 | 15:14:07 INFO - PROCESS | 1940 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:3.61 (3.2%) stddev-sans-first:0.50 15:14:07 INFO - PROCESS | 1940 | Values: 101.0 113.0 112.0 112.0 112.0 113.0 112.0 113.0 112.0 112.0 15:14:07 INFO - PROCESS | 1940 | 15:14:07 INFO - PROCESS | 1940 | [#1] audio-beat-detection Cycles:10 Average:132.50 Median:136.50 stddev:20.60 (15.1%) stddev-sans-first:20.73 15:14:07 INFO - PROCESS | 1940 | Values: 151.0 114.0 136.0 173.0 138.0 135.0 129.0 104.0 137.0 108.0 15:14:07 INFO - PROCESS | 1940 | 15:14:07 INFO - PROCESS | 1940 | [#2] audio-dft Cycles:10 Average:193.30 Median:184.50 stddev:24.16 (13.1%) stddev-sans-first:25.33 15:14:07 INFO - PROCESS | 1940 | Values: 183.0 183.0 184.0 182.0 183.0 202.0 260.0 187.0 185.0 184.0 15:14:07 INFO - PROCESS | 1940 | 15:14:07 INFO - PROCESS | 1940 | [#3] audio-fft Cycles:10 Average:77.10 Median:66.50 stddev:24.96 (37.5%) stddev-sans-first:26.48 15:14:07 INFO - PROCESS | 1940 | Values: 76.0 73.0 58.0 109.0 59.0 76.0 51.0 60.0 131.0 78.0 15:14:07 INFO - PROCESS | 1940 | 15:14:07 INFO - PROCESS | 1940 | [#4] audio-oscillator Cycles:10 Average:80.20 Median:77.50 stddev:13.09 (16.9%) stddev-sans-first:13.87 15:14:07 INFO - PROCESS | 1940 | Values: 82.0 88.0 91.0 67.0 73.0 67.0 96.0 70.0 67.0 101.0 15:14:07 INFO - PROCESS | 1940 | 15:14:07 INFO - PROCESS | 1940 | [#5] imaging-gaussian-blur Cycles:10 Average:86.00 Median:87.00 stddev:2.00 (2.3%) stddev-sans-first:2.09 15:14:07 INFO - PROCESS | 1940 | Values: 87.0 84.0 88.0 84.0 88.0 84.0 89.0 85.0 87.0 84.0 15:14:07 INFO - PROCESS | 1940 | 15:14:07 INFO - PROCESS | 1940 | [#6] imaging-darkroom Cycles:10 Average:92.90 Median:93.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 15:14:07 INFO - PROCESS | 1940 | Values: 93.0 93.0 93.0 92.0 92.0 94.0 93.0 93.0 93.0 93.0 15:14:07 INFO - PROCESS | 1940 | 15:14:07 INFO - PROCESS | 1940 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:85.00 stddev:18.27 (21.5%) stddev-sans-first:15.36 15:14:07 INFO - PROCESS | 1940 | Values: 126.0 131.0 93.0 85.0 85.0 83.0 84.0 84.0 86.0 86.0 15:14:07 INFO - PROCESS | 1940 | 15:14:07 INFO - PROCESS | 1940 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:1.35 (2.5%) stddev-sans-first:1.42 15:14:07 INFO - PROCESS | 1940 | Values: 54.0 55.0 55.0 57.0 54.0 56.0 53.0 53.0 55.0 53.0 15:14:07 INFO - PROCESS | 1940 | 15:14:07 INFO - PROCESS | 1940 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:71.50 stddev:3.92 (5.5%) stddev-sans-first:3.94 15:14:07 INFO - PROCESS | 1940 | Values: 68.0 67.0 80.0 76.0 72.0 70.0 71.0 70.0 69.0 73.0 15:14:07 INFO - PROCESS | 1940 | 15:14:07 INFO - PROCESS | 1940 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.50 stddev:6.24 (7.4%) stddev-sans-first:6.60 15:14:07 INFO - PROCESS | 1940 | Values: 84.0 84.0 81.0 85.0 82.0 91.0 82.0 99.0 76.0 86.0 15:14:07 INFO - PROCESS | 1940 | 15:14:07 INFO - PROCESS | 1940 | [#11] stanford-crypto-ccm Cycles:10 Average:144.10 Median:136.50 stddev:28.20 (20.7%) stddev-sans-first:29.82 15:14:07 INFO - PROCESS | 1940 | Values: 138.0 136.0 135.0 136.0 129.0 134.0 137.0 134.0 224.0 138.0 15:14:07 INFO - PROCESS | 1940 | 15:14:07 INFO - PROCESS | 1940 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.70 Median:163.50 stddev:14.48 (8.9%) stddev-sans-first:15.12 15:14:07 INFO - PROCESS | 1940 | Values: 175.0 164.0 160.0 162.0 161.0 164.0 161.0 207.0 160.0 163.0 15:14:07 INFO - PROCESS | 1940 | 15:14:07 INFO - PROCESS | 1940 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 15:14:07 INFO - PROCESS | 1940 | Values: 66.0 66.0 66.0 66.0 66.0 66.0 66.0 66.0 65.0 67.0 15:14:07 INFO - PROCESS | 1940 | -------- Summary: end -------- 15:14:07 INFO - PROCESS | 1940 | 15:14:08 INFO - TEST-INFO | 1940: exit 0 15:14:08 INFO - TEST-OK | kraken | took 59133ms 15:14:08 INFO - SUITE-END | took 1176s 15:14:09 INFO - Completed test suite (00:19:36) 15:14:09 INFO - javascript benchmark 15:14:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3043.604331436913, 3356.32873425315, 3378.0879162626093, 3383.475561288, 3387.5934887813464, 5621.718914054301, 5685.090385538315, 5714.485696287334, 5757.68332741699, 5787.305523337205, 5766.798162064318, 5810.82567522975, 5817.127430885369, 5817.854553636162, 5828.970855145718, 5203.661761985469, 5262.710550919698, 5292.682439053649, 5293.68237905725, 5368.62419630626, 5302.92045619316, 5316.415194328621, 5331.853651464934, 5363.678179309254, 5366.812161574346, 5255.0803609368395, 5272.077386457374, 5308.389535203443, 5320.494553017457, 5364.624476286662, 5359.062164121283, 5364.249005139283, 5368.597355198376, 5376.489233522848, 5397.379301380352, 4560.247559152735, 5143.074246635604, 5149.742512874342, 5240.135377662681, 5323.281357016792, 5648.887022259573, 5721.427857214246, 5769.336526299488, 5787.768489260425, 5801.361850196475, 6283.057541368786, 6306.968465157691, 6319.905201421982, 6321.841953951188, 6325.14610527582, 6152.6308421494405, 6265.498760099181, 6302.621842689453, 6335.809925702236, 6349.809505714836, 5911.586188966774, 5932.228810254639, 5941.673207973517, 5967.46292833647, 5977.940220597825, 6299.937000630027, 6315.905261421082, 6323.177986861679, 6328.050792381087, 6329.620222786648, 6084.178635884099, 6097.282711138064, 6114.296855861544, 6175.660338681326, 6246.250449945945, 5555.666660000413, 6308.27454842699, 6320.936790632127, 6343.619382837044, 6346.460550853137, 5335.199720041947, 6185.876282474325, 6215.564910456224, 6253.218347706536, 6304.684765761694, 6130.061839217998, 6152.98475751496, 6185.0, 6185.8144255672405, 6286.5599408041, 5010.549050585465, 5033.899322013539, 5042.39491261051, 5043.571296439771, 5051.090803655304, 4481.462224533012, 4484.2376795944765, 4491.30384790358, 4513.142502924499, 4552.6130278926, 5632.746526406321, 5694.345150307768, 5715.685637289906, 5780.421957804186, 5802.767889284381, 6299.464545513682, 6326.873462530723, 6331.0, 6336.778212762623, 6413.518986076063, 5784.363719990798, 5786.537077033827, 5813.849590469099, 5815.854603634858, 5843.970780146157, 5378.91931621026, 5455.072637651609, 5502.394736578973, 5526.557875370041, 5532.225488431623, 6350.841228969312, 6358.078078678658, 6395.840103997437, 6400.871982560416, 6403.3276505966205, 5193.610479213999, 6242.781502647385, 6292.27638821523, 6295.653739044396, 6318.6840657965995, 6211.503079753699, 6243.8126856194385, 6289.905651415141, 6407.3592640737415, 6512.218533775977, 6276.403741644536, 6281.214848143982, 6282.0, 6283.308836027942, 6293.0, 6159.19930409044, 6310.936890631035, 6316.968415157895, 6333.0, 6356.586821856565, 5885.558583106199, 6120.357362476876, 6121.4490695837585, 6145.4161854623735, 6232.968835155795, 6146.51780542848, 6181.876362472815, 6194.318624951342, 6200.0389939557635, 6218.19163508741, 5846.210761547137, 6005.549583781147, 6089.357855890828, 6090.330063693079, 6132.601380910227, 6034.00438927572, 6092.786752463642, 6098.115773212948, 6122.2761798032625, 6123.404636889863, 6011.819645410645, 6014.699265036818, 6019.789307374221, 6024.487918526799, 6024.668643224665], "value": 5748.272597771081, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.81326282749734, 490.56339857526797, 535.5314100162357, 544.4854612391289, 552.3454706173183, 32242.0, 32782.99999999997, 32861.83569082154, 42769.0, 43865.0, 45620.771896140475, 46038.0, 46071.0, 46120.53879461213, 46228.306575401395, 9781.31530792843, 9971.601135954554, 9978.90021099787, 9983.201343892508, 9988.1510071644, 8838.911610883906, 9005.324600654943, 9724.416535007887, 11849.348285844275, 12085.516579336816, 12131.93934030333, 12142.575009874656, 12222.93888530556, 12226.14416990811, 12229.143959922809, 12057.155999080069, 12131.93934030333, 12155.513779448811, 12158.78412158777, 12161.270323780513, 8872.201501864798, 10390.168786497063, 11659.475323610457, 11822.822657660143, 11948.641540753792, 42994.78502607467, 43215.35176972348, 43339.133217335475, 43385.13229735388, 43521.129577408276, 3586.28274345132, 3731.458938453909, 3769.0765762388114, 3866.729328946975, 3873.8783401913806, 31013.0, 31443.270620115884, 32207.51688724671, 32310.35379292401, 33880.49179262313, 3282.0646115857103, 3320.6015278166533, 3325.235195904931, 3326.96673033269, 3399.5070714746225, 567685.0, 571384.0, 571740.0, 571874.0, 574477.0, 35640.0, 36431.0, 67361.66319168372, 68033.3196668027, 68207.3179268211, 36468.635313646526, 36470.8176459116, 36626.0, 36674.8166259167, 36720.63279367226, 15134.545963621109, 15282.235888205545, 15301.234938253043, 15309.6172595686, 15313.387464501518, 9698.903010969942, 12016.819747703792, 13005.21968681882, 13053.934730326288, 13097.279649619171, 7550.622468876644, 7774.766756997299, 7783.571903545246, 7801.765947021485, 7975.082865470429, 3265.7877237979455, 3284.8521816518314, 3308.2225676965895, 3308.2721801203697, 3322.152851023022, 935.9766005849908, 946.1390134977138, 986.6398764450923, 1014.3204053284318, 1049.3053718245133, 31668.208294792814, 31670.683293167232, 31892.681073189437, 32319.676803231665, 32383.0, 925.3846192282057, 1072.5120070367964, 1097.6926460591046, 1177.328922514176, 1274.1717883375695, 16069.27688254008, 16350.591235219215, 16387.508374748777, 16427.425040123537, 16992.405265815636, 693416.0, 702749.0, 709442.0, 713403.0, 713890.0, 64176.03735943871, 64837.351626483134, 64861.351386485534, 64924.0, 65074.0, 1238.8327575777514, 1241.050596293836, 1274.0762946863636, 1279.3027799849106, 1393.8745512903888, 31823.363532728752, 32715.672843271263, 32951.67048329486, 32994.505082423304, 33223.07791936044, 53631.6592085201, 54152.72923635357, 54226.0, 54227.64430889102, 54298.45701542934, 522141.0, 525454.0, 525856.0, 526943.0, 527273.0909036291, 24879.253622391356, 27501.72498275072, 27856.44287114287, 27990.860045699643, 28755.28111797222, 49599.50400495949, 49743.0, 50289.4913152606, 51204.71988200176, 51315.23027154521, 41819.0, 42028.57971420369, 42189.1562168761, 43495.9126021852, 43733.34399983939, 41598.58401416068, 41669.16661666689, 41779.164416712105, 43014.0, 43159.78420107879, 36699.53201871895, 39210.2157956845, 40862.38706419346, 41259.38110928398, 41395.793021034704, 33278.83360583182, 33756.0, 35373.0, 36216.91349259527, 36448.08879778027, 21866.45333866666, 22574.548509030057, 26095.608565871906, 26317.342066447727, 26584.580943052595], "value": 19676.803014602887, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.9964700352996, 373.95699494558124, 384.69993405144, 384.93263678856204, 402.18758108620585, 13782.724345513083, 15805.130717810516, 21115.894420527875, 21488.677669834964, 21511.032003559856, 21124.366269011953, 21230.787692123075, 21528.8923555382, 21641.783582164175, 21654.0, 5553.0, 5722.942770572283, 5748.885022299562, 6035.849103772397, 6055.122007308938, 5971.283445986466, 6049.758009679607, 6063.484603808682, 6077.997130473489, 6080.513558915276, 4757.64317676174, 4950.752462376885, 5727.398623144572, 5986.640801551921, 6007.068904319837, 5836.883262334772, 5897.646141231497, 5898.675572843492, 5914.645121292736, 5964.105384192362, 4960.826371076995, 5292.391374991887, 5295.152775555931, 5316.9734151329385, 5320.148776195829, 13070.346482675828, 13348.933255333759, 15798.842011579853, 25852.87073564639, 25926.0, 2229.921952731647, 2406.855588664686, 2641.537730897085, 2747.3543717226435, 2911.4613796447725, 9779.559919803625, 9809.509524523744, 9985.251106167067, 10199.949000255025, 10330.12193963514, 1800.5055803682912, 1806.205269681336, 1822.2710915633852, 1830.1581272614612, 1887.8206570375792, 79079.0, 97069.0, 114578.42710786393, 125306.0, 131685.0, 9631.699720537637, 10777.946110269399, 10863.0, 11546.364949927834, 11689.064874809996, 12523.373831308398, 13178.275194864184, 14342.784858227134, 14347.78478322826, 14359.210243436712, 8158.224968627971, 8484.830303394021, 8663.263622592025, 8673.349498787617, 8759.912400876037, 7614.390848732088, 8335.87465692136, 8687.913120868838, 8696.17386348296, 8798.29613630908, 4434.955650443454, 4513.81944722214, 4521.638268938543, 4566.26939689648, 4568.931466028012, 1882.3317722208692, 1886.4246404846378, 1902.5148587110198, 1907.160849226336, 1953.5116220944765, 875.4528419737663, 875.7591662292793, 882.3646974178581, 921.8893732752113, 963.6097380560884, 15702.921485392728, 18491.98294093838, 21523.246686366216, 21545.30683664542, 21637.242696505546, 888.138505649519, 929.2101713543569, 995.6365926436798, 1014.7158795537262, 1043.2644985285356, 8160.877586836202, 8947.507887066144, 11025.6141035065, 11171.273867198606, 11175.0, 601536.9923150357, 610074.0, 616297.0, 618115.0, 619412.0, 119280.8071919287, 125477.0, 132823.67176328306, 135141.97287040701, 136670.0, 961.2118063188259, 983.9262055345878, 998.7752755629925, 1002.5588740954103, 1002.6590959073804, 15736.940670200009, 17740.40336369733, 18066.36767713124, 18116.00361980051, 19608.313709020687, 53552.66118347072, 58142.7092864533, 58240.25279241629, 58571.0, 58706.0, 79896.20103798888, 81639.0, 83382.5830870866, 84072.57963710143, 84476.0, 5762.279715035621, 7504.061992250969, 7504.587247701429, 7537.924620753723, 7720.652570634223, 7356.77929662111, 10297.691069267934, 12415.93792031034, 12738.6178414644, 13299.335033248492, 9981.850272246067, 11136.721581960515, 11461.197716159788, 11791.82081791814, 11946.223495472766, 11416.486258118572, 11426.371549564521, 11435.828462572901, 11699.2980421175, 11771.11716621274, 11415.315081095161, 11482.196246262682, 11647.359395233005, 11867.703307417383, 12012.579559715368, 7106.857862842611, 7420.035395398563, 7453.4782565222085, 7693.1922148173635, 8431.494110353398, 10477.738056548647, 11568.363739994382, 11668.416579171177, 11837.82243266369, 11867.228630139014], "value": 9394.066563470444, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1387.6877702516929, 1532.4023630783997, 1571.2850652952907, 1789.588394669226, 1950.7268982342475, 6668.966655166723, 7683.346915512181, 9075.36472446929, 9087.636494540218, 9249.075092490748, 8956.55217239137, 9041.638334466614, 9113.908860911406, 9114.043025482328, 9159.725208243763, 2113.355426594888, 2198.2525941179997, 2345.94135146621, 2383.761623837611, 2387.283814855545, 2341.812654987597, 2409.8915548800346, 2421.406755344934, 2422.103821586016, 2428.659987601737, 2036.389083275019, 2355.9293221203393, 2376.3465047112095, 2412.662227288181, 2417.613181890898, 2104.3686893931913, 2184.530325979906, 2187.6937228787983, 2390.4501964548163, 2403.6995375578053, 2164.426426996847, 2322.3149170994598, 2413.083028449178, 2417.601095819188, 2426.2114812685772, 9112.908870911273, 9164.633414663405, 9178.128077832594, 9184.12750788674, 9185.12741289583, 5341.1988201769655, 5503.559715222773, 5523.143912693539, 5523.922835047168, 5527.50252477275, 3605.963940360589, 3607.2965771674535, 3672.173760903802, 3675.1363429594026, 3676.981615091934, 1084.701707030565, 1086.5436516663021, 1102.8676558812995, 1106.2145876427746, 1798.3885478937093, 12134.029277657855, 12229.694257643541, 12233.69415764613, 12262.448189831479, 12267.263964162179, 4440.555944405533, 4646.140464014101, 4705.082508910798, 4732.692374995614, 4757.619390448755, 9415.105564971316, 9451.291153163404, 9455.574499147555, 9477.147056764787, 9483.952580237055, 5356.7857285708915, 5358.0, 5358.303420555303, 5361.356637203483, 5376.220448035013, 4461.486929003141, 4613.400257966443, 4799.18413869643, 4946.703197808143, 5005.62457815658, 3815.4849095372324, 3822.636849499293, 3914.2954268231993, 3922.843086276517, 3936.0553467168247, 1174.7591743692694, 1182.7930112230326, 1187.4715751490503, 1193.7373777768878, 1197.736497970445, 629.5058379172327, 783.177663453383, 934.56075644447, 958.3100167879115, 976.5605477535138, 5919.704014799329, 6055.878882422415, 6106.786262480792, 6163.905193550766, 6203.2245969253845, 482.12494322803997, 496.7640370823902, 497.9103761322997, 505.0379027951758, 641.355437785023, 3887.5723670396233, 4076.9388459173138, 4152.314868046798, 4152.43942067817, 4158.896027599334, 10513.369197848153, 10898.945505272422, 11061.668149955514, 11063.557457701763, 11067.72330691723, 11022.118230541537, 11025.724356890982, 11029.0, 11038.00657940773, 11052.723681908017, 8126.10612832588, 8377.6230069647, 8493.745187644257, 8496.872546911802, 8499.277561407349, 5970.000049983304, 6040.214772079602, 6051.0, 6101.542384321282, 6153.800008998382, 9816.361936474106, 10265.794684106128, 10288.0, 10322.845157322496, 10355.637552685619, 10143.695689129338, 10512.26414151002, 10514.947425262824, 10539.26225164231, 10549.103326217357, 7117.644117794193, 7136.036635054201, 7192.100987376578, 7193.424526038009, 7197.892031619425, 8326.958365208378, 8438.0, 8467.237948584658, 8470.49177049379, 8485.066642669179, 6751.291114432914, 7571.129320128035, 7571.772846814604, 7712.884306735291, 7739.0, 6722.966385168239, 7295.197528271992, 7529.058867641545, 7613.276738709814, 7650.885236721565, 7063.117110361205, 7163.3552980232025, 7266.346028857428, 7284.854302913806, 7361.079865016873, 5112.0, 5157.432682405008, 5169.095408303607, 5178.8964220716125, 5238.580913526833, 4306.41863348444, 4728.905421891612, 5159.251908473326, 5371.355437347387, 5394.109971854757], "value": 4565.549531628332, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [240.40859485665266, 305.1699377692675, 307.61701681406646, 311.49848743522926, 317.2876891378855, 5245.711485868275, 5267.4469180736, 5267.841964741055, 5287.28621636079, 5292.576593872491, 4758.2862570614425, 4964.907720301528, 5237.47625237476, 5263.26314315996, 5335.7865685372635, 3782.3380908341, 3797.2025874566234, 3938.133610605662, 3977.5028121484816, 3984.1234928315725, 3495.7028652564563, 3941.940870886939, 3989.760614363133, 3990.0, 4066.2274167908004, 3964.2071585682834, 4021.1957608478274, 4028.47629808126, 4034.435179074932, 4049.7367671101283, 3344.331133773243, 3499.427920478446, 4035.2131334389805, 4039.192161567669, 4064.898377540585, 2778.597103419993, 2939.470895238856, 3329.5338652588657, 3522.2427178156818, 3566.7146628269675, 3756.4740936268945, 4960.503949605047, 5081.314022606938, 5090.236464530313, 5127.0777854941, 4581.4502259728715, 4601.332806743037, 4604.58558729716, 4609.239475486541, 4640.491840151964, 4669.556392142741, 5459.253039027512, 5500.779968801243, 5511.972440137773, 5541.944580554183, 3207.470767323389, 3422.691957723817, 3683.797391143486, 3877.612238776128, 3902.492675952108, 4420.563316921981, 4795.664303498756, 4872.366592342973, 4938.925916111261, 5591.329040515164, 3829.8276577554075, 3942.901427464279, 3951.0122469382654, 3963.3856752203455, 3992.3830848505822, 4021.778802165909, 4059.4722686050623, 4089.2843752343815, 4111.0, 4111.48606424197, 4248.723832950848, 4541.5231400703115, 4544.409226800561, 4561.5666511682, 4566.862994110182, 4581.289900065495, 5545.639533430314, 5557.360903496069, 5569.0, 5580.460890294906, 1316.407616572527, 1331.6271443995697, 1331.8668133186798, 1332.726791007841, 1336.1715736243398, 734.7869117955732, 790.1584812175015, 818.6643476174739, 827.7542298840207, 833.5123952487742, 4237.96985155609, 4297.808117859914, 4332.941852620043, 4357.738535687806, 4418.078136010781, 3953.327934251184, 4231.407602935591, 4294.463192100988, 4697.81208751653, 4722.0, 3869.2648396804516, 4219.83954412539, 4237.766922819274, 4262.46719160105, 4342.153280110411, 2543.465872166829, 2740.725927407283, 3003.05403797803, 3010.71398217169, 3036.681148479422, 5141.614378921596, 5157.936825269922, 5198.9861976914135, 5900.524868782804, 5926.977241606725, 5113.079645663742, 5237.0, 5805.82582522525, 5832.650040997553, 5841.649501029951, 5903.907777061343, 5909.172715819875, 5932.525397968238, 5966.046806830646, 5994.130851026664, 5713.428657134254, 5717.256756621779, 5722.0, 5753.223314852441, 5770.913436298375, 4680.836170734008, 5415.350157981067, 5472.98749731301, 5670.319561652463, 5741.97129014369, 5867.442592953663, 5872.148538461814, 5882.5293976482635, 5889.699270656272, 5895.67573783446, 3808.2383523294898, 3847.769133851978, 3849.82675779585, 3854.7879866606486, 3864.652181303696, 4569.588737013684, 5338.359396872245, 5561.249231353715, 5714.342850572238, 5764.521255860021, 4590.380298659638, 4858.5384388483035, 5560.944390556043, 5579.4978451937895, 5579.963313390665, 4671.929921051119, 5309.309789727466, 5553.8333849984565, 5556.749946252347, 5558.194061861089, 4636.976815115903, 5367.504110588595, 5443.8094666686475, 5454.863628409322, 5480.506754392124, 4839.0, 5539.9169012464035, 5541.639793413416, 5554.50009499147, 5580.609357344947, 4983.127952608206, 5117.769700363418, 5144.536991670768, 5435.972820135874, 5464.672119672673], "value": 3962.354257376187, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.5713514782965, 806.1495122645606, 810.4691427115238, 828.3331917806164, 837.7403005068429, 15267.770983435243, 16533.421330253444, 16548.420805271817, 16586.08776517291, 16600.750988735163, 14500.129992200475, 14871.0, 14925.701485970274, 15342.84657153431, 15390.538283851502, 715.9570425774444, 742.4505865659401, 902.4044130873625, 902.9390466202219, 910.6767097680328, 893.7810236492069, 922.8385032619299, 923.0584803500426, 923.6166990698852, 930.5207817973749, 976.9023097690246, 977.5796407544752, 979.2851218610418, 981.3719219699362, 985.069109691342, 753.408574269196, 940.8635747816528, 967.5549247346194, 969.8254314223437, 971.6453494474466, 709.7764204275637, 714.9964250178716, 715.0204220218334, 715.8031541326125, 718.81310859177, 15687.0, 15687.450939217073, 15692.372305107781, 15709.0, 15721.213939303103, 14586.92706536471, 14620.70758584833, 14684.779728304084, 14700.926495367561, 14745.557633271019, 11536.942315288454, 13517.256550889697, 13632.591022269347, 13735.931320343334, 13841.723165536734, 3523.312953973976, 4709.175894218532, 4735.408073990751, 4763.190257656172, 4773.188557945157, 88552.0, 112096.31855522255, 112104.51581936712, 112288.4385578075, 113019.0, 11259.887401126047, 11477.885221147682, 11524.481398337095, 11563.959243667941, 11633.185677002528, 23586.7641323588, 23693.05227790869, 23702.28893133209, 23705.170319038752, 23905.402364941016, 8118.837623247502, 8122.796930076677, 8241.134680858424, 8355.248027677417, 8390.496570205807, 4473.888152796206, 4608.5621865922685, 4698.718076915396, 4721.811127554859, 4756.952430475721, 3613.9819300903328, 3734.7198960078103, 3737.1404576947452, 3740.121071548184, 3740.551133863954, 670.9127813384229, 685.8628274345151, 696.2758730919787, 701.0640794539245, 701.386286998876, 504.83088165464983, 518.6058595467397, 577.3302968556454, 636.1952130554852, 657.3886285754198, 8889.422187557788, 9008.189262966365, 9087.136722011399, 9117.680881169128, 9306.627734890528, 599.12228585123, 599.5203836930439, 627.3170780126378, 641.8908785506475, 662.2251965200727, 4249.192653395845, 4413.337999300131, 4466.330050492452, 4482.551744825491, 4537.523560026216, 132333.0, 135359.0, 140747.0, 149288.0, 149783.0, 85686.57156714177, 101628.49185754024, 111018.0, 114464.0, 119426.0, 75763.62118189374, 76569.0, 95331.0, 103924.99999999849, 106413.40379894462, 9688.0, 9793.608255669978, 9817.901820981699, 9974.301798874008, 10126.392416455037, 48722.75638621784, 58539.70730146322, 58755.0, 58820.4117958815, 59597.0, 96780.0, 99677.0, 99760.50119749355, 104581.43127852936, 105541.0, 11697.824532631847, 11881.5841445549, 12013.579524716943, 12072.275663460221, 13287.867121328663, 10953.34279943174, 13173.93413032967, 15613.609659758597, 16122.193890305673, 16198.433054843024, 14146.646333841736, 14301.928490357897, 14658.340374682952, 14714.337854796346, 15038.097714137186, 14202.28988550589, 14549.781753273497, 14624.561263162122, 14742.96799224044, 15006.0, 13845.307734613027, 13922.234277114856, 14118.43526258938, 14220.431182752574, 14537.563873083824, 10439.217058720475, 11006.834897476705, 11181.440927953732, 11263.171961848871, 11760.235584686969, 10549.736256593647, 11535.908734772816, 11714.531418743154, 11862.584809531625, 11864.0], "value": 7980.232773221462, "unit": "score"}], "name": "dromaeo_css", "value": 7316.595554975084, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 112.0, 112.0, 112.0, 113.0, 112.0, 113.0, 112.0, 112.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 114.0, 136.0, 173.0, 138.0, 135.0, 129.0, 104.0, 137.0, 108.0], "value": 132.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 184.0, 182.0, 183.0, 202.0, 260.0, 187.0, 185.0, 184.0], "value": 193.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 58.0, 109.0, 59.0, 76.0, 51.0, 60.0, 131.0, 78.0], "value": 77.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 88.0, 91.0, 67.0, 73.0, 67.0, 96.0, 70.0, 67.0, 101.0], "value": 80.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 88.0, 84.0, 88.0, 84.0, 89.0, 85.0, 87.0, 84.0], "value": 86.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 92.0, 92.0, 94.0, 93.0, 93.0, 93.0, 93.0], "value": 92.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 131.0, 93.0, 85.0, 85.0, 83.0, 84.0, 84.0, 86.0, 86.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 57.0, 54.0, 56.0, 53.0, 53.0, 55.0, 53.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 80.0, 76.0, 72.0, 70.0, 71.0, 70.0, 69.0, 73.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 81.0, 85.0, 82.0, 91.0, 82.0, 99.0, 76.0, 86.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 136.0, 135.0, 136.0, 129.0, 134.0, 137.0, 134.0, 224.0, 138.0], "value": 144.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 164.0, 160.0, 162.0, 161.0, 164.0, 161.0, 207.0, 160.0, 163.0], "value": 167.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 67.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1456.3999999999999, "alertThreshold": 2.0}]} 15:14:09 INFO - Return code: 0 15:14:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:14:09 INFO - # TBPL SUCCESS # 15:14:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:14:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:14:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:14:09 INFO - 2016-07-04 15:14:09.238 screenresolution[1944:18536] starting screenresolution argv=screenresolution get 15:14:09 INFO - 2016-07-04 15:14:09.241 screenresolution[1944:18536] Display 0: 1600x1200x32@60 15:14:09 INFO - 2016-07-04 15:14:09.246 screenresolution[1945:18539] starting screenresolution argv=screenresolution list 15:14:09 INFO - Available Modes on Display 0 15:14:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:14:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:14:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:14:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:14:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:14:09 INFO - Intel Iris: 15:14:09 INFO - Chipset Model: Intel Iris 15:14:09 INFO - Type: GPU 15:14:09 INFO - Bus: Built-In 15:14:09 INFO - VRAM (Dynamic, Max): 1536 MB 15:14:09 INFO - Vendor: Intel (0x8086) 15:14:09 INFO - Device ID: 0x0a2e 15:14:09 INFO - Revision ID: 0x0009 15:14:09 INFO - Displays: 15:14:09 INFO - Display: 15:14:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:14:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:14:09 INFO - Display Serial Number: 1600x1200 60 15:14:09 INFO - Main Display: Yes 15:14:09 INFO - Mirror: Off 15:14:09 INFO - Online: Yes 15:14:09 INFO - Rotation: Supported 15:14:09 INFO - Return code: 0 15:14:09 INFO - Running post-action listener: _resource_record_post_action 15:14:09 INFO - ##### 15:14:09 INFO - ##### Finished run-tests step (success) 15:14:09 INFO - ##### 15:14:09 INFO - Running post-run listener: _resource_record_post_run 15:14:09 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 655360; Write bytes: 704009216; Read time: 9; Write time: 1921 15:14:09 INFO - TinderboxPrint: CPU usage
53.4% 15:14:09 INFO - TinderboxPrint: I/O read bytes / time
655,360 / 9 15:14:09 INFO - TinderboxPrint: I/O write bytes / time
704,009,216 / 1,921 15:14:09 INFO - TinderboxPrint: CPU idle
2,256.8 (46.6%) 15:14:09 INFO - TinderboxPrint: CPU system
966.9 (20.0%) 15:14:09 INFO - TinderboxPrint: CPU user
1,621.9 (33.5%) 15:14:09 INFO - TinderboxPrint: Swap in / out
407,801,856 / 0 15:14:09 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 392061440; Write bytes: 386053632; Read time: 29488; Write time: 671 15:14:09 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 655360; Write bytes: 294731264; Read time: 9; Write time: 1185 15:14:09 INFO - Running post-run listener: _upload_blobber_files 15:14:09 INFO - Blob upload gear active. 15:14:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:14:09 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 15:14:09 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:14:09 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:14:10 INFO - (blobuploader) - INFO - Open directory for files ... 15:14:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:14:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:14:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:14:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:14:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:14:11 INFO - (blobuploader) - INFO - Done attempting. 15:14:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:14:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:14:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:14:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:14:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:14:11 INFO - (blobuploader) - INFO - Done attempting. 15:14:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:14:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:14:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:14:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:14:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:14:14 INFO - (blobuploader) - INFO - Done attempting. 15:14:14 INFO - (blobuploader) - INFO - Iteration through files over. 15:14:14 INFO - Return code: 0 15:14:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:14:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:14:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48075d2f08585c63f525e345ce3a24c96cbf734dfa98313dd1253577adaacc4c2c465ba9d75dbd261b6317d2e3e3c930a47f4fbb991a1e20b533d9b9eaa134d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/69ccb267e33f3e4ae2499a0b4553853b7043cb70c7dfb7e31a373c6bdb03536a67bca7f68fc6991522e2ed6e039baf0f9058f8f71b568a5f4235e85e156d08e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/209ef2e8b8d6ef9cd126690deb2c46a04443f60f5cbc17489432100b005e5f0558aa0a79dc9a5ee5555ee84fbc55b455cc2e7268a9f1916f3a3558b628f652e3"} 15:14:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:14:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:14:14 INFO - Contents: 15:14:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48075d2f08585c63f525e345ce3a24c96cbf734dfa98313dd1253577adaacc4c2c465ba9d75dbd261b6317d2e3e3c930a47f4fbb991a1e20b533d9b9eaa134d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/69ccb267e33f3e4ae2499a0b4553853b7043cb70c7dfb7e31a373c6bdb03536a67bca7f68fc6991522e2ed6e039baf0f9058f8f71b568a5f4235e85e156d08e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/209ef2e8b8d6ef9cd126690deb2c46a04443f60f5cbc17489432100b005e5f0558aa0a79dc9a5ee5555ee84fbc55b455cc2e7268a9f1916f3a3558b628f652e3"} 15:14:14 INFO - Running post-run listener: copy_logs_to_upload_dir 15:14:14 INFO - Copying logs to upload dir... 15:14:14 INFO - mkdir: /builds/slave/test/build/upload/logs 15:14:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.904354 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-07-04 15:14:14.229981) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 15:14:14.233059) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ld28rmPtAA/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.mEs1n2pohs/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48075d2f08585c63f525e345ce3a24c96cbf734dfa98313dd1253577adaacc4c2c465ba9d75dbd261b6317d2e3e3c930a47f4fbb991a1e20b533d9b9eaa134d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/69ccb267e33f3e4ae2499a0b4553853b7043cb70c7dfb7e31a373c6bdb03536a67bca7f68fc6991522e2ed6e039baf0f9058f8f71b568a5f4235e85e156d08e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/209ef2e8b8d6ef9cd126690deb2c46a04443f60f5cbc17489432100b005e5f0558aa0a79dc9a5ee5555ee84fbc55b455cc2e7268a9f1916f3a3558b628f652e3"} build_url:https://queue.taskcluster.net/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010932 build_url: 'https://queue.taskcluster.net/v1/task/GNgDeJRUSPCa-uXmg4MvCQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48075d2f08585c63f525e345ce3a24c96cbf734dfa98313dd1253577adaacc4c2c465ba9d75dbd261b6317d2e3e3c930a47f4fbb991a1e20b533d9b9eaa134d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/69ccb267e33f3e4ae2499a0b4553853b7043cb70c7dfb7e31a373c6bdb03536a67bca7f68fc6991522e2ed6e039baf0f9058f8f71b568a5f4235e85e156d08e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/209ef2e8b8d6ef9cd126690deb2c46a04443f60f5cbc17489432100b005e5f0558aa0a79dc9a5ee5555ee84fbc55b455cc2e7268a9f1916f3a3558b628f652e3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 15:14:14.265518) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 15:14:14.265830) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ld28rmPtAA/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.mEs1n2pohs/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005009 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 15:14:14.314809) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 15:14:14.315105) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 15:14:14.315432) ========= ========= Total master_lag: 0.18 =========