builder: larch_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0051 starttime: 1469799890.75 results: success (0) buildid: 20160729023624 builduid: e84ff2993d774ae4be34819dfb8c5bce revision: 4e808f44b30e7182f5358f63bd89abb3b7c36cdd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 06:44:50.754373) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 06:44:50.754805) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 06:44:50.755094) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 06:44:50.780046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 06:44:50.780427) ========= 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.RVAgHyVghD/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.KYRAwj7Uxh/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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-29 06:44:50-- 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% 54.6M=0s 2016-07-29 06:44:50 (54.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092170 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 06:44:50.894939) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 06:44:50.895265) ========= 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.RVAgHyVghD/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.KYRAwj7Uxh/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.027300 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 06:44:50.944094) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-29 06:44:50.944444) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 4e808f44b30e7182f5358f63bd89abb3b7c36cdd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 4e808f44b30e7182f5358f63bd89abb3b7c36cdd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RVAgHyVghD/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.KYRAwj7Uxh/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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-29 06:44:51,017 truncating revision to first 12 chars 2016-07-29 06:44:51,017 Setting DEBUG logging. 2016-07-29 06:44:51,017 attempt 1/10 2016-07-29 06:44:51,017 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/4e808f44b30e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-29 06:44:51,801 unpacking tar archive at: larch-4e808f44b30e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.043781 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-29 06:44:52.009930) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 06:44:52.010266) ========= script_repo_revision: 4e808f44b30e7182f5358f63bd89abb3b7c36cdd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 06:44:52.010668) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 06:44:52.010943) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 06:44:52.028884) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-29 06:44:52.029302) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 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', 'Larch', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RVAgHyVghD/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.KYRAwj7Uxh/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 06:44:52 INFO - MultiFileLogger online at 20160729 06:44:52 in /builds/slave/test 06:44:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 06:44:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:44:52 INFO - {'append_to_log': False, 06:44:52 INFO - 'base_work_dir': '/builds/slave/test', 06:44:52 INFO - 'blob_upload_branch': 'Larch', 06:44:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:44:52 INFO - 'branch': 'Larch', 06:44:52 INFO - 'buildbot_json_path': 'buildprops.json', 06:44:52 INFO - 'config_files': ('talos/mac_config.py',), 06:44:52 INFO - 'default_actions': ('clobber', 06:44:52 INFO - 'read-buildbot-config', 06:44:52 INFO - 'download-and-extract', 06:44:52 INFO - 'populate-webroot', 06:44:52 INFO - 'create-virtualenv', 06:44:52 INFO - 'install', 06:44:52 INFO - 'run-tests'), 06:44:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:44:52 INFO - 'download_minidump_stackwalk': True, 06:44:52 INFO - 'download_symbols': 'ondemand', 06:44:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:44:52 INFO - 'tooltool.py': '/tools/tooltool.py', 06:44:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:44:52 INFO - '/tools/misc-python/virtualenv.py')}, 06:44:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:44:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:44:52 INFO - 'installer_path': 'installer.exe', 06:44:52 INFO - 'log_level': 'info', 06:44:52 INFO - 'log_name': 'talos', 06:44:52 INFO - 'log_to_console': True, 06:44:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:44:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:44:52 INFO - 'opt_config_files': (), 06:44:52 INFO - 'pip_index': False, 06:44:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:44:52 INFO - 'cmd': ('bash', 06:44:52 INFO - '-c', 06:44:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:44:52 INFO - 'enabled': True, 06:44:52 INFO - 'halt_on_failure': False, 06:44:52 INFO - 'name': 'check_screen_resolution'},), 06:44:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:44:52 INFO - 'cmd': ('bash', 06:44:52 INFO - '-c', 06:44:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:44:52 INFO - 'enabled': True, 06:44:52 INFO - 'halt_on_failure': False, 06:44:52 INFO - 'name': 'check_screen_resolution'},), 06:44:52 INFO - 'run_cmd_checks_enabled': True, 06:44:52 INFO - 'sps_profile': False, 06:44:52 INFO - 'sps_profile_interval': 0, 06:44:52 INFO - 'suite': 'dromaeojs-e10s', 06:44:52 INFO - 'system_bits': '32', 06:44:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:44:52 INFO - 'title': 't-yosemite-r7-0051', 06:44:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:44:52 INFO - 'use_talos_json': True, 06:44:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:44:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:44:52 INFO - 'work_dir': 'build'} 06:44:52 INFO - ##### 06:44:52 INFO - ##### Running clobber step. 06:44:52 INFO - ##### 06:44:52 INFO - Running pre-action listener: _resource_record_pre_action 06:44:52 INFO - Running main action method: clobber 06:44:52 INFO - rmtree: /builds/slave/test/build 06:44:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:44:54 INFO - Running post-action listener: _resource_record_post_action 06:44:54 INFO - ##### 06:44:54 INFO - ##### Finished clobber step (success) 06:44:54 INFO - ##### 06:44:54 INFO - ##### 06:44:54 INFO - ##### Running read-buildbot-config step. 06:44:54 INFO - ##### 06:44:54 INFO - Running pre-action listener: _resource_record_pre_action 06:44:54 INFO - Running main action method: read_buildbot_config 06:44:54 INFO - Using buildbot properties: 06:44:54 INFO - { 06:44:54 INFO - "project": "", 06:44:54 INFO - "product": "firefox", 06:44:54 INFO - "script_repo_revision": "production", 06:44:54 INFO - "builddir": "larch_yosemite_r7_test-dromaeojs-e10s", 06:44:54 INFO - "repository": "", 06:44:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 larch talos dromaeojs-e10s", 06:44:54 INFO - "buildid": "20160729023624", 06:44:54 INFO - "pgo_build": "False", 06:44:54 INFO - "basedir": "/builds/slave/test", 06:44:54 INFO - "buildnumber": 0, 06:44:54 INFO - "slavename": "t-yosemite-r7-0051", 06:44:54 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 06:44:54 INFO - "platform": "yosemite_r7", 06:44:54 INFO - "scheduler": "tests-larch-macosx64-talos", 06:44:54 INFO - "branch": "larch", 06:44:54 INFO - "repo_path": "projects/larch", 06:44:54 INFO - "revision": "4e808f44b30e7182f5358f63bd89abb3b7c36cdd", 06:44:54 INFO - "stage_platform": "macosx64", 06:44:54 INFO - "builduid": "e84ff2993d774ae4be34819dfb8c5bce", 06:44:54 INFO - "slavebuilddir": "test" 06:44:54 INFO - } 06:44:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/IWneReXDQmm3u5KV4BuUnw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 06:44:54 INFO - Running post-action listener: _resource_record_post_action 06:44:54 INFO - ##### 06:44:54 INFO - ##### Finished read-buildbot-config step (success) 06:44:54 INFO - ##### 06:44:54 INFO - ##### 06:44:54 INFO - ##### Running download-and-extract step. 06:44:54 INFO - ##### 06:44:54 INFO - Running pre-action listener: _resource_record_pre_action 06:44:54 INFO - Running main action method: download_and_extract 06:44:54 INFO - mkdir: /builds/slave/test/build/tests 06:44:54 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')]} 06:44:54 INFO - https://queue.taskcluster.net/v1/task/IWneReXDQmm3u5KV4BuUnw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:44:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWneReXDQmm3u5KV4BuUnw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 06:44:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWneReXDQmm3u5KV4BuUnw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 06:44:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWneReXDQmm3u5KV4BuUnw/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 06:44:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWneReXDQmm3u5KV4BuUnw/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 06:44:55 INFO - Downloaded 1199 bytes. 06:44:55 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 06:44:55 INFO - Using the following test package requirements: 06:44:55 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 06:44:55 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:44:55 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 06:44:55 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:44:55 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 06:44:55 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:44:55 INFO - u'jsshell-mac.zip'], 06:44:55 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:44:55 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 06:44:55 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 06:44:55 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:44:55 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 06:44:55 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:44:55 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 06:44:55 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:44:55 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 06:44:55 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:44:55 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 06:44:55 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:44:55 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')]} 06:44:55 INFO - https://queue.taskcluster.net/v1/task/IWneReXDQmm3u5KV4BuUnw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:44:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWneReXDQmm3u5KV4BuUnw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:44:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWneReXDQmm3u5KV4BuUnw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:44:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWneReXDQmm3u5KV4BuUnw/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 06:44:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWneReXDQmm3u5KV4BuUnw/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 06:44:56 INFO - Downloaded 18789525 bytes. 06:44:56 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'] 06:44:56 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 06:44:59 INFO - Return code: 0 06:44:59 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 06:44:59 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')]} 06:44:59 INFO - https://queue.taskcluster.net/v1/task/IWneReXDQmm3u5KV4BuUnw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:44:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWneReXDQmm3u5KV4BuUnw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:44:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWneReXDQmm3u5KV4BuUnw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:44:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWneReXDQmm3u5KV4BuUnw/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 06:44:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWneReXDQmm3u5KV4BuUnw/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 06:45:00 INFO - Downloaded 18789525 bytes. 06:45: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'] 06:45: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 06:45:04 INFO - Return code: 0 06:45: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')]} 06:45:04 INFO - https://queue.taskcluster.net/v1/task/IWneReXDQmm3u5KV4BuUnw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:45:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWneReXDQmm3u5KV4BuUnw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 06:45:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWneReXDQmm3u5KV4BuUnw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 06:45:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWneReXDQmm3u5KV4BuUnw/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 06:45:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWneReXDQmm3u5KV4BuUnw/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 06:45:05 INFO - Downloaded 14405242 bytes. 06:45: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'] 06:45: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 06:45:05 INFO - Return code: 0 06:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:05 INFO - https://queue.taskcluster.net/v1/task/IWneReXDQmm3u5KV4BuUnw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:45:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWneReXDQmm3u5KV4BuUnw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:45:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWneReXDQmm3u5KV4BuUnw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:45:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWneReXDQmm3u5KV4BuUnw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 06:45:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWneReXDQmm3u5KV4BuUnw/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 06:45:08 INFO - Downloaded 112475468 bytes. 06:45:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IWneReXDQmm3u5KV4BuUnw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:45:08 INFO - mkdir: /builds/slave/test/properties 06:45:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:45:08 INFO - Writing to file /builds/slave/test/properties/build_url 06:45:08 INFO - Contents: 06:45:08 INFO - build_url:https://queue.taskcluster.net/v1/task/IWneReXDQmm3u5KV4BuUnw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:45:09 INFO - Running post-action listener: _resource_record_post_action 06:45:09 INFO - Running post-action listener: set_extra_try_arguments 06:45:09 INFO - ##### 06:45:09 INFO - ##### Finished download-and-extract step (success) 06:45:09 INFO - ##### 06:45:09 INFO - ##### 06:45:09 INFO - ##### Running populate-webroot step. 06:45:09 INFO - ##### 06:45:09 INFO - Running pre-action listener: _resource_record_pre_action 06:45:09 INFO - Running main action method: populate_webroot 06:45:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:45:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:45:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:45:09 INFO - '--tppagecycles', 06:45:09 INFO - '7'], 06:45:09 INFO - 'tests': ['tsvgm']}}, 06:45:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:45:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:45:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:45:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:45:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:45:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:45:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:45:09 INFO - 'talos_options': ['--disable-e10s'], 06:45:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:45:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:45:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:45:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:45:09 INFO - 'talos_options': ['--disable-e10s'], 06:45:09 INFO - 'tests': ['damp', 'tps']}, 06:45:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:45:09 INFO - 'tests': ['damp', 'tps']}, 06:45:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:45:09 INFO - 'tests': ['dromaeo_dom']}, 06:45:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:45:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:45:09 INFO - 'tests': ['basic_compositor_video']}, 06:45:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:45:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:45:09 INFO - 'tests': ['a11yr', 06:45:09 INFO - 'ts_paint', 06:45:09 INFO - 'tpaint', 06:45:09 INFO - 'sessionrestore', 06:45:09 INFO - 'sessionrestore_no_auto_restore', 06:45:09 INFO - 'tabpaint']}, 06:45:09 INFO - 'other-e10s': {'tests': ['a11yr', 06:45:09 INFO - 'ts_paint', 06:45:09 INFO - 'tpaint', 06:45:09 INFO - 'sessionrestore', 06:45:09 INFO - 'sessionrestore_no_auto_restore', 06:45:09 INFO - 'tabpaint']}, 06:45:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:45:09 INFO - 'ts_paint', 06:45:09 INFO - 'tpaint', 06:45:09 INFO - 'sessionrestore', 06:45:09 INFO - 'sessionrestore_no_auto_restore', 06:45:09 INFO - 'tabpaint']}, 06:45:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:45:09 INFO - 'ts_paint', 06:45:09 INFO - 'tpaint', 06:45:09 INFO - 'sessionrestore', 06:45:09 INFO - 'sessionrestore_no_auto_restore', 06:45:09 INFO - 'tabpaint']}, 06:45:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:45:09 INFO - 'tests': ['a11yr', 06:45:09 INFO - 'ts_paint', 06:45:09 INFO - 'tpaint', 06:45:09 INFO - 'sessionrestore', 06:45:09 INFO - 'sessionrestore_no_auto_restore', 06:45:09 INFO - 'tabpaint']}, 06:45:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:45:09 INFO - 'tests': ['a11yr', 06:45:09 INFO - 'ts_paint', 06:45:09 INFO - 'tpaint', 06:45:09 INFO - 'sessionrestore', 06:45:09 INFO - 'sessionrestore_no_auto_restore', 06:45:09 INFO - 'tabpaint']}, 06:45:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:45:09 INFO - 'tests': ['tsvgx', 06:45:09 INFO - 'tsvgr_opacity', 06:45:09 INFO - 'tart', 06:45:09 INFO - 'tscrollx', 06:45:09 INFO - 'cart']}, 06:45:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:45:09 INFO - 'tsvgr_opacity', 06:45:09 INFO - 'tart', 06:45:09 INFO - 'tscrollx', 06:45:09 INFO - 'cart']}, 06:45:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:45:09 INFO - 'talos_options': ['--disable-e10s'], 06:45:09 INFO - 'tests': ['tp5o']}, 06:45:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:45:09 INFO - 'tests': ['tp5o']}, 06:45:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:45:09 INFO - 'talos_options': ['--disable-e10s', 06:45:09 INFO - '--xperf_path', 06:45:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:45:09 INFO - 'tests': ['tp5n']}, 06:45:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:45:09 INFO - 'talos_options': ['--xperf_path', 06:45:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:45:09 INFO - 'tests': ['tp5n']}}, 06:45:09 INFO - 'talos.zip': {'path': '', 06:45:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:45:09 INFO - Running post-action listener: _resource_record_post_action 06:45:09 INFO - ##### 06:45:09 INFO - ##### Finished populate-webroot step (success) 06:45:09 INFO - ##### 06:45:09 INFO - ##### 06:45:09 INFO - ##### Running create-virtualenv step. 06:45:09 INFO - ##### 06:45:09 INFO - Running pre-action listener: _resource_record_pre_action 06:45:09 INFO - Running main action method: create_virtualenv 06:45:09 INFO - Creating virtualenv /builds/slave/test/build/venv 06:45:09 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 06:45:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:45:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:45:09 INFO - Using real prefix '/tools/python27' 06:45:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:45:10 INFO - Installing distribute.............................................................................................................................................................................................done. 06:45:13 INFO - Installing pip.................done. 06:45:13 INFO - Return code: 0 06:45:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:45: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')]} 06:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45: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')]} 06:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45: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 0x10d974a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da09618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2e2dcedf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d8d30>, '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 0x10d63ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d0b20>, '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.RVAgHyVghD/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.KYRAwj7Uxh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 06:45: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 06:45: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 06:45:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RVAgHyVghD/Render', 06:45:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:45:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:45:13 INFO - 'HOME': '/Users/cltbld', 06:45:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:45:13 INFO - 'LOGNAME': 'cltbld', 06:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:13 INFO - 'MOZ_NO_REMOTE': '1', 06:45:13 INFO - 'NO_EM_RESTART': '1', 06:45:13 INFO - 'PAGER': '/bin/cat', 06:45:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:13 INFO - 'PWD': '/builds/slave/test', 06:45:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:45:13 INFO - 'SHELL': '/bin/bash', 06:45:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KYRAwj7Uxh/Listeners', 06:45:13 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 06:45:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:45:13 INFO - 'USER': 'cltbld', 06:45:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:45:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:13 INFO - 'XPC_FLAGS': '0x0', 06:45:13 INFO - 'XPC_SERVICE_NAME': '0', 06:45:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:13 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 06:45:13 INFO - Cleaning up... 06:45:13 INFO - Return code: 0 06:45:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:45: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')]} 06:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45: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')]} 06:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45: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', '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 0x10d974a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da09618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2e2dcedf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d8d30>, '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 0x10d63ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d0b20>, '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.RVAgHyVghD/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.KYRAwj7Uxh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 06:45: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', 'psutil>=3.1.1'] in /builds/slave/test/build 06:45: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 psutil>=3.1.1 06:45:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RVAgHyVghD/Render', 06:45:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:45:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:45:13 INFO - 'HOME': '/Users/cltbld', 06:45:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:45:13 INFO - 'LOGNAME': 'cltbld', 06:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:13 INFO - 'MOZ_NO_REMOTE': '1', 06:45:13 INFO - 'NO_EM_RESTART': '1', 06:45:13 INFO - 'PAGER': '/bin/cat', 06:45:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:13 INFO - 'PWD': '/builds/slave/test', 06:45:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:45:13 INFO - 'SHELL': '/bin/bash', 06:45:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KYRAwj7Uxh/Listeners', 06:45:13 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 06:45:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:45:13 INFO - 'USER': 'cltbld', 06:45:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:45:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:13 INFO - 'XPC_FLAGS': '0x0', 06:45:13 INFO - 'XPC_SERVICE_NAME': '0', 06:45:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:13 INFO - Downloading/unpacking psutil>=3.1.1 06:45:13 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 06:45:13 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 06:45:13 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 06:45:13 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 06:45:13 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 06:45:13 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 06:45:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:45:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:45:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:45:16 INFO - Installing collected packages: psutil 06:45:16 INFO - Running setup.py install for psutil 06:45:16 INFO - building 'psutil._psutil_osx' extension 06:45:16 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 06:45: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_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:45: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:45:17 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 06:45:17 INFO - building 'psutil._psutil_posix' extension 06:45:17 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 06:45:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:45:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:45:17 INFO - ^ 06:45:17 INFO - 1 warning generated. 06:45:17 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 06:45:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:45:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:45:17 INFO - Successfully installed psutil 06:45:17 INFO - Cleaning up... 06:45:17 INFO - Return code: 0 06:45:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:17 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 0x10d974a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da09618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2e2dcedf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d8d30>, '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 0x10d63ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d0b20>, '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.RVAgHyVghD/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.KYRAwj7Uxh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 06:45:17 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 06:45:17 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 06:45:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RVAgHyVghD/Render', 06:45:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:45:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:45:17 INFO - 'HOME': '/Users/cltbld', 06:45:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:45:17 INFO - 'LOGNAME': 'cltbld', 06:45:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:17 INFO - 'MOZ_NO_REMOTE': '1', 06:45:17 INFO - 'NO_EM_RESTART': '1', 06:45:17 INFO - 'PAGER': '/bin/cat', 06:45:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:45:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:17 INFO - 'PWD': '/builds/slave/test', 06:45:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:45:17 INFO - 'SHELL': '/bin/bash', 06:45:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KYRAwj7Uxh/Listeners', 06:45:17 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 06:45:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:45:17 INFO - 'USER': 'cltbld', 06:45:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:45:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:45:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:17 INFO - 'XPC_FLAGS': '0x0', 06:45:17 INFO - 'XPC_SERVICE_NAME': '0', 06:45:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:45:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:45: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 06:45: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 06:45: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 06:45: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 06:45: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 06:45: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 06:45:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:45:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:45:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:45:20 INFO - Installing collected packages: mozsystemmonitor 06:45:20 INFO - Running setup.py install for mozsystemmonitor 06:45:20 INFO - Successfully installed mozsystemmonitor 06:45:20 INFO - Cleaning up... 06:45:21 INFO - Return code: 0 06:45:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:45: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')]} 06:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45: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')]} 06:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45: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 0x10d974a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da09618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2e2dcedf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d8d30>, '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 0x10d63ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d0b20>, '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.RVAgHyVghD/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.KYRAwj7Uxh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 06:45: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 06:45: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 06:45:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RVAgHyVghD/Render', 06:45:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:45:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:45:21 INFO - 'HOME': '/Users/cltbld', 06:45:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:45:21 INFO - 'LOGNAME': 'cltbld', 06:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:21 INFO - 'MOZ_NO_REMOTE': '1', 06:45:21 INFO - 'NO_EM_RESTART': '1', 06:45:21 INFO - 'PAGER': '/bin/cat', 06:45:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:21 INFO - 'PWD': '/builds/slave/test', 06:45:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:45:21 INFO - 'SHELL': '/bin/bash', 06:45:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KYRAwj7Uxh/Listeners', 06:45:21 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 06:45:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:45:21 INFO - 'USER': 'cltbld', 06:45:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:45:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:21 INFO - 'XPC_FLAGS': '0x0', 06:45:21 INFO - 'XPC_SERVICE_NAME': '0', 06:45:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:21 INFO - Downloading/unpacking jsonschema==2.5.1 06:45: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 06:45: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 06:45: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 06:45: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 06:45: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 06:45: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 06:45:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:45:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:45:23 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 06:45:23 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 06:45:23 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 06:45:23 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 06:45:23 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 06:45:23 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 06:45:24 INFO - Downloading functools32-3.2.3-2.tar.gz 06:45:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:45:24 INFO - warning: no files found matching '*.txt' 06:45:24 INFO - no previously-included directories found matching 'build' 06:45:24 INFO - no previously-included directories found matching 'dist' 06:45:24 INFO - no previously-included directories found matching '.git*' 06:45:24 INFO - Installing collected packages: jsonschema, functools32 06:45:24 INFO - Running setup.py install for functools32 06:45:24 INFO - warning: no files found matching '*.txt' 06:45:24 INFO - no previously-included directories found matching 'build' 06:45:24 INFO - no previously-included directories found matching 'dist' 06:45:24 INFO - no previously-included directories found matching '.git*' 06:45:24 INFO - Successfully installed jsonschema functools32 06:45:24 INFO - Cleaning up... 06:45:24 INFO - Return code: 0 06:45:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d974a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da09618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2e2dcedf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d8d30>, '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 0x10d63ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d0b20>, '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.RVAgHyVghD/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.KYRAwj7Uxh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 06:45:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:45:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:45:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RVAgHyVghD/Render', 06:45:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:45:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:45:24 INFO - 'HOME': '/Users/cltbld', 06:45:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:45:24 INFO - 'LOGNAME': 'cltbld', 06:45:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:24 INFO - 'MOZ_NO_REMOTE': '1', 06:45:24 INFO - 'NO_EM_RESTART': '1', 06:45:24 INFO - 'PAGER': '/bin/cat', 06:45:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:45:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:24 INFO - 'PWD': '/builds/slave/test', 06:45:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:45:24 INFO - 'SHELL': '/bin/bash', 06:45:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KYRAwj7Uxh/Listeners', 06:45:24 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 06:45:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:45:24 INFO - 'USER': 'cltbld', 06:45:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:45:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:45:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:24 INFO - 'XPC_FLAGS': '0x0', 06:45:24 INFO - 'XPC_SERVICE_NAME': '0', 06:45:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:45:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:24 INFO - Downloading/unpacking blobuploader==1.2.4 06:45: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 06:45: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 06:45: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 06:45: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 06:45: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 06:45: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 06:45:27 INFO - Downloading blobuploader-1.2.4.tar.gz 06:45:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:45:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:45: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 06:45: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 06:45: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 06:45: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 06:45: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 06:45: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 06:45:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:45:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:45: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 06:45: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 06:45: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 06:45: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 06:45: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 06:45: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 06:45:28 INFO - Downloading docopt-0.6.1.tar.gz 06:45:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:45:28 INFO - Installing collected packages: blobuploader, requests, docopt 06:45:28 INFO - Running setup.py install for blobuploader 06:45:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:45:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:45:28 INFO - Running setup.py install for requests 06:45:29 INFO - Running setup.py install for docopt 06:45:29 INFO - Successfully installed blobuploader requests docopt 06:45:29 INFO - Cleaning up... 06:45:29 INFO - Return code: 0 06:45:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:29 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 0x10d974a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da09618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2e2dcedf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d8d30>, '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 0x10d63ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d0b20>, '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.RVAgHyVghD/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.KYRAwj7Uxh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 06:45:29 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 06:45:29 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 06:45:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RVAgHyVghD/Render', 06:45:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:45:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:45:29 INFO - 'HOME': '/Users/cltbld', 06:45:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:45:29 INFO - 'LOGNAME': 'cltbld', 06:45:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:29 INFO - 'MOZ_NO_REMOTE': '1', 06:45:29 INFO - 'NO_EM_RESTART': '1', 06:45:29 INFO - 'PAGER': '/bin/cat', 06:45:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:45:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:29 INFO - 'PWD': '/builds/slave/test', 06:45:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:45:29 INFO - 'SHELL': '/bin/bash', 06:45:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KYRAwj7Uxh/Listeners', 06:45:29 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 06:45:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:45:29 INFO - 'USER': 'cltbld', 06:45:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:45:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:45:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:29 INFO - 'XPC_FLAGS': '0x0', 06:45:29 INFO - 'XPC_SERVICE_NAME': '0', 06:45:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:45:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:45:29 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-J1wa26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:45:29 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-AisNVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:45:29 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-5Dlv7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:45:30 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-yP6Vy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:45:30 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-ID1ifz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:45:30 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-T2dcNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:45:30 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-EKvHAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:45:30 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-D74ChN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:45:30 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-sV4kTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:45:30 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-hHycAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:45:30 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Vxg2Mr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:45:30 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-hgCzY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:45:30 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-YN8Ihv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:45:31 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-xnzpuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:31 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-YprnVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:45:31 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-JmFgKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:45:31 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-JzIfDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:45:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:45:31 INFO - Running setup.py install for manifestparser 06:45:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:45:31 INFO - Running setup.py install for mozcrash 06:45:31 INFO - Running setup.py install for mozdebug 06:45:31 INFO - Running setup.py install for mozdevice 06:45:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:45:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:45:32 INFO - Running setup.py install for mozfile 06:45:32 INFO - Running setup.py install for mozhttpd 06:45:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:45:32 INFO - Running setup.py install for mozinfo 06:45:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:45:32 INFO - Running setup.py install for mozInstall 06:45:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:45:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:45:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:45:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:45:32 INFO - Running setup.py install for mozleak 06:45:32 INFO - Running setup.py install for mozlog 06:45:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:45:33 INFO - Running setup.py install for moznetwork 06:45:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:45:33 INFO - Running setup.py install for mozprocess 06:45:33 INFO - Running setup.py install for mozprofile 06:45:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:45:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:45:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:45:33 INFO - Running setup.py install for mozrunner 06:45:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:45:33 INFO - Running setup.py install for mozscreenshot 06:45:33 INFO - Running setup.py install for moztest 06:45:33 INFO - Running setup.py install for mozversion 06:45:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:45:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:45:34 INFO - Cleaning up... 06:45:34 INFO - Return code: 0 06:45:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:45: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')]} 06:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45: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')]} 06:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45: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 0x10d974a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da09618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2e2dcedf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d8d30>, '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 0x10d63ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d0b20>, '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.RVAgHyVghD/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.KYRAwj7Uxh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 06:45: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 06:45: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 06:45:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RVAgHyVghD/Render', 06:45:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:45:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:45:34 INFO - 'HOME': '/Users/cltbld', 06:45:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:45:34 INFO - 'LOGNAME': 'cltbld', 06:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:34 INFO - 'MOZ_NO_REMOTE': '1', 06:45:34 INFO - 'NO_EM_RESTART': '1', 06:45:34 INFO - 'PAGER': '/bin/cat', 06:45:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:34 INFO - 'PWD': '/builds/slave/test', 06:45:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:45:34 INFO - 'SHELL': '/bin/bash', 06:45:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KYRAwj7Uxh/Listeners', 06:45:34 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 06:45:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:45:34 INFO - 'USER': 'cltbld', 06:45:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:45:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:34 INFO - 'XPC_FLAGS': '0x0', 06:45:34 INFO - 'XPC_SERVICE_NAME': '0', 06:45:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:45:34 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-lATEth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:45:34 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)) 06:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:45:34 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-SPx461-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:45:34 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)) 06:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:45:34 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-zj0_N6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:45:34 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)) 06:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:45:34 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-VtpGKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:45:34 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)) 06:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:45:34 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-nDLpTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:45:34 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)) 06:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:45:34 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Gq2VW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:45: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)) 06:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:45:35 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-U1AUnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:45: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)) 06:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:45:35 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-cFL7UB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:45: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)) 06:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:45:35 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-2lCOIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:45: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)) 06:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:45:35 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-s3x0sa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:45:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:45:35 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-jvzt0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:45:35 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)) 06:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:45:35 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-iCGvAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:45:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:45:35 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-FrDkg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:45:35 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)) 06:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:45:35 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-XsH07J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:45:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:35 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-SNBxNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:35 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)) 06:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:45:35 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-QZ6uuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:45: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)) 06:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:45:36 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-5QbrUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:45: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)) 06:45: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)) 06:45: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)) 06:45: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)) 06:45: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)) 06:45: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)) 06:45:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:45: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 06:45: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 06:45: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 06:45: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 06:45: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 06:45: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 06:45:38 INFO - Downloading blessings-1.6.tar.gz 06:45:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:45:38 INFO - Installing collected packages: blessings 06:45:38 INFO - Running setup.py install for blessings 06:45:38 INFO - Successfully installed blessings 06:45:38 INFO - Cleaning up... 06:45:38 INFO - Return code: 0 06:45:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:45:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:45:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:45:39 INFO - Reading from file tmpfile_stdout 06:45:39 INFO - Current package versions: 06:45:39 INFO - blessings == 1.6 06:45:39 INFO - blobuploader == 1.2.4 06:45:39 INFO - docopt == 0.6.1 06:45:39 INFO - functools32 == 3.2.3-2 06:45:39 INFO - jsonschema == 2.5.1 06:45:39 INFO - manifestparser == 1.1 06:45:39 INFO - mozInstall == 1.12 06:45:39 INFO - mozcrash == 0.17 06:45:39 INFO - mozdebug == 0.1 06:45:39 INFO - mozdevice == 0.48 06:45:39 INFO - mozfile == 1.2 06:45:39 INFO - mozhttpd == 0.7 06:45:39 INFO - mozinfo == 0.9 06:45:39 INFO - mozleak == 0.1 06:45:39 INFO - mozlog == 3.2 06:45:39 INFO - moznetwork == 0.27 06:45:39 INFO - mozprocess == 0.22 06:45:39 INFO - mozprofile == 0.28 06:45:39 INFO - mozrunner == 6.11 06:45:39 INFO - mozscreenshot == 0.1 06:45:39 INFO - mozsystemmonitor == 0.3 06:45:39 INFO - moztest == 0.7 06:45:39 INFO - mozversion == 1.4 06:45:39 INFO - psutil == 3.1.1 06:45:39 INFO - requests == 1.2.3 06:45:39 INFO - wsgiref == 0.1.2 06:45:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:45:39 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')]} 06:45:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:39 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')]} 06:45:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:39 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 0x10d974a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da09618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2e2dcedf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d8d30>, '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 0x10d63ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d0b20>, '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.RVAgHyVghD/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.KYRAwj7Uxh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 06:45:39 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 06:45:39 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 06:45:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RVAgHyVghD/Render', 06:45:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:45:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:45:39 INFO - 'HOME': '/Users/cltbld', 06:45:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:45:39 INFO - 'LOGNAME': 'cltbld', 06:45:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:39 INFO - 'MOZ_NO_REMOTE': '1', 06:45:39 INFO - 'NO_EM_RESTART': '1', 06:45:39 INFO - 'PAGER': '/bin/cat', 06:45:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:45:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:39 INFO - 'PWD': '/builds/slave/test', 06:45:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:45:39 INFO - 'SHELL': '/bin/bash', 06:45:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KYRAwj7Uxh/Listeners', 06:45:39 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 06:45:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:45:39 INFO - 'USER': 'cltbld', 06:45:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:45:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:45:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:39 INFO - 'XPC_FLAGS': '0x0', 06:45:39 INFO - 'XPC_SERVICE_NAME': '0', 06:45:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:45:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:39 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)) 06:45:39 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)) 06:45:39 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)) 06:45:39 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)) 06:45:39 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)) 06:45:39 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)) 06:45:39 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)) 06:45:39 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)) 06:45:39 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)) 06:45:39 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)) 06:45:39 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)) 06:45:39 INFO - Cleaning up... 06:45:39 INFO - Return code: 0 06:45:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:45:39 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')]} 06:45:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:39 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')]} 06:45:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:39 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 0x10d974a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da09618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2e2dcedf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d8d30>, '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 0x10d63ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d0b20>, '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.RVAgHyVghD/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.KYRAwj7Uxh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 06:45:39 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 06:45:39 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 06:45:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RVAgHyVghD/Render', 06:45:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:45:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:45:39 INFO - 'HOME': '/Users/cltbld', 06:45:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:45:39 INFO - 'LOGNAME': 'cltbld', 06:45:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:39 INFO - 'MOZ_NO_REMOTE': '1', 06:45:39 INFO - 'NO_EM_RESTART': '1', 06:45:39 INFO - 'PAGER': '/bin/cat', 06:45:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:45:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:39 INFO - 'PWD': '/builds/slave/test', 06:45:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:45:39 INFO - 'SHELL': '/bin/bash', 06:45:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KYRAwj7Uxh/Listeners', 06:45:39 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 06:45:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:45:39 INFO - 'USER': 'cltbld', 06:45:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:45:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:45:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:39 INFO - 'XPC_FLAGS': '0x0', 06:45:39 INFO - 'XPC_SERVICE_NAME': '0', 06:45:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:45:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:45:39 INFO - Cleaning up... 06:45:39 INFO - Return code: 0 06:45:39 INFO - Running post-action listener: _resource_record_post_action 06:45:39 INFO - Running post-action listener: _start_resource_monitoring 06:45:39 INFO - Starting resource monitoring. 06:45:39 INFO - ##### 06:45:39 INFO - ##### Finished create-virtualenv step (success) 06:45:39 INFO - ##### 06:45:39 INFO - ##### 06:45:39 INFO - ##### Running install step. 06:45:39 INFO - ##### 06:45:39 INFO - Running pre-action listener: _resource_record_pre_action 06:45:39 INFO - Running main action method: install 06:45:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:45:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:45:40 INFO - Reading from file tmpfile_stdout 06:45:40 INFO - Detecting whether we're running mozinstall >=1.0... 06:45:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:45:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:45:40 INFO - Reading from file tmpfile_stdout 06:45:40 INFO - Output received: 06:45:40 INFO - Usage: mozinstall [options] installer 06:45:40 INFO - Options: 06:45:40 INFO - -h, --help show this help message and exit 06:45:40 INFO - -d DEST, --destination=DEST 06:45:40 INFO - Directory to install application into. [default: 06:45:40 INFO - "/builds/slave/test"] 06:45:40 INFO - --app=APP Application being installed. [default: firefox] 06:45:40 INFO - mkdir: /builds/slave/test/build/application 06:45:40 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'] 06:45:40 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 06:46:14 INFO - Reading from file tmpfile_stdout 06:46:14 INFO - Output received: 06:46:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:46:14 INFO - Running post-action listener: _resource_record_post_action 06:46:14 INFO - ##### 06:46:14 INFO - ##### Finished install step (success) 06:46:14 INFO - ##### 06:46:14 INFO - ##### 06:46:14 INFO - ##### Running run-tests step. 06:46:14 INFO - ##### 06:46:14 INFO - Running pre-action listener: _resource_record_pre_action 06:46:14 INFO - Running main action method: run_tests 06:46:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:46:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:46:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:46:14 INFO - 2016-07-29 06:46:14.482 screenresolution[1639:7373] starting screenresolution argv=screenresolution get 06:46:14 INFO - 2016-07-29 06:46:14.484 screenresolution[1639:7373] Display 0: 1600x1200x32@60 06:46:14 INFO - 2016-07-29 06:46:14.490 screenresolution[1640:7375] starting screenresolution argv=screenresolution list 06:46:14 INFO - Available Modes on Display 0 06:46:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:46:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:46:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:46:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:46:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:46:14 INFO - Intel Iris: 06:46:14 INFO - Chipset Model: Intel Iris 06:46:14 INFO - Type: GPU 06:46:14 INFO - Bus: Built-In 06:46:14 INFO - VRAM (Dynamic, Max): 1536 MB 06:46:14 INFO - Vendor: Intel (0x8086) 06:46:14 INFO - Device ID: 0x0a2e 06:46:14 INFO - Revision ID: 0x0009 06:46:14 INFO - Displays: 06:46:14 INFO - Display: 06:46:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:46:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:46:14 INFO - Display Serial Number: 1600x1200 60 06:46:14 INFO - Main Display: Yes 06:46:14 INFO - Mirror: Off 06:46:14 INFO - Online: Yes 06:46:14 INFO - Rotation: Supported 06:46:14 INFO - Return code: 0 06:46:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:46:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:46:14 INFO - Python 2.7.3 06:46:14 INFO - Return code: 0 06:46:14 INFO - grabbing minidump binary from tooltool 06:46: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')]} 06:46:14 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 0x10d8d8d30>, '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 0x10d63ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:46:14 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 06:46:14 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 06:46:14 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 06:46:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:46:14 INFO - Return code: 0 06:46:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:46:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:46:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:46:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:46:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:46:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IWneReXDQmm3u5KV4BuUnw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--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 06:46:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IWneReXDQmm3u5KV4BuUnw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0051 --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 06:46:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RVAgHyVghD/Render', 06:46:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:46:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:46:14 INFO - 'HOME': '/Users/cltbld', 06:46:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:46:14 INFO - 'LOGNAME': 'cltbld', 06:46:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:46:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:46:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:14 INFO - 'MOZ_NO_REMOTE': '1', 06:46:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:46:14 INFO - 'NO_EM_RESTART': '1', 06:46:14 INFO - 'PAGER': '/bin/cat', 06:46:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:46:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:14 INFO - 'PWD': '/builds/slave/test', 06:46:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:46:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:46:14 INFO - 'SHELL': '/bin/bash', 06:46:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KYRAwj7Uxh/Listeners', 06:46:14 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 06:46:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:46:14 INFO - 'USER': 'cltbld', 06:46:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:46:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:46:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:14 INFO - 'XPC_FLAGS': '0x0', 06:46:14 INFO - 'XPC_SERVICE_NAME': '0', 06:46:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:46:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IWneReXDQmm3u5KV4BuUnw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--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 06:46:15 INFO - mozversion application_buildid: 20160729023624 06:46:15 INFO - mozversion application_changeset: 4e808f44b30e7182f5358f63bd89abb3b7c36cdd 06:46:15 INFO - mozversion application_display_name: Nightly 06:46:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:46:15 INFO - mozversion application_name: Firefox 06:46:15 INFO - mozversion application_remotingname: firefox 06:46:15 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 06:46:15 INFO - mozversion application_vendor: Mozilla 06:46:15 INFO - mozversion application_version: 50.0a1 06:46:15 INFO - mozversion platform_buildid: 20160729023624 06:46:15 INFO - mozversion platform_changeset: 4e808f44b30e7182f5358f63bd89abb3b7c36cdd 06:46:15 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 06:46:15 INFO - mozversion platform_version: 50.0a1 06:46:15 INFO - using testdate: 1469799975 06:46:15 INFO - actual date: 1469799975 06:46:15 INFO - starting webserver on 'localhost:49271' 06:46:15 INFO - SUITE-START | Running 2 tests 06:46:15 INFO - TEST-START | dromaeo_css 06:46:15 INFO - operating with platform_type : mac_ 06:46:15 INFO - Initialising browser for dromaeo_css test... 06:46:15 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpQvj5Ok/profile http://localhost:49271/getInfo.html) 06:46:18 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 06:46:18 INFO - PROCESS | 1650 | colorDepth:24 06:46:18 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 06:46:18 INFO - PROCESS | 1650 | __metrics 06:46:18 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 06:46:18 INFO - TEST-INFO | 1650: exit 0 06:46:18 INFO - Browser initialized. 06:46:18 INFO - Running cycle 1/1 for dromaeo_css test... 06:46:18 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpQvj5Ok/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:46:30 INFO - PROCESS | 1653 | RSS: Main: 255512576 06:46:30 INFO - PROCESS | 1653 | 06:47:20 INFO - PROCESS | 1653 | 1469800040377 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] 06:49:31 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 06:49:32 INFO - PROCESS | 1653 | RSS: Main: 268218368 06:49:32 INFO - PROCESS | 1653 | 06:52:34 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 06:52:35 INFO - PROCESS | 1653 | RSS: Main: 276623360 06:52:35 INFO - PROCESS | 1653 | 06:55:37 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 06:55:37 INFO - PROCESS | 1653 | RSS: Main: 281198592 06:55:37 INFO - PROCESS | 1653 | 06:58:39 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 06:58:40 INFO - PROCESS | 1653 | RSS: Main: 280236032 06:58:40 INFO - PROCESS | 1653 | 07:01:43 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 07:01:43 INFO - PROCESS | 1653 | RSS: Main: 284000256 07:01:43 INFO - PROCESS | 1653 | 07:04:46 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 07:04:46 INFO - PROCESS | 1653 | RSS: Main: 284237824 07:04:46 INFO - PROCESS | 1653 | 07:04:46 INFO - PROCESS | 1653 | __start_tp_report 07:04:46 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 07:04:46 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 07:04:46 INFO - PROCESS | 1653 | |i|pagename|runs| 07:04:46 INFO - PROCESS | 1653 | |0;dojo.html;3311.205310725426;3314;3380.4760262159343;3391.4404123319655;3413.9829300853476;5621.2692349994495;5660.915086273699;5719.428057194289;5725.169850371693;5771.134329850514;5589.245451863997;5694.914576281359;5763.221965034709;5775.451332123442;5821.941780582193;5112.642115051948;5141.228815677641;5196.246544251081;5259.526642602165;5280.287161233223;594.3861407584532;5089.338386009814;5124.282600435923;5198.870028249286;5203.843884683447;5122.743862806845;5154.742262886878;5180.456052114511;5188.16989281715;5188.481151884819;5161.5354618084175;5182.818601348972;5202.739863006872;5214.921776173361;5250.264962905197;5085.160948443502;5115.309433226504;5143.074246635604;5146.485351464824;5179.948200518022;5523.447655234485;5676.432356764331;5685.914711279334;5690.40250773667;5738.713064346766;6086.573939824214;6133.6319820810895;6207.658578778165;6220.720067596969;6232.439080482733;6149.585595313103;6180.907286390708;6223.844403889893;6224.657643829588;6252.968735156295;5825.592208545403;5829.446202610745;5834.97082514589;5854.092615644582;5870.589058765888;5601.775928962796;6122.54080943931;6180.752769889244;6229.781957631461;6235.469985051231;6027.246594175728;6037.516998640098;6062.393760623991;6067.848303792441;6073.18012068374;5723.055695810144;6191.876162476725;6206.596571222856;6251.78118765841;6255.093011513305;5078.974605127025;6108.847278818065;6122.265328160649;6140.162398500937;6143.877122457615;5883.352831188651;6184.5980011299125;6194.225721784777;6202.100695399142;6220.34686357935;4932.013597280558;4933.728644924564;4947.604191664658;4959.231319145538;4961.578265847371;3658.8902332930056;4198.887294866801;4352.911772056986;4375.7374557526655;4469.217886869785;4677.906441871143;5563.554915606742;5728.1694154348215;5732.3407808101765;5733.827985160452;6152.907706384408;6191.380861913863;6199.101130336076;6202.1937148171355;6217.720202590895;5688.431156884279;5755.482006619424;5814.505767009767;5821.679807610537;5839.562032847553;5367.624266301399;5398.78404863801;5412.188171774265;5415.83752487426;5422.240886275925;6219.160413344141;6274.905876411949;6287.96856015717;6295.559310848288;6301.243850737941;6228.5951413158;6255.499560035095;6264.31092579825;6273.780417685359;6283;6271.059341098871;6280.152179455715;6281;6285.717142728679;6320.778772742932;6059.787907423219;6126.059675755388;6157.476614487819;6173.506119510518;6204.348543403058;6194.81415557534;6295.150154729053;6304.905426418516;6307.842303942438;6310.810675679737;4841.975790121168;6052.878942421215;6101.969490152698;6134.539909506716;6148.538859585638;5896.587238893237;5979.5814292999075;6017.308009578955;6077.908831367445;6144.170536977451;5772.307323121252;5845.09401042839;5908.822735317947;5949.791757288474;5952.136940143569;6046.395360463918;6060.939390606038;6061.121137435135;6099.786507472217;6112.602680825732;5821.010428227296;5910.615809972338;5932.436418540232;5944.791932282349;5997.280326360865 07:04:46 INFO - PROCESS | 1653 | |1;ext.html;498.73567009484964;498.7730582584924;499.13649386561247;541.5910987204661;573.2805329311718;37382.62617373829;39410.80294598526;39441.80279098604;39498.81503554898;39558.406623900664;39873.00317492057;40172;40227.39658905112;40721.79639101808;40750;9323.813523729521;9326.02076781935;9346.953265233698;9450.33847630666;9464.574094165744;9486.573104210293;9528.809423811519;9622.56698448568;9646.180074693624;9732;9422.62309507619;9536.952315238414;9594.760130996747;9604.991475895034;9608.471534065624;8009.999999999971;9547.331686781929;9597;9642.75893102671;9645.662401815904;9437.811243775155;9491.905080949171;9493.240540756722;9539.47532885691;9557.713268601952;38517;38861.80569097165;38904;38936.80531597324;38960.61039389598;3023.8488075596133;3287.0631869917197;3287.539744435781;3371.96628033719;3421.26442814796;25178.866950987067;28273.03133171008;28511.57232641512;29216.707832921613;29294;2864.1264414353614;2922.7369536741794;2931.457680329146;2954.847609432323;2991.820490770561;462791;464692;468954.99999999657;470429;470706;27082.86458567734;31964.041078767674;32193.195170120933;32228;32841.3431731364;29576.852115739715;32636;33773;34144.65855341464;34332;14349.497767578294;14595.489157879423;14601;14606.488772892897;14617;11992.980596649382;12222;12380.319082450551;12431.813522797165;12449.626511204679;6366.299707032223;7442.255774422514;7443;7491.737789177353;7510.812229694301;2683.5437975544205;3126.98436507816;3185.331080473127;3194.6326172490462;3205.6153261608288;879.6613303877925;921.6497730862363;992.9056739609725;1053.5417093564324;1121.2263538158645;23239.53520929572;29213.561796573067;29446.558301625493;29996.85001574978;30070.947516837245;1056.1920131099714;1068.58859339155;1085.7177133945074;1098.9725256868642;1104.8232282834708;15393.307301171475;15421.228938553028;15487.303071361815;15500.379984800707;15549.378024879104;697891;704677;709544;710912;712708.8729112747;54940.45059549433;56473.15290270649;56509;57101;57245.71377143088;1176.1884299833089;1375.113052081402;1375.6835927736677;1398.1331574423923;1400.5728252882766;24962.62556061697;28222.71777282201;29240;29658;29920.551191731705;47923.52076479191;47926.760366197945;48497;48740;48928.51071489382;621017.789822114;626399;627067;628431;631356;25667;25749.742502574736;26082.73917260803;26094.73905260923;26171.476570468865;46604.7669761649;47101.293480598506;47361.763191183825;47518.76240618913;47839.80400489876;38197.80901095477;38621.227575448895;39015.219695606494;39223.607763921995;39687.007824803455;34420;36336;38478.268477918;38772.612273878025;39091.21817563576;37537.37238393286;37872.43191352187;38028.2394352117;38561;38863.41704874373;32522;33793;34084.65915340914;34434;34522;24886.502269954137;25104.874475627505;25365.492690146464;25402.364940876625;26042.21873343803 07:04:46 INFO - PROCESS | 1653 | |2;jquery.html;355.5431270817;367.6433859156618;373.5312183210071;386.9361555343369;393.29600015971397;20109.195632174713;21265.14939402422;21590.24434144805;22211.44471388214;22296.219632312874;20333.255010573568;20905.059272332743;21157.894210528924;21272.787272127272;21355.679664805;4245.702800803945;5385.730713464331;5902.439268269529;6017.638941663514;6048.546359023069;6305.5901366411035;6686.398224159825;6704.597724136567;6733.8989915151315;6767.492438067165;5704.372519022904;6480.4815614750705;6489.935100649004;6648.601083934979;6706.0276259942275;6531.771388001397;6567.737290508422;6597.505187110962;6622.668866556653;6661.666916654172;4862.367892173995;4947.727874966876;5129.948700513021;5166.914947860953;5754.367019627837;20212.898935505375;24657.63013554798;25426.745732542808;26027.869860650764;26873;2247.3932038349717;2288.4507718147693;2389.880505974694;2392.880355982194;2910.738033576988;12840.743185136245;16074;16158.434454794144;16185.676286474205;16268.837311626969;1874.5219968907977;1908.7804902436258;1919.3666090190204;1956.1490751523133;1958.2950137950327;93551.53224233903;114673.85326146716;117170;117959.64080718337;119188;8625.827483450295;10876.347419154876;11205.60780372683;11337.206395552397;11343.03584195336;13743.518976835963;13982.370793314121;14014.369353379123;14038.227897465737;14073.437062517589;8501.532415717194;8655.78360540979;8763.123687631185;8818.206361427503;8865.069167737423;7180.31786980236;8864.379493435397;8887.466751994902;8984.730458086267;9003.954980225057;5923.348431672513;6528;6815.352541508549;6958.547694399847;6987.161540615159;1829.954251143732;1882.1906580170657;1884.321644208084;1888.716692496109;1889.6394595890936;680.3944489404435;847.9024912135184;955.5413401567148;1010.2271762101998;1041.8697662792151;22199.44501387478;22526.887365563067;22569.548609027726;22617.434564136027;22653.660195097087;892.9955350223337;929.8837645294338;948.7011591348703;967.9806403871883;992.3301771304341;11207.775844483065;11458.369789661481;12376.195547289397;12384;12393.504259829686;594889.0255548694;608462;609096;615744;617837;76439.61780191063;76754.61622691852;143144;143487;146673.53326466813;987.6592575561419;991.7520619845038;1011.4032720694826;1020.744813796536;1026.0560284538242;20116.59766804685;20301;20573.691394628793;20576.897115514326;20644.277450289166;39648;58305.12542311784;59463.70268148631;59508.10737838849;59953;80220.59889700514;80895.59552202202;81838;83369.58315208385;84088.57955710427;8401.62192701342;8402.369822263478;8483.74548763538;8557.614907329309;8599.097094805205;9454.716358509255;13062;13333.466661333827;13679.452821887013;13747.312634368041;11144.721381965192;11493.770124597628;11621.883781162418;11653.30080195191;11979.221350612183;10025.696659434227;10753.247272690836;11625.069994400597;11784.351860647404;11835.763284734428;11153;11764.764699706408;11896.286222826659;12020.218685785396;12066.698332541757;8342.958285208535;8452.323814094734;8615.095414981588;8709.433886797338;8798.164174403422;10821.420782362255;11866.991305738764;11874.287542747463;11936.985356244817;12010.459529321026 07:04:46 INFO - PROCESS | 1653 | |3;mootools.html;1501.9249037548122;1524.268351191428;1726.4216487476695;1841.2450895132997;1848.9630207395853;7876.921230787691;8456.238938495535;8468.830623387528;8882.733517994462;8896.37725359225;8526.957365213166;8605.39762216645;8679.91320086799;8691.087435819227;8729.258013068897;2279.977200227993;2310.607196776544;2313.421644588853;2314.9884250578725;2317.860928344296;2275.283285764987;2291.644795056769;2307.711536057993;2320.814334853216;2324.9421513211532;2044;2268.5122698619793;2303.170858490942;2311.838171328008;2320.8143348532076;1740.1299350324837;2281.2129815213725;2282.954340913189;2286.371247906822;2294.621387471065;2083.541620843412;2083.656196727538;2288.6567014947723;2292.255017119426;2298.6896768936313;7684.692612295501;8771.079036701181;8794.384393092487;8812.16284452976;8824;4450.666200034978;5194.4026436959475;5350.5452036576935;5352.812651557216;5354.196870469422;2571.739847474724;2842.7441530262377;3268.2156282492033;3312.519684645737;3348.665133486656;866.2766589897443;949.4493193947563;949.852772820214;957.5164541906362;971.0871780526353;11350.489227984677;11484.253523520945;11490.770184596346;11505.906938840797;11515.712107197303;4518.186726389282;4659.464161621389;4783.354247176587;4798.2082956311815;4813.15769740294;9715;9763.755906102262;9807.75480612976;9830.852537211947;9855.704328870146;5242.449542797951;5314.867128321823;5316.521513063843;5318.468153184651;5334.67991920486;4339.327404252346;4710.081534100817;4792.496787837296;4829.541193586604;4895.461499235082;3895.8636447724193;3935.0752573145287;4013.618706222904;4014;4031.274370613259;1277.4506962006426;1305.2755720575171;1310.5347601601484;1311.7376524695098;1322.7486777512242;869.6695255802755;910.658503061352;930.4277869110583;933.9066093390607;944.8346539355585;5876.324222714443;6035.969820150959;6095.299040610386;6125.693715314216;6175.938240617626;415.6778496665109;440.47583375782716;445.6412587866798;460.5256585716717;969.2246203037682;3869.400242962345;4027.81874815634;4120.1553681495225;4133.42132101506;4142.627163555295;10400.323978941344;10706.089982351432;10806.135509159405;10825.13398928084;10842.295250808673;10594.622699049074;10750.784984300426;10769.24615276923;10784.676459706221;10792.24454288208;7705.499142555716;8138.674453021813;8141.51150930946;8168.142345053802;8191.017077950565;6028.547858910511;6153.169322141633;6167.938320616916;6212.596181248205;6338;8353.582320884054;9706.6117355305;10023.749406264902;10128.392296462236;10157.796844063225;10153.035461631429;10223.028812262823;10290.845637315597;10342.741431463972;10427.009434103747;5770.711464426678;7055.6472176392;7461.179270280156;7590.620468976639;7627.199144090013;8476.152384761475;8494.150584941457;8550;8557.272631826365;8559.614817333111;7388.630568471663;7563.394928405604;7610.353119984863;7610.885836712343;7633.1985141559335;7394.704211831681;7411.740589079356;7415.99884015651;7473.962630187032;7514.9624251878395;7043.401310888632;7073.82315442118;7111.857762844817;7112.964435177998;7127.679254433459;4950.603951683928;5082.949170508247;5095.745212739423;5134.255532947627;5360.437154098763;5131.948680513147;5147.176451767699;5188.507091826271;5299;5306.946930530646 07:04:46 INFO - PROCESS | 1653 | |4;prototype.html;244.51585859997206;313.38889166126046;315.4542641230671;318.3362688793863;318.4904153354631;4617.769111544422;5686.175504551838;5686.877014164734;5731.598788084836;5732.5987180897355;5009.499050094998;5325.08297013075;5530.70028543292;5678.4605462480995;5686.2039314496005;3235.660255673156;3991.560928297885;4100.2209580179815;4183.581641835823;4257.169851878885;4167.916641667165;4219.78901054946;4220.5180725901255;4223.429836972;4250.829966801324;3888.51393575803;3953.3512546593706;4189.53366321788;4223.197592457439;4229.598188172119;3509.508668786372;4146.979265103685;4181.351890456969;4211.978940105279;4242.618164365222;2869.569564565311;3644.471551625026;3646.872359467406;3648.5986541480415;3660.194757153422;4666.463356713987;5406.972675191701;5426.945730542723;5437.265969094201;5438.700871452069;4495.617872480843;4768.117898188846;4866.805327786919;4893.730844803535;4896.265560165968;5143.974280128613;5827.329857066449;5882.588218824684;5932.495737862287;5954.7915822946425;3288.473844184919;3789.147441825595;3965.801709914522;3984.183242435294;3987.2623564640635;5147.536721695028;5988.550858685616;6067.150598916155;6194.752209911553;6217.96891015542;3989.501312335958;4006.7996600169877;4016.3373043448087;4018.1963607278662;4019.879403617896;3798.601146879593;3911.159100793343;4050.8784736457956;4086.387041943732;4088.509378874554;4013.8394464221687;4070.247004304213;4458.464984201916;4505.620784411692;4812.639052071108;4884.535969082932;5177.8187763428095;5411.37437916589;5885.411458854081;6022.638641681426;1139.6524060161564;1350.7298540291981;1391.9860801392058;1392.269058744147;1392.6352174868684;705.7670968580459;743.3272888036228;793.476305638276;847.8045955203133;858.965641374338;4849.4908034656555;5436.450611575682;5460.863478413072;5488.725563721798;5492.505674489235;5242.475752424803;5267.552258058031;5339.944121513167;6053.182820319201;6102.084687296941;4614.377059097046;5129.8717532062;5432.837014889559;5461.5357694596405;5470.425605311465;2562.8590427526665;2721.8911243550037;2885.9855700721782;3157.4158780625658;3244.0105767741065;5371.3617346709625;5494.972525137348;6049.6055689082195;6226.1905952225925;6252.499800015988;5588.329400471969;6027.60820546663;6193.721282542297;6207.610070123035;6224.844378890473;5481.643693159932;5925.64446133242;6209.534284928648;6213.539818142733;6260.686965651699;5522.5581953442825;5729.455701708331;6016.09758536223;6201.3178550358525;6242.375762423721;6117.296510901303;6148.370681769424;6161.661108638888;6175.660338681416;6190.164327815687;5215.16557350822;5789.739461724317;6188.11262564922;6390.201224846895;6456.128422663069;3609.097725568608;4006.358982562776;4015.317396042738;4025.3961905714377;4051.0480037191824;5905;6224.315325314121;6252.4681453044295;6262.718177682106;6282.183316168869;5015.724135172601;5628.831135065954;5744.310682717934;5938.643681378958;5958;4359.09860674688;5027.698338099725;5683.630564013326;5974;6033.396660334107;5621.325440947113;5882.411758824254;5896.027155519291;5907.32065812437;5912.556558258062;5308.548773354154;5799.391063938226;5850.946829570718;5977.342492325927;5997.0404735242155;5871.735771890189;5874.676892770939;5877.764889404376;5895.29256489224;5910 07:04:46 INFO - PROCESS | 1653 | |5;yui.html;635.8982562789953;677.2347247610202;719.1765428584271;723.844373459706;820.7250571058695;15214.695706085886;15677.686446271082;15714.685706285896;15733.056016638995;15788.526344209664;14012.369443375048;14083.436662533486;14089.647758806035;14093.71812563748;14108.788368174486;833.4874052457741;843.0431460292551;857.4512312120248;875.8554838451648;879.1033146190881;661.8940969444866;866.1425189062813;867.1371984875058;870.6256309786789;871.2376670413388;913.2876356441952;915.2174890468654;916.5279880861361;920.0707285641516;924.6116631014957;866.8786369908217;893.2139717048988;910.9453432794021;918.2883265469248;919.6321471411422;659.9076129341896;669.0666520204336;683.2211279141783;683.9555428897106;686.8317262270775;15510;15635.609109772233;15641.530754077396;15651.060936343856;15674.294656740474;12993.935030324788;13259.27074010929;14085.859141408557;14301.070430421989;14330.92834535831;11788.646340609796;11851.762964740743;11936.568385350014;12027.278363298143;12181.039670185932;3779.5464544254864;3782.659560639528;3837.863728894733;3847.9615203847884;3890.435886796427;105651;111086.23403883171;113386.43306783495;113844;115697.42151289273;10838.132949364031;10877.184211184192;11012.119030477543;11112.44437778108;11245.493952772145;21459.356219313446;21620.13519459204;21910.342689719335;22380;22429.66355504669;6633.734650613921;6835.316468353125;8030.598470076473;8085.393595480245;8162.795930101676;4364.781760912006;4527.909441811145;4544.772761361919;4549.953510692493;4564.612007979359;3386.72906167506;3481.7040551552896;3522.330757156132;3522.806245656462;3530.417481115587;630.0360448513782;636.5067073018355;641.6374748267214;650.9064771184455;662.7117204016268;486.4794669703454;627.7645882793952;632.7911789109583;641.6022066318912;647.4431988489895;8559.786005349915;8833.514156721441;8885;9008.684696035738;9142.451452912846;515.827197888704;568.3009897825698;601.8044135655929;628.3810446709987;632.6425569553188;3896.8699077267274;3961.2869683457257;4364.781760911942;4372.322290045048;4422.20400327944;94624.63438413957;120002;144368.27815861063;146880;157884.21057894867;91302.54348728214;109302;130810;130815.34592327169;132439.33780331037;111205;111428.44285778356;111985;113275.43362283136;116771;8440.282575980866;8520.701775438078;8573.871391929251;8602.913970860462;8650;61433.07850382158;62698.37301626925;62927.6853615729;64724.67637661781;65360.346396535424;94280.05719942713;97232;97883.61372208653;98053;101707;11135.498902549567;11137.266587207121;11247.044001259985;11402.087832973177;11427.485763140512;12102.939485302517;12109.218064132343;12276.570320038756;12303.138780285293;12340.259584424604;9904.504774761377;11458.431456151047;11664.941675291908;11976.341301228167;12148.817767733315;11821.881781182077;11860.22908510944;11928.642140735792;12017.278963262232;12313;10897.564097436014;11627.825582616098;11937.940310298392;11973.580924667594;12152.786375409305;9379.249660027317;9759.60961561558;9805.313628045968;9810.215182785218;10230.181585472996;9265.53672316368;9409.717708468757;9871.654492092743;9916.553755080895;9948.801023979624 07:04:46 INFO - PROCESS | 1653 | __end_tp_report 07:04:46 INFO - PROCESS | 1653 | __start_cc_report 07:04:46 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,438 07:04:46 INFO - PROCESS | 1653 | __end_cc_report 07:04:46 INFO - PROCESS | 1653 | __startTimestamp1469801086391__endTimestamp 07:04:46 INFO - PROCESS | 1653 | 07:04:46 INFO - PROCESS | 1653 | ------- Summary: start ------- 07:04:46 INFO - PROCESS | 1653 | Number of tests: 6 07:04:46 INFO - PROCESS | 1653 | 07:04:46 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5665.77 Median:5896.59 stddev:762.69 (12.9%) stddev-sans-first:742.33 07:04:46 INFO - PROCESS | 1653 | Values: 3311.2 3314.0 3380.5 3391.4 3414.0 5621.3 5660.9 5719.4 5725.2 5771.1 5589.2 5694.9 5763.2 5775.5 5821.9 5112.6 5141.2 5196.2 5259.5 5280.3 594.4 5089.3 5124.3 5198.9 5203.8 5122.7 5154.7 5180.5 5188.2 5188.5 5161.5 5182.8 5202.7 5214.9 5250.3 5085.2 5115.3 5143.1 5146.5 5179.9 5523.4 5676.4 5685.9 5690.4 5738.7 6086.6 6133.6 6207.7 6220.7 6232.4 6149.6 6180.9 6223.8 6224.7 6253.0 5825.6 5829.4 5835.0 5854.1 5870.6 5601.8 6122.5 6180.8 6229.8 6235.5 6027.2 6037.5 6062.4 6067.8 6073.2 5723.1 6191.9 6206.6 6251.8 6255.1 5079.0 6108.8 6122.3 6140.2 6143.9 5883.4 6184.6 6194.2 6202.1 6220.3 4932.0 4933.7 4947.6 4959.2 4961.6 3658.9 4198.9 4352.9 4375.7 4469.2 4677.9 5563.6 5728.2 5732.3 5733.8 6152.9 6191.4 6199.1 6202.2 6217.7 5688.4 5755.5 5814.5 5821.7 5839.6 5367.6 5398.8 5412.2 5415.8 5422.2 6219.2 6274.9 6288.0 6295.6 6301.2 6228.6 6255.5 6264.3 6273.8 6283.0 6271.1 6280.2 6281.0 6285.7 6320.8 6059.8 6126.1 6157.5 6173.5 6204.3 6194.8 6295.2 6304.9 6307.8 6310.8 4842.0 6052.9 6102.0 6134.5 6148.5 5896.6 5979.6 6017.3 6077.9 6144.2 5772.3 5845.1 5908.8 5949.8 5952.1 6046.4 6060.9 6061.1 6099.8 6112.6 5821.0 5910.6 5932.4 5944.8 5997.3 07:04:46 INFO - PROCESS | 1653 | 07:04:46 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:70300.19 Median:38539.00 stddev:163635.08 (424.6%) stddev-sans-first:164010.19 07:04:46 INFO - PROCESS | 1653 | Values: 498.7 498.8 499.1 541.6 573.3 37382.6 39410.8 39441.8 39498.8 39558.4 39873.0 40172.0 40227.4 40721.8 40750.0 9323.8 9326.0 9347.0 9450.3 9464.6 9486.6 9528.8 9622.6 9646.2 9732.0 9422.6 9537.0 9594.8 9605.0 9608.5 8010.0 9547.3 9597.0 9642.8 9645.7 9437.8 9491.9 9493.2 9539.5 9557.7 38517.0 38861.8 38904.0 38936.8 38960.6 3023.8 3287.1 3287.5 3372.0 3421.3 25178.9 28273.0 28511.6 29216.7 29294.0 2864.1 2922.7 2931.5 2954.8 2991.8 462791.0 464692.0 468955.0 470429.0 470706.0 27082.9 31964.0 32193.2 32228.0 32841.3 29576.9 32636.0 33773.0 34144.7 34332.0 14349.5 14595.5 14601.0 14606.5 14617.0 11993.0 12222.0 12380.3 12431.8 12449.6 6366.3 7442.3 7443.0 7491.7 7510.8 2683.5 3127.0 3185.3 3194.6 3205.6 879.7 921.6 992.9 1053.5 1121.2 23239.5 29213.6 29446.6 29996.9 30070.9 1056.2 1068.6 1085.7 1099.0 1104.8 15393.3 15421.2 15487.3 15500.4 15549.4 697891.0 704677.0 709544.0 710912.0 712708.9 54940.5 56473.2 56509.0 57101.0 57245.7 1176.2 1375.1 1375.7 1398.1 1400.6 24962.6 28222.7 29240.0 29658.0 29920.6 47923.5 47926.8 48497.0 48740.0 48928.5 621017.8 626399.0 627067.0 628431.0 631356.0 25667.0 25749.7 26082.7 26094.7 26171.5 46604.8 47101.3 47361.8 47518.8 47839.8 38197.8 38621.2 39015.2 39223.6 39687.0 34420.0 36336.0 38478.3 38772.6 39091.2 37537.4 37872.4 38028.2 38561.0 38863.4 32522.0 33793.0 34084.7 34434.0 34522.0 24886.5 25104.9 25365.5 25402.4 26042.2 07:04:46 INFO - PROCESS | 1653 | 07:04:46 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:35512.22 Median:25042.19 stddev:101340.00 (404.7%) stddev-sans-first:101589.90 07:04:46 INFO - PROCESS | 1653 | Values: 355.5 367.6 373.5 386.9 393.3 20109.2 21265.1 21590.2 22211.4 22296.2 20333.3 20905.1 21157.9 21272.8 21355.7 4245.7 5385.7 5902.4 6017.6 6048.5 6305.6 6686.4 6704.6 6733.9 6767.5 5704.4 6480.5 6489.9 6648.6 6706.0 6531.8 6567.7 6597.5 6622.7 6661.7 4862.4 4947.7 5129.9 5166.9 5754.4 20212.9 24657.6 25426.7 26027.9 26873.0 2247.4 2288.5 2389.9 2392.9 2910.7 12840.7 16074.0 16158.4 16185.7 16268.8 1874.5 1908.8 1919.4 1956.1 1958.3 93551.5 114673.9 117170.0 117959.6 119188.0 8625.8 10876.3 11205.6 11337.2 11343.0 13743.5 13982.4 14014.4 14038.2 14073.4 8501.5 8655.8 8763.1 8818.2 8865.1 7180.3 8864.4 8887.5 8984.7 9004.0 5923.3 6528.0 6815.4 6958.5 6987.2 1830.0 1882.2 1884.3 1888.7 1889.6 680.4 847.9 955.5 1010.2 1041.9 22199.4 22526.9 22569.5 22617.4 22653.7 893.0 929.9 948.7 968.0 992.3 11207.8 11458.4 12376.2 12384.0 12393.5 594889.0 608462.0 609096.0 615744.0 617837.0 76439.6 76754.6 143144.0 143487.0 146673.5 987.7 991.8 1011.4 1020.7 1026.1 20116.6 20301.0 20573.7 20576.9 20644.3 39648.0 58305.1 59463.7 59508.1 59953.0 80220.6 80895.6 81838.0 83369.6 84088.6 8401.6 8402.4 8483.7 8557.6 8599.1 9454.7 13062.0 13333.5 13679.5 13747.3 11144.7 11493.8 11621.9 11653.3 11979.2 10025.7 10753.2 11625.1 11784.4 11835.8 11153.0 11764.8 11896.3 12020.2 12066.7 8343.0 8452.3 8615.1 8709.4 8798.2 10821.4 11867.0 11874.3 11937.0 12010.5 07:04:46 INFO - PROCESS | 1653 | 07:04:46 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5678.33 Median:5113.85 stddev:3219.77 (63.0%) stddev-sans-first:3213.51 07:04:46 INFO - PROCESS | 1653 | Values: 1501.9 1524.3 1726.4 1841.2 1849.0 7876.9 8456.2 8468.8 8882.7 8896.4 8527.0 8605.4 8679.9 8691.1 8729.3 2280.0 2310.6 2313.4 2315.0 2317.9 2275.3 2291.6 2307.7 2320.8 2324.9 2044.0 2268.5 2303.2 2311.8 2320.8 1740.1 2281.2 2283.0 2286.4 2294.6 2083.5 2083.7 2288.7 2292.3 2298.7 7684.7 8771.1 8794.4 8812.2 8824.0 4450.7 5194.4 5350.5 5352.8 5354.2 2571.7 2842.7 3268.2 3312.5 3348.7 866.3 949.4 949.9 957.5 971.1 11350.5 11484.3 11490.8 11505.9 11515.7 4518.2 4659.5 4783.4 4798.2 4813.2 9715.0 9763.8 9807.8 9830.9 9855.7 5242.4 5314.9 5316.5 5318.5 5334.7 4339.3 4710.1 4792.5 4829.5 4895.5 3895.9 3935.1 4013.6 4014.0 4031.3 1277.5 1305.3 1310.5 1311.7 1322.7 869.7 910.7 930.4 933.9 944.8 5876.3 6036.0 6095.3 6125.7 6175.9 415.7 440.5 445.6 460.5 969.2 3869.4 4027.8 4120.2 4133.4 4142.6 10400.3 10706.1 10806.1 10825.1 10842.3 10594.6 10750.8 10769.2 10784.7 10792.2 7705.5 8138.7 8141.5 8168.1 8191.0 6028.5 6153.2 6167.9 6212.6 6338.0 8353.6 9706.6 10023.7 10128.4 10157.8 10153.0 10223.0 10290.8 10342.7 10427.0 5770.7 7055.6 7461.2 7590.6 7627.2 8476.2 8494.2 8550.0 8557.3 8559.6 7388.6 7563.4 7610.4 7610.9 7633.2 7394.7 7411.7 7416.0 7474.0 7515.0 7043.4 7073.8 7111.9 7113.0 7127.7 4950.6 5082.9 5095.7 5134.3 5360.4 5131.9 5147.2 5188.5 5299.0 5306.9 07:04:46 INFO - PROCESS | 1653 | 07:04:46 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4733.74 Median:5409.17 stddev:1509.85 (27.9%) stddev-sans-first:1476.01 07:04:46 INFO - PROCESS | 1653 | Values: 244.5 313.4 315.5 318.3 318.5 4617.8 5686.2 5686.9 5731.6 5732.6 5009.5 5325.1 5530.7 5678.5 5686.2 3235.7 3991.6 4100.2 4183.6 4257.2 4167.9 4219.8 4220.5 4223.4 4250.8 3888.5 3953.4 4189.5 4223.2 4229.6 3509.5 4147.0 4181.4 4212.0 4242.6 2869.6 3644.5 3646.9 3648.6 3660.2 4666.5 5407.0 5426.9 5437.3 5438.7 4495.6 4768.1 4866.8 4893.7 4896.3 5144.0 5827.3 5882.6 5932.5 5954.8 3288.5 3789.1 3965.8 3984.2 3987.3 5147.5 5988.6 6067.2 6194.8 6218.0 3989.5 4006.8 4016.3 4018.2 4019.9 3798.6 3911.2 4050.9 4086.4 4088.5 4013.8 4070.2 4458.5 4505.6 4812.6 4884.5 5177.8 5411.4 5885.4 6022.6 1139.7 1350.7 1392.0 1392.3 1392.6 705.8 743.3 793.5 847.8 859.0 4849.5 5436.5 5460.9 5488.7 5492.5 5242.5 5267.6 5339.9 6053.2 6102.1 4614.4 5129.9 5432.8 5461.5 5470.4 2562.9 2721.9 2886.0 3157.4 3244.0 5371.4 5495.0 6049.6 6226.2 6252.5 5588.3 6027.6 6193.7 6207.6 6224.8 5481.6 5925.6 6209.5 6213.5 6260.7 5522.6 5729.5 6016.1 6201.3 6242.4 6117.3 6148.4 6161.7 6175.7 6190.2 5215.2 5789.7 6188.1 6390.2 6456.1 3609.1 4006.4 4015.3 4025.4 4051.0 5905.0 6224.3 6252.5 6262.7 6282.2 5015.7 5628.8 5744.3 5938.6 5958.0 4359.1 5027.7 5683.6 5974.0 6033.4 5621.3 5882.4 5896.0 5907.3 5912.6 5308.5 5799.4 5850.9 5977.3 5997.0 5871.7 5874.7 5877.8 5895.3 5910.0 07:04:46 INFO - PROCESS | 1653 | 07:04:46 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:24103.87 Median:4163.03 stddev:38591.29 (927.0%) stddev-sans-first:38659.33 07:04:46 INFO - PROCESS | 1653 | Values: 635.9 677.2 719.2 723.8 820.7 15214.7 15677.7 15714.7 15733.1 15788.5 14012.4 14083.4 14089.6 14093.7 14108.8 833.5 843.0 857.5 875.9 879.1 661.9 866.1 867.1 870.6 871.2 913.3 915.2 916.5 920.1 924.6 866.9 893.2 910.9 918.3 919.6 659.9 669.1 683.2 684.0 686.8 15510.0 15635.6 15641.5 15651.1 15674.3 12993.9 13259.3 14085.9 14301.1 14330.9 11788.6 11851.8 11936.6 12027.3 12181.0 3779.5 3782.7 3837.9 3848.0 3890.4 105651.0 111086.2 113386.4 113844.0 115697.4 10838.1 10877.2 11012.1 11112.4 11245.5 21459.4 21620.1 21910.3 22380.0 22429.7 6633.7 6835.3 8030.6 8085.4 8162.8 4364.8 4527.9 4544.8 4550.0 4564.6 3386.7 3481.7 3522.3 3522.8 3530.4 630.0 636.5 641.6 650.9 662.7 486.5 627.8 632.8 641.6 647.4 8559.8 8833.5 8885.0 9008.7 9142.5 515.8 568.3 601.8 628.4 632.6 3896.9 3961.3 4364.8 4372.3 4422.2 94624.6 120002.0 144368.3 146880.0 157884.2 91302.5 109302.0 130810.0 130815.3 132439.3 111205.0 111428.4 111985.0 113275.4 116771.0 8440.3 8520.7 8573.9 8602.9 8650.0 61433.1 62698.4 62927.7 64724.7 65360.3 94280.1 97232.0 97883.6 98053.0 101707.0 11135.5 11137.3 11247.0 11402.1 11427.5 12102.9 12109.2 12276.6 12303.1 12340.3 9904.5 11458.4 11664.9 11976.3 12148.8 11821.9 11860.2 11928.6 12017.3 12313.0 10897.6 11627.8 11937.9 11973.6 12152.8 9379.2 9759.6 9805.3 9810.2 10230.2 9265.5 9409.7 9871.7 9916.6 9948.8 07:04:46 INFO - PROCESS | 1653 | -------- Summary: end -------- 07:04:46 INFO - PROCESS | 1653 | 07:04:46 INFO - TEST-INFO | 1653: exit 0 07:04:46 INFO - TEST-OK | dromaeo_css | took 1111896ms 07:04:46 INFO - TEST-START | kraken 07:04:46 INFO - operating with platform_type : mac_ 07:04:46 INFO - Initialising browser for kraken test... 07:04:46 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpLJyP82/profile http://localhost:49271/getInfo.html) 07:04:49 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 07:04:49 INFO - PROCESS | 1664 | colorDepth:24 07:04:49 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 07:04:49 INFO - PROCESS | 1664 | __metrics 07:04:49 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:04:50 INFO - TEST-INFO | 1664: exit 0 07:04:50 INFO - Browser initialized. 07:04:50 INFO - Running cycle 1/1 for kraken test... 07:04:50 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpLJyP82/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:05:02 INFO - PROCESS | 1666 | RSS: Main: 255754240 07:05:02 INFO - PROCESS | 1666 | 07:05:05 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 07:05:06 INFO - PROCESS | 1666 | RSS: Main: 268390400 07:05:06 INFO - PROCESS | 1666 | 07:05:08 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 07:05:09 INFO - PROCESS | 1666 | RSS: Main: 272494592 07:05:09 INFO - PROCESS | 1666 | 07:05:12 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 07:05:13 INFO - PROCESS | 1666 | RSS: Main: 272691200 07:05:13 INFO - PROCESS | 1666 | 07:05:15 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 07:05:15 INFO - PROCESS | 1666 | RSS: Main: 273698816 07:05:15 INFO - PROCESS | 1666 | 07:05:17 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:05:18 INFO - PROCESS | 1666 | RSS: Main: 274243584 07:05:18 INFO - PROCESS | 1666 | 07:05:21 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 07:05:21 INFO - PROCESS | 1666 | RSS: Main: 274620416 07:05:21 INFO - PROCESS | 1666 | 07:05:25 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 07:05:25 INFO - PROCESS | 1666 | RSS: Main: 274898944 07:05:25 INFO - PROCESS | 1666 | 07:05:29 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 07:05:29 INFO - PROCESS | 1666 | RSS: Main: 274878464 07:05:29 INFO - PROCESS | 1666 | 07:05:31 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:05:31 INFO - PROCESS | 1666 | RSS: Main: 274489344 07:05:31 INFO - PROCESS | 1666 | 07:05:33 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:05:34 INFO - PROCESS | 1666 | RSS: Main: 274599936 07:05:34 INFO - PROCESS | 1666 | 07:05:36 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:05:37 INFO - PROCESS | 1666 | RSS: Main: 274923520 07:05:37 INFO - PROCESS | 1666 | 07:05:40 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:05:40 INFO - PROCESS | 1666 | RSS: Main: 275415040 07:05:40 INFO - PROCESS | 1666 | 07:05:43 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:05:44 INFO - PROCESS | 1666 | RSS: Main: 275017728 07:05:44 INFO - PROCESS | 1666 | 07:05:46 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 07:05:46 INFO - PROCESS | 1666 | RSS: Main: 275898368 07:05:46 INFO - PROCESS | 1666 | 07:05:46 INFO - PROCESS | 1666 | __start_tp_report 07:05:46 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 07:05:46 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 07:05:46 INFO - PROCESS | 1666 | |i|pagename|runs| 07:05:46 INFO - PROCESS | 1666 | |0;ai-astar;106;148;107;117;164;114;113;117;117;116 07:05:46 INFO - PROCESS | 1666 | |1;audio-beat-detection;145;112;131;152;112;134;128;109;160;115 07:05:46 INFO - PROCESS | 1666 | |2;audio-dft;199;200;193;218;232;197;195;198;199;187 07:05:46 INFO - PROCESS | 1666 | |3;audio-fft;72;81;72;109;57;62;73;90;131;59 07:05:46 INFO - PROCESS | 1666 | |4;audio-oscillator;70;70;118;69;72;79;116;71;74;115 07:05:46 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;90;88;90;87;89;87;91;106;121;130 07:05:46 INFO - PROCESS | 1666 | |6;imaging-darkroom;142;134;135;105;108;151;105;152;147;94 07:05:46 INFO - PROCESS | 1666 | |7;imaging-desaturate;77;125;87;136;143;145;92;91;134;143 07:05:46 INFO - PROCESS | 1666 | |8;json-parse-financial;57;58;59;59;58;60;59;60;57;57 07:05:46 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;67;69;66;74;71;80;73;69;69;71 07:05:46 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;85;83;86;98;105;106;104;77;85;89 07:05:46 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;136;133;141;165;149;157;159;148;198;154 07:05:46 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;171;173;173;222;244;228;173;172;170;199 07:05:46 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;69;79;92;89;72;68;66;68;78;97 07:05:46 INFO - PROCESS | 1666 | __end_tp_report 07:05:46 INFO - PROCESS | 1666 | __start_cc_report 07:05:46 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1106 07:05:46 INFO - PROCESS | 1666 | __end_cc_report 07:05:46 INFO - PROCESS | 1666 | __startTimestamp1469801146689__endTimestamp 07:05:46 INFO - PROCESS | 1666 | 07:05:46 INFO - PROCESS | 1666 | ------- Summary: start ------- 07:05:46 INFO - PROCESS | 1666 | Number of tests: 14 07:05:46 INFO - PROCESS | 1666 | 07:05:46 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:121.90 Median:117.00 stddev:18.79 (16.1%) stddev-sans-first:19.03 07:05:46 INFO - PROCESS | 1666 | Values: 106.0 148.0 107.0 117.0 164.0 114.0 113.0 117.0 117.0 116.0 07:05:46 INFO - PROCESS | 1666 | 07:05:46 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:129.80 Median:132.50 stddev:18.08 (13.6%) stddev-sans-first:18.33 07:05:46 INFO - PROCESS | 1666 | Values: 145.0 112.0 131.0 152.0 112.0 134.0 128.0 109.0 160.0 115.0 07:05:46 INFO - PROCESS | 1666 | 07:05:46 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:201.80 Median:199.00 stddev:13.22 (6.6%) stddev-sans-first:13.99 07:05:46 INFO - PROCESS | 1666 | Values: 199.0 200.0 193.0 218.0 232.0 197.0 195.0 198.0 199.0 187.0 07:05:46 INFO - PROCESS | 1666 | 07:05:46 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:80.60 Median:72.00 stddev:23.59 (32.8%) stddev-sans-first:24.82 07:05:46 INFO - PROCESS | 1666 | Values: 72.0 81.0 72.0 109.0 57.0 62.0 73.0 90.0 131.0 59.0 07:05:46 INFO - PROCESS | 1666 | 07:05:46 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:85.40 Median:70.50 stddev:21.54 (30.6%) stddev-sans-first:22.12 07:05:46 INFO - PROCESS | 1666 | Values: 70.0 70.0 118.0 69.0 72.0 79.0 116.0 71.0 74.0 115.0 07:05:46 INFO - PROCESS | 1666 | 07:05:46 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:97.90 Median:88.50 stddev:15.69 (17.7%) stddev-sans-first:16.38 07:05:46 INFO - PROCESS | 1666 | Values: 90.0 88.0 90.0 87.0 89.0 87.0 91.0 106.0 121.0 130.0 07:05:46 INFO - PROCESS | 1666 | 07:05:46 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:127.30 Median:144.50 stddev:22.00 (15.2%) stddev-sans-first:22.68 07:05:46 INFO - PROCESS | 1666 | Values: 142.0 134.0 135.0 105.0 108.0 151.0 105.0 152.0 147.0 94.0 07:05:46 INFO - PROCESS | 1666 | 07:05:46 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:117.30 Median:111.00 stddev:27.18 (24.5%) stddev-sans-first:24.61 07:05:46 INFO - PROCESS | 1666 | Values: 77.0 125.0 87.0 136.0 143.0 145.0 92.0 91.0 134.0 143.0 07:05:46 INFO - PROCESS | 1666 | 07:05:46 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:59.00 stddev:1.17 (2.0%) stddev-sans-first:1.13 07:05:46 INFO - PROCESS | 1666 | Values: 57.0 58.0 59.0 59.0 58.0 60.0 59.0 60.0 57.0 57.0 07:05:46 INFO - PROCESS | 1666 | 07:05:46 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:71.00 stddev:4.04 (5.7%) stddev-sans-first:4.03 07:05:46 INFO - PROCESS | 1666 | Values: 67.0 69.0 66.0 74.0 71.0 80.0 73.0 69.0 69.0 71.0 07:05:46 INFO - PROCESS | 1666 | 07:05:46 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:91.80 Median:85.00 stddev:10.51 (12.4%) stddev-sans-first:10.85 07:05:46 INFO - PROCESS | 1666 | Values: 85.0 83.0 86.0 98.0 105.0 106.0 104.0 77.0 85.0 89.0 07:05:46 INFO - PROCESS | 1666 | 07:05:46 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:154.00 Median:155.50 stddev:18.52 (11.9%) stddev-sans-first:18.46 07:05:46 INFO - PROCESS | 1666 | Values: 136.0 133.0 141.0 165.0 149.0 157.0 159.0 148.0 198.0 154.0 07:05:46 INFO - PROCESS | 1666 | 07:05:46 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.50 Median:186.00 stddev:28.59 (15.4%) stddev-sans-first:29.24 07:05:46 INFO - PROCESS | 1666 | Values: 171.0 173.0 173.0 222.0 244.0 228.0 173.0 172.0 170.0 199.0 07:05:46 INFO - PROCESS | 1666 | 07:05:46 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.80 Median:78.50 stddev:11.25 (14.3%) stddev-sans-first:11.48 07:05:46 INFO - PROCESS | 1666 | Values: 69.0 79.0 92.0 89.0 72.0 68.0 66.0 68.0 78.0 97.0 07:05:46 INFO - PROCESS | 1666 | -------- Summary: end -------- 07:05:46 INFO - PROCESS | 1666 | 07:05:47 INFO - TEST-INFO | 1666: exit 0 07:05:47 INFO - TEST-OK | kraken | took 60514ms 07:05:47 INFO - SUITE-END | took 1172s 07:05:47 INFO - Completed test suite (00:19:32) 07:05:47 INFO - javascript benchmark 07:05:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7243.40896629033, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3311.205310725426, 3314.0, 3380.4760262159343, 3391.4404123319655, 3413.9829300853476, 5621.2692349994495, 5660.915086273699, 5719.428057194289, 5725.169850371693, 5771.134329850514, 5589.245451863997, 5694.914576281359, 5763.221965034709, 5775.451332123442, 5821.941780582193, 5112.642115051948, 5141.228815677641, 5196.246544251081, 5259.526642602165, 5280.287161233223, 594.3861407584532, 5089.338386009814, 5124.282600435923, 5198.870028249286, 5203.843884683447, 5122.743862806845, 5154.742262886878, 5180.456052114511, 5188.16989281715, 5188.481151884819, 5161.5354618084175, 5182.818601348972, 5202.739863006872, 5214.921776173361, 5250.264962905197, 5085.160948443502, 5115.309433226504, 5143.074246635604, 5146.485351464824, 5179.948200518022, 5523.447655234485, 5676.432356764331, 5685.914711279334, 5690.40250773667, 5738.713064346766, 6086.573939824214, 6133.6319820810895, 6207.658578778165, 6220.720067596969, 6232.439080482733, 6149.585595313103, 6180.907286390708, 6223.844403889893, 6224.657643829588, 6252.968735156295, 5825.592208545403, 5829.446202610745, 5834.97082514589, 5854.092615644582, 5870.589058765888, 5601.775928962796, 6122.54080943931, 6180.752769889244, 6229.781957631461, 6235.469985051231, 6027.246594175728, 6037.516998640098, 6062.393760623991, 6067.848303792441, 6073.18012068374, 5723.055695810144, 6191.876162476725, 6206.596571222856, 6251.78118765841, 6255.093011513305, 5078.974605127025, 6108.847278818065, 6122.265328160649, 6140.162398500937, 6143.877122457615, 5883.352831188651, 6184.5980011299125, 6194.225721784777, 6202.100695399142, 6220.34686357935, 4932.013597280558, 4933.728644924564, 4947.604191664658, 4959.231319145538, 4961.578265847371, 3658.8902332930056, 4198.887294866801, 4352.911772056986, 4375.7374557526655, 4469.217886869785, 4677.906441871143, 5563.554915606742, 5728.1694154348215, 5732.3407808101765, 5733.827985160452, 6152.907706384408, 6191.380861913863, 6199.101130336076, 6202.1937148171355, 6217.720202590895, 5688.431156884279, 5755.482006619424, 5814.505767009767, 5821.679807610537, 5839.562032847553, 5367.624266301399, 5398.78404863801, 5412.188171774265, 5415.83752487426, 5422.240886275925, 6219.160413344141, 6274.905876411949, 6287.96856015717, 6295.559310848288, 6301.243850737941, 6228.5951413158, 6255.499560035095, 6264.31092579825, 6273.780417685359, 6283.0, 6271.059341098871, 6280.152179455715, 6281.0, 6285.717142728679, 6320.778772742932, 6059.787907423219, 6126.059675755388, 6157.476614487819, 6173.506119510518, 6204.348543403058, 6194.81415557534, 6295.150154729053, 6304.905426418516, 6307.842303942438, 6310.810675679737, 4841.975790121168, 6052.878942421215, 6101.969490152698, 6134.539909506716, 6148.538859585638, 5896.587238893237, 5979.5814292999075, 6017.308009578955, 6077.908831367445, 6144.170536977451, 5772.307323121252, 5845.09401042839, 5908.822735317947, 5949.791757288474, 5952.136940143569, 6046.395360463918, 6060.939390606038, 6061.121137435135, 6099.786507472217, 6112.602680825732, 5821.010428227296, 5910.615809972338, 5932.436418540232, 5944.791932282349, 5997.280326360865], "value": 5618.500390952523, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.73567009484964, 498.7730582584924, 499.13649386561247, 541.5910987204661, 573.2805329311718, 37382.62617373829, 39410.80294598526, 39441.80279098604, 39498.81503554898, 39558.406623900664, 39873.00317492057, 40172.0, 40227.39658905112, 40721.79639101808, 40750.0, 9323.813523729521, 9326.02076781935, 9346.953265233698, 9450.33847630666, 9464.574094165744, 9486.573104210293, 9528.809423811519, 9622.56698448568, 9646.180074693624, 9732.0, 9422.62309507619, 9536.952315238414, 9594.760130996747, 9604.991475895034, 9608.471534065624, 8009.999999999971, 9547.331686781929, 9597.0, 9642.75893102671, 9645.662401815904, 9437.811243775155, 9491.905080949171, 9493.240540756722, 9539.47532885691, 9557.713268601952, 38517.0, 38861.80569097165, 38904.0, 38936.80531597324, 38960.61039389598, 3023.8488075596133, 3287.0631869917197, 3287.539744435781, 3371.96628033719, 3421.26442814796, 25178.866950987067, 28273.03133171008, 28511.57232641512, 29216.707832921613, 29294.0, 2864.1264414353614, 2922.7369536741794, 2931.457680329146, 2954.847609432323, 2991.820490770561, 462791.0, 464692.0, 468954.99999999657, 470429.0, 470706.0, 27082.86458567734, 31964.041078767674, 32193.195170120933, 32228.0, 32841.3431731364, 29576.852115739715, 32636.0, 33773.0, 34144.65855341464, 34332.0, 14349.497767578294, 14595.489157879423, 14601.0, 14606.488772892897, 14617.0, 11992.980596649382, 12222.0, 12380.319082450551, 12431.813522797165, 12449.626511204679, 6366.299707032223, 7442.255774422514, 7443.0, 7491.737789177353, 7510.812229694301, 2683.5437975544205, 3126.98436507816, 3185.331080473127, 3194.6326172490462, 3205.6153261608288, 879.6613303877925, 921.6497730862363, 992.9056739609725, 1053.5417093564324, 1121.2263538158645, 23239.53520929572, 29213.561796573067, 29446.558301625493, 29996.85001574978, 30070.947516837245, 1056.1920131099714, 1068.58859339155, 1085.7177133945074, 1098.9725256868642, 1104.8232282834708, 15393.307301171475, 15421.228938553028, 15487.303071361815, 15500.379984800707, 15549.378024879104, 697891.0, 704677.0, 709544.0, 710912.0, 712708.8729112747, 54940.45059549433, 56473.15290270649, 56509.0, 57101.0, 57245.71377143088, 1176.1884299833089, 1375.113052081402, 1375.6835927736677, 1398.1331574423923, 1400.5728252882766, 24962.62556061697, 28222.71777282201, 29240.0, 29658.0, 29920.551191731705, 47923.52076479191, 47926.760366197945, 48497.0, 48740.0, 48928.51071489382, 621017.789822114, 626399.0, 627067.0, 628431.0, 631356.0, 25667.0, 25749.742502574736, 26082.73917260803, 26094.73905260923, 26171.476570468865, 46604.7669761649, 47101.293480598506, 47361.763191183825, 47518.76240618913, 47839.80400489876, 38197.80901095477, 38621.227575448895, 39015.219695606494, 39223.607763921995, 39687.007824803455, 34420.0, 36336.0, 38478.268477918, 38772.612273878025, 39091.21817563576, 37537.37238393286, 37872.43191352187, 38028.2394352117, 38561.0, 38863.41704874373, 32522.0, 33793.0, 34084.65915340914, 34434.0, 34522.0, 24886.502269954137, 25104.874475627505, 25365.492690146464, 25402.364940876625, 26042.21873343803], "value": 18024.20173525632, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.5431270817, 367.6433859156618, 373.5312183210071, 386.9361555343369, 393.29600015971397, 20109.195632174713, 21265.14939402422, 21590.24434144805, 22211.44471388214, 22296.219632312874, 20333.255010573568, 20905.059272332743, 21157.894210528924, 21272.787272127272, 21355.679664805, 4245.702800803945, 5385.730713464331, 5902.439268269529, 6017.638941663514, 6048.546359023069, 6305.5901366411035, 6686.398224159825, 6704.597724136567, 6733.8989915151315, 6767.492438067165, 5704.372519022904, 6480.4815614750705, 6489.935100649004, 6648.601083934979, 6706.0276259942275, 6531.771388001397, 6567.737290508422, 6597.505187110962, 6622.668866556653, 6661.666916654172, 4862.367892173995, 4947.727874966876, 5129.948700513021, 5166.914947860953, 5754.367019627837, 20212.898935505375, 24657.63013554798, 25426.745732542808, 26027.869860650764, 26873.0, 2247.3932038349717, 2288.4507718147693, 2389.880505974694, 2392.880355982194, 2910.738033576988, 12840.743185136245, 16074.0, 16158.434454794144, 16185.676286474205, 16268.837311626969, 1874.5219968907977, 1908.7804902436258, 1919.3666090190204, 1956.1490751523133, 1958.2950137950327, 93551.53224233903, 114673.85326146716, 117170.0, 117959.64080718337, 119188.0, 8625.827483450295, 10876.347419154876, 11205.60780372683, 11337.206395552397, 11343.03584195336, 13743.518976835963, 13982.370793314121, 14014.369353379123, 14038.227897465737, 14073.437062517589, 8501.532415717194, 8655.78360540979, 8763.123687631185, 8818.206361427503, 8865.069167737423, 7180.31786980236, 8864.379493435397, 8887.466751994902, 8984.730458086267, 9003.954980225057, 5923.348431672513, 6528.0, 6815.352541508549, 6958.547694399847, 6987.161540615159, 1829.954251143732, 1882.1906580170657, 1884.321644208084, 1888.716692496109, 1889.6394595890936, 680.3944489404435, 847.9024912135184, 955.5413401567148, 1010.2271762101998, 1041.8697662792151, 22199.44501387478, 22526.887365563067, 22569.548609027726, 22617.434564136027, 22653.660195097087, 892.9955350223337, 929.8837645294338, 948.7011591348703, 967.9806403871883, 992.3301771304341, 11207.775844483065, 11458.369789661481, 12376.195547289397, 12384.0, 12393.504259829686, 594889.0255548694, 608462.0, 609096.0, 615744.0, 617837.0, 76439.61780191063, 76754.61622691852, 143144.0, 143487.0, 146673.53326466813, 987.6592575561419, 991.7520619845038, 1011.4032720694826, 1020.744813796536, 1026.0560284538242, 20116.59766804685, 20301.0, 20573.691394628793, 20576.897115514326, 20644.277450289166, 39648.0, 58305.12542311784, 59463.70268148631, 59508.10737838849, 59953.0, 80220.59889700514, 80895.59552202202, 81838.0, 83369.58315208385, 84088.57955710427, 8401.62192701342, 8402.369822263478, 8483.74548763538, 8557.614907329309, 8599.097094805205, 9454.716358509255, 13062.0, 13333.466661333827, 13679.452821887013, 13747.312634368041, 11144.721381965192, 11493.770124597628, 11621.883781162418, 11653.30080195191, 11979.221350612183, 10025.696659434227, 10753.247272690836, 11625.069994400597, 11784.351860647404, 11835.763284734428, 11153.0, 11764.764699706408, 11896.286222826659, 12020.218685785396, 12066.698332541757, 8342.958285208535, 8452.323814094734, 8615.095414981588, 8709.433886797338, 8798.164174403422, 10821.420782362255, 11866.991305738764, 11874.287542747463, 11936.985356244817, 12010.459529321026], "value": 9994.419421167346, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1501.9249037548122, 1524.268351191428, 1726.4216487476695, 1841.2450895132997, 1848.9630207395853, 7876.921230787691, 8456.238938495535, 8468.830623387528, 8882.733517994462, 8896.37725359225, 8526.957365213166, 8605.39762216645, 8679.91320086799, 8691.087435819227, 8729.258013068897, 2279.977200227993, 2310.607196776544, 2313.421644588853, 2314.9884250578725, 2317.860928344296, 2275.283285764987, 2291.644795056769, 2307.711536057993, 2320.814334853216, 2324.9421513211532, 2044.0, 2268.5122698619793, 2303.170858490942, 2311.838171328008, 2320.8143348532076, 1740.1299350324837, 2281.2129815213725, 2282.954340913189, 2286.371247906822, 2294.621387471065, 2083.541620843412, 2083.656196727538, 2288.6567014947723, 2292.255017119426, 2298.6896768936313, 7684.692612295501, 8771.079036701181, 8794.384393092487, 8812.16284452976, 8824.0, 4450.666200034978, 5194.4026436959475, 5350.5452036576935, 5352.812651557216, 5354.196870469422, 2571.739847474724, 2842.7441530262377, 3268.2156282492033, 3312.519684645737, 3348.665133486656, 866.2766589897443, 949.4493193947563, 949.852772820214, 957.5164541906362, 971.0871780526353, 11350.489227984677, 11484.253523520945, 11490.770184596346, 11505.906938840797, 11515.712107197303, 4518.186726389282, 4659.464161621389, 4783.354247176587, 4798.2082956311815, 4813.15769740294, 9715.0, 9763.755906102262, 9807.75480612976, 9830.852537211947, 9855.704328870146, 5242.449542797951, 5314.867128321823, 5316.521513063843, 5318.468153184651, 5334.67991920486, 4339.327404252346, 4710.081534100817, 4792.496787837296, 4829.541193586604, 4895.461499235082, 3895.8636447724193, 3935.0752573145287, 4013.618706222904, 4014.0, 4031.274370613259, 1277.4506962006426, 1305.2755720575171, 1310.5347601601484, 1311.7376524695098, 1322.7486777512242, 869.6695255802755, 910.658503061352, 930.4277869110583, 933.9066093390607, 944.8346539355585, 5876.324222714443, 6035.969820150959, 6095.299040610386, 6125.693715314216, 6175.938240617626, 415.6778496665109, 440.47583375782716, 445.6412587866798, 460.5256585716717, 969.2246203037682, 3869.400242962345, 4027.81874815634, 4120.1553681495225, 4133.42132101506, 4142.627163555295, 10400.323978941344, 10706.089982351432, 10806.135509159405, 10825.13398928084, 10842.295250808673, 10594.622699049074, 10750.784984300426, 10769.24615276923, 10784.676459706221, 10792.24454288208, 7705.499142555716, 8138.674453021813, 8141.51150930946, 8168.142345053802, 8191.017077950565, 6028.547858910511, 6153.169322141633, 6167.938320616916, 6212.596181248205, 6338.0, 8353.582320884054, 9706.6117355305, 10023.749406264902, 10128.392296462236, 10157.796844063225, 10153.035461631429, 10223.028812262823, 10290.845637315597, 10342.741431463972, 10427.009434103747, 5770.711464426678, 7055.6472176392, 7461.179270280156, 7590.620468976639, 7627.199144090013, 8476.152384761475, 8494.150584941457, 8550.0, 8557.272631826365, 8559.614817333111, 7388.630568471663, 7563.394928405604, 7610.353119984863, 7610.885836712343, 7633.1985141559335, 7394.704211831681, 7411.740589079356, 7415.99884015651, 7473.962630187032, 7514.9624251878395, 7043.401310888632, 7073.82315442118, 7111.857762844817, 7112.964435177998, 7127.679254433459, 4950.603951683928, 5082.949170508247, 5095.745212739423, 5134.255532947627, 5360.437154098763, 5131.948680513147, 5147.176451767699, 5188.507091826271, 5299.0, 5306.946930530646], "value": 4482.739656836111, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [244.51585859997206, 313.38889166126046, 315.4542641230671, 318.3362688793863, 318.4904153354631, 4617.769111544422, 5686.175504551838, 5686.877014164734, 5731.598788084836, 5732.5987180897355, 5009.499050094998, 5325.08297013075, 5530.70028543292, 5678.4605462480995, 5686.2039314496005, 3235.660255673156, 3991.560928297885, 4100.2209580179815, 4183.581641835823, 4257.169851878885, 4167.916641667165, 4219.78901054946, 4220.5180725901255, 4223.429836972, 4250.829966801324, 3888.51393575803, 3953.3512546593706, 4189.53366321788, 4223.197592457439, 4229.598188172119, 3509.508668786372, 4146.979265103685, 4181.351890456969, 4211.978940105279, 4242.618164365222, 2869.569564565311, 3644.471551625026, 3646.872359467406, 3648.5986541480415, 3660.194757153422, 4666.463356713987, 5406.972675191701, 5426.945730542723, 5437.265969094201, 5438.700871452069, 4495.617872480843, 4768.117898188846, 4866.805327786919, 4893.730844803535, 4896.265560165968, 5143.974280128613, 5827.329857066449, 5882.588218824684, 5932.495737862287, 5954.7915822946425, 3288.473844184919, 3789.147441825595, 3965.801709914522, 3984.183242435294, 3987.2623564640635, 5147.536721695028, 5988.550858685616, 6067.150598916155, 6194.752209911553, 6217.96891015542, 3989.501312335958, 4006.7996600169877, 4016.3373043448087, 4018.1963607278662, 4019.879403617896, 3798.601146879593, 3911.159100793343, 4050.8784736457956, 4086.387041943732, 4088.509378874554, 4013.8394464221687, 4070.247004304213, 4458.464984201916, 4505.620784411692, 4812.639052071108, 4884.535969082932, 5177.8187763428095, 5411.37437916589, 5885.411458854081, 6022.638641681426, 1139.6524060161564, 1350.7298540291981, 1391.9860801392058, 1392.269058744147, 1392.6352174868684, 705.7670968580459, 743.3272888036228, 793.476305638276, 847.8045955203133, 858.965641374338, 4849.4908034656555, 5436.450611575682, 5460.863478413072, 5488.725563721798, 5492.505674489235, 5242.475752424803, 5267.552258058031, 5339.944121513167, 6053.182820319201, 6102.084687296941, 4614.377059097046, 5129.8717532062, 5432.837014889559, 5461.5357694596405, 5470.425605311465, 2562.8590427526665, 2721.8911243550037, 2885.9855700721782, 3157.4158780625658, 3244.0105767741065, 5371.3617346709625, 5494.972525137348, 6049.6055689082195, 6226.1905952225925, 6252.499800015988, 5588.329400471969, 6027.60820546663, 6193.721282542297, 6207.610070123035, 6224.844378890473, 5481.643693159932, 5925.64446133242, 6209.534284928648, 6213.539818142733, 6260.686965651699, 5522.5581953442825, 5729.455701708331, 6016.09758536223, 6201.3178550358525, 6242.375762423721, 6117.296510901303, 6148.370681769424, 6161.661108638888, 6175.660338681416, 6190.164327815687, 5215.16557350822, 5789.739461724317, 6188.11262564922, 6390.201224846895, 6456.128422663069, 3609.097725568608, 4006.358982562776, 4015.317396042738, 4025.3961905714377, 4051.0480037191824, 5905.0, 6224.315325314121, 6252.4681453044295, 6262.718177682106, 6282.183316168869, 5015.724135172601, 5628.831135065954, 5744.310682717934, 5938.643681378958, 5958.0, 4359.09860674688, 5027.698338099725, 5683.630564013326, 5974.0, 6033.396660334107, 5621.325440947113, 5882.411758824254, 5896.027155519291, 5907.32065812437, 5912.556558258062, 5308.548773354154, 5799.391063938226, 5850.946829570718, 5977.342492325927, 5997.0404735242155, 5871.735771890189, 5874.676892770939, 5877.764889404376, 5895.29256489224, 5910.0], "value": 4234.972944524804, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [635.8982562789953, 677.2347247610202, 719.1765428584271, 723.844373459706, 820.7250571058695, 15214.695706085886, 15677.686446271082, 15714.685706285896, 15733.056016638995, 15788.526344209664, 14012.369443375048, 14083.436662533486, 14089.647758806035, 14093.71812563748, 14108.788368174486, 833.4874052457741, 843.0431460292551, 857.4512312120248, 875.8554838451648, 879.1033146190881, 661.8940969444866, 866.1425189062813, 867.1371984875058, 870.6256309786789, 871.2376670413388, 913.2876356441952, 915.2174890468654, 916.5279880861361, 920.0707285641516, 924.6116631014957, 866.8786369908217, 893.2139717048988, 910.9453432794021, 918.2883265469248, 919.6321471411422, 659.9076129341896, 669.0666520204336, 683.2211279141783, 683.9555428897106, 686.8317262270775, 15510.0, 15635.609109772233, 15641.530754077396, 15651.060936343856, 15674.294656740474, 12993.935030324788, 13259.27074010929, 14085.859141408557, 14301.070430421989, 14330.92834535831, 11788.646340609796, 11851.762964740743, 11936.568385350014, 12027.278363298143, 12181.039670185932, 3779.5464544254864, 3782.659560639528, 3837.863728894733, 3847.9615203847884, 3890.435886796427, 105651.0, 111086.23403883171, 113386.43306783495, 113844.0, 115697.42151289273, 10838.132949364031, 10877.184211184192, 11012.119030477543, 11112.44437778108, 11245.493952772145, 21459.356219313446, 21620.13519459204, 21910.342689719335, 22380.0, 22429.66355504669, 6633.734650613921, 6835.316468353125, 8030.598470076473, 8085.393595480245, 8162.795930101676, 4364.781760912006, 4527.909441811145, 4544.772761361919, 4549.953510692493, 4564.612007979359, 3386.72906167506, 3481.7040551552896, 3522.330757156132, 3522.806245656462, 3530.417481115587, 630.0360448513782, 636.5067073018355, 641.6374748267214, 650.9064771184455, 662.7117204016268, 486.4794669703454, 627.7645882793952, 632.7911789109583, 641.6022066318912, 647.4431988489895, 8559.786005349915, 8833.514156721441, 8885.0, 9008.684696035738, 9142.451452912846, 515.827197888704, 568.3009897825698, 601.8044135655929, 628.3810446709987, 632.6425569553188, 3896.8699077267274, 3961.2869683457257, 4364.781760911942, 4372.322290045048, 4422.20400327944, 94624.63438413957, 120002.0, 144368.27815861063, 146880.0, 157884.21057894867, 91302.54348728214, 109302.0, 130810.0, 130815.34592327169, 132439.33780331037, 111205.0, 111428.44285778356, 111985.0, 113275.43362283136, 116771.0, 8440.282575980866, 8520.701775438078, 8573.871391929251, 8602.913970860462, 8650.0, 61433.07850382158, 62698.37301626925, 62927.6853615729, 64724.67637661781, 65360.346396535424, 94280.05719942713, 97232.0, 97883.61372208653, 98053.0, 101707.0, 11135.498902549567, 11137.266587207121, 11247.044001259985, 11402.087832973177, 11427.485763140512, 12102.939485302517, 12109.218064132343, 12276.570320038756, 12303.138780285293, 12340.259584424604, 9904.504774761377, 11458.431456151047, 11664.941675291908, 11976.341301228167, 12148.817767733315, 11821.881781182077, 11860.22908510944, 11928.642140735792, 12017.278963262232, 12313.0, 10897.564097436014, 11627.825582616098, 11937.940310298392, 11973.580924667594, 12152.786375409305, 9379.249660027317, 9759.60961561558, 9805.313628045968, 9810.215182785218, 10230.181585472996, 9265.53672316368, 9409.717708468757, 9871.654492092743, 9916.553755080895, 9948.801023979624], "value": 7516.013478239769, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1607.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 148.0, 107.0, 117.0, 164.0, 114.0, 113.0, 117.0, 117.0, 116.0], "value": 121.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 112.0, 131.0, 152.0, 112.0, 134.0, 128.0, 109.0, 160.0, 115.0], "value": 129.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 200.0, 193.0, 218.0, 232.0, 197.0, 195.0, 198.0, 199.0, 187.0], "value": 201.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 81.0, 72.0, 109.0, 57.0, 62.0, 73.0, 90.0, 131.0, 59.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 118.0, 69.0, 72.0, 79.0, 116.0, 71.0, 74.0, 115.0], "value": 85.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 90.0, 87.0, 89.0, 87.0, 91.0, 106.0, 121.0, 130.0], "value": 97.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 134.0, 135.0, 105.0, 108.0, 151.0, 105.0, 152.0, 147.0, 94.0], "value": 127.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 125.0, 87.0, 136.0, 143.0, 145.0, 92.0, 91.0, 134.0, 143.0], "value": 117.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 59.0, 59.0, 58.0, 60.0, 59.0, 60.0, 57.0, 57.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 66.0, 74.0, 71.0, 80.0, 73.0, 69.0, 69.0, 71.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 86.0, 98.0, 105.0, 106.0, 104.0, 77.0, 85.0, 89.0], "value": 91.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 133.0, 141.0, 165.0, 149.0, 157.0, 159.0, 148.0, 198.0, 154.0], "value": 154.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 173.0, 222.0, 244.0, 228.0, 173.0, 172.0, 170.0, 199.0], "value": 192.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 79.0, 92.0, 89.0, 72.0, 68.0, 66.0, 68.0, 78.0, 97.0], "value": 77.8, "unit": "score"}]}]} 07:05:47 INFO - Return code: 0 07:05:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:05:47 ERROR - # TBPL SUCCESS # 07:05:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:05:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:05:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:05:47 INFO - 2016-07-29 07:05:47.988 screenresolution[1671:10288] starting screenresolution argv=screenresolution get 07:05:47 INFO - 2016-07-29 07:05:47.990 screenresolution[1671:10288] Display 0: 1600x1200x32@60 07:05:47 INFO - 2016-07-29 07:05:47.996 screenresolution[1672:10291] starting screenresolution argv=screenresolution list 07:05:47 INFO - Available Modes on Display 0 07:05:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:05:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:05:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:05:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:05:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:05:48 INFO - Intel Iris: 07:05:48 INFO - Chipset Model: Intel Iris 07:05:48 INFO - Type: GPU 07:05:48 INFO - Bus: Built-In 07:05:48 INFO - VRAM (Dynamic, Max): 1536 MB 07:05:48 INFO - Vendor: Intel (0x8086) 07:05:48 INFO - Device ID: 0x0a2e 07:05:48 INFO - Revision ID: 0x0009 07:05:48 INFO - Displays: 07:05:48 INFO - Display: 07:05:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:05:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:05:48 INFO - Display Serial Number: 1600x1200 60 07:05:48 INFO - Main Display: Yes 07:05:48 INFO - Mirror: Off 07:05:48 INFO - Online: Yes 07:05:48 INFO - Rotation: Supported 07:05:48 INFO - Return code: 0 07:05:48 INFO - Running post-action listener: _resource_record_post_action 07:05:48 INFO - ##### 07:05:48 INFO - ##### Finished run-tests step (success) 07:05:48 INFO - ##### 07:05:48 INFO - Running post-run listener: _resource_record_post_run 07:05:48 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 37963264; Write bytes: 704275968; Read time: 377; Write time: 1927 07:05:48 INFO - TinderboxPrint: CPU usage
54.3% 07:05:48 INFO - TinderboxPrint: I/O read bytes / time
37,963,264 / 377 07:05:48 INFO - TinderboxPrint: I/O write bytes / time
704,275,968 / 1,927 07:05:48 INFO - TinderboxPrint: CPU idle
2,206.1 (45.7%) 07:05:48 INFO - TinderboxPrint: CPU system
974.5 (20.2%) 07:05:48 INFO - TinderboxPrint: CPU user
1,649.1 (34.1%) 07:05:48 INFO - TinderboxPrint: Swap in / out
445,190,144 / 0 07:05:48 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 392088064; Write bytes: 385975808; Read time: 29181; Write time: 743 07:05:48 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 37008896; Write bytes: 295006208; Read time: 362; Write time: 1140 07:05:48 INFO - Running post-run listener: _upload_blobber_files 07:05:48 INFO - Blob upload gear active. 07:05:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:05:48 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 07:05:48 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', 'Larch', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:05:48 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 Larch -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:05:49 INFO - (blobuploader) - INFO - Open directory for files ... 07:05:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:05:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:05:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:05:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:05:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:05:50 INFO - (blobuploader) - INFO - Done attempting. 07:05:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:05:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:05:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:05:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:05:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:05:51 INFO - (blobuploader) - INFO - Done attempting. 07:05:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:05:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:05:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:05:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:05:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:05:53 INFO - (blobuploader) - INFO - Done attempting. 07:05:53 INFO - (blobuploader) - INFO - Iteration through files over. 07:05:53 INFO - Return code: 0 07:05:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:05:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:05:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/6374cf9178961715fdd2ad7a883d857080ef8b2fdef2d7a30a8205b53437c4f2e951d1700cf0521b9739c156536a5b6011b175c70907acbe60a1533ad9a1e3ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/fde172e176ea8b9ff0b443e73c5b297633b94ff57b103ad65cf784e8bf121d3c3bf399984327405296df81067ece6df48d34e477718953009ed237918467dc96", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/42c26778ec11642e5807fc951a6583e410cf60c84de5fda330862a82eda8d5bc72d91bfa6c130455445fa10ac3fc02bdc35543952cfbad1b0871e114a79385ae"} 07:05:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:05:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:05:53 INFO - Contents: 07:05:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/6374cf9178961715fdd2ad7a883d857080ef8b2fdef2d7a30a8205b53437c4f2e951d1700cf0521b9739c156536a5b6011b175c70907acbe60a1533ad9a1e3ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/fde172e176ea8b9ff0b443e73c5b297633b94ff57b103ad65cf784e8bf121d3c3bf399984327405296df81067ece6df48d34e477718953009ed237918467dc96", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/42c26778ec11642e5807fc951a6583e410cf60c84de5fda330862a82eda8d5bc72d91bfa6c130455445fa10ac3fc02bdc35543952cfbad1b0871e114a79385ae"} 07:05:53 INFO - Running post-run listener: copy_logs_to_upload_dir 07:05:53 INFO - Copying logs to upload dir... 07:05:53 INFO - mkdir: /builds/slave/test/build/upload/logs 07:05:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.666241 ========= master_lag: 3.79 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-29 07:05:57.481344) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-07-29 07:05:57.484551) ========= 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.RVAgHyVghD/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.KYRAwj7Uxh/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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/Larch/sha512/6374cf9178961715fdd2ad7a883d857080ef8b2fdef2d7a30a8205b53437c4f2e951d1700cf0521b9739c156536a5b6011b175c70907acbe60a1533ad9a1e3ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/fde172e176ea8b9ff0b443e73c5b297633b94ff57b103ad65cf784e8bf121d3c3bf399984327405296df81067ece6df48d34e477718953009ed237918467dc96", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/42c26778ec11642e5807fc951a6583e410cf60c84de5fda330862a82eda8d5bc72d91bfa6c130455445fa10ac3fc02bdc35543952cfbad1b0871e114a79385ae"} build_url:https://queue.taskcluster.net/v1/task/IWneReXDQmm3u5KV4BuUnw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011069 build_url: 'https://queue.taskcluster.net/v1/task/IWneReXDQmm3u5KV4BuUnw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/6374cf9178961715fdd2ad7a883d857080ef8b2fdef2d7a30a8205b53437c4f2e951d1700cf0521b9739c156536a5b6011b175c70907acbe60a1533ad9a1e3ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/fde172e176ea8b9ff0b443e73c5b297633b94ff57b103ad65cf784e8bf121d3c3bf399984327405296df81067ece6df48d34e477718953009ed237918467dc96", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/42c26778ec11642e5807fc951a6583e410cf60c84de5fda330862a82eda8d5bc72d91bfa6c130455445fa10ac3fc02bdc35543952cfbad1b0871e114a79385ae"}' ========= master_lag: 1.73 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-07-29 07:05:59.226839) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-07-29 07:05:59.227202) ========= 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.RVAgHyVghD/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.KYRAwj7Uxh/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.005200 ========= master_lag: 1.61 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-07-29 07:06:00.847081) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 07:06:00.847423) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 07:06:00.850501) ========= ========= Total master_lag: 7.20 =========