builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0317 starttime: 1469151040.2 results: success (0) buildid: 20160721173023 builduid: 94038867fbc44fc4920c87be52b72e10 revision: 4a8156e1267732f57c9013349b6a49688b3857e3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 18:30:40.199232) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 18:30:40.199681) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 18:30:40.199948) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 18:30:40.224060) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-21 18:30:40.224423) ========= 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.eWsrSHj2e4/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.dPIOQhbMDs/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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-21 18:30:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2016-07-21 18:30:40 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118967 ========= master_lag: 2.31 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-21 18:30:42.653693) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 18:30:42.654002) ========= 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.eWsrSHj2e4/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.dPIOQhbMDs/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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.026258 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 18:30:42.705896) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-21 18:30:42.706585) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 4a8156e1267732f57c9013349b6a49688b3857e3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 4a8156e1267732f57c9013349b6a49688b3857e3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.eWsrSHj2e4/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.dPIOQhbMDs/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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-21 18:30:42,788 truncating revision to first 12 chars 2016-07-21 18:30:42,788 Setting DEBUG logging. 2016-07-21 18:30:42,788 attempt 1/10 2016-07-21 18:30:42,788 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/4a8156e12677?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 18:30:44,062 unpacking tar archive at: autoland-4a8156e12677/testing/mozharness/ program finished with exit code 0 elapsedTime=1.552949 ========= master_lag: 0.55 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-21 18:30:44.813098) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 18:30:44.813392) ========= script_repo_revision: 4a8156e1267732f57c9013349b6a49688b3857e3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 18:30:44.813765) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 18:30:44.814042) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 18:30:44.832992) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-07-21 18:30:44.833404) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.eWsrSHj2e4/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.dPIOQhbMDs/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 18:30:45 INFO - MultiFileLogger online at 20160721 18:30:45 in /builds/slave/test 18:30:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 18:30:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:30:45 INFO - {'append_to_log': False, 18:30:45 INFO - 'base_work_dir': '/builds/slave/test', 18:30:45 INFO - 'blob_upload_branch': 'Autoland', 18:30:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:30:45 INFO - 'branch': 'Autoland', 18:30:45 INFO - 'buildbot_json_path': 'buildprops.json', 18:30:45 INFO - 'config_files': ('talos/mac_config.py',), 18:30:45 INFO - 'default_actions': ('clobber', 18:30:45 INFO - 'read-buildbot-config', 18:30:45 INFO - 'download-and-extract', 18:30:45 INFO - 'populate-webroot', 18:30:45 INFO - 'create-virtualenv', 18:30:45 INFO - 'install', 18:30:45 INFO - 'run-tests'), 18:30:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:30:45 INFO - 'download_minidump_stackwalk': True, 18:30:45 INFO - 'download_symbols': 'ondemand', 18:30:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:30:45 INFO - 'tooltool.py': '/tools/tooltool.py', 18:30:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:30:45 INFO - '/tools/misc-python/virtualenv.py')}, 18:30:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:30:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:30:45 INFO - 'installer_path': 'installer.exe', 18:30:45 INFO - 'log_level': 'info', 18:30:45 INFO - 'log_name': 'talos', 18:30:45 INFO - 'log_to_console': True, 18:30:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:30:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:30:45 INFO - 'opt_config_files': (), 18:30:45 INFO - 'pip_index': False, 18:30:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:30:45 INFO - 'cmd': ('bash', 18:30:45 INFO - '-c', 18:30:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:30:45 INFO - 'enabled': True, 18:30:45 INFO - 'halt_on_failure': False, 18:30:45 INFO - 'name': 'check_screen_resolution'},), 18:30:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:30:45 INFO - 'cmd': ('bash', 18:30:45 INFO - '-c', 18:30:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:30:45 INFO - 'enabled': True, 18:30:45 INFO - 'halt_on_failure': False, 18:30:45 INFO - 'name': 'check_screen_resolution'},), 18:30:45 INFO - 'run_cmd_checks_enabled': True, 18:30:45 INFO - 'sps_profile': False, 18:30:45 INFO - 'sps_profile_interval': 0, 18:30:45 INFO - 'suite': 'dromaeojs-e10s', 18:30:45 INFO - 'system_bits': '32', 18:30:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:30:45 INFO - 'title': 't-yosemite-r7-0317', 18:30:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:30:45 INFO - 'use_talos_json': True, 18:30:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:30:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:30:45 INFO - 'work_dir': 'build'} 18:30:45 INFO - [mozharness: 2016-07-22 01:30:45.024871Z] Running clobber step. 18:30:45 INFO - Running pre-action listener: _resource_record_pre_action 18:30:45 INFO - Running main action method: clobber 18:30:45 INFO - rmtree: /builds/slave/test/build 18:30:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:30:47 INFO - Running post-action listener: _resource_record_post_action 18:30:47 INFO - [mozharness: 2016-07-22 01:30:47.018146Z] Finished clobber step (success) 18:30:47 INFO - [mozharness: 2016-07-22 01:30:47.018319Z] Running read-buildbot-config step. 18:30:47 INFO - Running pre-action listener: _resource_record_pre_action 18:30:47 INFO - Running main action method: read_buildbot_config 18:30:47 INFO - Using buildbot properties: 18:30:47 INFO - { 18:30:47 INFO - "project": "", 18:30:47 INFO - "product": "firefox", 18:30:47 INFO - "script_repo_revision": "production", 18:30:47 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 18:30:47 INFO - "repository": "", 18:30:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 18:30:47 INFO - "buildid": "20160721173023", 18:30:47 INFO - "pgo_build": "False", 18:30:47 INFO - "basedir": "/builds/slave/test", 18:30:47 INFO - "buildnumber": 77, 18:30:47 INFO - "slavename": "t-yosemite-r7-0317", 18:30:47 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 18:30:47 INFO - "platform": "yosemite_r7", 18:30:47 INFO - "scheduler": "tests-autoland-macosx64-talos", 18:30:47 INFO - "branch": "autoland", 18:30:47 INFO - "repo_path": "integration/autoland", 18:30:47 INFO - "revision": "4a8156e1267732f57c9013349b6a49688b3857e3", 18:30:47 INFO - "stage_platform": "macosx64", 18:30:47 INFO - "builduid": "94038867fbc44fc4920c87be52b72e10", 18:30:47 INFO - "slavebuilddir": "test" 18:30:47 INFO - } 18:30:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/cfNLrgskTwO_AwKnGWf3Gg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 18:30:47 INFO - Running post-action listener: _resource_record_post_action 18:30:47 INFO - [mozharness: 2016-07-22 01:30:47.023950Z] Finished read-buildbot-config step (success) 18:30:47 INFO - [mozharness: 2016-07-22 01:30:47.024107Z] Running download-and-extract step. 18:30:47 INFO - Running pre-action listener: _resource_record_pre_action 18:30:47 INFO - Running main action method: download_and_extract 18:30:47 INFO - mkdir: /builds/slave/test/build/tests 18:30:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:47 INFO - https://queue.taskcluster.net/v1/task/cfNLrgskTwO_AwKnGWf3Gg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 18:30:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfNLrgskTwO_AwKnGWf3Gg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 18:30:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfNLrgskTwO_AwKnGWf3Gg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 18:30:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfNLrgskTwO_AwKnGWf3Gg/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 18:30:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfNLrgskTwO_AwKnGWf3Gg/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 18:30:51 INFO - Downloaded 1199 bytes. 18:30:51 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 18:30:51 INFO - Using the following test package requirements: 18:30:51 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 18:30:51 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:30:51 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 18:30:51 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:30:51 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 18:30:51 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:30:51 INFO - u'jsshell-mac.zip'], 18:30:51 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:30:51 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 18:30:51 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 18:30:51 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:30:51 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 18:30:51 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:30:51 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 18:30:51 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:30:51 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 18:30:51 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:30:51 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 18:30:51 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:30: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')]} 18:30:51 INFO - https://queue.taskcluster.net/v1/task/cfNLrgskTwO_AwKnGWf3Gg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:30:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfNLrgskTwO_AwKnGWf3Gg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:30:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfNLrgskTwO_AwKnGWf3Gg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:30:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfNLrgskTwO_AwKnGWf3Gg/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 18:30:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfNLrgskTwO_AwKnGWf3Gg/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 18:30:54 INFO - Downloaded 18806750 bytes. 18:30:54 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'] 18:30:54 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 18:30:57 INFO - Return code: 0 18:30:57 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 18:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:57 INFO - https://queue.taskcluster.net/v1/task/cfNLrgskTwO_AwKnGWf3Gg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:30:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfNLrgskTwO_AwKnGWf3Gg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:30:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfNLrgskTwO_AwKnGWf3Gg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:30:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfNLrgskTwO_AwKnGWf3Gg/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 18:30:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfNLrgskTwO_AwKnGWf3Gg/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 18:31:00 INFO - Downloaded 18806750 bytes. 18:31:00 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'] 18:31:00 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 18:31:04 INFO - Return code: 0 18:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:04 INFO - https://queue.taskcluster.net/v1/task/cfNLrgskTwO_AwKnGWf3Gg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:31:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfNLrgskTwO_AwKnGWf3Gg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 18:31:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfNLrgskTwO_AwKnGWf3Gg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 18:31:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfNLrgskTwO_AwKnGWf3Gg/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 18:31:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfNLrgskTwO_AwKnGWf3Gg/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 18:31:05 INFO - Downloaded 14403289 bytes. 18:31:05 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'] 18:31:05 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 18:31:06 INFO - Return code: 0 18:31: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')]} 18:31:06 INFO - https://queue.taskcluster.net/v1/task/cfNLrgskTwO_AwKnGWf3Gg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:31:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfNLrgskTwO_AwKnGWf3Gg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 18:31:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfNLrgskTwO_AwKnGWf3Gg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 18:31:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfNLrgskTwO_AwKnGWf3Gg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 18:31:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfNLrgskTwO_AwKnGWf3Gg/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 18:31:08 INFO - Downloaded 112792919 bytes. 18:31:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cfNLrgskTwO_AwKnGWf3Gg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 18:31:08 INFO - mkdir: /builds/slave/test/properties 18:31:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:31:08 INFO - Writing to file /builds/slave/test/properties/build_url 18:31:08 INFO - Contents: 18:31:08 INFO - build_url:https://queue.taskcluster.net/v1/task/cfNLrgskTwO_AwKnGWf3Gg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 18:31:10 INFO - Running post-action listener: _resource_record_post_action 18:31:10 INFO - Running post-action listener: set_extra_try_arguments 18:31:10 INFO - [mozharness: 2016-07-22 01:31:10.100103Z] Finished download-and-extract step (success) 18:31:10 INFO - [mozharness: 2016-07-22 01:31:10.100271Z] Running populate-webroot step. 18:31:10 INFO - Running pre-action listener: _resource_record_pre_action 18:31:10 INFO - Running main action method: populate_webroot 18:31:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:31:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:31:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:31:10 INFO - '--tppagecycles', 18:31:10 INFO - '7'], 18:31:10 INFO - 'tests': ['tsvgm']}}, 18:31:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:31:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:31:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:31:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:31:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:31:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:31:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:10 INFO - 'talos_options': ['--disable-e10s'], 18:31:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:31:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:31:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:10 INFO - 'talos_options': ['--disable-e10s'], 18:31:10 INFO - 'tests': ['damp', 'tps']}, 18:31:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:10 INFO - 'tests': ['damp', 'tps']}, 18:31:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:31:10 INFO - 'tests': ['dromaeo_dom']}, 18:31:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:31:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:31:10 INFO - 'tests': ['basic_compositor_video']}, 18:31:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:31:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:31:10 INFO - 'tests': ['a11yr', 18:31:10 INFO - 'ts_paint', 18:31:10 INFO - 'tpaint', 18:31:10 INFO - 'sessionrestore', 18:31:10 INFO - 'sessionrestore_no_auto_restore', 18:31:10 INFO - 'tabpaint']}, 18:31:10 INFO - 'other-e10s': {'tests': ['a11yr', 18:31:10 INFO - 'ts_paint', 18:31:10 INFO - 'tpaint', 18:31:10 INFO - 'sessionrestore', 18:31:10 INFO - 'sessionrestore_no_auto_restore', 18:31:10 INFO - 'tabpaint']}, 18:31:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:31:10 INFO - 'ts_paint', 18:31:10 INFO - 'tpaint', 18:31:10 INFO - 'sessionrestore', 18:31:10 INFO - 'sessionrestore_no_auto_restore', 18:31:10 INFO - 'tabpaint']}, 18:31:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:31:10 INFO - 'ts_paint', 18:31:10 INFO - 'tpaint', 18:31:10 INFO - 'sessionrestore', 18:31:10 INFO - 'sessionrestore_no_auto_restore', 18:31:10 INFO - 'tabpaint']}, 18:31:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:31:10 INFO - 'tests': ['a11yr', 18:31:10 INFO - 'ts_paint', 18:31:10 INFO - 'tpaint', 18:31:10 INFO - 'sessionrestore', 18:31:10 INFO - 'sessionrestore_no_auto_restore', 18:31:10 INFO - 'tabpaint']}, 18:31:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:31:10 INFO - 'tests': ['a11yr', 18:31:10 INFO - 'ts_paint', 18:31:10 INFO - 'tpaint', 18:31:10 INFO - 'sessionrestore', 18:31:10 INFO - 'sessionrestore_no_auto_restore', 18:31:10 INFO - 'tabpaint']}, 18:31:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:31:10 INFO - 'tests': ['tsvgx', 18:31:10 INFO - 'tsvgr_opacity', 18:31:10 INFO - 'tart', 18:31:10 INFO - 'tscrollx', 18:31:10 INFO - 'cart']}, 18:31:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:31:10 INFO - 'tsvgr_opacity', 18:31:10 INFO - 'tart', 18:31:10 INFO - 'tscrollx', 18:31:10 INFO - 'cart']}, 18:31:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:10 INFO - 'talos_options': ['--disable-e10s'], 18:31:10 INFO - 'tests': ['tp5o']}, 18:31:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:10 INFO - 'tests': ['tp5o']}, 18:31:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:10 INFO - 'talos_options': ['--disable-e10s', 18:31:10 INFO - '--xperf_path', 18:31:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:31:10 INFO - 'tests': ['tp5n']}, 18:31:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:10 INFO - 'talos_options': ['--xperf_path', 18:31:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:31:10 INFO - 'tests': ['tp5n']}}, 18:31:10 INFO - 'talos.zip': {'path': '', 18:31:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:31:10 INFO - Running post-action listener: _resource_record_post_action 18:31:10 INFO - [mozharness: 2016-07-22 01:31:10.119747Z] Finished populate-webroot step (success) 18:31:10 INFO - [mozharness: 2016-07-22 01:31:10.119863Z] Running create-virtualenv step. 18:31:10 INFO - Running pre-action listener: _resource_record_pre_action 18:31:10 INFO - Running main action method: create_virtualenv 18:31:10 INFO - Creating virtualenv /builds/slave/test/build/venv 18:31:10 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 18:31:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:31:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:31:10 INFO - Using real prefix '/tools/python27' 18:31:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:31:10 INFO - Installing distribute.............................................................................................................................................................................................done. 18:31:13 INFO - Installing pip.................done. 18:31:13 INFO - Return code: 0 18:31:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:13 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 0x10a7bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a850618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf514c9aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a71fd30>, '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 0x10a484db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a717b20>, '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.eWsrSHj2e4/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.dPIOQhbMDs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 18:31:13 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 18:31:13 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 18:31:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eWsrSHj2e4/Render', 18:31:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:13 INFO - 'HOME': '/Users/cltbld', 18:31:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:13 INFO - 'LOGNAME': 'cltbld', 18:31:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:13 INFO - 'MOZ_NO_REMOTE': '1', 18:31:13 INFO - 'NO_EM_RESTART': '1', 18:31:13 INFO - 'PAGER': '/bin/cat', 18:31:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:13 INFO - 'PWD': '/builds/slave/test', 18:31:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:13 INFO - 'SHELL': '/bin/bash', 18:31:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dPIOQhbMDs/Listeners', 18:31:13 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 18:31:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:13 INFO - 'USER': 'cltbld', 18:31:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:13 INFO - 'XPC_FLAGS': '0x0', 18:31:13 INFO - 'XPC_SERVICE_NAME': '0', 18:31:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:14 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 18:31:14 INFO - Cleaning up... 18:31:14 INFO - Return code: 0 18:31:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:31:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a7bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a850618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf514c9aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a71fd30>, '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 0x10a484db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a717b20>, '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.eWsrSHj2e4/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.dPIOQhbMDs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 18:31:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:31:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:31:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eWsrSHj2e4/Render', 18:31:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:14 INFO - 'HOME': '/Users/cltbld', 18:31:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:14 INFO - 'LOGNAME': 'cltbld', 18:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:14 INFO - 'MOZ_NO_REMOTE': '1', 18:31:14 INFO - 'NO_EM_RESTART': '1', 18:31:14 INFO - 'PAGER': '/bin/cat', 18:31:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:14 INFO - 'PWD': '/builds/slave/test', 18:31:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:14 INFO - 'SHELL': '/bin/bash', 18:31:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dPIOQhbMDs/Listeners', 18:31:14 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 18:31:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:14 INFO - 'USER': 'cltbld', 18:31:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:14 INFO - 'XPC_FLAGS': '0x0', 18:31:14 INFO - 'XPC_SERVICE_NAME': '0', 18:31:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:14 INFO - Downloading/unpacking psutil>=3.1.1 18:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:31:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:17 INFO - Installing collected packages: psutil 18:31:17 INFO - Running setup.py install for psutil 18:31:17 INFO - building 'psutil._psutil_osx' extension 18:31:17 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 18:31:18 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 18:31:18 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 18:31:18 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 18:31:18 INFO - building 'psutil._psutil_posix' extension 18:31:18 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 18:31:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:31:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:31:18 INFO - ^ 18:31:18 INFO - 1 warning generated. 18:31:18 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 18:31:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:18 INFO - Successfully installed psutil 18:31:18 INFO - Cleaning up... 18:31:18 INFO - Return code: 0 18:31:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:31: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')]} 18:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31: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')]} 18:31:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:18 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 0x10a7bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a850618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf514c9aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a71fd30>, '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 0x10a484db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a717b20>, '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.eWsrSHj2e4/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.dPIOQhbMDs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 18:31:18 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 18:31:18 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 18:31:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eWsrSHj2e4/Render', 18:31:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:18 INFO - 'HOME': '/Users/cltbld', 18:31:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:18 INFO - 'LOGNAME': 'cltbld', 18:31:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:18 INFO - 'MOZ_NO_REMOTE': '1', 18:31:18 INFO - 'NO_EM_RESTART': '1', 18:31:18 INFO - 'PAGER': '/bin/cat', 18:31:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:18 INFO - 'PWD': '/builds/slave/test', 18:31:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:18 INFO - 'SHELL': '/bin/bash', 18:31:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dPIOQhbMDs/Listeners', 18:31:18 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 18:31:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:18 INFO - 'USER': 'cltbld', 18:31:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:18 INFO - 'XPC_FLAGS': '0x0', 18:31:18 INFO - 'XPC_SERVICE_NAME': '0', 18:31:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:31:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:31:21 INFO - Installing collected packages: mozsystemmonitor 18:31:21 INFO - Running setup.py install for mozsystemmonitor 18:31:21 INFO - Successfully installed mozsystemmonitor 18:31:21 INFO - Cleaning up... 18:31:21 INFO - Return code: 0 18:31:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:21 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 0x10a7bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a850618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf514c9aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a71fd30>, '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 0x10a484db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a717b20>, '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.eWsrSHj2e4/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.dPIOQhbMDs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 18:31:21 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 18:31:21 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 18:31:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eWsrSHj2e4/Render', 18:31:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:21 INFO - 'HOME': '/Users/cltbld', 18:31:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:21 INFO - 'LOGNAME': 'cltbld', 18:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:21 INFO - 'MOZ_NO_REMOTE': '1', 18:31:21 INFO - 'NO_EM_RESTART': '1', 18:31:21 INFO - 'PAGER': '/bin/cat', 18:31:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:21 INFO - 'PWD': '/builds/slave/test', 18:31:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:21 INFO - 'SHELL': '/bin/bash', 18:31:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dPIOQhbMDs/Listeners', 18:31:21 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 18:31:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:21 INFO - 'USER': 'cltbld', 18:31:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:21 INFO - 'XPC_FLAGS': '0x0', 18:31:21 INFO - 'XPC_SERVICE_NAME': '0', 18:31:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:21 INFO - Downloading/unpacking jsonschema==2.5.1 18:31:21 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 18:31:21 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 18:31:21 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 18:31:21 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 18:31:21 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 18:31:21 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 18:31:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:31:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:24 INFO - Downloading functools32-3.2.3-2.tar.gz 18:31:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:31:24 INFO - warning: no files found matching '*.txt' 18:31:24 INFO - no previously-included directories found matching 'build' 18:31:24 INFO - no previously-included directories found matching 'dist' 18:31:24 INFO - no previously-included directories found matching '.git*' 18:31:24 INFO - Installing collected packages: jsonschema, functools32 18:31:24 INFO - Running setup.py install for functools32 18:31:24 INFO - warning: no files found matching '*.txt' 18:31:24 INFO - no previously-included directories found matching 'build' 18:31:24 INFO - no previously-included directories found matching 'dist' 18:31:24 INFO - no previously-included directories found matching '.git*' 18:31:24 INFO - Successfully installed jsonschema functools32 18:31:24 INFO - Cleaning up... 18:31:25 INFO - Return code: 0 18:31:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:31:25 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')]} 18:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:25 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')]} 18:31:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:25 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 0x10a7bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a850618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf514c9aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a71fd30>, '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 0x10a484db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a717b20>, '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.eWsrSHj2e4/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.dPIOQhbMDs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 18:31:25 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 18:31:25 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 18:31:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eWsrSHj2e4/Render', 18:31:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:25 INFO - 'HOME': '/Users/cltbld', 18:31:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:25 INFO - 'LOGNAME': 'cltbld', 18:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:25 INFO - 'MOZ_NO_REMOTE': '1', 18:31:25 INFO - 'NO_EM_RESTART': '1', 18:31:25 INFO - 'PAGER': '/bin/cat', 18:31:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:25 INFO - 'PWD': '/builds/slave/test', 18:31:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:25 INFO - 'SHELL': '/bin/bash', 18:31:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dPIOQhbMDs/Listeners', 18:31:25 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 18:31:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:25 INFO - 'USER': 'cltbld', 18:31:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:25 INFO - 'XPC_FLAGS': '0x0', 18:31:25 INFO - 'XPC_SERVICE_NAME': '0', 18:31:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:25 INFO - Downloading/unpacking blobuploader==1.2.4 18:31:25 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 18:31:25 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 18:31:25 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 18:31:25 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 18:31:25 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 18:31:25 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 18:31:27 INFO - Downloading blobuploader-1.2.4.tar.gz 18:31:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:31:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:31:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:31:28 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 18:31:28 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 18:31:28 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 18:31:28 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 18:31:28 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 18:31:28 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 18:31:29 INFO - Downloading docopt-0.6.1.tar.gz 18:31:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:31:29 INFO - Installing collected packages: blobuploader, requests, docopt 18:31:29 INFO - Running setup.py install for blobuploader 18:31:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:31:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:31:29 INFO - Running setup.py install for requests 18:31:29 INFO - Running setup.py install for docopt 18:31:29 INFO - Successfully installed blobuploader requests docopt 18:31:29 INFO - Cleaning up... 18:31:30 INFO - Return code: 0 18:31:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:30 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 0x10a7bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a850618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf514c9aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a71fd30>, '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 0x10a484db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a717b20>, '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.eWsrSHj2e4/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.dPIOQhbMDs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 18:31:30 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 18:31:30 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 18:31:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eWsrSHj2e4/Render', 18:31:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:30 INFO - 'HOME': '/Users/cltbld', 18:31:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:30 INFO - 'LOGNAME': 'cltbld', 18:31:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:30 INFO - 'MOZ_NO_REMOTE': '1', 18:31:30 INFO - 'NO_EM_RESTART': '1', 18:31:30 INFO - 'PAGER': '/bin/cat', 18:31:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:30 INFO - 'PWD': '/builds/slave/test', 18:31:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:30 INFO - 'SHELL': '/bin/bash', 18:31:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dPIOQhbMDs/Listeners', 18:31:30 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 18:31:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:30 INFO - 'USER': 'cltbld', 18:31:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:30 INFO - 'XPC_FLAGS': '0x0', 18:31:30 INFO - 'XPC_SERVICE_NAME': '0', 18:31:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:31:30 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-jzwltj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:31:30 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-czY5q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:31:30 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-s6nU7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:31:30 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-QHv0Gr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:31:30 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-OKS1Ny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:31:30 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-K4LzuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:31:30 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-u1utdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:31:31 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-WpGkQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:31:31 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-K9sOdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:31:31 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-ZfFRmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:31:31 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-oN7dJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:31:31 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-7lfaJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:31:31 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-KxAzIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:31:31 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-5P6Txi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:31 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-_rbKvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:31:31 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-LebVgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:31:31 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-vK_xPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:31:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:31:32 INFO - Running setup.py install for manifestparser 18:31:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:31:32 INFO - Running setup.py install for mozcrash 18:31:32 INFO - Running setup.py install for mozdebug 18:31:32 INFO - Running setup.py install for mozdevice 18:31:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:31:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:31:32 INFO - Running setup.py install for mozfile 18:31:32 INFO - Running setup.py install for mozhttpd 18:31:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:31:32 INFO - Running setup.py install for mozinfo 18:31:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:31:33 INFO - Running setup.py install for mozInstall 18:31:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:31:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:31:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:31:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:31:33 INFO - Running setup.py install for mozleak 18:31:33 INFO - Running setup.py install for mozlog 18:31:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:31:33 INFO - Running setup.py install for moznetwork 18:31:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:31:33 INFO - Running setup.py install for mozprocess 18:31:33 INFO - Running setup.py install for mozprofile 18:31:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:31:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:31:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:31:34 INFO - Running setup.py install for mozrunner 18:31:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:31:34 INFO - Running setup.py install for mozscreenshot 18:31:34 INFO - Running setup.py install for moztest 18:31:34 INFO - Running setup.py install for mozversion 18:31:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:31:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:31:34 INFO - Cleaning up... 18:31:34 INFO - Return code: 0 18:31:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:34 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')]} 18:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:34 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')]} 18:31:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:34 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 0x10a7bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a850618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf514c9aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a71fd30>, '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 0x10a484db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a717b20>, '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.eWsrSHj2e4/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.dPIOQhbMDs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 18:31:34 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 18:31:34 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 18:31:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eWsrSHj2e4/Render', 18:31:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:34 INFO - 'HOME': '/Users/cltbld', 18:31:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:34 INFO - 'LOGNAME': 'cltbld', 18:31:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:34 INFO - 'MOZ_NO_REMOTE': '1', 18:31:34 INFO - 'NO_EM_RESTART': '1', 18:31:34 INFO - 'PAGER': '/bin/cat', 18:31:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:34 INFO - 'PWD': '/builds/slave/test', 18:31:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:34 INFO - 'SHELL': '/bin/bash', 18:31:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dPIOQhbMDs/Listeners', 18:31:34 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 18:31:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:34 INFO - 'USER': 'cltbld', 18:31:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:34 INFO - 'XPC_FLAGS': '0x0', 18:31:34 INFO - 'XPC_SERVICE_NAME': '0', 18:31:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:31:34 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-w21YY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:31:35 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)) 18:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:31:35 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-i1aZsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:31:35 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)) 18:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:31:35 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-QC996M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:31:35 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)) 18:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:31:35 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-HZqLsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:31:35 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)) 18:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:31:35 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-ghpzlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:31:35 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)) 18:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:31:35 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-1g7Tm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:31:35 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)) 18:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:31:35 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-JgCx3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:31:35 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)) 18:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:31:35 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-Mqlxxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:31:35 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)) 18:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:31:35 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-ybE33T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:31:35 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)) 18:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:31:35 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-I9d5Er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 18:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:31:35 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-vq1Uy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:31:36 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)) 18:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:31:36 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-mEzEcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:31:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 18:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:31:36 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-gT0207-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:31:36 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)) 18:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:31:36 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-KGMk9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:31:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 18:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:36 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-_F1MeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:36 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)) 18:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:31:36 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-xZGHwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:31:36 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)) 18:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:31:36 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-N01sE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:31:36 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)) 18:31:36 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)) 18:31:36 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)) 18:31:36 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)) 18:31:36 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)) 18:31:36 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)) 18:31:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:31:36 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 18:31:36 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 18:31:36 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 18:31:36 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 18:31:36 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 18:31:36 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 18:31:39 INFO - Downloading blessings-1.6.tar.gz 18:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:31:39 INFO - Installing collected packages: blessings 18:31:39 INFO - Running setup.py install for blessings 18:31:39 INFO - Successfully installed blessings 18:31:39 INFO - Cleaning up... 18:31:39 INFO - Return code: 0 18:31:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:31:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:31:40 INFO - Reading from file tmpfile_stdout 18:31:40 INFO - Current package versions: 18:31:40 INFO - blessings == 1.6 18:31:40 INFO - blobuploader == 1.2.4 18:31:40 INFO - docopt == 0.6.1 18:31:40 INFO - functools32 == 3.2.3-2 18:31:40 INFO - jsonschema == 2.5.1 18:31:40 INFO - manifestparser == 1.1 18:31:40 INFO - mozInstall == 1.12 18:31:40 INFO - mozcrash == 0.17 18:31:40 INFO - mozdebug == 0.1 18:31:40 INFO - mozdevice == 0.48 18:31:40 INFO - mozfile == 1.2 18:31:40 INFO - mozhttpd == 0.7 18:31:40 INFO - mozinfo == 0.9 18:31:40 INFO - mozleak == 0.1 18:31:40 INFO - mozlog == 3.3 18:31:40 INFO - moznetwork == 0.27 18:31:40 INFO - mozprocess == 0.23 18:31:40 INFO - mozprofile == 0.28 18:31:40 INFO - mozrunner == 6.12 18:31:40 INFO - mozscreenshot == 0.1 18:31:40 INFO - mozsystemmonitor == 0.3 18:31:40 INFO - moztest == 0.7 18:31:40 INFO - mozversion == 1.4 18:31:40 INFO - psutil == 3.1.1 18:31:40 INFO - requests == 1.2.3 18:31:40 INFO - wsgiref == 0.1.2 18:31:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:40 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')]} 18:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:40 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')]} 18:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:40 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 0x10a7bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a850618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf514c9aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a71fd30>, '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 0x10a484db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a717b20>, '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.eWsrSHj2e4/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.dPIOQhbMDs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 18:31:40 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 18:31:40 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 18:31:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eWsrSHj2e4/Render', 18:31:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:40 INFO - 'HOME': '/Users/cltbld', 18:31:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:40 INFO - 'LOGNAME': 'cltbld', 18:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:40 INFO - 'MOZ_NO_REMOTE': '1', 18:31:40 INFO - 'NO_EM_RESTART': '1', 18:31:40 INFO - 'PAGER': '/bin/cat', 18:31:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:40 INFO - 'PWD': '/builds/slave/test', 18:31:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:40 INFO - 'SHELL': '/bin/bash', 18:31:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dPIOQhbMDs/Listeners', 18:31:40 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 18:31:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:40 INFO - 'USER': 'cltbld', 18:31:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:40 INFO - 'XPC_FLAGS': '0x0', 18:31:40 INFO - 'XPC_SERVICE_NAME': '0', 18:31:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:40 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)) 18:31:40 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)) 18:31:40 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)) 18:31:40 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)) 18:31:40 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)) 18:31:40 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)) 18:31:40 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)) 18:31:40 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)) 18:31:40 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)) 18:31:40 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)) 18:31:40 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)) 18:31:40 INFO - Cleaning up... 18:31:40 INFO - Return code: 0 18:31:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:31:40 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')]} 18:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:40 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')]} 18:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:40 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 0x10a7bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a850618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf514c9aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a71fd30>, '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 0x10a484db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a717b20>, '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.eWsrSHj2e4/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.dPIOQhbMDs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 18:31:40 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 18:31:40 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 18:31:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eWsrSHj2e4/Render', 18:31:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:40 INFO - 'HOME': '/Users/cltbld', 18:31:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:40 INFO - 'LOGNAME': 'cltbld', 18:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:40 INFO - 'MOZ_NO_REMOTE': '1', 18:31:40 INFO - 'NO_EM_RESTART': '1', 18:31:40 INFO - 'PAGER': '/bin/cat', 18:31:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:40 INFO - 'PWD': '/builds/slave/test', 18:31:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:40 INFO - 'SHELL': '/bin/bash', 18:31:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dPIOQhbMDs/Listeners', 18:31:40 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 18:31:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:40 INFO - 'USER': 'cltbld', 18:31:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:40 INFO - 'XPC_FLAGS': '0x0', 18:31:40 INFO - 'XPC_SERVICE_NAME': '0', 18:31:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:31:41 INFO - Cleaning up... 18:31:41 INFO - Return code: 0 18:31:41 INFO - Running post-action listener: _resource_record_post_action 18:31:41 INFO - Running post-action listener: _start_resource_monitoring 18:31:41 INFO - Starting resource monitoring. 18:31:41 INFO - [mozharness: 2016-07-22 01:31:41.082640Z] Finished create-virtualenv step (success) 18:31:41 INFO - [mozharness: 2016-07-22 01:31:41.083576Z] Running install step. 18:31:41 INFO - Running pre-action listener: _resource_record_pre_action 18:31:41 INFO - Running main action method: install 18:31:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:31:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:31:41 INFO - Reading from file tmpfile_stdout 18:31:41 INFO - Detecting whether we're running mozinstall >=1.0... 18:31:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:31:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:31:41 INFO - Reading from file tmpfile_stdout 18:31:41 INFO - Output received: 18:31:41 INFO - Usage: mozinstall [options] installer 18:31:41 INFO - Options: 18:31:41 INFO - -h, --help show this help message and exit 18:31:41 INFO - -d DEST, --destination=DEST 18:31:41 INFO - Directory to install application into. [default: 18:31:41 INFO - "/builds/slave/test"] 18:31:41 INFO - --app=APP Application being installed. [default: firefox] 18:31:41 INFO - mkdir: /builds/slave/test/build/application 18:31:41 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'] 18:31:41 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 18:32:16 INFO - Reading from file tmpfile_stdout 18:32:16 INFO - Output received: 18:32:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:32:16 INFO - Running post-action listener: _resource_record_post_action 18:32:16 INFO - [mozharness: 2016-07-22 01:32:16.264734Z] Finished install step (success) 18:32:16 INFO - [mozharness: 2016-07-22 01:32:16.264859Z] Running run-tests step. 18:32:16 INFO - Running pre-action listener: _resource_record_pre_action 18:32:16 INFO - Running main action method: run_tests 18:32:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:32:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:32:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:32:16 INFO - 2016-07-21 18:32:16.279 screenresolution[1638:7448] starting screenresolution argv=screenresolution get 18:32:16 INFO - 2016-07-21 18:32:16.282 screenresolution[1638:7448] Display 0: 1600x1200x32@60 18:32:16 INFO - 2016-07-21 18:32:16.288 screenresolution[1639:7450] starting screenresolution argv=screenresolution list 18:32:16 INFO - Available Modes on Display 0 18:32:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:32:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:32:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:32:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:32:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:32:16 INFO - Intel Iris: 18:32:16 INFO - Chipset Model: Intel Iris 18:32:16 INFO - Type: GPU 18:32:16 INFO - Bus: Built-In 18:32:16 INFO - VRAM (Dynamic, Max): 1536 MB 18:32:16 INFO - Vendor: Intel (0x8086) 18:32:16 INFO - Device ID: 0x0a2e 18:32:16 INFO - Revision ID: 0x0009 18:32:16 INFO - Displays: 18:32:16 INFO - Display: 18:32:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:32:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:32:16 INFO - Display Serial Number: 1600x1200 60 18:32:16 INFO - Main Display: Yes 18:32:16 INFO - Mirror: Off 18:32:16 INFO - Online: Yes 18:32:16 INFO - Rotation: Supported 18:32:16 INFO - Return code: 0 18:32:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:32:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:32:16 INFO - Python 2.7.3 18:32:16 INFO - Return code: 0 18:32:16 INFO - grabbing minidump binary from tooltool 18:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:16 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 0x10a71fd30>, '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 0x10a484db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a717b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:32:16 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 18:32:16 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 18:32:16 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 18:32:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:32:16 INFO - Return code: 0 18:32:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:32:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:32:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:32:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:32:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:32:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cfNLrgskTwO_AwKnGWf3Gg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0317', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:32:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cfNLrgskTwO_AwKnGWf3Gg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0317 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:32:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eWsrSHj2e4/Render', 18:32:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:32:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:32:16 INFO - 'HOME': '/Users/cltbld', 18:32:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:32:16 INFO - 'LOGNAME': 'cltbld', 18:32:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:32:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:16 INFO - 'MOZ_NO_REMOTE': '1', 18:32:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:32:16 INFO - 'NO_EM_RESTART': '1', 18:32:16 INFO - 'PAGER': '/bin/cat', 18:32:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:16 INFO - 'PWD': '/builds/slave/test', 18:32:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:32:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:32:16 INFO - 'SHELL': '/bin/bash', 18:32:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dPIOQhbMDs/Listeners', 18:32:16 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 18:32:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:32:16 INFO - 'USER': 'cltbld', 18:32:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:32:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:16 INFO - 'XPC_FLAGS': '0x0', 18:32:16 INFO - 'XPC_SERVICE_NAME': '0', 18:32:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:32:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cfNLrgskTwO_AwKnGWf3Gg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0317', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:32:16 INFO - mozversion application_buildid: 20160721173023 18:32:16 INFO - mozversion application_changeset: 4a8156e1267732f57c9013349b6a49688b3857e3 18:32:16 INFO - mozversion application_display_name: Nightly 18:32:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:32:16 INFO - mozversion application_name: Firefox 18:32:16 INFO - mozversion application_remotingname: firefox 18:32:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 18:32:16 INFO - mozversion application_vendor: Mozilla 18:32:16 INFO - mozversion application_version: 50.0a1 18:32:16 INFO - mozversion platform_buildid: 20160721173023 18:32:16 INFO - mozversion platform_changeset: 4a8156e1267732f57c9013349b6a49688b3857e3 18:32:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 18:32:16 INFO - mozversion platform_version: 50.0a1 18:32:16 INFO - using testdate: 1469151136 18:32:16 INFO - actual date: 1469151136 18:32:16 INFO - starting webserver on 'localhost:49266' 18:32:16 INFO - SUITE-START | Running 2 tests 18:32:16 INFO - TEST-START | dromaeo_css 18:32:16 INFO - operating with platform_type : mac_ 18:32:16 INFO - Initialising browser for dromaeo_css test... 18:32:16 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpBeW7kc/profile http://localhost:49266/getInfo.html) 18:32:19 INFO - PROCESS | 1649 | JavaScript error: , line 0: uncaught exception: undefined 18:32:20 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 18:32:20 INFO - PROCESS | 1649 | colorDepth:24 18:32:20 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 18:32:20 INFO - PROCESS | 1649 | __metrics 18:32:20 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 18:32:20 INFO - TEST-INFO | 1649: exit 0 18:32:20 INFO - Browser initialized. 18:32:20 INFO - Running cycle 1/1 for dromaeo_css test... 18:32:20 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpBeW7kc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:32:32 INFO - PROCESS | 1652 | RSS: Main: 255918080 18:32:32 INFO - PROCESS | 1652 | 18:33:22 INFO - PROCESS | 1652 | 1469151202384 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] 18:35:33 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 18:35:35 INFO - PROCESS | 1652 | RSS: Main: 270856192 18:35:35 INFO - PROCESS | 1652 | 18:38:37 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 18:38:38 INFO - PROCESS | 1652 | RSS: Main: 281190400 18:38:38 INFO - PROCESS | 1652 | 18:41:40 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 18:41:40 INFO - PROCESS | 1652 | RSS: Main: 287723520 18:41:40 INFO - PROCESS | 1652 | 18:44:42 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 18:44:43 INFO - PROCESS | 1652 | RSS: Main: 286887936 18:44:43 INFO - PROCESS | 1652 | 18:47:46 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 18:47:46 INFO - PROCESS | 1652 | RSS: Main: 290545664 18:47:46 INFO - PROCESS | 1652 | 18:50:49 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 18:50:49 INFO - PROCESS | 1652 | RSS: Main: 290680832 18:50:49 INFO - PROCESS | 1652 | 18:50:49 INFO - PROCESS | 1652 | __start_tp_report 18:50:49 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 18:50:49 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 18:50:49 INFO - PROCESS | 1652 | |i|pagename|runs| 18:50:49 INFO - PROCESS | 1652 | |0;dojo.html;3337.4159522083637;3438.467037609171;3445.173158441973;3466.757326987112;3483.7561370704043;4506.391637128987;5806.925718742031;5872.324682661495;5977.133315669236;6037.456628903398;5702.087665973445;5824.301083869931;5870.501007414364;5940.108983652454;5987.88024239516;5249.8950020999655;5298.973505132469;5320.1753728172;5404.513593776559;5465.808696695616;5480.424555421683;5534.0592099343;5549.861253468655;5554.222408862763;5580.553555715554;5284.207368894658;5323.361196656388;5382.946170538284;5419.5393391561765;5461.644993075457;5389.51494365509;5405.405405405402;5408.2698835657075;5424.267723857268;5432.348118225838;4596.632269418438;5259.2899958505495;5345.09133447311;5372.677639341652;5411.485908838654;5737.88524229513;5801.883962320772;5865.824025279248;5908.438698323653;5939.792107276225;6265.122882796412;6291.653959032252;6294.7482100715915;6300.842478938017;6313.43179113882;6350.460210882081;6352.333005034498;6353.650549219791;6381.425671689523;6450.161479007746;5866.6186697864505;5959.28488581373;6050.364711705296;6095.542834287447;6131.908021379683;6490.156279683611;6517.022446633043;6522.054302126166;6532.346765323525;6547.181602299713;6183.474404675563;6303.590266632654;6322.936770632326;6323.399277068671;6343.777967771106;6205.069239614094;6234.688265586793;6249.750009999549;6374.808755737336;6420.940544810054;5606.383297837235;6231.657258850716;6298.685065746694;6304.148939893055;6307.684615769193;6246.75012999484;6278.466330361879;6293.590916590407;6302.527310451735;6311.779087731999;4972.801087956441;5022.096022715873;5028.120078986163;5120.975804839047;5142.331496905378;3821.9044523887123;4206.978965105155;4539.432570928634;4550.772461376918;4605.40129783126;6069.119977603223;6084.969575152096;6140.570160088841;6158.507319414526;6162.26052873658;6209.161763162006;6273.466755325757;6313.305536390993;6313.652749098844;6409.935900641027;6107.219158344477;6128.142060111588;6134.969325153421;6145.139680444741;6161.599496032743;5686.914696279559;5701.458361455738;5702.372738998707;5711.600187986801;5744;6354.682265886595;6451.2903580607035;6507.577007494687;6652.73389064432;6685.79942601713;6315;6361.840953976188;6362.268339141058;6400;6411.6153030818305;6323.766865461191;6609.306022867722;6639.302873198438;6639.900401494078;6652.73389064432;6193.1329613853195;6200.162977998093;6225.066240064027;6265.467435268053;6297.716602752796;6358.77744278948;6362.586431882098;6371.426571608392;6376.362363763772;6387.489000879826;6292.024736165901;6296.024116261987;6296.370362963667;6314.778982735582;6320.525960553069;5215.947840521546;6091.177691011657;6254.4996400286955;6276.686165691606;6289.276733175743;5966.343702192668;6150.723217455135;6182.629042257479;6191.246033171681;6221.906671400023;6085.66528840918;6269.655168965568;6285.497160227263;6314.4632706218645;6314.589551679126;6030.517558595389;6100.581173165739;6121.392004143408;6213.875722485615;6227.626342419469 18:50:49 INFO - PROCESS | 1652 | |1;ext.html;480.5410832654815;513.4172713969645;547.17923115327;562.8602080786409;566.5043087298614;31242.53136202959;41227;41325.586744132546;41347.793261033694;41499.377509337384;42092.57907420925;42541.57458425415;42598.36102458466;42611.36082958758;42654.36018459718;9595.52022398879;9646.517674116301;9648.131668149865;9774.609015639366;9784.804303913954;9653.710388688316;9750.853737193913;9751.219902407825;9759.560819763128;9762.853557196648;8330.50016998979;9729.464879431629;9751.756206094833;9762.804743905117;9800.16698580618;9557.426554406758;9674.032596740304;9721.951390243074;9748.75628109296;9760.17038551724;9630.951845240728;9716.659916902874;9726.319157658967;9727.513624318826;9734;39910.60089399098;40150;40314.59685403138;40333.39499907504;40359;3237.3848968695875;3447.517347571342;3457.360388328167;3484.878029268989;3646.4348026056005;26307.21078367652;27988.580171297446;30029.849850750827;30382.93659721899;30675;3132.6867313268717;3158.6209654841564;3179.5230715392645;3183.586133802614;3277.213468767479;459748;465686;466341.66829165636;467650;469743.6512817448;33511;33649.49525757116;33717.494237586456;33739.662603373654;33746.325073498396;34308.48537271943;34368.656313437044;34400.82799585986;35673.46489802655;35815.82092089575;16449.42427015073;16638.417655382003;16644.417445389594;16647.41734039303;16684.082375469465;12742.10805243624;12744.171628844095;12817.807732884014;12823.807642885364;12861.099723019486;18824.529386765167;18845.963472008898;18886.43340699781;19097.522561936064;19107.522311942033;6959.478039147084;8133.064697559738;8286.502809831429;8321.79472439804;8329.95835020821;845.8435189489965;996.3872218585518;997.6159178716101;1012.367270455965;1064.3454275620438;28142;29693.703062969525;29990.70009299879;30420.39159216803;30463.847680761453;985.103555764251;1060.4114716332356;1118.367183911482;1144.9942750286195;1247.8939290160256;14789.778153327708;15125.924370378078;15269.923650381677;15565.922170389302;15569.7544196464;630469;647080;647150;648638;650929;45945.5405445948;56402.43597564054;56814.43185568174;57052.42947570554;57454;1382.9446822127204;1400.7128538649552;1431.4632012995128;1436.6695659998259;1440.3806363263689;24296.05472478501;26079.217623471326;29557.192066753625;29674.109776706733;29879.701202987693;49645.75177124091;50198.49801501938;50199.49800502094;50380.74809625928;50583;507851;508336;509679;511029;515504;22186.88906555457;24949.455113645075;25974;26326.736732632427;26355.868220658773;45490.86272843073;45874.082518350115;46963.53036469728;47389;47575;32516.187095322806;38178.618213817506;38252.6174738249;39048.023799405244;40089.39865901956;37817.24365512619;38396.04009899775;38848.6115138845;39144.6085539141;39442.01394965149;36757.816210918776;36956.26087478289;37613.435798462495;37897.81051094727;38249;33383.99848004564;33531.54329633338;33806.985790426326;33888.83055584706;33904.83047584746;25141.622875656514;25265.368365791;25534.361640959123;25565.872170639028;25763.355916102246 18:50:49 INFO - PROCESS | 1652 | |2;jquery.html;331.17537332043213;371.8475425075718;374.68152070739876;393.1782574419463;401.59041763410437;16450.095244761535;16612.50162495124;21655.242066527673;21886.562268754635;22161.224357147505;21558.461038474044;21980;22088.447788805286;22275.777242227574;22464.438389040282;5520.696361700105;5613.382527921925;5739.196512488255;5941.940580594203;6162.845928851792;5378.489043540857;5725.971370143144;6055.636661800306;6135.141080248769;6142.96928515359;5842;5961.910571341434;6007.399260074001;6030.125631783389;6097.115918191859;5992.460678538909;6010;6037.335893051761;6072.666003369813;6084.6045007074845;5156.432792392834;5255.973720131413;5300.443453437372;5309.840704778863;5311.840644780663;24012.399690007715;26992.730072699218;27157.91368345264;27425.86287068572;27550.862245688844;1911.4934542346289;2326.127702111708;2357.7642235776457;2815.225812901448;3120.828354440505;15724.606884827856;16450.341986320534;16527.669446611122;16699.165041747863;16700.248488818033;1860.1443336065427;1887.6507846048526;1902.657521646103;1977.1893523655376;1981.6234915366178;122392;123474;127617.36191319076;128225.35887320597;129628;11459.713507162387;11602.25966105091;11772.823407648892;11823.527058917547;12036.75926481483;14596.489122880648;14880.735137513217;14882.255887205596;14908.030977986396;14929.253537323091;8642.78393040179;8776.561171941377;8794.03265640779;8795.25240354577;8808.647654093764;8741.956290218508;8772.609049576142;8805.031446540876;8867.911320886838;8873.201411872962;4594.95405045952;4637.976810115928;4642.489326174118;4708.340832283483;4716.622670186445;1955.599102184049;1991.3030439346403;1995.2717258200653;1998.6502362086576;2004.8095430934038;819.9136144608418;930.8371035068972;978.4129522286571;1051.2431049644244;1071.3013888339353;22055.44861378446;22559.210427634953;22605.208817691302;22613.773862261496;22756.4310892229;955.8757361543094;963.7253382785873;972.8103019911049;976.3409698453657;1028.290479569095;10798.67603971882;11517.48171332292;11553.017993470648;11586;11697.473613687234;550039;553158;558866;562045;564704;99915;122668;132640.0103998441;137503.6249637511;138168;736.7716008037526;938.990610093904;942.3026960049651;994.9651762188289;1004.487711267259;17023.91488042552;20315.49211269671;20389.388318350473;20619.072141753957;20635.071421785757;55370.44629553653;57184;57270.14094788665;58358.7082064604;58725.412745873706;71708;80651.19348806437;85603.57198214218;87165.1283487157;87829.56085219533;7227.49407541467;7401.296876796696;7624.504407213513;7943.602819859099;8564.229219370287;9466.242700584075;12900.806487902877;13585;14127.788083178555;14168.929155354157;10195.84706229422;10463.424511651932;11707;11906.821397679216;12015.219010764273;8770.912290877264;9424.29317801154;9707;11400.372979486208;11954.701132471759;11607.535698572301;11914.642560723192;11967.760644786882;12040.939795300967;12200.328981906081;6069.846729121453;7480.738174163878;7532.8493430132185;7622.58075805836;7767.300942915164;5755.827325180251;6813.829654258485;9671.854922176313;11158.15890378111;11467.827982580435 18:50:49 INFO - PROCESS | 1652 | |3;mootools.html;1585.603599100225;1614.765858950452;1877.258482899255;1934.0426488888002;1935.5354714868427;7207.927920720791;8049.798755031127;8596.1403859614;8618.56907154642;8993.460392376463;8712.60793264303;8870.866936995933;8892.377533572653;8899.37704360695;8903.332250081237;2364.8462849914786;2369.2655276864184;2400.603900356439;2406.1578447543393;2407.4944261705064;2385.7017872765905;2387;2426.817988650849;2434.2453839309783;2442.1452491627965;2098.58028394321;2352.9411764705933;2402.243293362585;2414.239514552919;2415.2754173747894;2389.749076346976;2395.2574701842486;2395.9281221563206;2396;2403.2790162951046;2379.060271192869;2384.511175209078;2384.940376490584;2387.4866903615634;2389.545986262622;8995.370324077317;9000.639974401016;9002;9049.2308153807;9061;5316.069687804657;5395.622306438551;5473.8357849264585;5485.862853428656;5487.259220005288;3531.2054787672823;3647.3070116678014;3683.613220611824;3712.424574191005;3720.4605332226947;1103.2332528892423;1107.7950579142885;1114.5430373546808;1118.1334465788998;1124.9212555121144;11610.825837612443;11616.767664646744;11628.24416412939;11720.765584688259;11755.529778808837;4401.559844015573;4506.3916371290115;4581.3586097945645;4635.304704294383;4682.578567928903;9138.223251023737;9153.77115572116;9173.266138708887;9211.95394023039;9223.76940576491;5155.896882062338;5242.633015688865;5262.947370526323;5272.2882410874045;5274.8945021100135;4434.84478043267;4809.350737650442;4891.413030436371;4918.11473934688;4950.752462376867;3077.9538306925415;3813.122981714221;3858.5369755628944;3876.0697432616535;3936.527616686016;1176.188429983326;1191.3804821492774;1191.5472120594118;1199.8860108289698;1202.3927916402336;965.232640051147;966.8163049020663;973.9366941148803;983.3264214013424;991.2417000994245;6011.543362566542;6022.126791615279;6076.301225359052;6160.661163636043;6163.291221509584;416.78535554189614;436.2431181899402;437.6214574393127;448.49544262704455;452.35539356416973;3730.0674831292176;4047.1905618876344;4052.675785937118;4099.590040995877;4174.624283814472;10463.633772817915;10916.617918372818;10971.341719496855;10986.395748233765;11013;10862.293950893167;10930.070943969693;10934.890651093387;10951;11004.944975275232;7964.522128672298;8331.041930178108;8371.95814020926;8452.239298463044;8476;5159.767810448464;5288;6011.098335249572;6178.382161783786;6196.194494715838;9719.319647624598;9773.560189791619;9845.852312215466;9911.851322230317;9944.35361701487;7941.00737407824;9920;10168.440735759605;10274.691759247235;10422.218333624856;7084.326988936043;7560.168381478143;7687.308142267223;7692.92307076922;7845.13703492604;8626.5255410953;8697.521636310064;8705.782355441164;8709.346798989975;8750.69372571957;7563.168051514439;7643.885341719767;7686;7792.532448053135;7820.882686759589;7468.290512401313;7550.584717840352;7576.772696819105;7615.238476152341;7681.385489160742;5977.312609049841;6982.720691172296;7080.752173673896;7112.644367781487;7116.857662846817;4234.851780187679;5018.197088465828;5084.872878177927;5119.411267704261;5269.446708095595;5066.898662026812;5082.085224659597;5239.685618862881;5242.213667949685;5300.522952934254 18:50:49 INFO - PROCESS | 1652 | |4;prototype.html;305.60424250595474;306.43309876728057;316.94295026895156;321.1281371077524;321.27392093867854;5059.748411956672;5356.3572371315495;5559.082751346028;5650.74571644276;5660.9433905660935;4299.205516414332;5425.864353391167;5528.06022976094;5612.719364031803;5687.544996400288;3474.600420951585;3654.6893514051203;4195.8741237762915;4217.713597352807;4221.7889105544755;3884.8834534964;4174.97912510437;4217.219814334358;4225.281702110648;4267.637250833667;3648.9817550912207;3886.4753258310047;3957.5250969883655;4082.877208767598;4119.114390406062;4055.4930633670792;4110.588941105895;4116.197341518405;4137.2552940470705;4165;2979.55306703994;3045.238690327418;3396.3886500429912;3581.7492775505725;3583.7312201584987;4558.931616025762;4982.327385802906;5332.3601167859715;5441.83674489766;5483.588730845203;4135.731177473454;4721.220998535272;4754.595859351959;4759.428868535798;4771.330034487902;5783.624064435799;5787.305523337184;5813.215215945836;5837.730870712415;5931.199288096095;3303.537504749337;3722.3485889969147;3856.9421458678144;3941.9014524636827;3962.48382277256;5387.703676297802;5502.817858427584;5800.477956983849;5894.2926848778425;5967.7016149192805;3383.678550537695;3521.2253304273017;4003.7197396181987;4011.2779699654343;4023.7183397161916;3385.356782211372;3418.4275233392423;3832.9616703833162;4021.477207962946;4052.7365721228025;3852.653261206505;4712.222483290218;4741.601227637855;4764.95235047652;4769.546893045224;4844.32179494871;5364.490373414519;5873.089671100986;5882.529397648178;5985.820425387245;1297.4550688710765;1357.4909408971635;1369.5206677662939;1383.508854356709;1395.8464568897414;825.9876101858476;898.3307435960252;910.8679241509944;930.851063829784;933.1927882381691;4523.683342166082;4555.430571178603;4669.552438744;5189.662671926389;5419.403865574784;4884.291777692215;4993.251012348177;5150.330457040561;5289.814856480005;5499.717617188901;5246.344206974129;5292.52367286946;5413.350397952271;5444.673319600836;5446.782128714807;2269.6368581026954;2336.9649455258186;2580.541993773512;2652.3899503114008;2674.879630416636;4737.8341758038305;4968.155413579628;4998.500149985045;5221.269022336875;5278.577713782888;4402.581754733295;4544.341070544752;5104.897902041938;5132.79468821243;5176.404713457925;4666.646672464947;4997.525235102659;5210.921836172461;5215.843524694341;5229.398619158846;4178;5044.924326135184;5078.1972399799015;5081.618878584195;5152.742362881916;4456.442944631921;4662.673612847068;4811.855644330676;4839.733814640229;5018.7741551631;5252.894942101213;5851.941480585139;6293.527985401021;6327.462165715966;6335.022539406472;3921.098147426051;3997.200559887976;4021.256067627381;4027.516697996259;4050.736702114353;5102.2346648003095;5600.467955544217;6020.6989650516425;6031.728572214349;6070;5684.403137670485;5823.970880145572;5853.858497592929;5866.354700982974;5884.264466941632;4882.462929077869;5837.153612726216;5856.853578660397;5860.747285256723;5865.472107510344;5590.778961883751;5618.65152363438;5620.550355971431;5687.800926967537;5723.6851973141875;5079.568236699774;5348.224507446476;5837.234983435745;5893.852653683693;5925.940740592711;5121.487851214998;5206.479352064764;5546.916796247979;5695.430456954437;5755.172810081416 18:50:49 INFO - PROCESS | 1652 | |5;yui.html;716.3982254905875;737.7417903733692;750.2122771090358;775.9728409505668;877.9385443018989;14104.858951410508;15138.924305378472;15567.766483502757;15994.600134996615;16012;12265.448054837532;14340.928295358508;14426.783598246035;14431;14462.349194286257;655.4433221099888;841.2596914715042;927.4296307770707;954.1984732824426;954.2413781044087;936.9859452108224;953.4041224234853;955.5126885288519;956.0344052506948;956.5456408206081;991.8165139449225;1009.399407352624;1012.3166862367909;1013.4274135113637;1016.5577973581479;934.2572654739498;996.795656890343;999.6501224571379;1002.0230275481384;1009.7324209084562;745.6309126982125;748.124694107895;749.9737509187153;751.0836779129453;751.7819832248641;15752;15859.52421427359;15859.841401586067;15874.36502539897;15894.9205253973;13478.460861565525;13566.864331356659;13606.455741770318;13837.962152838578;13948.372323245478;11768.588099416565;11957;12322.199057061262;13133.146345487512;13815.309234538232;3520.873320537429;3785.6971442284826;3858.787766672832;3954.189391174802;4060.593940605945;79760.60119699422;103424.96575034228;118887;124729.40131444344;125885;11183.888161118284;11521.88478115208;11540.884591153981;11544.236831375974;11782.469788859522;22531.662025069636;22533.774662253494;22845.200417985292;22875.771242287698;22878.771212287997;8317.625706843206;8520.19058189471;8559.443636163629;8634.740957771277;8909.55452227386;4181.787281688337;4497.190505708938;4719.126961512131;4827.324174615556;4828.058528586892;3521.3133438979153;3576.5171701819922;3612.0428086557085;3625.0393645683916;3640;679.7043286170532;684.2644157530674;689.2452764223168;692.9722811087601;698.3679769808332;528.4609698107909;664.4916638771343;710.3997122431537;725.3906718356606;730.2952650692108;9385.62457501706;9561.952190239004;9708.029197080235;9756.512174391251;9864.65473708431;669.802408289546;671.1409395973162;686.5640318397853;705.8517711280689;726.0597526203579;4526.479454862667;4708.293755936637;4743.146233677971;4763.285507173882;4771.856844294607;89634;91546;116983.41508292404;122476.38761806134;140064;124411.3779431097;124908;125741;126176;128837;81351.59324203341;89280;109830.45084774685;110183;111178.33232501519;9000.50497222659;9121.954390228006;9152.908470915205;9214.078592140731;9254.35219534626;57583.848323032464;58470.707646461495;60827.695861520406;61439.692801535704;61547.6922615384;86302.56848715716;86578;91308.08691912996;92135.6291496692;96633;13568.525101621395;13570.59288221355;13692.657683557592;14070.577882663536;14070.78893816614;12554.220223645943;15466.690666186838;15531.223438827787;15616.375344986074;16039.438619648256;14062.60879945079;14556.272186390426;14691.853081469477;14859.034162779384;14881.851181488046;13853.861461385257;13902.721945561234;14354.066985645899;14368.13791172533;14983.77524337114;13151.145175563557;14177.716445671234;14415.567532974028;14521.53765664308;14754.262286885398;11174.66476005721;11462.140339474407;11588.246763960316;11590.188686791844;11989.100817438553;9370.876814201729;11167.832482512606;11632.243904146542;11777.411129443664;11872.584459543874 18:50:49 INFO - PROCESS | 1652 | __end_tp_report 18:50:49 INFO - PROCESS | 1652 | __start_cc_report 18:50:49 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,455 18:50:49 INFO - PROCESS | 1652 | __end_cc_report 18:50:49 INFO - PROCESS | 1652 | __startTimestamp1469152249833__endTimestamp 18:50:49 INFO - PROCESS | 1652 | 18:50:49 INFO - PROCESS | 1652 | ------- Summary: start ------- 18:50:49 INFO - PROCESS | 1652 | Number of tests: 6 18:50:49 INFO - PROCESS | 1652 | 18:50:49 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5894.64 Median:6161.60 stddev:676.97 (11.0%) stddev-sans-first:648.64 18:50:49 INFO - PROCESS | 1652 | Values: 3337.4 3438.5 3445.2 3466.8 3483.8 4506.4 5806.9 5872.3 5977.1 6037.5 5702.1 5824.3 5870.5 5940.1 5987.9 5249.9 5299.0 5320.2 5404.5 5465.8 5480.4 5534.1 5549.9 5554.2 5580.6 5284.2 5323.4 5382.9 5419.5 5461.6 5389.5 5405.4 5408.3 5424.3 5432.3 4596.6 5259.3 5345.1 5372.7 5411.5 5737.9 5801.9 5865.8 5908.4 5939.8 6265.1 6291.7 6294.7 6300.8 6313.4 6350.5 6352.3 6353.7 6381.4 6450.2 5866.6 5959.3 6050.4 6095.5 6131.9 6490.2 6517.0 6522.1 6532.3 6547.2 6183.5 6303.6 6322.9 6323.4 6343.8 6205.1 6234.7 6249.8 6374.8 6420.9 5606.4 6231.7 6298.7 6304.1 6307.7 6246.8 6278.5 6293.6 6302.5 6311.8 4972.8 5022.1 5028.1 5121.0 5142.3 3821.9 4207.0 4539.4 4550.8 4605.4 6069.1 6085.0 6140.6 6158.5 6162.3 6209.2 6273.5 6313.3 6313.7 6409.9 6107.2 6128.1 6135.0 6145.1 6161.6 5686.9 5701.5 5702.4 5711.6 5744.0 6354.7 6451.3 6507.6 6652.7 6685.8 6315.0 6361.8 6362.3 6400.0 6411.6 6323.8 6609.3 6639.3 6639.9 6652.7 6193.1 6200.2 6225.1 6265.5 6297.7 6358.8 6362.6 6371.4 6376.4 6387.5 6292.0 6296.0 6296.4 6314.8 6320.5 5215.9 6091.2 6254.5 6276.7 6289.3 5966.3 6150.7 6182.6 6191.2 6221.9 6085.7 6269.7 6285.5 6314.5 6314.6 6030.5 6100.6 6121.4 6213.9 6227.6 18:50:49 INFO - PROCESS | 1652 | 18:50:49 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:66080.10 Median:38324.33 stddev:145913.60 (380.7%) stddev-sans-first:146239.80 18:50:49 INFO - PROCESS | 1652 | Values: 480.5 513.4 547.2 562.9 566.5 31242.5 41227.0 41325.6 41347.8 41499.4 42092.6 42541.6 42598.4 42611.4 42654.4 9595.5 9646.5 9648.1 9774.6 9784.8 9653.7 9750.9 9751.2 9759.6 9762.9 8330.5 9729.5 9751.8 9762.8 9800.2 9557.4 9674.0 9722.0 9748.8 9760.2 9631.0 9716.7 9726.3 9727.5 9734.0 39910.6 40150.0 40314.6 40333.4 40359.0 3237.4 3447.5 3457.4 3484.9 3646.4 26307.2 27988.6 30029.8 30382.9 30675.0 3132.7 3158.6 3179.5 3183.6 3277.2 459748.0 465686.0 466341.7 467650.0 469743.7 33511.0 33649.5 33717.5 33739.7 33746.3 34308.5 34368.7 34400.8 35673.5 35815.8 16449.4 16638.4 16644.4 16647.4 16684.1 12742.1 12744.2 12817.8 12823.8 12861.1 18824.5 18846.0 18886.4 19097.5 19107.5 6959.5 8133.1 8286.5 8321.8 8330.0 845.8 996.4 997.6 1012.4 1064.3 28142.0 29693.7 29990.7 30420.4 30463.8 985.1 1060.4 1118.4 1145.0 1247.9 14789.8 15125.9 15269.9 15565.9 15569.8 630469.0 647080.0 647150.0 648638.0 650929.0 45945.5 56402.4 56814.4 57052.4 57454.0 1382.9 1400.7 1431.5 1436.7 1440.4 24296.1 26079.2 29557.2 29674.1 29879.7 49645.8 50198.5 50199.5 50380.7 50583.0 507851.0 508336.0 509679.0 511029.0 515504.0 22186.9 24949.5 25974.0 26326.7 26355.9 45490.9 45874.1 46963.5 47389.0 47575.0 32516.2 38178.6 38252.6 39048.0 40089.4 37817.2 38396.0 38848.6 39144.6 39442.0 36757.8 36956.3 37613.4 37897.8 38249.0 33384.0 33531.5 33807.0 33888.8 33904.8 25141.6 25265.4 25534.4 25565.9 25763.4 18:50:49 INFO - PROCESS | 1652 | 18:50:49 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:34627.33 Median:1726.00 stddev:93735.46 (5430.8%) stddev-sans-first:93963.04 18:50:49 INFO - PROCESS | 1652 | Values: 331.2 371.8 374.7 393.2 401.6 16450.1 16612.5 21655.2 21886.6 22161.2 21558.5 21980.0 22088.4 22275.8 22464.4 5520.7 5613.4 5739.2 5941.9 6162.8 5378.5 5726.0 6055.6 6135.1 6143.0 5842.0 5961.9 6007.4 6030.1 6097.1 5992.5 6010.0 6037.3 6072.7 6084.6 5156.4 5256.0 5300.4 5309.8 5311.8 24012.4 26992.7 27157.9 27425.9 27550.9 1911.5 2326.1 2357.8 2815.2 3120.8 15724.6 16450.3 16527.7 16699.2 16700.2 1860.1 1887.7 1902.7 1977.2 1981.6 122392.0 123474.0 127617.4 128225.4 129628.0 11459.7 11602.3 11772.8 11823.5 12036.8 14596.5 14880.7 14882.3 14908.0 14929.3 8642.8 8776.6 8794.0 8795.3 8808.6 8742.0 8772.6 8805.0 8867.9 8873.2 4595.0 4638.0 4642.5 4708.3 4716.6 1955.6 1991.3 1995.3 1998.7 2004.8 819.9 930.8 978.4 1051.2 1071.3 22055.4 22559.2 22605.2 22613.8 22756.4 955.9 963.7 972.8 976.3 1028.3 10798.7 11517.5 11553.0 11586.0 11697.5 550039.0 553158.0 558866.0 562045.0 564704.0 99915.0 122668.0 132640.0 137503.6 138168.0 736.8 939.0 942.3 995.0 1004.5 17023.9 20315.5 20389.4 20619.1 20635.1 55370.4 57184.0 57270.1 58358.7 58725.4 71708.0 80651.2 85603.6 87165.1 87829.6 7227.5 7401.3 7624.5 7943.6 8564.2 9466.2 12900.8 13585.0 14127.8 14168.9 10195.8 10463.4 11707.0 11906.8 12015.2 8770.9 9424.3 9707.0 11400.4 11954.7 11607.5 11914.6 11967.8 12040.9 12200.3 6069.8 7480.7 7532.8 7622.6 7767.3 5755.8 6813.8 9671.9 11158.2 11467.8 18:50:49 INFO - PROCESS | 1652 | 18:50:49 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5721.64 Median:5074.49 stddev:3212.13 (63.3%) stddev-sans-first:3206.10 18:50:49 INFO - PROCESS | 1652 | Values: 1585.6 1614.8 1877.3 1934.0 1935.5 7207.9 8049.8 8596.1 8618.6 8993.5 8712.6 8870.9 8892.4 8899.4 8903.3 2364.8 2369.3 2400.6 2406.2 2407.5 2385.7 2387.0 2426.8 2434.2 2442.1 2098.6 2352.9 2402.2 2414.2 2415.3 2389.7 2395.3 2395.9 2396.0 2403.3 2379.1 2384.5 2384.9 2387.5 2389.5 8995.4 9000.6 9002.0 9049.2 9061.0 5316.1 5395.6 5473.8 5485.9 5487.3 3531.2 3647.3 3683.6 3712.4 3720.5 1103.2 1107.8 1114.5 1118.1 1124.9 11610.8 11616.8 11628.2 11720.8 11755.5 4401.6 4506.4 4581.4 4635.3 4682.6 9138.2 9153.8 9173.3 9212.0 9223.8 5155.9 5242.6 5262.9 5272.3 5274.9 4434.8 4809.4 4891.4 4918.1 4950.8 3078.0 3813.1 3858.5 3876.1 3936.5 1176.2 1191.4 1191.5 1199.9 1202.4 965.2 966.8 973.9 983.3 991.2 6011.5 6022.1 6076.3 6160.7 6163.3 416.8 436.2 437.6 448.5 452.4 3730.1 4047.2 4052.7 4099.6 4174.6 10463.6 10916.6 10971.3 10986.4 11013.0 10862.3 10930.1 10934.9 10951.0 11004.9 7964.5 8331.0 8372.0 8452.2 8476.0 5159.8 5288.0 6011.1 6178.4 6196.2 9719.3 9773.6 9845.9 9911.9 9944.4 7941.0 9920.0 10168.4 10274.7 10422.2 7084.3 7560.2 7687.3 7692.9 7845.1 8626.5 8697.5 8705.8 8709.3 8750.7 7563.2 7643.9 7686.0 7792.5 7820.9 7468.3 7550.6 7576.8 7615.2 7681.4 5977.3 6982.7 7080.8 7112.6 7116.9 4234.9 5018.2 5084.9 5119.4 5269.4 5066.9 5082.1 5239.7 5242.2 5300.5 18:50:49 INFO - PROCESS | 1652 | 18:50:49 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4503.95 Median:4998.01 stddev:1401.06 (28.0%) stddev-sans-first:1369.09 18:50:49 INFO - PROCESS | 1652 | Values: 305.6 306.4 316.9 321.1 321.3 5059.7 5356.4 5559.1 5650.7 5660.9 4299.2 5425.9 5528.1 5612.7 5687.5 3474.6 3654.7 4195.9 4217.7 4221.8 3884.9 4175.0 4217.2 4225.3 4267.6 3649.0 3886.5 3957.5 4082.9 4119.1 4055.5 4110.6 4116.2 4137.3 4165.0 2979.6 3045.2 3396.4 3581.7 3583.7 4558.9 4982.3 5332.4 5441.8 5483.6 4135.7 4721.2 4754.6 4759.4 4771.3 5783.6 5787.3 5813.2 5837.7 5931.2 3303.5 3722.3 3856.9 3941.9 3962.5 5387.7 5502.8 5800.5 5894.3 5967.7 3383.7 3521.2 4003.7 4011.3 4023.7 3385.4 3418.4 3833.0 4021.5 4052.7 3852.7 4712.2 4741.6 4765.0 4769.5 4844.3 5364.5 5873.1 5882.5 5985.8 1297.5 1357.5 1369.5 1383.5 1395.8 826.0 898.3 910.9 930.9 933.2 4523.7 4555.4 4669.6 5189.7 5419.4 4884.3 4993.3 5150.3 5289.8 5499.7 5246.3 5292.5 5413.4 5444.7 5446.8 2269.6 2337.0 2580.5 2652.4 2674.9 4737.8 4968.2 4998.5 5221.3 5278.6 4402.6 4544.3 5104.9 5132.8 5176.4 4666.6 4997.5 5210.9 5215.8 5229.4 4178.0 5044.9 5078.2 5081.6 5152.7 4456.4 4662.7 4811.9 4839.7 5018.8 5252.9 5851.9 6293.5 6327.5 6335.0 3921.1 3997.2 4021.3 4027.5 4050.7 5102.2 5600.5 6020.7 6031.7 6070.0 5684.4 5824.0 5853.9 5866.4 5884.3 4882.5 5837.2 5856.9 5860.7 5865.5 5590.8 5618.7 5620.6 5687.8 5723.7 5079.6 5348.2 5837.2 5893.9 5925.9 5121.5 5206.5 5546.9 5695.4 5755.2 18:50:49 INFO - PROCESS | 1652 | 18:50:49 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:23654.12 Median:3521.09 stddev:36063.24 (1024.2%) stddev-sans-first:36123.28 18:50:49 INFO - PROCESS | 1652 | Values: 716.4 737.7 750.2 776.0 877.9 14104.9 15138.9 15567.8 15994.6 16012.0 12265.4 14340.9 14426.8 14431.0 14462.3 655.4 841.3 927.4 954.2 954.2 937.0 953.4 955.5 956.0 956.5 991.8 1009.4 1012.3 1013.4 1016.6 934.3 996.8 999.7 1002.0 1009.7 745.6 748.1 750.0 751.1 751.8 15752.0 15859.5 15859.8 15874.4 15894.9 13478.5 13566.9 13606.5 13838.0 13948.4 11768.6 11957.0 12322.2 13133.1 13815.3 3520.9 3785.7 3858.8 3954.2 4060.6 79760.6 103425.0 118887.0 124729.4 125885.0 11183.9 11521.9 11540.9 11544.2 11782.5 22531.7 22533.8 22845.2 22875.8 22878.8 8317.6 8520.2 8559.4 8634.7 8909.6 4181.8 4497.2 4719.1 4827.3 4828.1 3521.3 3576.5 3612.0 3625.0 3640.0 679.7 684.3 689.2 693.0 698.4 528.5 664.5 710.4 725.4 730.3 9385.6 9562.0 9708.0 9756.5 9864.7 669.8 671.1 686.6 705.9 726.1 4526.5 4708.3 4743.1 4763.3 4771.9 89634.0 91546.0 116983.4 122476.4 140064.0 124411.4 124908.0 125741.0 126176.0 128837.0 81351.6 89280.0 109830.5 110183.0 111178.3 9000.5 9122.0 9152.9 9214.1 9254.4 57583.8 58470.7 60827.7 61439.7 61547.7 86302.6 86578.0 91308.1 92135.6 96633.0 13568.5 13570.6 13692.7 14070.6 14070.8 12554.2 15466.7 15531.2 15616.4 16039.4 14062.6 14556.3 14691.9 14859.0 14881.9 13853.9 13902.7 14354.1 14368.1 14983.8 13151.1 14177.7 14415.6 14521.5 14754.3 11174.7 11462.1 11588.2 11590.2 11989.1 9370.9 11167.8 11632.2 11777.4 11872.6 18:50:49 INFO - PROCESS | 1652 | -------- Summary: end -------- 18:50:49 INFO - PROCESS | 1652 | 18:50:50 INFO - TEST-INFO | 1652: exit 0 18:50:50 INFO - TEST-OK | dromaeo_css | took 1113601ms 18:50:50 INFO - TEST-START | kraken 18:50:50 INFO - operating with platform_type : mac_ 18:50:50 INFO - Initialising browser for kraken test... 18:50:50 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpGG66xS/profile http://localhost:49266/getInfo.html) 18:50:52 INFO - PROCESS | 1660 | JavaScript error: , line 0: uncaught exception: undefined 18:50:53 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 18:50:53 INFO - PROCESS | 1660 | colorDepth:24 18:50:53 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 18:50:53 INFO - PROCESS | 1660 | __metrics 18:50:53 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 18:50:54 INFO - TEST-INFO | 1660: exit 0 18:50:54 INFO - Browser initialized. 18:50:54 INFO - Running cycle 1/1 for kraken test... 18:50:54 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpGG66xS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:51:06 INFO - PROCESS | 1662 | RSS: Main: 256299008 18:51:06 INFO - PROCESS | 1662 | 18:51:09 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 18:51:10 INFO - PROCESS | 1662 | RSS: Main: 269430784 18:51:10 INFO - PROCESS | 1662 | 18:51:12 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 18:51:13 INFO - PROCESS | 1662 | RSS: Main: 277712896 18:51:13 INFO - PROCESS | 1662 | 18:51:16 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 18:51:17 INFO - PROCESS | 1662 | RSS: Main: 281092096 18:51:17 INFO - PROCESS | 1662 | 18:51:19 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 18:51:20 INFO - PROCESS | 1662 | RSS: Main: 283500544 18:51:20 INFO - PROCESS | 1662 | 18:51:22 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:51:22 INFO - PROCESS | 1662 | RSS: Main: 283967488 18:51:22 INFO - PROCESS | 1662 | 18:51:25 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 18:51:26 INFO - PROCESS | 1662 | RSS: Main: 284471296 18:51:26 INFO - PROCESS | 1662 | 18:51:29 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 18:51:29 INFO - PROCESS | 1662 | RSS: Main: 284663808 18:51:29 INFO - PROCESS | 1662 | 18:51:33 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 18:51:33 INFO - PROCESS | 1662 | RSS: Main: 284774400 18:51:33 INFO - PROCESS | 1662 | 18:51:35 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:51:36 INFO - PROCESS | 1662 | RSS: Main: 284708864 18:51:36 INFO - PROCESS | 1662 | 18:51:38 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:51:38 INFO - PROCESS | 1662 | RSS: Main: 284672000 18:51:38 INFO - PROCESS | 1662 | 18:51:40 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:51:41 INFO - PROCESS | 1662 | RSS: Main: 284725248 18:51:41 INFO - PROCESS | 1662 | 18:51:44 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:51:45 INFO - PROCESS | 1662 | RSS: Main: 284786688 18:51:45 INFO - PROCESS | 1662 | 18:51:48 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:51:48 INFO - PROCESS | 1662 | RSS: Main: 284729344 18:51:48 INFO - PROCESS | 1662 | 18:51:50 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 18:51:51 INFO - PROCESS | 1662 | RSS: Main: 285704192 18:51:51 INFO - PROCESS | 1662 | 18:51:51 INFO - PROCESS | 1662 | __start_tp_report 18:51:51 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 18:51:51 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 18:51:51 INFO - PROCESS | 1662 | |i|pagename|runs| 18:51:51 INFO - PROCESS | 1662 | |0;ai-astar;117;119;111;117;117;117;101;116;121;113 18:51:51 INFO - PROCESS | 1662 | |1;audio-beat-detection;155;94;148;191;146;121;132;182;142;92 18:51:51 INFO - PROCESS | 1662 | |2;audio-dft;198;200;204;230;242;198;214;249;200;200 18:51:51 INFO - PROCESS | 1662 | |3;audio-fft;72;110;104;157;51;56;64;81;164;84 18:51:51 INFO - PROCESS | 1662 | |4;audio-oscillator;68;71;145;89;72;96;115;70;72;115 18:51:51 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;90;103;89;88;91;86;90;88;92;86 18:51:51 INFO - PROCESS | 1662 | |6;imaging-darkroom;100;96;96;99;97;95;95;107;149;120 18:51:51 INFO - PROCESS | 1662 | |7;imaging-desaturate;90;93;120;142;98;130;92;91;143;142 18:51:51 INFO - PROCESS | 1662 | |8;json-parse-financial;56;56;57;67;77;87;87;89;73;75 18:51:51 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;69;72;65;80;83;80;78;71;71;73 18:51:51 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;77;72;75;100;75;76;72;74;104;107 18:51:51 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;143;160;148;172;155;159;151;136;162;152 18:51:51 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;148;221;226;214;164;180;156;211;226;186 18:51:51 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;61;90;66;70;87;88;81;92;91;90 18:51:51 INFO - PROCESS | 1662 | __end_tp_report 18:51:51 INFO - PROCESS | 1662 | __start_cc_report 18:51:51 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1142 18:51:51 INFO - PROCESS | 1662 | __end_cc_report 18:51:51 INFO - PROCESS | 1662 | __startTimestamp1469152311137__endTimestamp 18:51:51 INFO - PROCESS | 1662 | 18:51:51 INFO - PROCESS | 1662 | ------- Summary: start ------- 18:51:51 INFO - PROCESS | 1662 | Number of tests: 14 18:51:51 INFO - PROCESS | 1662 | 18:51:51 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:114.90 Median:117.00 stddev:5.63 (4.8%) stddev-sans-first:5.92 18:51:51 INFO - PROCESS | 1662 | Values: 117.0 119.0 111.0 117.0 117.0 117.0 101.0 116.0 121.0 113.0 18:51:51 INFO - PROCESS | 1662 | 18:51:51 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:168.50 stddev:32.55 (19.3%) stddev-sans-first:34.09 18:51:51 INFO - PROCESS | 1662 | Values: 155.0 94.0 148.0 191.0 146.0 121.0 132.0 182.0 142.0 92.0 18:51:51 INFO - PROCESS | 1662 | 18:51:51 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:213.50 Median:209.00 stddev:19.61 (9.4%) stddev-sans-first:19.99 18:51:51 INFO - PROCESS | 1662 | Values: 198.0 200.0 204.0 230.0 242.0 198.0 214.0 249.0 200.0 200.0 18:51:51 INFO - PROCESS | 1662 | 18:51:51 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:94.30 Median:60.00 stddev:39.68 (66.1%) stddev-sans-first:41.26 18:51:51 INFO - PROCESS | 1662 | Values: 72.0 110.0 104.0 157.0 51.0 56.0 64.0 81.0 164.0 84.0 18:51:51 INFO - PROCESS | 1662 | 18:51:51 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:71.50 stddev:26.22 (36.7%) stddev-sans-first:26.42 18:51:51 INFO - PROCESS | 1662 | Values: 68.0 71.0 145.0 89.0 72.0 96.0 115.0 70.0 72.0 115.0 18:51:51 INFO - PROCESS | 1662 | 18:51:51 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:90.30 Median:89.50 stddev:4.88 (5.4%) stddev-sans-first:5.17 18:51:51 INFO - PROCESS | 1662 | Values: 90.0 103.0 89.0 88.0 91.0 86.0 90.0 88.0 92.0 86.0 18:51:51 INFO - PROCESS | 1662 | 18:51:51 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:105.40 Median:95.50 stddev:17.16 (18.0%) stddev-sans-first:18.09 18:51:51 INFO - PROCESS | 1662 | Values: 100.0 96.0 96.0 99.0 97.0 95.0 95.0 107.0 149.0 120.0 18:51:51 INFO - PROCESS | 1662 | 18:51:51 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:114.10 Median:90.50 stddev:23.54 (26.0%) stddev-sans-first:23.30 18:51:51 INFO - PROCESS | 1662 | Values: 90.0 93.0 120.0 142.0 98.0 130.0 92.0 91.0 143.0 142.0 18:51:51 INFO - PROCESS | 1662 | 18:51:51 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:72.40 Median:76.00 stddev:13.06 (17.2%) stddev-sans-first:12.43 18:51:51 INFO - PROCESS | 1662 | Values: 56.0 56.0 57.0 67.0 77.0 87.0 87.0 89.0 73.0 75.0 18:51:51 INFO - PROCESS | 1662 | 18:51:51 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:74.20 Median:75.50 stddev:5.75 (7.6%) stddev-sans-first:5.78 18:51:51 INFO - PROCESS | 1662 | Values: 69.0 72.0 65.0 80.0 83.0 80.0 78.0 71.0 71.0 73.0 18:51:51 INFO - PROCESS | 1662 | 18:51:51 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:74.50 stddev:14.30 (19.2%) stddev-sans-first:15.00 18:51:51 INFO - PROCESS | 1662 | Values: 77.0 72.0 75.0 100.0 75.0 76.0 72.0 74.0 104.0 107.0 18:51:51 INFO - PROCESS | 1662 | 18:51:51 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:153.80 Median:157.00 stddev:10.24 (6.5%) stddev-sans-first:10.09 18:51:51 INFO - PROCESS | 1662 | Values: 143.0 160.0 148.0 172.0 155.0 159.0 151.0 136.0 162.0 152.0 18:51:51 INFO - PROCESS | 1662 | 18:51:51 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.20 Median:212.50 stddev:30.15 (14.2%) stddev-sans-first:27.18 18:51:51 INFO - PROCESS | 1662 | Values: 148.0 221.0 226.0 214.0 164.0 180.0 156.0 211.0 226.0 186.0 18:51:51 INFO - PROCESS | 1662 | 18:51:51 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.60 Median:89.00 stddev:11.60 (13.0%) stddev-sans-first:9.61 18:51:51 INFO - PROCESS | 1662 | Values: 61.0 90.0 66.0 70.0 87.0 88.0 81.0 92.0 91.0 90.0 18:51:51 INFO - PROCESS | 1662 | -------- Summary: end -------- 18:51:51 INFO - PROCESS | 1662 | 18:51:51 INFO - TEST-INFO | 1662: exit 0 18:51:51 INFO - TEST-OK | kraken | took 61481ms 18:51:51 INFO - SUITE-END | took 1175s 18:51:52 INFO - Completed test suite (00:19:35) 18:51:52 INFO - javascript benchmark 18:51:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7390.395181995894, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3337.4159522083637, 3438.467037609171, 3445.173158441973, 3466.757326987112, 3483.7561370704043, 4506.391637128987, 5806.925718742031, 5872.324682661495, 5977.133315669236, 6037.456628903398, 5702.087665973445, 5824.301083869931, 5870.501007414364, 5940.108983652454, 5987.88024239516, 5249.8950020999655, 5298.973505132469, 5320.1753728172, 5404.513593776559, 5465.808696695616, 5480.424555421683, 5534.0592099343, 5549.861253468655, 5554.222408862763, 5580.553555715554, 5284.207368894658, 5323.361196656388, 5382.946170538284, 5419.5393391561765, 5461.644993075457, 5389.51494365509, 5405.405405405402, 5408.2698835657075, 5424.267723857268, 5432.348118225838, 4596.632269418438, 5259.2899958505495, 5345.09133447311, 5372.677639341652, 5411.485908838654, 5737.88524229513, 5801.883962320772, 5865.824025279248, 5908.438698323653, 5939.792107276225, 6265.122882796412, 6291.653959032252, 6294.7482100715915, 6300.842478938017, 6313.43179113882, 6350.460210882081, 6352.333005034498, 6353.650549219791, 6381.425671689523, 6450.161479007746, 5866.6186697864505, 5959.28488581373, 6050.364711705296, 6095.542834287447, 6131.908021379683, 6490.156279683611, 6517.022446633043, 6522.054302126166, 6532.346765323525, 6547.181602299713, 6183.474404675563, 6303.590266632654, 6322.936770632326, 6323.399277068671, 6343.777967771106, 6205.069239614094, 6234.688265586793, 6249.750009999549, 6374.808755737336, 6420.940544810054, 5606.383297837235, 6231.657258850716, 6298.685065746694, 6304.148939893055, 6307.684615769193, 6246.75012999484, 6278.466330361879, 6293.590916590407, 6302.527310451735, 6311.779087731999, 4972.801087956441, 5022.096022715873, 5028.120078986163, 5120.975804839047, 5142.331496905378, 3821.9044523887123, 4206.978965105155, 4539.432570928634, 4550.772461376918, 4605.40129783126, 6069.119977603223, 6084.969575152096, 6140.570160088841, 6158.507319414526, 6162.26052873658, 6209.161763162006, 6273.466755325757, 6313.305536390993, 6313.652749098844, 6409.935900641027, 6107.219158344477, 6128.142060111588, 6134.969325153421, 6145.139680444741, 6161.599496032743, 5686.914696279559, 5701.458361455738, 5702.372738998707, 5711.600187986801, 5744.0, 6354.682265886595, 6451.2903580607035, 6507.577007494687, 6652.73389064432, 6685.79942601713, 6315.0, 6361.840953976188, 6362.268339141058, 6400.0, 6411.6153030818305, 6323.766865461191, 6609.306022867722, 6639.302873198438, 6639.900401494078, 6652.73389064432, 6193.1329613853195, 6200.162977998093, 6225.066240064027, 6265.467435268053, 6297.716602752796, 6358.77744278948, 6362.586431882098, 6371.426571608392, 6376.362363763772, 6387.489000879826, 6292.024736165901, 6296.024116261987, 6296.370362963667, 6314.778982735582, 6320.525960553069, 5215.947840521546, 6091.177691011657, 6254.4996400286955, 6276.686165691606, 6289.276733175743, 5966.343702192668, 6150.723217455135, 6182.629042257479, 6191.246033171681, 6221.906671400023, 6085.66528840918, 6269.655168965568, 6285.497160227263, 6314.4632706218645, 6314.589551679126, 6030.517558595389, 6100.581173165739, 6121.392004143408, 6213.875722485615, 6227.626342419469], "value": 5850.68454388294, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.5410832654815, 513.4172713969645, 547.17923115327, 562.8602080786409, 566.5043087298614, 31242.53136202959, 41227.0, 41325.586744132546, 41347.793261033694, 41499.377509337384, 42092.57907420925, 42541.57458425415, 42598.36102458466, 42611.36082958758, 42654.36018459718, 9595.52022398879, 9646.517674116301, 9648.131668149865, 9774.609015639366, 9784.804303913954, 9653.710388688316, 9750.853737193913, 9751.219902407825, 9759.560819763128, 9762.853557196648, 8330.50016998979, 9729.464879431629, 9751.756206094833, 9762.804743905117, 9800.16698580618, 9557.426554406758, 9674.032596740304, 9721.951390243074, 9748.75628109296, 9760.17038551724, 9630.951845240728, 9716.659916902874, 9726.319157658967, 9727.513624318826, 9734.0, 39910.60089399098, 40150.0, 40314.59685403138, 40333.39499907504, 40359.0, 3237.3848968695875, 3447.517347571342, 3457.360388328167, 3484.878029268989, 3646.4348026056005, 26307.21078367652, 27988.580171297446, 30029.849850750827, 30382.93659721899, 30675.0, 3132.6867313268717, 3158.6209654841564, 3179.5230715392645, 3183.586133802614, 3277.213468767479, 459748.0, 465686.0, 466341.66829165636, 467650.0, 469743.6512817448, 33511.0, 33649.49525757116, 33717.494237586456, 33739.662603373654, 33746.325073498396, 34308.48537271943, 34368.656313437044, 34400.82799585986, 35673.46489802655, 35815.82092089575, 16449.42427015073, 16638.417655382003, 16644.417445389594, 16647.41734039303, 16684.082375469465, 12742.10805243624, 12744.171628844095, 12817.807732884014, 12823.807642885364, 12861.099723019486, 18824.529386765167, 18845.963472008898, 18886.43340699781, 19097.522561936064, 19107.522311942033, 6959.478039147084, 8133.064697559738, 8286.502809831429, 8321.79472439804, 8329.95835020821, 845.8435189489965, 996.3872218585518, 997.6159178716101, 1012.367270455965, 1064.3454275620438, 28142.0, 29693.703062969525, 29990.70009299879, 30420.39159216803, 30463.847680761453, 985.103555764251, 1060.4114716332356, 1118.367183911482, 1144.9942750286195, 1247.8939290160256, 14789.778153327708, 15125.924370378078, 15269.923650381677, 15565.922170389302, 15569.7544196464, 630469.0, 647080.0, 647150.0, 648638.0, 650929.0, 45945.5405445948, 56402.43597564054, 56814.43185568174, 57052.42947570554, 57454.0, 1382.9446822127204, 1400.7128538649552, 1431.4632012995128, 1436.6695659998259, 1440.3806363263689, 24296.05472478501, 26079.217623471326, 29557.192066753625, 29674.109776706733, 29879.701202987693, 49645.75177124091, 50198.49801501938, 50199.49800502094, 50380.74809625928, 50583.0, 507851.0, 508336.0, 509679.0, 511029.0, 515504.0, 22186.88906555457, 24949.455113645075, 25974.0, 26326.736732632427, 26355.868220658773, 45490.86272843073, 45874.082518350115, 46963.53036469728, 47389.0, 47575.0, 32516.187095322806, 38178.618213817506, 38252.6174738249, 39048.023799405244, 40089.39865901956, 37817.24365512619, 38396.04009899775, 38848.6115138845, 39144.6085539141, 39442.01394965149, 36757.816210918776, 36956.26087478289, 37613.435798462495, 37897.81051094727, 38249.0, 33383.99848004564, 33531.54329633338, 33806.985790426326, 33888.83055584706, 33904.83047584746, 25141.622875656514, 25265.368365791, 25534.361640959123, 25565.872170639028, 25763.355916102246], "value": 19231.052591132, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.17537332043213, 371.8475425075718, 374.68152070739876, 393.1782574419463, 401.59041763410437, 16450.095244761535, 16612.50162495124, 21655.242066527673, 21886.562268754635, 22161.224357147505, 21558.461038474044, 21980.0, 22088.447788805286, 22275.777242227574, 22464.438389040282, 5520.696361700105, 5613.382527921925, 5739.196512488255, 5941.940580594203, 6162.845928851792, 5378.489043540857, 5725.971370143144, 6055.636661800306, 6135.141080248769, 6142.96928515359, 5842.0, 5961.910571341434, 6007.399260074001, 6030.125631783389, 6097.115918191859, 5992.460678538909, 6010.0, 6037.335893051761, 6072.666003369813, 6084.6045007074845, 5156.432792392834, 5255.973720131413, 5300.443453437372, 5309.840704778863, 5311.840644780663, 24012.399690007715, 26992.730072699218, 27157.91368345264, 27425.86287068572, 27550.862245688844, 1911.4934542346289, 2326.127702111708, 2357.7642235776457, 2815.225812901448, 3120.828354440505, 15724.606884827856, 16450.341986320534, 16527.669446611122, 16699.165041747863, 16700.248488818033, 1860.1443336065427, 1887.6507846048526, 1902.657521646103, 1977.1893523655376, 1981.6234915366178, 122392.0, 123474.0, 127617.36191319076, 128225.35887320597, 129628.0, 11459.713507162387, 11602.25966105091, 11772.823407648892, 11823.527058917547, 12036.75926481483, 14596.489122880648, 14880.735137513217, 14882.255887205596, 14908.030977986396, 14929.253537323091, 8642.78393040179, 8776.561171941377, 8794.03265640779, 8795.25240354577, 8808.647654093764, 8741.956290218508, 8772.609049576142, 8805.031446540876, 8867.911320886838, 8873.201411872962, 4594.95405045952, 4637.976810115928, 4642.489326174118, 4708.340832283483, 4716.622670186445, 1955.599102184049, 1991.3030439346403, 1995.2717258200653, 1998.6502362086576, 2004.8095430934038, 819.9136144608418, 930.8371035068972, 978.4129522286571, 1051.2431049644244, 1071.3013888339353, 22055.44861378446, 22559.210427634953, 22605.208817691302, 22613.773862261496, 22756.4310892229, 955.8757361543094, 963.7253382785873, 972.8103019911049, 976.3409698453657, 1028.290479569095, 10798.67603971882, 11517.48171332292, 11553.017993470648, 11586.0, 11697.473613687234, 550039.0, 553158.0, 558866.0, 562045.0, 564704.0, 99915.0, 122668.0, 132640.0103998441, 137503.6249637511, 138168.0, 736.7716008037526, 938.990610093904, 942.3026960049651, 994.9651762188289, 1004.487711267259, 17023.91488042552, 20315.49211269671, 20389.388318350473, 20619.072141753957, 20635.071421785757, 55370.44629553653, 57184.0, 57270.14094788665, 58358.7082064604, 58725.412745873706, 71708.0, 80651.19348806437, 85603.57198214218, 87165.1283487157, 87829.56085219533, 7227.49407541467, 7401.296876796696, 7624.504407213513, 7943.602819859099, 8564.229219370287, 9466.242700584075, 12900.806487902877, 13585.0, 14127.788083178555, 14168.929155354157, 10195.84706229422, 10463.424511651932, 11707.0, 11906.821397679216, 12015.219010764273, 8770.912290877264, 9424.29317801154, 9707.0, 11400.372979486208, 11954.701132471759, 11607.535698572301, 11914.642560723192, 11967.760644786882, 12040.939795300967, 12200.328981906081, 6069.846729121453, 7480.738174163878, 7532.8493430132185, 7622.58075805836, 7767.300942915164, 5755.827325180251, 6813.829654258485, 9671.854922176313, 11158.15890378111, 11467.827982580435], "value": 9795.220207036406, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1585.603599100225, 1614.765858950452, 1877.258482899255, 1934.0426488888002, 1935.5354714868427, 7207.927920720791, 8049.798755031127, 8596.1403859614, 8618.56907154642, 8993.460392376463, 8712.60793264303, 8870.866936995933, 8892.377533572653, 8899.37704360695, 8903.332250081237, 2364.8462849914786, 2369.2655276864184, 2400.603900356439, 2406.1578447543393, 2407.4944261705064, 2385.7017872765905, 2387.0, 2426.817988650849, 2434.2453839309783, 2442.1452491627965, 2098.58028394321, 2352.9411764705933, 2402.243293362585, 2414.239514552919, 2415.2754173747894, 2389.749076346976, 2395.2574701842486, 2395.9281221563206, 2396.0, 2403.2790162951046, 2379.060271192869, 2384.511175209078, 2384.940376490584, 2387.4866903615634, 2389.545986262622, 8995.370324077317, 9000.639974401016, 9002.0, 9049.2308153807, 9061.0, 5316.069687804657, 5395.622306438551, 5473.8357849264585, 5485.862853428656, 5487.259220005288, 3531.2054787672823, 3647.3070116678014, 3683.613220611824, 3712.424574191005, 3720.4605332226947, 1103.2332528892423, 1107.7950579142885, 1114.5430373546808, 1118.1334465788998, 1124.9212555121144, 11610.825837612443, 11616.767664646744, 11628.24416412939, 11720.765584688259, 11755.529778808837, 4401.559844015573, 4506.3916371290115, 4581.3586097945645, 4635.304704294383, 4682.578567928903, 9138.223251023737, 9153.77115572116, 9173.266138708887, 9211.95394023039, 9223.76940576491, 5155.896882062338, 5242.633015688865, 5262.947370526323, 5272.2882410874045, 5274.8945021100135, 4434.84478043267, 4809.350737650442, 4891.413030436371, 4918.11473934688, 4950.752462376867, 3077.9538306925415, 3813.122981714221, 3858.5369755628944, 3876.0697432616535, 3936.527616686016, 1176.188429983326, 1191.3804821492774, 1191.5472120594118, 1199.8860108289698, 1202.3927916402336, 965.232640051147, 966.8163049020663, 973.9366941148803, 983.3264214013424, 991.2417000994245, 6011.543362566542, 6022.126791615279, 6076.301225359052, 6160.661163636043, 6163.291221509584, 416.78535554189614, 436.2431181899402, 437.6214574393127, 448.49544262704455, 452.35539356416973, 3730.0674831292176, 4047.1905618876344, 4052.675785937118, 4099.590040995877, 4174.624283814472, 10463.633772817915, 10916.617918372818, 10971.341719496855, 10986.395748233765, 11013.0, 10862.293950893167, 10930.070943969693, 10934.890651093387, 10951.0, 11004.944975275232, 7964.522128672298, 8331.041930178108, 8371.95814020926, 8452.239298463044, 8476.0, 5159.767810448464, 5288.0, 6011.098335249572, 6178.382161783786, 6196.194494715838, 9719.319647624598, 9773.560189791619, 9845.852312215466, 9911.851322230317, 9944.35361701487, 7941.00737407824, 9920.0, 10168.440735759605, 10274.691759247235, 10422.218333624856, 7084.326988936043, 7560.168381478143, 7687.308142267223, 7692.92307076922, 7845.13703492604, 8626.5255410953, 8697.521636310064, 8705.782355441164, 8709.346798989975, 8750.69372571957, 7563.168051514439, 7643.885341719767, 7686.0, 7792.532448053135, 7820.882686759589, 7468.290512401313, 7550.584717840352, 7576.772696819105, 7615.238476152341, 7681.385489160742, 5977.312609049841, 6982.720691172296, 7080.752173673896, 7112.644367781487, 7116.857662846817, 4234.851780187679, 5018.197088465828, 5084.872878177927, 5119.411267704261, 5269.446708095595, 5066.898662026812, 5082.085224659597, 5239.685618862881, 5242.213667949685, 5300.522952934254], "value": 4533.327245251863, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.60424250595474, 306.43309876728057, 316.94295026895156, 321.1281371077524, 321.27392093867854, 5059.748411956672, 5356.3572371315495, 5559.082751346028, 5650.74571644276, 5660.9433905660935, 4299.205516414332, 5425.864353391167, 5528.06022976094, 5612.719364031803, 5687.544996400288, 3474.600420951585, 3654.6893514051203, 4195.8741237762915, 4217.713597352807, 4221.7889105544755, 3884.8834534964, 4174.97912510437, 4217.219814334358, 4225.281702110648, 4267.637250833667, 3648.9817550912207, 3886.4753258310047, 3957.5250969883655, 4082.877208767598, 4119.114390406062, 4055.4930633670792, 4110.588941105895, 4116.197341518405, 4137.2552940470705, 4165.0, 2979.55306703994, 3045.238690327418, 3396.3886500429912, 3581.7492775505725, 3583.7312201584987, 4558.931616025762, 4982.327385802906, 5332.3601167859715, 5441.83674489766, 5483.588730845203, 4135.731177473454, 4721.220998535272, 4754.595859351959, 4759.428868535798, 4771.330034487902, 5783.624064435799, 5787.305523337184, 5813.215215945836, 5837.730870712415, 5931.199288096095, 3303.537504749337, 3722.3485889969147, 3856.9421458678144, 3941.9014524636827, 3962.48382277256, 5387.703676297802, 5502.817858427584, 5800.477956983849, 5894.2926848778425, 5967.7016149192805, 3383.678550537695, 3521.2253304273017, 4003.7197396181987, 4011.2779699654343, 4023.7183397161916, 3385.356782211372, 3418.4275233392423, 3832.9616703833162, 4021.477207962946, 4052.7365721228025, 3852.653261206505, 4712.222483290218, 4741.601227637855, 4764.95235047652, 4769.546893045224, 4844.32179494871, 5364.490373414519, 5873.089671100986, 5882.529397648178, 5985.820425387245, 1297.4550688710765, 1357.4909408971635, 1369.5206677662939, 1383.508854356709, 1395.8464568897414, 825.9876101858476, 898.3307435960252, 910.8679241509944, 930.851063829784, 933.1927882381691, 4523.683342166082, 4555.430571178603, 4669.552438744, 5189.662671926389, 5419.403865574784, 4884.291777692215, 4993.251012348177, 5150.330457040561, 5289.814856480005, 5499.717617188901, 5246.344206974129, 5292.52367286946, 5413.350397952271, 5444.673319600836, 5446.782128714807, 2269.6368581026954, 2336.9649455258186, 2580.541993773512, 2652.3899503114008, 2674.879630416636, 4737.8341758038305, 4968.155413579628, 4998.500149985045, 5221.269022336875, 5278.577713782888, 4402.581754733295, 4544.341070544752, 5104.897902041938, 5132.79468821243, 5176.404713457925, 4666.646672464947, 4997.525235102659, 5210.921836172461, 5215.843524694341, 5229.398619158846, 4178.0, 5044.924326135184, 5078.1972399799015, 5081.618878584195, 5152.742362881916, 4456.442944631921, 4662.673612847068, 4811.855644330676, 4839.733814640229, 5018.7741551631, 5252.894942101213, 5851.941480585139, 6293.527985401021, 6327.462165715966, 6335.022539406472, 3921.098147426051, 3997.200559887976, 4021.256067627381, 4027.516697996259, 4050.736702114353, 5102.2346648003095, 5600.467955544217, 6020.6989650516425, 6031.728572214349, 6070.0, 5684.403137670485, 5823.970880145572, 5853.858497592929, 5866.354700982974, 5884.264466941632, 4882.462929077869, 5837.153612726216, 5856.853578660397, 5860.747285256723, 5865.472107510344, 5590.778961883751, 5618.65152363438, 5620.550355971431, 5687.800926967537, 5723.6851973141875, 5079.568236699774, 5348.224507446476, 5837.234983435745, 5893.852653683693, 5925.940740592711, 5121.487851214998, 5206.479352064764, 5546.916796247979, 5695.430456954437, 5755.172810081416], "value": 4063.4557927913866, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.3982254905875, 737.7417903733692, 750.2122771090358, 775.9728409505668, 877.9385443018989, 14104.858951410508, 15138.924305378472, 15567.766483502757, 15994.600134996615, 16012.0, 12265.448054837532, 14340.928295358508, 14426.783598246035, 14431.0, 14462.349194286257, 655.4433221099888, 841.2596914715042, 927.4296307770707, 954.1984732824426, 954.2413781044087, 936.9859452108224, 953.4041224234853, 955.5126885288519, 956.0344052506948, 956.5456408206081, 991.8165139449225, 1009.399407352624, 1012.3166862367909, 1013.4274135113637, 1016.5577973581479, 934.2572654739498, 996.795656890343, 999.6501224571379, 1002.0230275481384, 1009.7324209084562, 745.6309126982125, 748.124694107895, 749.9737509187153, 751.0836779129453, 751.7819832248641, 15752.0, 15859.52421427359, 15859.841401586067, 15874.36502539897, 15894.9205253973, 13478.460861565525, 13566.864331356659, 13606.455741770318, 13837.962152838578, 13948.372323245478, 11768.588099416565, 11957.0, 12322.199057061262, 13133.146345487512, 13815.309234538232, 3520.873320537429, 3785.6971442284826, 3858.787766672832, 3954.189391174802, 4060.593940605945, 79760.60119699422, 103424.96575034228, 118887.0, 124729.40131444344, 125885.0, 11183.888161118284, 11521.88478115208, 11540.884591153981, 11544.236831375974, 11782.469788859522, 22531.662025069636, 22533.774662253494, 22845.200417985292, 22875.771242287698, 22878.771212287997, 8317.625706843206, 8520.19058189471, 8559.443636163629, 8634.740957771277, 8909.55452227386, 4181.787281688337, 4497.190505708938, 4719.126961512131, 4827.324174615556, 4828.058528586892, 3521.3133438979153, 3576.5171701819922, 3612.0428086557085, 3625.0393645683916, 3640.0, 679.7043286170532, 684.2644157530674, 689.2452764223168, 692.9722811087601, 698.3679769808332, 528.4609698107909, 664.4916638771343, 710.3997122431537, 725.3906718356606, 730.2952650692108, 9385.62457501706, 9561.952190239004, 9708.029197080235, 9756.512174391251, 9864.65473708431, 669.802408289546, 671.1409395973162, 686.5640318397853, 705.8517711280689, 726.0597526203579, 4526.479454862667, 4708.293755936637, 4743.146233677971, 4763.285507173882, 4771.856844294607, 89634.0, 91546.0, 116983.41508292404, 122476.38761806134, 140064.0, 124411.3779431097, 124908.0, 125741.0, 126176.0, 128837.0, 81351.59324203341, 89280.0, 109830.45084774685, 110183.0, 111178.33232501519, 9000.50497222659, 9121.954390228006, 9152.908470915205, 9214.078592140731, 9254.35219534626, 57583.848323032464, 58470.707646461495, 60827.695861520406, 61439.692801535704, 61547.6922615384, 86302.56848715716, 86578.0, 91308.08691912996, 92135.6291496692, 96633.0, 13568.525101621395, 13570.59288221355, 13692.657683557592, 14070.577882663536, 14070.78893816614, 12554.220223645943, 15466.690666186838, 15531.223438827787, 15616.375344986074, 16039.438619648256, 14062.60879945079, 14556.272186390426, 14691.853081469477, 14859.034162779384, 14881.851181488046, 13853.861461385257, 13902.721945561234, 14354.066985645899, 14368.13791172533, 14983.77524337114, 13151.145175563557, 14177.716445671234, 14415.567532974028, 14521.53765664308, 14754.262286885398, 11174.66476005721, 11462.140339474407, 11588.246763960316, 11590.188686791844, 11989.100817438553, 9370.876814201729, 11167.832482512606, 11632.243904146542, 11777.411129443664, 11872.584459543874], "value": 8024.612516597605, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1622.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 111.0, 117.0, 117.0, 117.0, 101.0, 116.0, 121.0, 113.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 94.0, 148.0, 191.0, 146.0, 121.0, 132.0, 182.0, 142.0, 92.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 200.0, 204.0, 230.0, 242.0, 198.0, 214.0, 249.0, 200.0, 200.0], "value": 213.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 110.0, 104.0, 157.0, 51.0, 56.0, 64.0, 81.0, 164.0, 84.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 145.0, 89.0, 72.0, 96.0, 115.0, 70.0, 72.0, 115.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 103.0, 89.0, 88.0, 91.0, 86.0, 90.0, 88.0, 92.0, 86.0], "value": 90.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 96.0, 96.0, 99.0, 97.0, 95.0, 95.0, 107.0, 149.0, 120.0], "value": 105.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 93.0, 120.0, 142.0, 98.0, 130.0, 92.0, 91.0, 143.0, 142.0], "value": 114.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 67.0, 77.0, 87.0, 87.0, 89.0, 73.0, 75.0], "value": 72.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 65.0, 80.0, 83.0, 80.0, 78.0, 71.0, 71.0, 73.0], "value": 74.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 72.0, 75.0, 100.0, 75.0, 76.0, 72.0, 74.0, 104.0, 107.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 160.0, 148.0, 172.0, 155.0, 159.0, 151.0, 136.0, 162.0, 152.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 221.0, 226.0, 214.0, 164.0, 180.0, 156.0, 211.0, 226.0, 186.0], "value": 193.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 90.0, 66.0, 70.0, 87.0, 88.0, 81.0, 92.0, 91.0, 90.0], "value": 81.6, "unit": "score"}]}]} 18:51:52 INFO - Return code: 0 18:51:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:51:52 ERROR - # TBPL SUCCESS # 18:51:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:51:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:51:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:51:52 INFO - 2016-07-21 18:51:52.429 screenresolution[1667:10261] starting screenresolution argv=screenresolution get 18:51:52 INFO - 2016-07-21 18:51:52.432 screenresolution[1667:10261] Display 0: 1600x1200x32@60 18:51:52 INFO - 2016-07-21 18:51:52.438 screenresolution[1668:10264] starting screenresolution argv=screenresolution list 18:51:52 INFO - Available Modes on Display 0 18:51:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:51:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:51:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:51:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:51:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:51:52 INFO - Intel Iris: 18:51:52 INFO - Chipset Model: Intel Iris 18:51:52 INFO - Type: GPU 18:51:52 INFO - Bus: Built-In 18:51:52 INFO - VRAM (Dynamic, Max): 1536 MB 18:51:52 INFO - Vendor: Intel (0x8086) 18:51:52 INFO - Device ID: 0x0a2e 18:51:52 INFO - Revision ID: 0x0009 18:51:52 INFO - Displays: 18:51:52 INFO - Display: 18:51:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:51:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:51:52 INFO - Display Serial Number: 1600x1200 60 18:51:52 INFO - Main Display: Yes 18:51:52 INFO - Mirror: Off 18:51:52 INFO - Online: Yes 18:51:52 INFO - Rotation: Supported 18:51:52 INFO - Return code: 0 18:51:52 INFO - Running post-action listener: _resource_record_post_action 18:51:52 INFO - [mozharness: 2016-07-22 01:51:52.684897Z] Finished run-tests step (success) 18:51:52 INFO - Running post-run listener: _resource_record_post_run 18:51:52 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 37073920; Write bytes: 709076992; Read time: 253; Write time: 2036 18:51:52 INFO - TinderboxPrint: CPU usage
54.4% 18:51:52 INFO - TinderboxPrint: I/O read bytes / time
37,073,920 / 253 18:51:52 INFO - TinderboxPrint: I/O write bytes / time
709,076,992 / 2,036 18:51:52 INFO - TinderboxPrint: CPU idle
2,210.7 (45.6%) 18:51:52 INFO - TinderboxPrint: CPU system
981.6 (20.3%) 18:51:52 INFO - TinderboxPrint: CPU user
1,653.4 (34.1%) 18:51:52 INFO - TinderboxPrint: Swap in / out
444,157,952 / 0 18:51:52 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 413211136; Write bytes: 401720832; Read time: 30812; Write time: 868 18:51:52 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 29051904; Write bytes: 297681408; Read time: 172; Write time: 1138 18:51:53 INFO - Running post-run listener: _upload_blobber_files 18:51:53 INFO - Blob upload gear active. 18:51:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:51:53 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 18:51:53 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:51:53 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:51:53 INFO - (blobuploader) - INFO - Open directory for files ... 18:51:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:51:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:51:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:54 INFO - (blobuploader) - INFO - Done attempting. 18:51:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:51:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:51:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:55 INFO - (blobuploader) - INFO - Done attempting. 18:51:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:51:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:51:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:58 INFO - (blobuploader) - INFO - Done attempting. 18:51:58 INFO - (blobuploader) - INFO - Iteration through files over. 18:51:58 INFO - Return code: 0 18:51:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:51:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:51:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fe10dce7ae23b1e94d65a05499fce9292dd22fc7558c2a0e6eed6edb080d5cd8cc0660587267748aa4bdc2a951a3496f45ca09b62f33fb304294e978a361a4cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2b430c32e31d69efff144fe48942ddf8136887add3dc198e737876dd374d3e3c37d2ad87fd59e6e807d672d51d4067907c754307ae680598b74fa96e028b277e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/df1be690d2ed87fa3b59f396382ecd6b0790b061bd021d59676946809f60f15a644bdeede2c16d8e011f54072d55dfd7c33d1025613a1910d9744ae532d19290"} 18:51:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:51:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:51:58 INFO - Contents: 18:51:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fe10dce7ae23b1e94d65a05499fce9292dd22fc7558c2a0e6eed6edb080d5cd8cc0660587267748aa4bdc2a951a3496f45ca09b62f33fb304294e978a361a4cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2b430c32e31d69efff144fe48942ddf8136887add3dc198e737876dd374d3e3c37d2ad87fd59e6e807d672d51d4067907c754307ae680598b74fa96e028b277e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/df1be690d2ed87fa3b59f396382ecd6b0790b061bd021d59676946809f60f15a644bdeede2c16d8e011f54072d55dfd7c33d1025613a1910d9744ae532d19290"} 18:51:58 INFO - Running post-run listener: copy_logs_to_upload_dir 18:51:58 INFO - Copying logs to upload dir... 18:51:58 INFO - mkdir: /builds/slave/test/build/upload/logs 18:51:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.878891 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-07-21 18:51:58.749919) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 18:51:58.753734) ========= 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.eWsrSHj2e4/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.dPIOQhbMDs/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fe10dce7ae23b1e94d65a05499fce9292dd22fc7558c2a0e6eed6edb080d5cd8cc0660587267748aa4bdc2a951a3496f45ca09b62f33fb304294e978a361a4cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2b430c32e31d69efff144fe48942ddf8136887add3dc198e737876dd374d3e3c37d2ad87fd59e6e807d672d51d4067907c754307ae680598b74fa96e028b277e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/df1be690d2ed87fa3b59f396382ecd6b0790b061bd021d59676946809f60f15a644bdeede2c16d8e011f54072d55dfd7c33d1025613a1910d9744ae532d19290"} build_url:https://queue.taskcluster.net/v1/task/cfNLrgskTwO_AwKnGWf3Gg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010898 build_url: 'https://queue.taskcluster.net/v1/task/cfNLrgskTwO_AwKnGWf3Gg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fe10dce7ae23b1e94d65a05499fce9292dd22fc7558c2a0e6eed6edb080d5cd8cc0660587267748aa4bdc2a951a3496f45ca09b62f33fb304294e978a361a4cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2b430c32e31d69efff144fe48942ddf8136887add3dc198e737876dd374d3e3c37d2ad87fd59e6e807d672d51d4067907c754307ae680598b74fa96e028b277e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/df1be690d2ed87fa3b59f396382ecd6b0790b061bd021d59676946809f60f15a644bdeede2c16d8e011f54072d55dfd7c33d1025613a1910d9744ae532d19290"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 18:51:58.785860) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 18:51:58.786200) ========= 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.eWsrSHj2e4/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.dPIOQhbMDs/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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.005173 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 18:51:58.835358) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 18:51:58.835674) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 18:51:58.836055) ========= ========= Total master_lag: 2.99 =========