builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0169 starttime: 1468957989.25 results: success (0) buildid: 20160719115118 builduid: 4319aa8b9c0342fd8bea7b6e294a0d3e revision: 528caba5bd200398aeb8fc13bb3bf4b09f254afa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 12:53:09.252481) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 12:53:09.252939) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 12:53:09.253235) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 12:53:09.278574) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 12:53:09.279043) ========= 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.Cx2EN2xwHC/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.fk2qm3Vqkj/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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-19 12:53:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.1M=0.001s 2016-07-19 12:53:09 (15.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.291556 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 12:53:09.593034) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 12:53:09.593343) ========= 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.Cx2EN2xwHC/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.fk2qm3Vqkj/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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.028558 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 12:53:09.642806) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 12:53:09.643152) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 528caba5bd200398aeb8fc13bb3bf4b09f254afa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 528caba5bd200398aeb8fc13bb3bf4b09f254afa --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Cx2EN2xwHC/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.fk2qm3Vqkj/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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-19 12:53:09,716 truncating revision to first 12 chars 2016-07-19 12:53:09,716 Setting DEBUG logging. 2016-07-19 12:53:09,716 attempt 1/10 2016-07-19 12:53:09,716 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/528caba5bd20?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-19 12:53:10,441 unpacking tar archive at: autoland-528caba5bd20/testing/mozharness/ program finished with exit code 0 elapsedTime=0.972346 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 12:53:10.637116) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 12:53:10.637437) ========= script_repo_revision: 528caba5bd200398aeb8fc13bb3bf4b09f254afa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 12:53:10.637827) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 12:53:10.638086) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 12:53:10.656131) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-19 12:53:10.656423) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Cx2EN2xwHC/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.fk2qm3Vqkj/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 12:53:10 INFO - MultiFileLogger online at 20160719 12:53:10 in /builds/slave/test 12:53:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 12:53:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:53:10 INFO - {'append_to_log': False, 12:53:10 INFO - 'base_work_dir': '/builds/slave/test', 12:53:10 INFO - 'blob_upload_branch': 'Autoland', 12:53:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:53:10 INFO - 'branch': 'Autoland', 12:53:10 INFO - 'buildbot_json_path': 'buildprops.json', 12:53:10 INFO - 'config_files': ('talos/mac_config.py',), 12:53:10 INFO - 'default_actions': ('clobber', 12:53:10 INFO - 'read-buildbot-config', 12:53:10 INFO - 'download-and-extract', 12:53:10 INFO - 'populate-webroot', 12:53:10 INFO - 'create-virtualenv', 12:53:10 INFO - 'install', 12:53:10 INFO - 'run-tests'), 12:53:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:53:10 INFO - 'download_minidump_stackwalk': True, 12:53:10 INFO - 'download_symbols': 'ondemand', 12:53:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:53:10 INFO - 'tooltool.py': '/tools/tooltool.py', 12:53:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:53:10 INFO - '/tools/misc-python/virtualenv.py')}, 12:53:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:53:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:53:10 INFO - 'installer_path': 'installer.exe', 12:53:10 INFO - 'log_level': 'info', 12:53:10 INFO - 'log_name': 'talos', 12:53:10 INFO - 'log_to_console': True, 12:53:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:53:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:53:10 INFO - 'opt_config_files': (), 12:53:10 INFO - 'pip_index': False, 12:53:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:53:10 INFO - 'cmd': ('bash', 12:53:10 INFO - '-c', 12:53:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:53:10 INFO - 'enabled': True, 12:53:10 INFO - 'halt_on_failure': False, 12:53:10 INFO - 'name': 'check_screen_resolution'},), 12:53:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:53:10 INFO - 'cmd': ('bash', 12:53:10 INFO - '-c', 12:53:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:53:10 INFO - 'enabled': True, 12:53:10 INFO - 'halt_on_failure': False, 12:53:10 INFO - 'name': 'check_screen_resolution'},), 12:53:10 INFO - 'run_cmd_checks_enabled': True, 12:53:10 INFO - 'sps_profile': False, 12:53:10 INFO - 'sps_profile_interval': 0, 12:53:10 INFO - 'suite': 'dromaeojs-e10s', 12:53:10 INFO - 'system_bits': '32', 12:53:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:53:10 INFO - 'title': 't-yosemite-r7-0169', 12:53:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:53:10 INFO - 'use_talos_json': True, 12:53:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:53:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:53:10 INFO - 'work_dir': 'build'} 12:53:10 INFO - [mozharness: 2016-07-19 19:53:10.847649Z] Running clobber step. 12:53:10 INFO - Running pre-action listener: _resource_record_pre_action 12:53:10 INFO - Running main action method: clobber 12:53:10 INFO - rmtree: /builds/slave/test/build 12:53:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:53:12 INFO - Running post-action listener: _resource_record_post_action 12:53:12 INFO - [mozharness: 2016-07-19 19:53:12.850568Z] Finished clobber step (success) 12:53:12 INFO - [mozharness: 2016-07-19 19:53:12.850703Z] Running read-buildbot-config step. 12:53:12 INFO - Running pre-action listener: _resource_record_pre_action 12:53:12 INFO - Running main action method: read_buildbot_config 12:53:12 INFO - Using buildbot properties: 12:53:12 INFO - { 12:53:12 INFO - "project": "", 12:53:12 INFO - "product": "firefox", 12:53:12 INFO - "script_repo_revision": "production", 12:53:12 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 12:53:12 INFO - "repository": "", 12:53:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 12:53:12 INFO - "buildid": "20160719115118", 12:53:12 INFO - "pgo_build": "False", 12:53:12 INFO - "basedir": "/builds/slave/test", 12:53:12 INFO - "buildnumber": 34, 12:53:12 INFO - "slavename": "t-yosemite-r7-0169", 12:53:12 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 12:53:12 INFO - "platform": "yosemite_r7", 12:53:12 INFO - "scheduler": "tests-autoland-macosx64-talos", 12:53:12 INFO - "branch": "autoland", 12:53:12 INFO - "repo_path": "integration/autoland", 12:53:12 INFO - "revision": "528caba5bd200398aeb8fc13bb3bf4b09f254afa", 12:53:12 INFO - "stage_platform": "macosx64", 12:53:12 INFO - "builduid": "4319aa8b9c0342fd8bea7b6e294a0d3e", 12:53:12 INFO - "slavebuilddir": "test" 12:53:12 INFO - } 12:53:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/M7WjRPkBT76otnGyLrjIgg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 12:53:12 INFO - Running post-action listener: _resource_record_post_action 12:53:12 INFO - [mozharness: 2016-07-19 19:53:12.854019Z] Finished read-buildbot-config step (success) 12:53:12 INFO - [mozharness: 2016-07-19 19:53:12.854130Z] Running download-and-extract step. 12:53:12 INFO - Running pre-action listener: _resource_record_pre_action 12:53:12 INFO - Running main action method: download_and_extract 12:53:12 INFO - mkdir: /builds/slave/test/build/tests 12:53:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:12 INFO - https://queue.taskcluster.net/v1/task/M7WjRPkBT76otnGyLrjIgg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 12:53:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7WjRPkBT76otnGyLrjIgg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 12:53:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7WjRPkBT76otnGyLrjIgg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 12:53:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7WjRPkBT76otnGyLrjIgg/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 12:53:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7WjRPkBT76otnGyLrjIgg/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 12:53:14 INFO - Downloaded 1199 bytes. 12:53:14 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 12:53:14 INFO - Using the following test package requirements: 12:53:14 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 12:53:14 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:53:14 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 12:53:14 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:53:14 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 12:53:14 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:53:14 INFO - u'jsshell-mac.zip'], 12:53:14 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:53:14 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 12:53:14 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 12:53:14 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:53:14 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 12:53:14 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:53:14 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 12:53:14 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:53:14 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 12:53:14 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:53:14 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 12:53:14 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:53: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')]} 12:53:14 INFO - https://queue.taskcluster.net/v1/task/M7WjRPkBT76otnGyLrjIgg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:53:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7WjRPkBT76otnGyLrjIgg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 12:53:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7WjRPkBT76otnGyLrjIgg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 12:53:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7WjRPkBT76otnGyLrjIgg/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 12:53:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7WjRPkBT76otnGyLrjIgg/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 12:53:15 INFO - Downloaded 18835974 bytes. 12:53:15 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'] 12:53:15 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 12:53:18 INFO - Return code: 0 12:53:18 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 12:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:18 INFO - https://queue.taskcluster.net/v1/task/M7WjRPkBT76otnGyLrjIgg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:53:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7WjRPkBT76otnGyLrjIgg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 12:53:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7WjRPkBT76otnGyLrjIgg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 12:53:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7WjRPkBT76otnGyLrjIgg/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 12:53:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7WjRPkBT76otnGyLrjIgg/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 12:53:20 INFO - Downloaded 18835974 bytes. 12:53:20 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'] 12:53:20 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 12:53:24 INFO - Return code: 0 12:53: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')]} 12:53:24 INFO - https://queue.taskcluster.net/v1/task/M7WjRPkBT76otnGyLrjIgg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:53:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7WjRPkBT76otnGyLrjIgg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 12:53:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7WjRPkBT76otnGyLrjIgg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 12:53:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7WjRPkBT76otnGyLrjIgg/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 12:53:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7WjRPkBT76otnGyLrjIgg/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 12:53:25 INFO - Downloaded 14403317 bytes. 12:53:25 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'] 12:53:25 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 12:53:25 INFO - Return code: 0 12:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:25 INFO - https://queue.taskcluster.net/v1/task/M7WjRPkBT76otnGyLrjIgg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:53:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7WjRPkBT76otnGyLrjIgg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 12:53:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7WjRPkBT76otnGyLrjIgg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 12:53:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7WjRPkBT76otnGyLrjIgg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 12:53:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7WjRPkBT76otnGyLrjIgg/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 12:53:28 INFO - Downloaded 112896981 bytes. 12:53:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M7WjRPkBT76otnGyLrjIgg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 12:53:28 INFO - mkdir: /builds/slave/test/properties 12:53:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:53:28 INFO - Writing to file /builds/slave/test/properties/build_url 12:53:28 INFO - Contents: 12:53:28 INFO - build_url:https://queue.taskcluster.net/v1/task/M7WjRPkBT76otnGyLrjIgg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 12:53:29 INFO - Running post-action listener: _resource_record_post_action 12:53:29 INFO - Running post-action listener: set_extra_try_arguments 12:53:29 INFO - [mozharness: 2016-07-19 19:53:29.793698Z] Finished download-and-extract step (success) 12:53:29 INFO - [mozharness: 2016-07-19 19:53:29.793827Z] Running populate-webroot step. 12:53:29 INFO - Running pre-action listener: _resource_record_pre_action 12:53:29 INFO - Running main action method: populate_webroot 12:53:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:53:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:53:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:53:29 INFO - '--tppagecycles', 12:53:29 INFO - '7'], 12:53:29 INFO - 'tests': ['tsvgm']}}, 12:53:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:53:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:53:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:53:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:53:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:53:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:53:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:29 INFO - 'talos_options': ['--disable-e10s'], 12:53:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:53:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:53:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:29 INFO - 'talos_options': ['--disable-e10s'], 12:53:29 INFO - 'tests': ['damp', 'tps']}, 12:53:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:29 INFO - 'tests': ['damp', 'tps']}, 12:53:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:53:29 INFO - 'tests': ['dromaeo_dom']}, 12:53:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:53:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:53:29 INFO - 'tests': ['basic_compositor_video']}, 12:53:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:53:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:53:29 INFO - 'tests': ['a11yr', 12:53:29 INFO - 'ts_paint', 12:53:29 INFO - 'tpaint', 12:53:29 INFO - 'sessionrestore', 12:53:29 INFO - 'sessionrestore_no_auto_restore', 12:53:29 INFO - 'tabpaint']}, 12:53:29 INFO - 'other-e10s': {'tests': ['a11yr', 12:53:29 INFO - 'ts_paint', 12:53:29 INFO - 'tpaint', 12:53:29 INFO - 'sessionrestore', 12:53:29 INFO - 'sessionrestore_no_auto_restore', 12:53:29 INFO - 'tabpaint']}, 12:53:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:53:29 INFO - 'ts_paint', 12:53:29 INFO - 'tpaint', 12:53:29 INFO - 'sessionrestore', 12:53:29 INFO - 'sessionrestore_no_auto_restore', 12:53:29 INFO - 'tabpaint']}, 12:53:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:53:29 INFO - 'ts_paint', 12:53:29 INFO - 'tpaint', 12:53:29 INFO - 'sessionrestore', 12:53:29 INFO - 'sessionrestore_no_auto_restore', 12:53:29 INFO - 'tabpaint']}, 12:53:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:53:29 INFO - 'tests': ['a11yr', 12:53:29 INFO - 'ts_paint', 12:53:29 INFO - 'tpaint', 12:53:29 INFO - 'sessionrestore', 12:53:29 INFO - 'sessionrestore_no_auto_restore', 12:53:29 INFO - 'tabpaint']}, 12:53:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:53:29 INFO - 'tests': ['a11yr', 12:53:29 INFO - 'ts_paint', 12:53:29 INFO - 'tpaint', 12:53:29 INFO - 'sessionrestore', 12:53:29 INFO - 'sessionrestore_no_auto_restore', 12:53:29 INFO - 'tabpaint']}, 12:53:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:53:29 INFO - 'tests': ['tsvgx', 12:53:29 INFO - 'tsvgr_opacity', 12:53:29 INFO - 'tart', 12:53:29 INFO - 'tscrollx', 12:53:29 INFO - 'cart']}, 12:53:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:53:29 INFO - 'tsvgr_opacity', 12:53:29 INFO - 'tart', 12:53:29 INFO - 'tscrollx', 12:53:29 INFO - 'cart']}, 12:53:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:29 INFO - 'talos_options': ['--disable-e10s'], 12:53:29 INFO - 'tests': ['tp5o']}, 12:53:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:29 INFO - 'tests': ['tp5o']}, 12:53:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:29 INFO - 'talos_options': ['--disable-e10s', 12:53:29 INFO - '--xperf_path', 12:53:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:53:29 INFO - 'tests': ['tp5n']}, 12:53:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:29 INFO - 'talos_options': ['--xperf_path', 12:53:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:53:29 INFO - 'tests': ['tp5n']}}, 12:53:29 INFO - 'talos.zip': {'path': '', 12:53:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:53:29 INFO - Running post-action listener: _resource_record_post_action 12:53:29 INFO - [mozharness: 2016-07-19 19:53:29.812950Z] Finished populate-webroot step (success) 12:53:29 INFO - [mozharness: 2016-07-19 19:53:29.813085Z] Running create-virtualenv step. 12:53:29 INFO - Running pre-action listener: _resource_record_pre_action 12:53:29 INFO - Running main action method: create_virtualenv 12:53:29 INFO - Creating virtualenv /builds/slave/test/build/venv 12:53:29 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 12:53:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:53:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:53:29 INFO - Using real prefix '/tools/python27' 12:53:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:53:30 INFO - Installing distribute.............................................................................................................................................................................................done. 12:53:33 INFO - Installing pip.................done. 12:53:33 INFO - Return code: 0 12:53:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:53:33 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')]} 12:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:33 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')]} 12:53:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:33 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 0x10e59ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e631618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fcbc45890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e500d30>, '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 0x10e265db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4f8b20>, '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.Cx2EN2xwHC/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.fk2qm3Vqkj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 12:53:33 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 12:53:33 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 12:53:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cx2EN2xwHC/Render', 12:53:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:53:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:53:33 INFO - 'HOME': '/Users/cltbld', 12:53:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:53:33 INFO - 'LOGNAME': 'cltbld', 12:53:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:33 INFO - 'MOZ_NO_REMOTE': '1', 12:53:33 INFO - 'NO_EM_RESTART': '1', 12:53:33 INFO - 'PAGER': '/bin/cat', 12:53:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:53:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:33 INFO - 'PWD': '/builds/slave/test', 12:53:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:53:33 INFO - 'SHELL': '/bin/bash', 12:53:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fk2qm3Vqkj/Listeners', 12:53:33 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 12:53:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:53:33 INFO - 'USER': 'cltbld', 12:53:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:53:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:53:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:33 INFO - 'XPC_FLAGS': '0x0', 12:53:33 INFO - 'XPC_SERVICE_NAME': '0', 12:53:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:53:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:33 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 12:53:33 INFO - Cleaning up... 12:53:33 INFO - Return code: 0 12:53:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:53:33 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')]} 12:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:33 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')]} 12:53:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:33 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 0x10e59ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e631618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fcbc45890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e500d30>, '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 0x10e265db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4f8b20>, '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.Cx2EN2xwHC/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.fk2qm3Vqkj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 12:53:33 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 12:53:33 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 12:53:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cx2EN2xwHC/Render', 12:53:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:53:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:53:33 INFO - 'HOME': '/Users/cltbld', 12:53:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:53:33 INFO - 'LOGNAME': 'cltbld', 12:53:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:33 INFO - 'MOZ_NO_REMOTE': '1', 12:53:33 INFO - 'NO_EM_RESTART': '1', 12:53:33 INFO - 'PAGER': '/bin/cat', 12:53:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:53:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:33 INFO - 'PWD': '/builds/slave/test', 12:53:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:53:33 INFO - 'SHELL': '/bin/bash', 12:53:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fk2qm3Vqkj/Listeners', 12:53:33 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 12:53:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:53:33 INFO - 'USER': 'cltbld', 12:53:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:53:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:53:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:33 INFO - 'XPC_FLAGS': '0x0', 12:53:33 INFO - 'XPC_SERVICE_NAME': '0', 12:53:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:34 INFO - Downloading/unpacking psutil>=3.1.1 12:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:53:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:53:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:53:36 INFO - Installing collected packages: psutil 12:53:36 INFO - Running setup.py install for psutil 12:53:36 INFO - building 'psutil._psutil_osx' extension 12:53:36 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 12:53:37 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 12:53:37 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 12:53:37 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 12:53:37 INFO - building 'psutil._psutil_posix' extension 12:53:37 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 12:53:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:53:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:53:37 INFO - ^ 12:53:37 INFO - 1 warning generated. 12:53:37 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 12:53:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:53:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:53:37 INFO - Successfully installed psutil 12:53:37 INFO - Cleaning up... 12:53:37 INFO - Return code: 0 12:53:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:53:37 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')]} 12:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:37 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')]} 12:53:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:37 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 0x10e59ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e631618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fcbc45890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e500d30>, '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 0x10e265db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4f8b20>, '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.Cx2EN2xwHC/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.fk2qm3Vqkj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 12:53:37 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 12:53:37 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 12:53:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cx2EN2xwHC/Render', 12:53:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:53:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:53:37 INFO - 'HOME': '/Users/cltbld', 12:53:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:53:37 INFO - 'LOGNAME': 'cltbld', 12:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:37 INFO - 'MOZ_NO_REMOTE': '1', 12:53:37 INFO - 'NO_EM_RESTART': '1', 12:53:37 INFO - 'PAGER': '/bin/cat', 12:53:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:37 INFO - 'PWD': '/builds/slave/test', 12:53:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:53:37 INFO - 'SHELL': '/bin/bash', 12:53:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fk2qm3Vqkj/Listeners', 12:53:37 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 12:53:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:53:37 INFO - 'USER': 'cltbld', 12:53:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:53:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:37 INFO - 'XPC_FLAGS': '0x0', 12:53:37 INFO - 'XPC_SERVICE_NAME': '0', 12:53:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:53:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:53:40 INFO - Installing collected packages: mozsystemmonitor 12:53:40 INFO - Running setup.py install for mozsystemmonitor 12:53:40 INFO - Successfully installed mozsystemmonitor 12:53:40 INFO - Cleaning up... 12:53:40 INFO - Return code: 0 12:53:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e59ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e631618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fcbc45890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e500d30>, '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 0x10e265db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4f8b20>, '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.Cx2EN2xwHC/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.fk2qm3Vqkj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 12:53:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:53:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:53:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cx2EN2xwHC/Render', 12:53:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:53:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:53:40 INFO - 'HOME': '/Users/cltbld', 12:53:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:53:40 INFO - 'LOGNAME': 'cltbld', 12:53:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:40 INFO - 'MOZ_NO_REMOTE': '1', 12:53:40 INFO - 'NO_EM_RESTART': '1', 12:53:40 INFO - 'PAGER': '/bin/cat', 12:53:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:53:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:40 INFO - 'PWD': '/builds/slave/test', 12:53:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:53:40 INFO - 'SHELL': '/bin/bash', 12:53:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fk2qm3Vqkj/Listeners', 12:53:40 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 12:53:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:53:40 INFO - 'USER': 'cltbld', 12:53:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:53:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:53:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:40 INFO - 'XPC_FLAGS': '0x0', 12:53:40 INFO - 'XPC_SERVICE_NAME': '0', 12:53:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:53:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:41 INFO - Downloading/unpacking jsonschema==2.5.1 12:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:53:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:44 INFO - Downloading functools32-3.2.3-2.tar.gz 12:53:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:53:44 INFO - warning: no files found matching '*.txt' 12:53:44 INFO - no previously-included directories found matching 'build' 12:53:44 INFO - no previously-included directories found matching 'dist' 12:53:44 INFO - no previously-included directories found matching '.git*' 12:53:44 INFO - Installing collected packages: jsonschema, functools32 12:53:44 INFO - Running setup.py install for functools32 12:53:44 INFO - warning: no files found matching '*.txt' 12:53:44 INFO - no previously-included directories found matching 'build' 12:53:44 INFO - no previously-included directories found matching 'dist' 12:53:44 INFO - no previously-included directories found matching '.git*' 12:53:44 INFO - Successfully installed jsonschema functools32 12:53:44 INFO - Cleaning up... 12:53:44 INFO - Return code: 0 12:53:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:53:44 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')]} 12:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:44 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')]} 12:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:44 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 0x10e59ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e631618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fcbc45890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e500d30>, '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 0x10e265db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4f8b20>, '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.Cx2EN2xwHC/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.fk2qm3Vqkj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 12:53:44 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 12:53:44 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 12:53:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cx2EN2xwHC/Render', 12:53:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:53:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:53:44 INFO - 'HOME': '/Users/cltbld', 12:53:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:53:44 INFO - 'LOGNAME': 'cltbld', 12:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:44 INFO - 'MOZ_NO_REMOTE': '1', 12:53:44 INFO - 'NO_EM_RESTART': '1', 12:53:44 INFO - 'PAGER': '/bin/cat', 12:53:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:44 INFO - 'PWD': '/builds/slave/test', 12:53:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:53:44 INFO - 'SHELL': '/bin/bash', 12:53:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fk2qm3Vqkj/Listeners', 12:53:44 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 12:53:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:53:44 INFO - 'USER': 'cltbld', 12:53:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:53:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:44 INFO - 'XPC_FLAGS': '0x0', 12:53:44 INFO - 'XPC_SERVICE_NAME': '0', 12:53:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:44 INFO - Downloading/unpacking blobuploader==1.2.4 12:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:47 INFO - Downloading blobuploader-1.2.4.tar.gz 12:53:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:53:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:53:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:48 INFO - Downloading docopt-0.6.1.tar.gz 12:53:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:53:48 INFO - Installing collected packages: blobuploader, requests, docopt 12:53:48 INFO - Running setup.py install for blobuploader 12:53:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:53:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:53:48 INFO - Running setup.py install for requests 12:53:49 INFO - Running setup.py install for docopt 12:53:49 INFO - Successfully installed blobuploader requests docopt 12:53:49 INFO - Cleaning up... 12:53:49 INFO - Return code: 0 12:53:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:53:49 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')]} 12:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:49 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')]} 12:53:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:49 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 0x10e59ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e631618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fcbc45890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e500d30>, '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 0x10e265db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4f8b20>, '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.Cx2EN2xwHC/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.fk2qm3Vqkj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 12:53:49 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 12:53:49 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 12:53:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cx2EN2xwHC/Render', 12:53:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:53:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:53:49 INFO - 'HOME': '/Users/cltbld', 12:53:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:53:49 INFO - 'LOGNAME': 'cltbld', 12:53:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:49 INFO - 'MOZ_NO_REMOTE': '1', 12:53:49 INFO - 'NO_EM_RESTART': '1', 12:53:49 INFO - 'PAGER': '/bin/cat', 12:53:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:53:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:49 INFO - 'PWD': '/builds/slave/test', 12:53:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:53:49 INFO - 'SHELL': '/bin/bash', 12:53:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fk2qm3Vqkj/Listeners', 12:53:49 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 12:53:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:53:49 INFO - 'USER': 'cltbld', 12:53:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:53:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:53:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:49 INFO - 'XPC_FLAGS': '0x0', 12:53:49 INFO - 'XPC_SERVICE_NAME': '0', 12:53:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:53:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:53:49 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-BzygHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:53:49 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-r3bq61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:53:49 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-td_vHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:53:49 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-TZGQNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:53:50 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-0bjVqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:53:50 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-ARZdN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:53:50 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-1v5KsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:53:50 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-vTR7vV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:53:50 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-CcDNO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:53:50 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-fIJX0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:53:50 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-NKoqQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:53:50 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-rJd9fH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:53:50 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-C_Gr5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:53:50 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-kEuOC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:53:51 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-hAqjZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:53:51 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-cYASHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:53:51 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-6M8cCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:53:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:53:51 INFO - Running setup.py install for manifestparser 12:53:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:53:51 INFO - Running setup.py install for mozcrash 12:53:51 INFO - Running setup.py install for mozdebug 12:53:51 INFO - Running setup.py install for mozdevice 12:53:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:53:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:53:52 INFO - Running setup.py install for mozfile 12:53:52 INFO - Running setup.py install for mozhttpd 12:53:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:53:52 INFO - Running setup.py install for mozinfo 12:53:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:53:52 INFO - Running setup.py install for mozInstall 12:53:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:53:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:53:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:53:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:53:52 INFO - Running setup.py install for mozleak 12:53:52 INFO - Running setup.py install for mozlog 12:53:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:53:52 INFO - Running setup.py install for moznetwork 12:53:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:53:53 INFO - Running setup.py install for mozprocess 12:53:53 INFO - Running setup.py install for mozprofile 12:53:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:53:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:53:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:53:53 INFO - Running setup.py install for mozrunner 12:53:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:53:53 INFO - Running setup.py install for mozscreenshot 12:53:53 INFO - Running setup.py install for moztest 12:53:53 INFO - Running setup.py install for mozversion 12:53:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:53:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:53:53 INFO - Cleaning up... 12:53:53 INFO - Return code: 0 12:53:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:53:53 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')]} 12:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:53 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')]} 12:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:53 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 0x10e59ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e631618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fcbc45890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e500d30>, '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 0x10e265db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4f8b20>, '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.Cx2EN2xwHC/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.fk2qm3Vqkj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 12:53:53 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 12:53:53 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 12:53:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cx2EN2xwHC/Render', 12:53:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:53:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:53:53 INFO - 'HOME': '/Users/cltbld', 12:53:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:53:53 INFO - 'LOGNAME': 'cltbld', 12:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:53 INFO - 'MOZ_NO_REMOTE': '1', 12:53:53 INFO - 'NO_EM_RESTART': '1', 12:53:53 INFO - 'PAGER': '/bin/cat', 12:53:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:53 INFO - 'PWD': '/builds/slave/test', 12:53:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:53:53 INFO - 'SHELL': '/bin/bash', 12:53:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fk2qm3Vqkj/Listeners', 12:53:53 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 12:53:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:53:53 INFO - 'USER': 'cltbld', 12:53:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:53:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:53 INFO - 'XPC_FLAGS': '0x0', 12:53:53 INFO - 'XPC_SERVICE_NAME': '0', 12:53:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:53:54 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-1pb2lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:53:54 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)) 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:53:54 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-6Y1UHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:53:54 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)) 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:53:54 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-0wJdo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:53:54 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)) 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:53:54 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-_mi8sE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:53:54 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)) 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:53:54 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-LGBUxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:53:54 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)) 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:53:54 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-Sko0de-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:53:54 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)) 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:53:54 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-s0Z4KK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:53:54 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)) 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:53:54 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-KVbNsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:53:55 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)) 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:53:55 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-vJKxIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:53:55 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)) 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:53:55 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-04tHbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:53:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:53:55 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-OSbFJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:53:55 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)) 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:53:55 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-tb9Bzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:53:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:53:55 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-W1wkoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:53:55 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)) 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:53:55 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-Z0uEeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:53:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:53:55 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-mbhpqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:53:55 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)) 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:53:55 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-d60upO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:53:55 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)) 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:53:55 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-s5526Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:53:56 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)) 12:53:56 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)) 12:53:56 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)) 12:53:56 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)) 12:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:53:56 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)) 12:53:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:53:56 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 12:53:56 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 12:53:56 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 12:53:56 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 12:53:56 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 12:53:56 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 12:53:58 INFO - Downloading blessings-1.6.tar.gz 12:53:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:53:58 INFO - Installing collected packages: blessings 12:53:58 INFO - Running setup.py install for blessings 12:53:58 INFO - Successfully installed blessings 12:53:58 INFO - Cleaning up... 12:53:58 INFO - Return code: 0 12:53:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:53:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:53:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:53:59 INFO - Reading from file tmpfile_stdout 12:53:59 INFO - Current package versions: 12:53:59 INFO - blessings == 1.6 12:53:59 INFO - blobuploader == 1.2.4 12:53:59 INFO - docopt == 0.6.1 12:53:59 INFO - functools32 == 3.2.3-2 12:53:59 INFO - jsonschema == 2.5.1 12:53:59 INFO - manifestparser == 1.1 12:53:59 INFO - mozInstall == 1.12 12:53:59 INFO - mozcrash == 0.17 12:53:59 INFO - mozdebug == 0.1 12:53:59 INFO - mozdevice == 0.48 12:53:59 INFO - mozfile == 1.2 12:53:59 INFO - mozhttpd == 0.7 12:53:59 INFO - mozinfo == 0.9 12:53:59 INFO - mozleak == 0.1 12:53:59 INFO - mozlog == 3.3 12:53:59 INFO - moznetwork == 0.27 12:53:59 INFO - mozprocess == 0.23 12:53:59 INFO - mozprofile == 0.28 12:53:59 INFO - mozrunner == 6.12 12:53:59 INFO - mozscreenshot == 0.1 12:53:59 INFO - mozsystemmonitor == 0.3 12:53:59 INFO - moztest == 0.7 12:53:59 INFO - mozversion == 1.4 12:53:59 INFO - psutil == 3.1.1 12:53:59 INFO - requests == 1.2.3 12:53:59 INFO - wsgiref == 0.1.2 12:53:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:53: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')]} 12:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53: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')]} 12:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:59 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 0x10e59ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e631618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fcbc45890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e500d30>, '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 0x10e265db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4f8b20>, '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.Cx2EN2xwHC/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.fk2qm3Vqkj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 12:53:59 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 12:53:59 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 12:53:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cx2EN2xwHC/Render', 12:53:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:53:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:53:59 INFO - 'HOME': '/Users/cltbld', 12:53:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:53:59 INFO - 'LOGNAME': 'cltbld', 12:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:59 INFO - 'MOZ_NO_REMOTE': '1', 12:53:59 INFO - 'NO_EM_RESTART': '1', 12:53:59 INFO - 'PAGER': '/bin/cat', 12:53:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:59 INFO - 'PWD': '/builds/slave/test', 12:53:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:53:59 INFO - 'SHELL': '/bin/bash', 12:53:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fk2qm3Vqkj/Listeners', 12:53:59 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 12:53:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:53:59 INFO - 'USER': 'cltbld', 12:53:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:53:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:59 INFO - 'XPC_FLAGS': '0x0', 12:53:59 INFO - 'XPC_SERVICE_NAME': '0', 12:53:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:59 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)) 12:53:59 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)) 12:53:59 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)) 12:53:59 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)) 12:53:59 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)) 12:53:59 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)) 12:53:59 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)) 12:53:59 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)) 12:53:59 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)) 12:53:59 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)) 12:53:59 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)) 12:53:59 INFO - Cleaning up... 12:53:59 INFO - Return code: 0 12:53:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:53: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')]} 12:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53: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')]} 12:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:59 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 0x10e59ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e631618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fcbc45890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e500d30>, '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 0x10e265db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4f8b20>, '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.Cx2EN2xwHC/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.fk2qm3Vqkj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 12:53:59 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 12:53:59 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 12:53:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cx2EN2xwHC/Render', 12:53:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:53:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:53:59 INFO - 'HOME': '/Users/cltbld', 12:53:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:53:59 INFO - 'LOGNAME': 'cltbld', 12:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:59 INFO - 'MOZ_NO_REMOTE': '1', 12:53:59 INFO - 'NO_EM_RESTART': '1', 12:53:59 INFO - 'PAGER': '/bin/cat', 12:53:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:59 INFO - 'PWD': '/builds/slave/test', 12:53:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:53:59 INFO - 'SHELL': '/bin/bash', 12:53:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fk2qm3Vqkj/Listeners', 12:53:59 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 12:53:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:53:59 INFO - 'USER': 'cltbld', 12:53:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:53:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:59 INFO - 'XPC_FLAGS': '0x0', 12:53:59 INFO - 'XPC_SERVICE_NAME': '0', 12:53:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:53:59 INFO - Cleaning up... 12:53:59 INFO - Return code: 0 12:53:59 INFO - Running post-action listener: _resource_record_post_action 12:53:59 INFO - Running post-action listener: _start_resource_monitoring 12:53:59 INFO - Starting resource monitoring. 12:53:59 INFO - [mozharness: 2016-07-19 19:53:59.644914Z] Finished create-virtualenv step (success) 12:53:59 INFO - [mozharness: 2016-07-19 19:53:59.645863Z] Running install step. 12:53:59 INFO - Running pre-action listener: _resource_record_pre_action 12:53:59 INFO - Running main action method: install 12:53:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:53:59 INFO - Reading from file tmpfile_stdout 12:53:59 INFO - Detecting whether we're running mozinstall >=1.0... 12:53:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:54:00 INFO - Reading from file tmpfile_stdout 12:54:00 INFO - Output received: 12:54:00 INFO - Usage: mozinstall [options] installer 12:54:00 INFO - Options: 12:54:00 INFO - -h, --help show this help message and exit 12:54:00 INFO - -d DEST, --destination=DEST 12:54:00 INFO - Directory to install application into. [default: 12:54:00 INFO - "/builds/slave/test"] 12:54:00 INFO - --app=APP Application being installed. [default: firefox] 12:54:00 INFO - mkdir: /builds/slave/test/build/application 12:54:00 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'] 12:54:00 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 12:54:35 INFO - Reading from file tmpfile_stdout 12:54:35 INFO - Output received: 12:54:35 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:54:35 INFO - Running post-action listener: _resource_record_post_action 12:54:35 INFO - [mozharness: 2016-07-19 19:54:35.328550Z] Finished install step (success) 12:54:35 INFO - [mozharness: 2016-07-19 19:54:35.328676Z] Running run-tests step. 12:54:35 INFO - Running pre-action listener: _resource_record_pre_action 12:54:35 INFO - Running main action method: run_tests 12:54:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:54:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:54:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:54:35 INFO - 2016-07-19 12:54:35.343 screenresolution[1641:7474] starting screenresolution argv=screenresolution get 12:54:35 INFO - 2016-07-19 12:54:35.345 screenresolution[1641:7474] Display 0: 1600x1200x32@60 12:54:35 INFO - 2016-07-19 12:54:35.351 screenresolution[1642:7476] starting screenresolution argv=screenresolution list 12:54:35 INFO - Available Modes on Display 0 12:54:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:54:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:54:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:54:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:54:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:54:35 INFO - Intel Iris: 12:54:35 INFO - Chipset Model: Intel Iris 12:54:35 INFO - Type: GPU 12:54:35 INFO - Bus: Built-In 12:54:35 INFO - VRAM (Dynamic, Max): 1536 MB 12:54:35 INFO - Vendor: Intel (0x8086) 12:54:35 INFO - Device ID: 0x0a2e 12:54:35 INFO - Revision ID: 0x0009 12:54:35 INFO - Displays: 12:54:35 INFO - Display: 12:54:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:54:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:54:35 INFO - Display Serial Number: 1600x1200 60 12:54:35 INFO - Main Display: Yes 12:54:35 INFO - Mirror: Off 12:54:35 INFO - Online: Yes 12:54:35 INFO - Rotation: Supported 12:54:35 INFO - Return code: 0 12:54:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:54:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:54:35 INFO - Python 2.7.3 12:54:35 INFO - Return code: 0 12:54:35 INFO - grabbing minidump binary from tooltool 12:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:35 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 0x10e500d30>, '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 0x10e265db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4f8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:54:35 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 12:54:35 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 12:54:35 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 12:54:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:54:35 INFO - Return code: 0 12:54:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:54:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:54:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:54:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:54:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:54:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M7WjRPkBT76otnGyLrjIgg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0169', '--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 12:54:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M7WjRPkBT76otnGyLrjIgg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0169 --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 12:54:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cx2EN2xwHC/Render', 12:54:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:54:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:54:35 INFO - 'HOME': '/Users/cltbld', 12:54:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:54:35 INFO - 'LOGNAME': 'cltbld', 12:54:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:54:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:35 INFO - 'MOZ_NO_REMOTE': '1', 12:54:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:54:35 INFO - 'NO_EM_RESTART': '1', 12:54:35 INFO - 'PAGER': '/bin/cat', 12:54:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:35 INFO - 'PWD': '/builds/slave/test', 12:54:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:54:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:54:35 INFO - 'SHELL': '/bin/bash', 12:54:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fk2qm3Vqkj/Listeners', 12:54:35 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 12:54:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:54:35 INFO - 'USER': 'cltbld', 12:54:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:54:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:35 INFO - 'XPC_FLAGS': '0x0', 12:54:35 INFO - 'XPC_SERVICE_NAME': '0', 12:54:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:54:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M7WjRPkBT76otnGyLrjIgg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0169', '--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 12:54:35 INFO - mozversion application_buildid: 20160719115118 12:54:35 INFO - mozversion application_changeset: 528caba5bd200398aeb8fc13bb3bf4b09f254afa 12:54:35 INFO - mozversion application_display_name: Nightly 12:54:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:54:35 INFO - mozversion application_name: Firefox 12:54:35 INFO - mozversion application_remotingname: firefox 12:54:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 12:54:35 INFO - mozversion application_vendor: Mozilla 12:54:35 INFO - mozversion application_version: 50.0a1 12:54:35 INFO - mozversion platform_buildid: 20160719115118 12:54:35 INFO - mozversion platform_changeset: 528caba5bd200398aeb8fc13bb3bf4b09f254afa 12:54:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 12:54:35 INFO - mozversion platform_version: 50.0a1 12:54:35 INFO - using testdate: 1468958075 12:54:35 INFO - actual date: 1468958075 12:54:35 INFO - starting webserver on 'localhost:49272' 12:54:35 INFO - SUITE-START | Running 2 tests 12:54:35 INFO - TEST-START | dromaeo_css 12:54:35 INFO - operating with platform_type : mac_ 12:54:35 INFO - Initialising browser for dromaeo_css test... 12:54:35 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpzoPqhU/profile http://localhost:49272/getInfo.html) 12:54:39 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 12:54:39 INFO - PROCESS | 1652 | colorDepth:24 12:54:39 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 12:54:39 INFO - PROCESS | 1652 | __metrics 12:54:39 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 12:54:39 INFO - TEST-INFO | 1652: exit 0 12:54:39 INFO - Browser initialized. 12:54:39 INFO - Running cycle 1/1 for dromaeo_css test... 12:54:39 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpzoPqhU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:54:51 INFO - PROCESS | 1655 | RSS: Main: 254451712 12:54:51 INFO - PROCESS | 1655 | 12:55:41 INFO - PROCESS | 1655 | 1468958141384 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] 12:57:52 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 12:57:53 INFO - PROCESS | 1655 | RSS: Main: 266690560 12:57:53 INFO - PROCESS | 1655 | 13:00:56 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 13:00:56 INFO - PROCESS | 1655 | RSS: Main: 275435520 13:00:56 INFO - PROCESS | 1655 | 13:03:58 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 13:03:59 INFO - PROCESS | 1655 | RSS: Main: 280068096 13:03:59 INFO - PROCESS | 1655 | 13:07:01 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 13:07:01 INFO - PROCESS | 1655 | RSS: Main: 279015424 13:07:01 INFO - PROCESS | 1655 | 13:10:04 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 13:10:05 INFO - PROCESS | 1655 | RSS: Main: 283000832 13:10:05 INFO - PROCESS | 1655 | 13:13:07 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 13:13:08 INFO - PROCESS | 1655 | RSS: Main: 283000832 13:13:08 INFO - PROCESS | 1655 | 13:13:08 INFO - PROCESS | 1655 | __start_tp_report 13:13:08 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 13:13:08 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 13:13:08 INFO - PROCESS | 1655 | |i|pagename|runs| 13:13:08 INFO - PROCESS | 1655 | |0;dojo.html;3373.1061268763765;3376.358491886542;3411.9658803411967;3414.2830005698816;3417.5386322846425;5764.270271613525;5844.415558444153;5892.381299963501;5921.674307913063;5964.701764911748;5040.697558146514;5161.657968928087;5436.565074794017;5755.971220143904;5787.536997040237;5201.427842937273;5252.6848389096585;5306.363236411636;5348.598855085865;5362.168863826094;507.1494590333279;5228.633995620308;5292.973535132319;5357.196420536931;5379;4400.823967041347;5270.314859068297;5296.9735151324385;5298.7350632468415;5307.336582927134;5290.206469029637;5350.705711185883;5370.57035437168;5382.0581398255545;5405.459454054602;4356.564343565649;5221;5225.503577160163;5285.260063591062;5343.278657381243;5726.68503232322;5882.2353094097925;5893.646381217098;5939.67331796751;5952.494038006775;6139.154842350791;6196.318404975449;6240.656763877985;6251.374862513758;6252.124702541648;6128.747575574743;6192.442680158807;6212.4408803207925;6267.4986001119805;6275.403836635558;5942;5955.821325360246;5965.671888046112;5976.6115202512565;5997.310309314441;6210.7515699372425;6305.684715764285;6329.778457753957;6364.7135878885565;6380;5293.57651387888;6167.876642467126;6205.2553693557065;6205.503559715212;6222.595531290452;6199.876002480015;6264.123022776815;6294.087357333253;6316.210473690789;6319.715612797435;6189.84525386869;6204.100405441186;6261.812145635638;6271.4669253114;6277.089821975788;6193.783217587453;6216.067589861466;6216.160818289473;6232.470240029557;6251;4543.909461729228;4580.656450766206;5013.1227035268685;5024.42219144803;5024.974875125601;4205.222033923734;4360.171567402183;4406;4521.683482156218;4568.063546972862;5544.63959842609;5952.880942381128;6006;6071;6097.207363042776;6271.184745983084;6278.434940855345;6282.246130464374;6303.842403939938;6314;5913.349531551526;6008.24896887889;6023.397660233942;6047.3045599755715;6051.576389652682;5498.972505137449;5525.778968841281;5531.502164805187;5532.225488431623;5536.529395001389;6268;6493.123428337209;6495.415412612888;6528.347165283433;6534.673266336664;6167.537434692326;6210.596311239755;6216.502679785697;6249.437550620466;6268.153799237227;6386.90419643715;6418.582792118497;6427.967860160669;6434.420902118832;6467;6151.415615516519;6156.5998210116195;6185.443310102112;6207.099970504342;6230.43926046658;6190.721417536131;6202.379762023762;6244.469220116341;6268.937310626835;6277.811665650038;6240.656763878031;6248.156498872594;6265.248170219421;6270.278917924497;6273.65494897785;6103.786367477117;6140.105498721277;6198;6211.9068213977735;6230.252369715482;5092.414372347227;5886.735096920564;6019.789307374221;6079.574429789872;6102.237220347457;5192.948070519246;5806.622569532967;6202.007678771375;6218.160548326099;6232.158658581034;4930.285108659296;6050.909236361546;6093.664848433379;6104.45039575082;6113.172264937315 13:13:08 INFO - PROCESS | 1655 | |1;ext.html;485.6090846868271;505.4061477763628;526.6076772804262;528.2841749429521;546.59825028604;38698.22603547931;40959.59040409595;41016;41040;41109.38335924956;33601.327973440515;41032.38451423231;41429.37855932163;41479.58520414795;42213.94465138373;9587.616495340195;9726.90273097267;9773.462459564722;9773.51132443375;9778.413295202276;9677.903220967806;9755.170810481117;9757.073078057572;9764.414135151877;9783.657571984982;9665.565049572751;9755.512224388787;9784.21726261901;9787.168090712297;9806.852897206547;9670.274729395289;9671.758206044835;9685.128338449504;9704.369216001009;9759;9557.378770379903;9611.90388096117;9630.614775408976;9693.352130137893;9710.611575537041;39308.80345598282;39309;39768.40347394792;39772.80113599442;39860;2959.837208953507;3076.8461576921286;3318;3366.158460384879;3402.081438011723;30673;30949.535756963665;31005.534916976037;31090.53364199539;31463.52804707931;3043.7412819910332;3157.778955473118;3173.904782856518;3222.5166225066428;3277.0987978305916;423752;427304;430612.8469357696;430749;431882.99999999686;32826;33055.66944330574;33063.83468082644;33121.50317745236;33668.66331336704;29041.273968150967;29460.852695736383;33542.16144596356;33596.328073438395;34655.13362165966;14490.058146220463;14645.707085858436;14747.778783318045;14766.114033158045;14790.260486975609;12261.693457663452;12268.693282668004;12474.75050498985;12609.991200703922;12620.30588317633;7200.991861139445;7329.8900516492295;7370.742024029133;7374.705011799468;7422.406207503494;3063.433264846011;3090.98454507726;3099.1167517257472;3106.782525223258;3116.2365220520664;913.4017218721748;921.410297409645;951.8381875081114;994.5077186792583;1023.4831410137833;29112;29461.705382946326;29526;30195.396092078034;30214.94247701364;995.3928103856787;1026.8767747870304;1042.0673497220098;1046.6441409920662;1088.7169335972703;14676.926615367069;15220.162891041098;15479;15851.890367674152;15919.522414327588;547071;607347;660846;674951.0019599259;693893;58428.7078564613;58485;58768.11847822201;58946.70526647425;59060.70469647624;1362.2303398579968;1363.1275983370651;1394.4491925689297;1397.9580612581435;1401.9345297573918;29085.272868178465;29306.560401593568;29374.265643359086;29961.400771984874;30079.849600751855;41596.58403416048;49457.752711236215;49766.253506196714;50379.496205038944;50410;608820;611119;612768;614159;614708;26409.811558480298;26467.867660662345;26765.92936282605;26837;26867.596986044835;48518;49672;49757;49925;49987.00025999532;35003.124921877155;39957.40063898986;40516.594834051284;41166.382504263056;42354.941126472084;39832.40251396174;40293.1941361177;40590.79704601458;41052.58947410607;41632.3755143667;33287.16782080467;38001.80999095098;38831.41752873766;38932.80533597314;39756;34909.65090349064;34959.65040349666;35795;35853.64146358503;35980.820095899355;26157.084502042337;26319.868400657873;26503.734962650127;26834.197434144415;26972.460550789267 13:13:08 INFO - PROCESS | 1655 | |2;jquery.html;379.39297124600625;386.51685393258435;395.3674121405753;396.06133463691054;404.01622050307503;14690;17277.531409830164;18964.810351896478;21336.786632133655;22448.76531790751;12099.971502422304;12125.757484850319;12439.626811195656;12479.750404991917;17073.658526829488;5439.782408703647;5599.636023658449;5615.438456154372;5616.438356164372;5625.437456254363;3912.960870391288;6485;6587.868242635144;6900.3444672756;6909.205441374231;5740.971295143519;6087.847803804918;6454.419102280794;6868.450523958097;6919.515633905628;4608;6103.6032657877095;6146.84632884177;6152.78465253714;6155.969220153916;5795.82612521625;5843.620164689281;5858.882822343572;5881.823545293648;5904.114382842608;17895.910520447444;26130.86934565334;26975.055873044348;27038.729612704014;27155.592666110024;2127.3298910843037;2222.466608014081;2231.497912969569;2346.1319311854554;2796.930076748077;10373.222008349405;10478.790424191473;11059.281146725438;11606.12630807766;16708.83291167085;1923.7306777051224;1925.643755905162;1927.4795805132676;1928.5082304012387;1933.6519426503223;121388;134604;134865.6513434863;136178;136383.31808340995;11548.249363791327;11651.30092194471;11653.00949419309;11749.236299640495;11777;12129.87870121305;14751.041182323115;14802.407903683947;14835.03572267799;14853.183074930983;8470.830583388297;8681.782955426164;8746.91253087461;8785.033646298902;8786.86819697705;8690.739277821676;8698.217160455462;8735.737927862174;8837.60230789616;8867.157620026088;4182.853600123981;4566.06395688883;4582.770861456914;4625.167469855391;4651.86044418668;1693.3903794633923;1846;1860.6278744251204;1991.1836147179588;1995.750531183602;820.5035953248199;878.870651213188;883.4037025008093;908.8818453601122;983.5854266747897;15473.5357939262;17755.73366399505;21780.466724287024;21947.67078493824;23306.951187196617;778.5285809819446;938.5307346326837;942.5617088054088;982.823091843475;1016.598443614768;9353.90646093544;11056.834147487794;11260.324380537195;11554.306741595532;11614.012808911337;542009;614081;618956;620656.8967155135;625388;144974;146554;147374;150163;150346;1030.386919782728;1034.4569101221919;1049.6850944716555;1050.217587897037;1050.9579616815395;19255.8074419254;19256.22975080981;20804.167833286498;20833.89583052075;21085.894570527664;58850;59671.70164149151;59841.401585985324;59948.700256498436;60139;80716.19283807321;83110;83727;83793;84510;8400.579971001303;8520.61657225414;8535.402521823413;8638.352123590881;8659.437136586102;12946.352682365656;13756.17462952226;13809.861901380858;13859.307034648025;13905.513307034205;11722.765544688888;11881.346525940811;11918.880811192124;11973.521059157536;12031.27812331263;11008.449577520933;11049.889501105208;11687.474063667325;11874.46564904564;11924.523019079139;11859.762804743685;11922;12002.519899203933;12016;12059.939700301793;6824.556403833735;8525.701600443954;8533.53065581399;8556.016058153393;8610.095939926217;8490.405671602928;10338.948305258426;10966.506507207036;11368.128321001077;11856.762864742484 13:13:08 INFO - PROCESS | 1655 | |3;mootools.html;1523.489630973624;1569.1448160752389;1782.1801971093296;1895.7725072991234;1903.6573416784972;7785.766427007185;8063.556504392256;8291.336693064555;8675.826483470326;9075.863862042075;8648.870266946002;8798.076201998794;8806.295496360292;8806.691765788199;8812.4712517249;2331.720193576773;2351.306364622432;2357.752435994213;2364.113457453455;2371.905123795046;2332.4751930815514;2336.894839732208;2354.3525530479083;2367.3371455992265;2374.2758458670187;2335.2060299498166;2335.8131349492087;2341.976580234193;2346.7887890089887;2355.352278123521;2312.3294244669028;2326.8254880883915;2334.21803695763;2338.8362814602983;2341.6604592334015;2325.802306803907;2335.591271527476;2335.7430682625068;2338.3218866528687;2344.284993077111;8815.471071735716;8817.515036672981;8914.064023277528;8981.955090224572;9015.36892417531;4667.766611669403;4794.256890182028;5151.356080489939;5213.5829133669595;5322.441143679896;3134.49848024315;3404;3557.5730912290433;3621.7323936622233;3633.836477358499;962.4802606592432;1003.9648612298607;1070.122499550369;1101.9669409917715;1112.9054030407426;9991.250656200742;11712.063034957184;11803.586874459439;11906.761864762657;11916.404179791063;4607.262837945979;4612.423447069116;4779.784909679072;4816.903661926742;4879.39007624047;9843.261755368376;9908.256880733974;9917.801643967225;10100.898991010143;10120.544575494121;5330.440303768126;5344.4922732340365;5364.570834333244;5364.624476286701;5382.461753824665;4340.652747780233;4721.5750582447745;4909.993451342466;4925.458199598042;4933.827316043921;3895.629915158112;3989.0625702959783;4020.557738648746;4025.838966441368;4115.753054816721;1087.8694556653252;1281.9423125959354;1292.4184117147322;1293.7994610835335;1298.571471414431;883.8541640629225;924.9768755781159;927.958241879117;963.036963036963;976.0727309056425;6044.7582096716515;6081.087836824512;6159.5072394208355;6243.469305109116;6357.809265722036;951.6145960885852;951.6574033347989;967.8596603492454;982.4449186209769;988.6589126751403;3415.5047518109736;4130.56629053951;4196.8111434984885;4256.9574304257185;4260.808263628144;10699.893001070046;10931.617393391192;11078.113750899909;11117.110631149488;11121.944390277997;10834.783304334027;10950.835737463944;10975.615853445091;11041.39272340013;11046.171537134747;7960.641771120314;8338.958305208434;8351.624176911931;8458.28104611115;8478.194571515696;6073.848153796013;6138.324784273816;6148.600340977822;6194.194754682043;6223.533235007302;9853.507324633596;9883.901160988586;9903;9935.751606209902;10025.849612255675;8801.207891289814;9680.564374603018;9842.311038227255;9927.255455840985;10216.693499195037;7099;7442.96278518604;7621;7657.502262352929;7758.689652414066;8435.156484351515;8467.830643386975;8509.234168924579;8535.3598480113;8574.485530868167;7466.440016998638;7600.581967991813;7637.809054773675;7689.50018248812;7690.038745156856;6851.520393572402;6966.338197871194;7387.667554959932;7398.630068496446;7524.360429363346;6674.9332506676255;6706.798796036127;6708.563943343667;6725.865482690417;6744.797656070129;4475.5748203920575;4956.801727930842;5132.666376685504;5140.691558506502;5179.585633149414;5062.82280120194;5139.434662187082;5181.792728290826;5188.403333616531;5300.098983172793 13:13:08 INFO - PROCESS | 1655 | |4;prototype.html;293.7077607780259;300.45617432447284;313.18103160235984;319.37721443185785;322.36333241847353;5571.192177134313;5651.2935883014625;5812.285375814135;5868.589198756089;5871.471567558919;5009.749512524378;5321.840344789663;5544.251526043983;5712.685802280873;5766;4371.3661519079715;4374.4531933508315;4389.978050109745;4399.538048504909;4406.294992801152;3905.9649192963743;4132.636230044078;4157.521884983235;4367.279398899178;4391.231534481453;3573.5533058367705;3972.960270397288;4340.67444941629;4359.215341238576;4364.607185353333;3622.565292164957;4357.8451710296795;4359.019220675338;4367.366731823868;4373.584509471595;3594.6045934947133;3727.6645101940685;3763.8682646107527;3768.8680896168503;3770.3213421584105;4835.443923948756;5563.499285064323;5603.551715862721;5627.8593035174035;5638.40796716343;4408.919814645433;4623.491415944243;4983.377077865267;5059.696418214919;5081.593472522226;5708.543316534668;6019.578629495937;6023.6385816851125;6046.09308603713;6050.851947558642;3440.9655903440894;3622.728295377831;3933.0167458135465;4113.341865301567;4139.234241665302;6353.205849268841;6375.617462952191;6381.999999999954;6396.520260980398;6442.420182183626;3870.670992965573;3998.820053097618;4049.8785036448953;4197.496300443966;4220.345846393814;3919.0398352403845;4020.8994775130273;4262.318029115327;4268.850590229327;4271.337942618899;4219.45147130871;4999.900001999939;5004.974975125101;5046.369203849519;5057.317262169634;5097.64316497849;5588.936004435152;5841.620294680833;6151.292601350812;6215.782447614311;1399.601113682616;1404.4241860837212;1454.7236025155187;1474.378183997594;1491.6420059185934;767.5279702982625;870.6822009966317;883.7967267528504;889.5818965086528;894.6803464889366;4082.1223436961195;4245.936310955338;4301.65586753059;4648.884757435359;4818.759062046884;4362.90927268183;5007.749612519359;5230.581553475713;5269.446708095671;5296.788128474818;4213.220554197484;4614.584687378085;4694.201985662377;4789.204048481819;4839.249916262985;2347.1080989223988;2548.1463709657473;2567.4608332250064;2567.730388309238;2803.668257577675;5376.059189641797;5418.672425255838;5446.754896029688;5495.203195536625;5520.834374968757;4333.653307735373;4623.56076172763;4702.835400760957;4742.312364707098;5350.785968561214;4687.585893264972;4880.09676226272;5361.758720857649;5488.313960754906;5537.6954267515675;4681.7659117044695;4747.454042784986;5279.208118782213;5296.06068631913;5333.586504637113;4843.782029808596;4891.437484689306;5187.662801918014;5196.818111366084;5221.295125158207;4510.594046535827;4872.658913875995;5176;5451.419088464301;5523.226748255328;3313.4698448248164;3670.50448189491;3680.5031320772423;3699.2231631357718;3760.304343696425;4448.733076015449;4645.837395691135;4739.691920025188;5226.007058658843;6262.53031022666;5079.171498260549;6041.516678665608;6102.925005498152;6110.51115910735;6140.219336392396;5060.746962651926;6011.90982135277;6065.3934606539;6071.635701857903;6107.633541987495;5439.619226654255;5450.918236226539;5641.294838145232;5943.52451803846;5946.108083787293;5532.672158681968;5896.70516474166;6075.149479072845;6084.574079814371;6095.603785753912;5312.335958005249;5367.3827509836865;5906.940930590639;5956.285245770362;5973.910391344047 13:13:08 INFO - PROCESS | 1655 | |5;yui.html;649.9480041596671;738.121635254048;776.9223077692232;828.3580225325368;835.6072645856448;15871.444499442521;16024;16046;16068.919655401722;16083.83916160838;14780.926095369536;14815.33331000105;14885.851141488582;14890.776638350433;14907.403703851833;716.8888822232536;888.2361169394316;893;901.5987885391004;913.0732306708696;905.5789058087988;911.1435250864199;912.0879120879121;914.4878867834034;915.8946721127056;961.7403301108696;963.5278713430404;966.9516524173763;967.6613185385129;969.4910172159603;958.3052287091872;959.7216807125925;959.9664011759555;961.0437614573474;962.3696478806393;706.9010338552607;714.0752725220851;714.8641758066003;715.0811207598264;716.061958833924;15420.768688469681;15425.922870385688;15666.843331566652;15676.29456674441;15710.528684139494;13323.600291991159;13411.865881341158;13649.727005459836;13688.452461901512;14028.43886244549;13242.668933276746;13326.93336533311;13400;13487;13553.186808791505;3760.9811950940343;4130.731502452361;4555.840545580922;4642.0715856828765;4666.953330466686;105563.47218263937;107232.4638376803;107910;108249;111644.4417777914;11019;11055.391953442477;11178.552857885756;11206.439678016066;11475.196736228383;21165.57668846645;21315.015897774323;21326.253581124587;21337.253196138372;21337.35987920365;8106.918930810734;8158.796030099176;8177.059638141571;8214.712485063113;8270.582768286782;4584.15193189261;4595.012072404449;4601.67788254819;4663.137319595886;4782.760861956958;3397.490376443553;3426.6573342666034;3499.772514786531;3500.6674365935196;3506.0708912138302;637.7480895046431;644.3395519592361;653.9084528165965;658.3942772649174;665.3346653346654;559.0356634805011;584.272580637101;604.5526310530264;619.8326451857973;630.4767043354005;8956.462612243286;8980.191782739585;9108.59011344491;9127.178553930178;9149.862752058725;593.7892048322783;614.0850133301439;629.6945981199115;629.7103332467117;643.9388258115565;4309.935350969738;4429.136318417877;4461.24158892989;4462.352958820953;4568.954310456919;92819;127732.36133819271;133951;146678;147680;128254;131252;133638;133868.66131338757;134386;111821;114737.4263128679;116564;117236.8276317243;117376.41311793386;8406.915930840612;8537.445066070686;8611.82776344482;8791.428557143765;8800.647974080965;61192;62112.068318976155;62260;62486;62933;67376.66311668606;78855.81716274146;86143.13856861602;92605.07394925965;93369;11297;11401.600943966921;11809.645710628694;11853.34806585646;11855.940720296343;12406.875931240573;12420.053231637272;12453.564125255572;12454.875451245372;12913.677158071123;11928.522859085539;12010.519579216734;12035.75928481408;12315.69210769738;12337.013038956682;12039;12090.093243006986;12091.214071085351;12375.381230938237;12467.875321247035;8247.218396726495;8505.319574434154;8654.567271636268;9963.302568820403;10184.949075254874;8791.560421978747;9724.659636912675;10036.849447258443;10144.188464922936;10414.21893357986;9406.952965235403;9683.806323873343;10088.142507886912;10130.848037279595;10148 13:13:08 INFO - PROCESS | 1655 | __end_tp_report 13:13:08 INFO - PROCESS | 1655 | __start_cc_report 13:13:08 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,448 13:13:08 INFO - PROCESS | 1655 | __end_cc_report 13:13:08 INFO - PROCESS | 1655 | __startTimestamp1468959188048__endTimestamp 13:13:08 INFO - PROCESS | 1655 | 13:13:08 INFO - PROCESS | 1655 | ------- Summary: start ------- 13:13:08 INFO - PROCESS | 1655 | Number of tests: 6 13:13:08 INFO - PROCESS | 1655 | 13:13:08 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5754.02 Median:6079.57 stddev:790.09 (13.0%) stddev-sans-first:770.12 13:13:08 INFO - PROCESS | 1655 | Values: 3373.1 3376.4 3412.0 3414.3 3417.5 5764.3 5844.4 5892.4 5921.7 5964.7 5040.7 5161.7 5436.6 5756.0 5787.5 5201.4 5252.7 5306.4 5348.6 5362.2 507.1 5228.6 5293.0 5357.2 5379.0 4400.8 5270.3 5297.0 5298.7 5307.3 5290.2 5350.7 5370.6 5382.1 5405.5 4356.6 5221.0 5225.5 5285.3 5343.3 5726.7 5882.2 5893.6 5939.7 5952.5 6139.2 6196.3 6240.7 6251.4 6252.1 6128.7 6192.4 6212.4 6267.5 6275.4 5942.0 5955.8 5965.7 5976.6 5997.3 6210.8 6305.7 6329.8 6364.7 6380.0 5293.6 6167.9 6205.3 6205.5 6222.6 6199.9 6264.1 6294.1 6316.2 6319.7 6189.8 6204.1 6261.8 6271.5 6277.1 6193.8 6216.1 6216.2 6232.5 6251.0 4543.9 4580.7 5013.1 5024.4 5025.0 4205.2 4360.2 4406.0 4521.7 4568.1 5544.6 5952.9 6006.0 6071.0 6097.2 6271.2 6278.4 6282.2 6303.8 6314.0 5913.3 6008.2 6023.4 6047.3 6051.6 5499.0 5525.8 5531.5 5532.2 5536.5 6268.0 6493.1 6495.4 6528.3 6534.7 6167.5 6210.6 6216.5 6249.4 6268.2 6386.9 6418.6 6428.0 6434.4 6467.0 6151.4 6156.6 6185.4 6207.1 6230.4 6190.7 6202.4 6244.5 6268.9 6277.8 6240.7 6248.2 6265.2 6270.3 6273.7 6103.8 6140.1 6198.0 6211.9 6230.3 5092.4 5886.7 6019.8 6079.6 6102.2 5192.9 5806.6 6202.0 6218.2 6232.2 4930.3 6050.9 6093.7 6104.5 6113.2 13:13:08 INFO - PROCESS | 1655 | 13:13:08 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:67474.99 Median:39770.60 stddev:152245.31 (382.8%) stddev-sans-first:152589.31 13:13:08 INFO - PROCESS | 1655 | Values: 485.6 505.4 526.6 528.3 546.6 38698.2 40959.6 41016.0 41040.0 41109.4 33601.3 41032.4 41429.4 41479.6 42213.9 9587.6 9726.9 9773.5 9773.5 9778.4 9677.9 9755.2 9757.1 9764.4 9783.7 9665.6 9755.5 9784.2 9787.2 9806.9 9670.3 9671.8 9685.1 9704.4 9759.0 9557.4 9611.9 9630.6 9693.4 9710.6 39308.8 39309.0 39768.4 39772.8 39860.0 2959.8 3076.8 3318.0 3366.2 3402.1 30673.0 30949.5 31005.5 31090.5 31463.5 3043.7 3157.8 3173.9 3222.5 3277.1 423752.0 427304.0 430612.8 430749.0 431883.0 32826.0 33055.7 33063.8 33121.5 33668.7 29041.3 29460.9 33542.2 33596.3 34655.1 14490.1 14645.7 14747.8 14766.1 14790.3 12261.7 12268.7 12474.8 12610.0 12620.3 7201.0 7329.9 7370.7 7374.7 7422.4 3063.4 3091.0 3099.1 3106.8 3116.2 913.4 921.4 951.8 994.5 1023.5 29112.0 29461.7 29526.0 30195.4 30214.9 995.4 1026.9 1042.1 1046.6 1088.7 14676.9 15220.2 15479.0 15851.9 15919.5 547071.0 607347.0 660846.0 674951.0 693893.0 58428.7 58485.0 58768.1 58946.7 59060.7 1362.2 1363.1 1394.4 1398.0 1401.9 29085.3 29306.6 29374.3 29961.4 30079.8 41596.6 49457.8 49766.3 50379.5 50410.0 608820.0 611119.0 612768.0 614159.0 614708.0 26409.8 26467.9 26765.9 26837.0 26867.6 48518.0 49672.0 49757.0 49925.0 49987.0 35003.1 39957.4 40516.6 41166.4 42354.9 39832.4 40293.2 40590.8 41052.6 41632.4 33287.2 38001.8 38831.4 38932.8 39756.0 34909.7 34959.7 35795.0 35853.6 35980.8 26157.1 26319.9 26503.7 26834.2 26972.5 13:13:08 INFO - PROCESS | 1655 | 13:13:08 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:36438.32 Median:12340.13 stddev:101950.59 (826.2%) stddev-sans-first:102200.63 13:13:08 INFO - PROCESS | 1655 | Values: 379.4 386.5 395.4 396.1 404.0 14690.0 17277.5 18964.8 21336.8 22448.8 12100.0 12125.8 12439.6 12479.8 17073.7 5439.8 5599.6 5615.4 5616.4 5625.4 3913.0 6485.0 6587.9 6900.3 6909.2 5741.0 6087.8 6454.4 6868.5 6919.5 4608.0 6103.6 6146.8 6152.8 6156.0 5795.8 5843.6 5858.9 5881.8 5904.1 17895.9 26130.9 26975.1 27038.7 27155.6 2127.3 2222.5 2231.5 2346.1 2796.9 10373.2 10478.8 11059.3 11606.1 16708.8 1923.7 1925.6 1927.5 1928.5 1933.7 121388.0 134604.0 134865.7 136178.0 136383.3 11548.2 11651.3 11653.0 11749.2 11777.0 12129.9 14751.0 14802.4 14835.0 14853.2 8470.8 8681.8 8746.9 8785.0 8786.9 8690.7 8698.2 8735.7 8837.6 8867.2 4182.9 4566.1 4582.8 4625.2 4651.9 1693.4 1846.0 1860.6 1991.2 1995.8 820.5 878.9 883.4 908.9 983.6 15473.5 17755.7 21780.5 21947.7 23307.0 778.5 938.5 942.6 982.8 1016.6 9353.9 11056.8 11260.3 11554.3 11614.0 542009.0 614081.0 618956.0 620656.9 625388.0 144974.0 146554.0 147374.0 150163.0 150346.0 1030.4 1034.5 1049.7 1050.2 1051.0 19255.8 19256.2 20804.2 20833.9 21085.9 58850.0 59671.7 59841.4 59948.7 60139.0 80716.2 83110.0 83727.0 83793.0 84510.0 8400.6 8520.6 8535.4 8638.4 8659.4 12946.4 13756.2 13809.9 13859.3 13905.5 11722.8 11881.3 11918.9 11973.5 12031.3 11008.4 11049.9 11687.5 11874.5 11924.5 11859.8 11922.0 12002.5 12016.0 12059.9 6824.6 8525.7 8533.5 8556.0 8610.1 8490.4 10338.9 10966.5 11368.1 11856.8 13:13:08 INFO - PROCESS | 1655 | 13:13:08 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5737.19 Median:5165.47 stddev:3203.01 (62.0%) stddev-sans-first:3196.35 13:13:08 INFO - PROCESS | 1655 | Values: 1523.5 1569.1 1782.2 1895.8 1903.7 7785.8 8063.6 8291.3 8675.8 9075.9 8648.9 8798.1 8806.3 8806.7 8812.5 2331.7 2351.3 2357.8 2364.1 2371.9 2332.5 2336.9 2354.4 2367.3 2374.3 2335.2 2335.8 2342.0 2346.8 2355.4 2312.3 2326.8 2334.2 2338.8 2341.7 2325.8 2335.6 2335.7 2338.3 2344.3 8815.5 8817.5 8914.1 8982.0 9015.4 4667.8 4794.3 5151.4 5213.6 5322.4 3134.5 3404.0 3557.6 3621.7 3633.8 962.5 1004.0 1070.1 1102.0 1112.9 9991.3 11712.1 11803.6 11906.8 11916.4 4607.3 4612.4 4779.8 4816.9 4879.4 9843.3 9908.3 9917.8 10100.9 10120.5 5330.4 5344.5 5364.6 5364.6 5382.5 4340.7 4721.6 4910.0 4925.5 4933.8 3895.6 3989.1 4020.6 4025.8 4115.8 1087.9 1281.9 1292.4 1293.8 1298.6 883.9 925.0 928.0 963.0 976.1 6044.8 6081.1 6159.5 6243.5 6357.8 951.6 951.7 967.9 982.4 988.7 3415.5 4130.6 4196.8 4257.0 4260.8 10699.9 10931.6 11078.1 11117.1 11121.9 10834.8 10950.8 10975.6 11041.4 11046.2 7960.6 8339.0 8351.6 8458.3 8478.2 6073.8 6138.3 6148.6 6194.2 6223.5 9853.5 9883.9 9903.0 9935.8 10025.8 8801.2 9680.6 9842.3 9927.3 10216.7 7099.0 7443.0 7621.0 7657.5 7758.7 8435.2 8467.8 8509.2 8535.4 8574.5 7466.4 7600.6 7637.8 7689.5 7690.0 6851.5 6966.3 7387.7 7398.6 7524.4 6674.9 6706.8 6708.6 6725.9 6744.8 4475.6 4956.8 5132.7 5140.7 5179.6 5062.8 5139.4 5181.8 5188.4 5300.1 13:13:08 INFO - PROCESS | 1655 | 13:13:08 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4580.49 Median:4991.64 stddev:1413.38 (28.3%) stddev-sans-first:1380.24 13:13:08 INFO - PROCESS | 1655 | Values: 293.7 300.5 313.2 319.4 322.4 5571.2 5651.3 5812.3 5868.6 5871.5 5009.7 5321.8 5544.3 5712.7 5766.0 4371.4 4374.5 4390.0 4399.5 4406.3 3906.0 4132.6 4157.5 4367.3 4391.2 3573.6 3973.0 4340.7 4359.2 4364.6 3622.6 4357.8 4359.0 4367.4 4373.6 3594.6 3727.7 3763.9 3768.9 3770.3 4835.4 5563.5 5603.6 5627.9 5638.4 4408.9 4623.5 4983.4 5059.7 5081.6 5708.5 6019.6 6023.6 6046.1 6050.9 3441.0 3622.7 3933.0 4113.3 4139.2 6353.2 6375.6 6382.0 6396.5 6442.4 3870.7 3998.8 4049.9 4197.5 4220.3 3919.0 4020.9 4262.3 4268.9 4271.3 4219.5 4999.9 5005.0 5046.4 5057.3 5097.6 5588.9 5841.6 6151.3 6215.8 1399.6 1404.4 1454.7 1474.4 1491.6 767.5 870.7 883.8 889.6 894.7 4082.1 4245.9 4301.7 4648.9 4818.8 4362.9 5007.7 5230.6 5269.4 5296.8 4213.2 4614.6 4694.2 4789.2 4839.2 2347.1 2548.1 2567.5 2567.7 2803.7 5376.1 5418.7 5446.8 5495.2 5520.8 4333.7 4623.6 4702.8 4742.3 5350.8 4687.6 4880.1 5361.8 5488.3 5537.7 4681.8 4747.5 5279.2 5296.1 5333.6 4843.8 4891.4 5187.7 5196.8 5221.3 4510.6 4872.7 5176.0 5451.4 5523.2 3313.5 3670.5 3680.5 3699.2 3760.3 4448.7 4645.8 4739.7 5226.0 6262.5 5079.2 6041.5 6102.9 6110.5 6140.2 5060.7 6011.9 6065.4 6071.6 6107.6 5439.6 5450.9 5641.3 5943.5 5946.1 5532.7 5896.7 6075.1 6084.6 6095.6 5312.3 5367.4 5906.9 5956.3 5973.9 13:13:08 INFO - PROCESS | 1655 | 13:13:08 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:24020.13 Median:4461.80 stddev:38410.25 (860.9%) stddev-sans-first:38477.92 13:13:08 INFO - PROCESS | 1655 | Values: 649.9 738.1 776.9 828.4 835.6 15871.4 16024.0 16046.0 16068.9 16083.8 14780.9 14815.3 14885.9 14890.8 14907.4 716.9 888.2 893.0 901.6 913.1 905.6 911.1 912.1 914.5 915.9 961.7 963.5 967.0 967.7 969.5 958.3 959.7 960.0 961.0 962.4 706.9 714.1 714.9 715.1 716.1 15420.8 15425.9 15666.8 15676.3 15710.5 13323.6 13411.9 13649.7 13688.5 14028.4 13242.7 13326.9 13400.0 13487.0 13553.2 3761.0 4130.7 4555.8 4642.1 4667.0 105563.5 107232.5 107910.0 108249.0 111644.4 11019.0 11055.4 11178.6 11206.4 11475.2 21165.6 21315.0 21326.3 21337.3 21337.4 8106.9 8158.8 8177.1 8214.7 8270.6 4584.2 4595.0 4601.7 4663.1 4782.8 3397.5 3426.7 3499.8 3500.7 3506.1 637.7 644.3 653.9 658.4 665.3 559.0 584.3 604.6 619.8 630.5 8956.5 8980.2 9108.6 9127.2 9149.9 593.8 614.1 629.7 629.7 643.9 4309.9 4429.1 4461.2 4462.4 4569.0 92819.0 127732.4 133951.0 146678.0 147680.0 128254.0 131252.0 133638.0 133868.7 134386.0 111821.0 114737.4 116564.0 117236.8 117376.4 8406.9 8537.4 8611.8 8791.4 8800.6 61192.0 62112.1 62260.0 62486.0 62933.0 67376.7 78855.8 86143.1 92605.1 93369.0 11297.0 11401.6 11809.6 11853.3 11855.9 12406.9 12420.1 12453.6 12454.9 12913.7 11928.5 12010.5 12035.8 12315.7 12337.0 12039.0 12090.1 12091.2 12375.4 12467.9 8247.2 8505.3 8654.6 9963.3 10184.9 8791.6 9724.7 10036.8 10144.2 10414.2 9407.0 9683.8 10088.1 10130.8 10148.0 13:13:08 INFO - PROCESS | 1655 | -------- Summary: end -------- 13:13:08 INFO - PROCESS | 1655 | 13:13:08 INFO - TEST-INFO | 1655: exit 0 13:13:08 INFO - TEST-OK | dromaeo_css | took 1112804ms 13:13:08 INFO - TEST-START | kraken 13:13:08 INFO - operating with platform_type : mac_ 13:13:08 INFO - Initialising browser for kraken test... 13:13:08 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmp4Bmubq/profile http://localhost:49272/getInfo.html) 13:13:11 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 13:13:11 INFO - PROCESS | 1664 | colorDepth:24 13:13:11 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 13:13:11 INFO - PROCESS | 1664 | __metrics 13:13:11 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 13:13:12 INFO - TEST-INFO | 1664: exit 0 13:13:12 INFO - Browser initialized. 13:13:12 INFO - Running cycle 1/1 for kraken test... 13:13:12 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmp4Bmubq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:13:24 INFO - PROCESS | 1666 | RSS: Main: 254607360 13:13:24 INFO - PROCESS | 1666 | 13:13:27 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 13:13:28 INFO - PROCESS | 1666 | RSS: Main: 267366400 13:13:28 INFO - PROCESS | 1666 | 13:13:30 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 13:13:31 INFO - PROCESS | 1666 | RSS: Main: 271310848 13:13:31 INFO - PROCESS | 1666 | 13:13:34 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 13:13:35 INFO - PROCESS | 1666 | RSS: Main: 271245312 13:13:35 INFO - PROCESS | 1666 | 13:13:37 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 13:13:37 INFO - PROCESS | 1666 | RSS: Main: 272404480 13:13:37 INFO - PROCESS | 1666 | 13:13:39 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:13:40 INFO - PROCESS | 1666 | RSS: Main: 273178624 13:13:40 INFO - PROCESS | 1666 | 13:13:43 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 13:13:43 INFO - PROCESS | 1666 | RSS: Main: 274182144 13:13:43 INFO - PROCESS | 1666 | 13:13:46 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 13:13:47 INFO - PROCESS | 1666 | RSS: Main: 274100224 13:13:47 INFO - PROCESS | 1666 | 13:13:50 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 13:13:51 INFO - PROCESS | 1666 | RSS: Main: 274497536 13:13:51 INFO - PROCESS | 1666 | 13:13:52 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:13:53 INFO - PROCESS | 1666 | RSS: Main: 274165760 13:13:53 INFO - PROCESS | 1666 | 13:13:55 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:13:55 INFO - PROCESS | 1666 | RSS: Main: 274411520 13:13:55 INFO - PROCESS | 1666 | 13:13:57 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:13:58 INFO - PROCESS | 1666 | RSS: Main: 274595840 13:13:58 INFO - PROCESS | 1666 | 13:14:01 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:14:02 INFO - PROCESS | 1666 | RSS: Main: 274587648 13:14:02 INFO - PROCESS | 1666 | 13:14:05 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:14:05 INFO - PROCESS | 1666 | RSS: Main: 274571264 13:14:05 INFO - PROCESS | 1666 | 13:14:07 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 13:14:07 INFO - PROCESS | 1666 | RSS: Main: 275693568 13:14:07 INFO - PROCESS | 1666 | 13:14:07 INFO - PROCESS | 1666 | __start_tp_report 13:14:07 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 13:14:07 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 13:14:07 INFO - PROCESS | 1666 | |i|pagename|runs| 13:14:07 INFO - PROCESS | 1666 | |0;ai-astar;106;117;107;117;116;115;114;116;118;117 13:14:07 INFO - PROCESS | 1666 | |1;audio-beat-detection;142;111;128;158;108;128;147;142;159;131 13:14:07 INFO - PROCESS | 1666 | |2;audio-dft;198;200;198;198;213;219;195;201;200;195 13:14:07 INFO - PROCESS | 1666 | |3;audio-fft;65;80;76;112;59;60;58;64;133;66 13:14:07 INFO - PROCESS | 1666 | |4;audio-oscillator;70;70;122;72;73;84;110;69;73;113 13:14:07 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;92;89;91;89;91;88;92;90;91;86 13:14:07 INFO - PROCESS | 1666 | |6;imaging-darkroom;97;96;97;101;97;116;122;102;98;97 13:14:07 INFO - PROCESS | 1666 | |7;imaging-desaturate;144;143;90;91;91;92;91;115;147;147 13:14:07 INFO - PROCESS | 1666 | |8;json-parse-financial;55;57;53;56;58;55;55;55;56;56 13:14:07 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;70;71;69;79;90;79;76;71;76;74 13:14:07 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;84;84;85;86;76;95;102;102;101;75 13:14:07 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;144;155;143;137;134;134;135;138;179;136 13:14:07 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;166;171;194;165;229;204;168;163;167;163 13:14:07 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;59;62;87;90;84;66;68;64;68;70 13:14:07 INFO - PROCESS | 1666 | __end_tp_report 13:14:07 INFO - PROCESS | 1666 | __start_cc_report 13:14:07 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1122 13:14:07 INFO - PROCESS | 1666 | __end_cc_report 13:14:07 INFO - PROCESS | 1666 | __startTimestamp1468959247815__endTimestamp 13:14:07 INFO - PROCESS | 1666 | 13:14:07 INFO - PROCESS | 1666 | ------- Summary: start ------- 13:14:07 INFO - PROCESS | 1666 | Number of tests: 14 13:14:07 INFO - PROCESS | 1666 | 13:14:07 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:114.30 Median:116.50 stddev:4.27 (3.7%) stddev-sans-first:3.31 13:14:07 INFO - PROCESS | 1666 | Values: 106.0 117.0 107.0 117.0 116.0 115.0 114.0 116.0 118.0 117.0 13:14:07 INFO - PROCESS | 1666 | 13:14:07 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:135.40 Median:142.00 stddev:17.53 (12.3%) stddev-sans-first:18.43 13:14:07 INFO - PROCESS | 1666 | Values: 142.0 111.0 128.0 158.0 108.0 128.0 147.0 142.0 159.0 131.0 13:14:07 INFO - PROCESS | 1666 | 13:14:07 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:201.70 Median:200.00 stddev:7.92 (4.0%) stddev-sans-first:8.28 13:14:07 INFO - PROCESS | 1666 | Values: 198.0 200.0 198.0 198.0 213.0 219.0 195.0 201.0 200.0 195.0 13:14:07 INFO - PROCESS | 1666 | 13:14:07 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:77.30 Median:64.50 stddev:25.34 (39.3%) stddev-sans-first:26.48 13:14:07 INFO - PROCESS | 1666 | Values: 65.0 80.0 76.0 112.0 59.0 60.0 58.0 64.0 133.0 66.0 13:14:07 INFO - PROCESS | 1666 | 13:14:07 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:85.60 Median:71.00 stddev:20.92 (29.5%) stddev-sans-first:21.41 13:14:07 INFO - PROCESS | 1666 | Values: 70.0 70.0 122.0 72.0 73.0 84.0 110.0 69.0 73.0 113.0 13:14:07 INFO - PROCESS | 1666 | 13:14:07 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:89.90 Median:91.00 stddev:1.91 (2.1%) stddev-sans-first:1.87 13:14:07 INFO - PROCESS | 1666 | Values: 92.0 89.0 91.0 89.0 91.0 88.0 92.0 90.0 91.0 86.0 13:14:07 INFO - PROCESS | 1666 | 13:14:07 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:102.30 Median:97.00 stddev:9.12 (9.4%) stddev-sans-first:9.47 13:14:07 INFO - PROCESS | 1666 | Values: 97.0 96.0 97.0 101.0 97.0 116.0 122.0 102.0 98.0 97.0 13:14:07 INFO - PROCESS | 1666 | 13:14:07 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:115.10 Median:90.50 stddev:26.99 (29.8%) stddev-sans-first:26.52 13:14:07 INFO - PROCESS | 1666 | Values: 144.0 143.0 90.0 91.0 91.0 92.0 91.0 115.0 147.0 147.0 13:14:07 INFO - PROCESS | 1666 | 13:14:07 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.35 (2.4%) stddev-sans-first:1.41 13:14:07 INFO - PROCESS | 1666 | Values: 55.0 57.0 53.0 56.0 58.0 55.0 55.0 55.0 56.0 56.0 13:14:07 INFO - PROCESS | 1666 | 13:14:07 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:75.50 Median:76.00 stddev:6.24 (8.2%) stddev-sans-first:6.29 13:14:07 INFO - PROCESS | 1666 | Values: 70.0 71.0 69.0 79.0 90.0 79.0 76.0 71.0 76.0 74.0 13:14:07 INFO - PROCESS | 1666 | 13:14:07 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:84.00 stddev:10.32 (12.3%) stddev-sans-first:10.78 13:14:07 INFO - PROCESS | 1666 | Values: 84.0 84.0 85.0 86.0 76.0 95.0 102.0 102.0 101.0 75.0 13:14:07 INFO - PROCESS | 1666 | 13:14:07 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:143.50 Median:140.50 stddev:14.04 (10.0%) stddev-sans-first:14.89 13:14:07 INFO - PROCESS | 1666 | Values: 144.0 155.0 143.0 137.0 134.0 134.0 135.0 138.0 179.0 136.0 13:14:07 INFO - PROCESS | 1666 | 13:14:07 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.00 Median:169.50 stddev:22.50 (13.3%) stddev-sans-first:23.37 13:14:07 INFO - PROCESS | 1666 | Values: 166.0 171.0 194.0 165.0 229.0 204.0 168.0 163.0 167.0 163.0 13:14:07 INFO - PROCESS | 1666 | 13:14:07 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:69.00 stddev:11.04 (16.0%) stddev-sans-first:10.70 13:14:07 INFO - PROCESS | 1666 | Values: 59.0 62.0 87.0 90.0 84.0 66.0 68.0 64.0 68.0 70.0 13:14:07 INFO - PROCESS | 1666 | -------- Summary: end -------- 13:14:07 INFO - PROCESS | 1666 | 13:14:08 INFO - TEST-INFO | 1666: exit 0 13:14:08 INFO - TEST-OK | kraken | took 60074ms 13:14:08 INFO - SUITE-END | took 1172s 13:14:08 INFO - Completed test suite (00:19:33) 13:14:08 INFO - javascript benchmark 13:14:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7279.910102138314, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3373.1061268763765, 3376.358491886542, 3411.9658803411967, 3414.2830005698816, 3417.5386322846425, 5764.270271613525, 5844.415558444153, 5892.381299963501, 5921.674307913063, 5964.701764911748, 5040.697558146514, 5161.657968928087, 5436.565074794017, 5755.971220143904, 5787.536997040237, 5201.427842937273, 5252.6848389096585, 5306.363236411636, 5348.598855085865, 5362.168863826094, 507.1494590333279, 5228.633995620308, 5292.973535132319, 5357.196420536931, 5379.0, 4400.823967041347, 5270.314859068297, 5296.9735151324385, 5298.7350632468415, 5307.336582927134, 5290.206469029637, 5350.705711185883, 5370.57035437168, 5382.0581398255545, 5405.459454054602, 4356.564343565649, 5221.0, 5225.503577160163, 5285.260063591062, 5343.278657381243, 5726.68503232322, 5882.2353094097925, 5893.646381217098, 5939.67331796751, 5952.494038006775, 6139.154842350791, 6196.318404975449, 6240.656763877985, 6251.374862513758, 6252.124702541648, 6128.747575574743, 6192.442680158807, 6212.4408803207925, 6267.4986001119805, 6275.403836635558, 5942.0, 5955.821325360246, 5965.671888046112, 5976.6115202512565, 5997.310309314441, 6210.7515699372425, 6305.684715764285, 6329.778457753957, 6364.7135878885565, 6380.0, 5293.57651387888, 6167.876642467126, 6205.2553693557065, 6205.503559715212, 6222.595531290452, 6199.876002480015, 6264.123022776815, 6294.087357333253, 6316.210473690789, 6319.715612797435, 6189.84525386869, 6204.100405441186, 6261.812145635638, 6271.4669253114, 6277.089821975788, 6193.783217587453, 6216.067589861466, 6216.160818289473, 6232.470240029557, 6251.0, 4543.909461729228, 4580.656450766206, 5013.1227035268685, 5024.42219144803, 5024.974875125601, 4205.222033923734, 4360.171567402183, 4406.0, 4521.683482156218, 4568.063546972862, 5544.63959842609, 5952.880942381128, 6006.0, 6071.0, 6097.207363042776, 6271.184745983084, 6278.434940855345, 6282.246130464374, 6303.842403939938, 6314.0, 5913.349531551526, 6008.24896887889, 6023.397660233942, 6047.3045599755715, 6051.576389652682, 5498.972505137449, 5525.778968841281, 5531.502164805187, 5532.225488431623, 5536.529395001389, 6268.0, 6493.123428337209, 6495.415412612888, 6528.347165283433, 6534.673266336664, 6167.537434692326, 6210.596311239755, 6216.502679785697, 6249.437550620466, 6268.153799237227, 6386.90419643715, 6418.582792118497, 6427.967860160669, 6434.420902118832, 6467.0, 6151.415615516519, 6156.5998210116195, 6185.443310102112, 6207.099970504342, 6230.43926046658, 6190.721417536131, 6202.379762023762, 6244.469220116341, 6268.937310626835, 6277.811665650038, 6240.656763878031, 6248.156498872594, 6265.248170219421, 6270.278917924497, 6273.65494897785, 6103.786367477117, 6140.105498721277, 6198.0, 6211.9068213977735, 6230.252369715482, 5092.414372347227, 5886.735096920564, 6019.789307374221, 6079.574429789872, 6102.237220347457, 5192.948070519246, 5806.622569532967, 6202.007678771375, 6218.160548326099, 6232.158658581034, 4930.285108659296, 6050.909236361546, 6093.664848433379, 6104.45039575082, 6113.172264937315], "value": 5705.464968046308, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [485.6090846868271, 505.4061477763628, 526.6076772804262, 528.2841749429521, 546.59825028604, 38698.22603547931, 40959.59040409595, 41016.0, 41040.0, 41109.38335924956, 33601.327973440515, 41032.38451423231, 41429.37855932163, 41479.58520414795, 42213.94465138373, 9587.616495340195, 9726.90273097267, 9773.462459564722, 9773.51132443375, 9778.413295202276, 9677.903220967806, 9755.170810481117, 9757.073078057572, 9764.414135151877, 9783.657571984982, 9665.565049572751, 9755.512224388787, 9784.21726261901, 9787.168090712297, 9806.852897206547, 9670.274729395289, 9671.758206044835, 9685.128338449504, 9704.369216001009, 9759.0, 9557.378770379903, 9611.90388096117, 9630.614775408976, 9693.352130137893, 9710.611575537041, 39308.80345598282, 39309.0, 39768.40347394792, 39772.80113599442, 39860.0, 2959.837208953507, 3076.8461576921286, 3318.0, 3366.158460384879, 3402.081438011723, 30673.0, 30949.535756963665, 31005.534916976037, 31090.53364199539, 31463.52804707931, 3043.7412819910332, 3157.778955473118, 3173.904782856518, 3222.5166225066428, 3277.0987978305916, 423752.0, 427304.0, 430612.8469357696, 430749.0, 431882.99999999686, 32826.0, 33055.66944330574, 33063.83468082644, 33121.50317745236, 33668.66331336704, 29041.273968150967, 29460.852695736383, 33542.16144596356, 33596.328073438395, 34655.13362165966, 14490.058146220463, 14645.707085858436, 14747.778783318045, 14766.114033158045, 14790.260486975609, 12261.693457663452, 12268.693282668004, 12474.75050498985, 12609.991200703922, 12620.30588317633, 7200.991861139445, 7329.8900516492295, 7370.742024029133, 7374.705011799468, 7422.406207503494, 3063.433264846011, 3090.98454507726, 3099.1167517257472, 3106.782525223258, 3116.2365220520664, 913.4017218721748, 921.410297409645, 951.8381875081114, 994.5077186792583, 1023.4831410137833, 29112.0, 29461.705382946326, 29526.0, 30195.396092078034, 30214.94247701364, 995.3928103856787, 1026.8767747870304, 1042.0673497220098, 1046.6441409920662, 1088.7169335972703, 14676.926615367069, 15220.162891041098, 15479.0, 15851.890367674152, 15919.522414327588, 547071.0, 607347.0, 660846.0, 674951.0019599259, 693893.0, 58428.7078564613, 58485.0, 58768.11847822201, 58946.70526647425, 59060.70469647624, 1362.2303398579968, 1363.1275983370651, 1394.4491925689297, 1397.9580612581435, 1401.9345297573918, 29085.272868178465, 29306.560401593568, 29374.265643359086, 29961.400771984874, 30079.849600751855, 41596.58403416048, 49457.752711236215, 49766.253506196714, 50379.496205038944, 50410.0, 608820.0, 611119.0, 612768.0, 614159.0, 614708.0, 26409.811558480298, 26467.867660662345, 26765.92936282605, 26837.0, 26867.596986044835, 48518.0, 49672.0, 49757.0, 49925.0, 49987.00025999532, 35003.124921877155, 39957.40063898986, 40516.594834051284, 41166.382504263056, 42354.941126472084, 39832.40251396174, 40293.1941361177, 40590.79704601458, 41052.58947410607, 41632.3755143667, 33287.16782080467, 38001.80999095098, 38831.41752873766, 38932.80533597314, 39756.0, 34909.65090349064, 34959.65040349666, 35795.0, 35853.64146358503, 35980.820095899355, 26157.084502042337, 26319.868400657873, 26503.734962650127, 26834.197434144415, 26972.460550789267], "value": 18289.686554138832, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.39297124600625, 386.51685393258435, 395.3674121405753, 396.06133463691054, 404.01622050307503, 14690.0, 17277.531409830164, 18964.810351896478, 21336.786632133655, 22448.76531790751, 12099.971502422304, 12125.757484850319, 12439.626811195656, 12479.750404991917, 17073.658526829488, 5439.782408703647, 5599.636023658449, 5615.438456154372, 5616.438356164372, 5625.437456254363, 3912.960870391288, 6485.0, 6587.868242635144, 6900.3444672756, 6909.205441374231, 5740.971295143519, 6087.847803804918, 6454.419102280794, 6868.450523958097, 6919.515633905628, 4608.0, 6103.6032657877095, 6146.84632884177, 6152.78465253714, 6155.969220153916, 5795.82612521625, 5843.620164689281, 5858.882822343572, 5881.823545293648, 5904.114382842608, 17895.910520447444, 26130.86934565334, 26975.055873044348, 27038.729612704014, 27155.592666110024, 2127.3298910843037, 2222.466608014081, 2231.497912969569, 2346.1319311854554, 2796.930076748077, 10373.222008349405, 10478.790424191473, 11059.281146725438, 11606.12630807766, 16708.83291167085, 1923.7306777051224, 1925.643755905162, 1927.4795805132676, 1928.5082304012387, 1933.6519426503223, 121388.0, 134604.0, 134865.6513434863, 136178.0, 136383.31808340995, 11548.249363791327, 11651.30092194471, 11653.00949419309, 11749.236299640495, 11777.0, 12129.87870121305, 14751.041182323115, 14802.407903683947, 14835.03572267799, 14853.183074930983, 8470.830583388297, 8681.782955426164, 8746.91253087461, 8785.033646298902, 8786.86819697705, 8690.739277821676, 8698.217160455462, 8735.737927862174, 8837.60230789616, 8867.157620026088, 4182.853600123981, 4566.06395688883, 4582.770861456914, 4625.167469855391, 4651.86044418668, 1693.3903794633923, 1846.0, 1860.6278744251204, 1991.1836147179588, 1995.750531183602, 820.5035953248199, 878.870651213188, 883.4037025008093, 908.8818453601122, 983.5854266747897, 15473.5357939262, 17755.73366399505, 21780.466724287024, 21947.67078493824, 23306.951187196617, 778.5285809819446, 938.5307346326837, 942.5617088054088, 982.823091843475, 1016.598443614768, 9353.90646093544, 11056.834147487794, 11260.324380537195, 11554.306741595532, 11614.012808911337, 542009.0, 614081.0, 618956.0, 620656.8967155135, 625388.0, 144974.0, 146554.0, 147374.0, 150163.0, 150346.0, 1030.386919782728, 1034.4569101221919, 1049.6850944716555, 1050.217587897037, 1050.9579616815395, 19255.8074419254, 19256.22975080981, 20804.167833286498, 20833.89583052075, 21085.894570527664, 58850.0, 59671.70164149151, 59841.401585985324, 59948.700256498436, 60139.0, 80716.19283807321, 83110.0, 83727.0, 83793.0, 84510.0, 8400.579971001303, 8520.61657225414, 8535.402521823413, 8638.352123590881, 8659.437136586102, 12946.352682365656, 13756.17462952226, 13809.861901380858, 13859.307034648025, 13905.513307034205, 11722.765544688888, 11881.346525940811, 11918.880811192124, 11973.521059157536, 12031.27812331263, 11008.449577520933, 11049.889501105208, 11687.474063667325, 11874.46564904564, 11924.523019079139, 11859.762804743685, 11922.0, 12002.519899203933, 12016.0, 12059.939700301793, 6824.556403833735, 8525.701600443954, 8533.53065581399, 8556.016058153393, 8610.095939926217, 8490.405671602928, 10338.948305258426, 10966.506507207036, 11368.128321001077, 11856.762864742484], "value": 9759.84976440976, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1523.489630973624, 1569.1448160752389, 1782.1801971093296, 1895.7725072991234, 1903.6573416784972, 7785.766427007185, 8063.556504392256, 8291.336693064555, 8675.826483470326, 9075.863862042075, 8648.870266946002, 8798.076201998794, 8806.295496360292, 8806.691765788199, 8812.4712517249, 2331.720193576773, 2351.306364622432, 2357.752435994213, 2364.113457453455, 2371.905123795046, 2332.4751930815514, 2336.894839732208, 2354.3525530479083, 2367.3371455992265, 2374.2758458670187, 2335.2060299498166, 2335.8131349492087, 2341.976580234193, 2346.7887890089887, 2355.352278123521, 2312.3294244669028, 2326.8254880883915, 2334.21803695763, 2338.8362814602983, 2341.6604592334015, 2325.802306803907, 2335.591271527476, 2335.7430682625068, 2338.3218866528687, 2344.284993077111, 8815.471071735716, 8817.515036672981, 8914.064023277528, 8981.955090224572, 9015.36892417531, 4667.766611669403, 4794.256890182028, 5151.356080489939, 5213.5829133669595, 5322.441143679896, 3134.49848024315, 3404.0, 3557.5730912290433, 3621.7323936622233, 3633.836477358499, 962.4802606592432, 1003.9648612298607, 1070.122499550369, 1101.9669409917715, 1112.9054030407426, 9991.250656200742, 11712.063034957184, 11803.586874459439, 11906.761864762657, 11916.404179791063, 4607.262837945979, 4612.423447069116, 4779.784909679072, 4816.903661926742, 4879.39007624047, 9843.261755368376, 9908.256880733974, 9917.801643967225, 10100.898991010143, 10120.544575494121, 5330.440303768126, 5344.4922732340365, 5364.570834333244, 5364.624476286701, 5382.461753824665, 4340.652747780233, 4721.5750582447745, 4909.993451342466, 4925.458199598042, 4933.827316043921, 3895.629915158112, 3989.0625702959783, 4020.557738648746, 4025.838966441368, 4115.753054816721, 1087.8694556653252, 1281.9423125959354, 1292.4184117147322, 1293.7994610835335, 1298.571471414431, 883.8541640629225, 924.9768755781159, 927.958241879117, 963.036963036963, 976.0727309056425, 6044.7582096716515, 6081.087836824512, 6159.5072394208355, 6243.469305109116, 6357.809265722036, 951.6145960885852, 951.6574033347989, 967.8596603492454, 982.4449186209769, 988.6589126751403, 3415.5047518109736, 4130.56629053951, 4196.8111434984885, 4256.9574304257185, 4260.808263628144, 10699.893001070046, 10931.617393391192, 11078.113750899909, 11117.110631149488, 11121.944390277997, 10834.783304334027, 10950.835737463944, 10975.615853445091, 11041.39272340013, 11046.171537134747, 7960.641771120314, 8338.958305208434, 8351.624176911931, 8458.28104611115, 8478.194571515696, 6073.848153796013, 6138.324784273816, 6148.600340977822, 6194.194754682043, 6223.533235007302, 9853.507324633596, 9883.901160988586, 9903.0, 9935.751606209902, 10025.849612255675, 8801.207891289814, 9680.564374603018, 9842.311038227255, 9927.255455840985, 10216.693499195037, 7099.0, 7442.96278518604, 7621.0, 7657.502262352929, 7758.689652414066, 8435.156484351515, 8467.830643386975, 8509.234168924579, 8535.3598480113, 8574.485530868167, 7466.440016998638, 7600.581967991813, 7637.809054773675, 7689.50018248812, 7690.038745156856, 6851.520393572402, 6966.338197871194, 7387.667554959932, 7398.630068496446, 7524.360429363346, 6674.9332506676255, 6706.798796036127, 6708.563943343667, 6725.865482690417, 6744.797656070129, 4475.5748203920575, 4956.801727930842, 5132.666376685504, 5140.691558506502, 5179.585633149414, 5062.82280120194, 5139.434662187082, 5181.792728290826, 5188.403333616531, 5300.098983172793], "value": 4619.038948894616, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.7077607780259, 300.45617432447284, 313.18103160235984, 319.37721443185785, 322.36333241847353, 5571.192177134313, 5651.2935883014625, 5812.285375814135, 5868.589198756089, 5871.471567558919, 5009.749512524378, 5321.840344789663, 5544.251526043983, 5712.685802280873, 5766.0, 4371.3661519079715, 4374.4531933508315, 4389.978050109745, 4399.538048504909, 4406.294992801152, 3905.9649192963743, 4132.636230044078, 4157.521884983235, 4367.279398899178, 4391.231534481453, 3573.5533058367705, 3972.960270397288, 4340.67444941629, 4359.215341238576, 4364.607185353333, 3622.565292164957, 4357.8451710296795, 4359.019220675338, 4367.366731823868, 4373.584509471595, 3594.6045934947133, 3727.6645101940685, 3763.8682646107527, 3768.8680896168503, 3770.3213421584105, 4835.443923948756, 5563.499285064323, 5603.551715862721, 5627.8593035174035, 5638.40796716343, 4408.919814645433, 4623.491415944243, 4983.377077865267, 5059.696418214919, 5081.593472522226, 5708.543316534668, 6019.578629495937, 6023.6385816851125, 6046.09308603713, 6050.851947558642, 3440.9655903440894, 3622.728295377831, 3933.0167458135465, 4113.341865301567, 4139.234241665302, 6353.205849268841, 6375.617462952191, 6381.999999999954, 6396.520260980398, 6442.420182183626, 3870.670992965573, 3998.820053097618, 4049.8785036448953, 4197.496300443966, 4220.345846393814, 3919.0398352403845, 4020.8994775130273, 4262.318029115327, 4268.850590229327, 4271.337942618899, 4219.45147130871, 4999.900001999939, 5004.974975125101, 5046.369203849519, 5057.317262169634, 5097.64316497849, 5588.936004435152, 5841.620294680833, 6151.292601350812, 6215.782447614311, 1399.601113682616, 1404.4241860837212, 1454.7236025155187, 1474.378183997594, 1491.6420059185934, 767.5279702982625, 870.6822009966317, 883.7967267528504, 889.5818965086528, 894.6803464889366, 4082.1223436961195, 4245.936310955338, 4301.65586753059, 4648.884757435359, 4818.759062046884, 4362.90927268183, 5007.749612519359, 5230.581553475713, 5269.446708095671, 5296.788128474818, 4213.220554197484, 4614.584687378085, 4694.201985662377, 4789.204048481819, 4839.249916262985, 2347.1080989223988, 2548.1463709657473, 2567.4608332250064, 2567.730388309238, 2803.668257577675, 5376.059189641797, 5418.672425255838, 5446.754896029688, 5495.203195536625, 5520.834374968757, 4333.653307735373, 4623.56076172763, 4702.835400760957, 4742.312364707098, 5350.785968561214, 4687.585893264972, 4880.09676226272, 5361.758720857649, 5488.313960754906, 5537.6954267515675, 4681.7659117044695, 4747.454042784986, 5279.208118782213, 5296.06068631913, 5333.586504637113, 4843.782029808596, 4891.437484689306, 5187.662801918014, 5196.818111366084, 5221.295125158207, 4510.594046535827, 4872.658913875995, 5176.0, 5451.419088464301, 5523.226748255328, 3313.4698448248164, 3670.50448189491, 3680.5031320772423, 3699.2231631357718, 3760.304343696425, 4448.733076015449, 4645.837395691135, 4739.691920025188, 5226.007058658843, 6262.53031022666, 5079.171498260549, 6041.516678665608, 6102.925005498152, 6110.51115910735, 6140.219336392396, 5060.746962651926, 6011.90982135277, 6065.3934606539, 6071.635701857903, 6107.633541987495, 5439.619226654255, 5450.918236226539, 5641.294838145232, 5943.52451803846, 5946.108083787293, 5532.672158681968, 5896.70516474166, 6075.149479072845, 6084.574079814371, 6095.603785753912, 5312.335958005249, 5367.3827509836865, 5906.940930590639, 5956.285245770362, 5973.910391344047], "value": 4131.707840017769, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.9480041596671, 738.121635254048, 776.9223077692232, 828.3580225325368, 835.6072645856448, 15871.444499442521, 16024.0, 16046.0, 16068.919655401722, 16083.83916160838, 14780.926095369536, 14815.33331000105, 14885.851141488582, 14890.776638350433, 14907.403703851833, 716.8888822232536, 888.2361169394316, 893.0, 901.5987885391004, 913.0732306708696, 905.5789058087988, 911.1435250864199, 912.0879120879121, 914.4878867834034, 915.8946721127056, 961.7403301108696, 963.5278713430404, 966.9516524173763, 967.6613185385129, 969.4910172159603, 958.3052287091872, 959.7216807125925, 959.9664011759555, 961.0437614573474, 962.3696478806393, 706.9010338552607, 714.0752725220851, 714.8641758066003, 715.0811207598264, 716.061958833924, 15420.768688469681, 15425.922870385688, 15666.843331566652, 15676.29456674441, 15710.528684139494, 13323.600291991159, 13411.865881341158, 13649.727005459836, 13688.452461901512, 14028.43886244549, 13242.668933276746, 13326.93336533311, 13400.0, 13487.0, 13553.186808791505, 3760.9811950940343, 4130.731502452361, 4555.840545580922, 4642.0715856828765, 4666.953330466686, 105563.47218263937, 107232.4638376803, 107910.0, 108249.0, 111644.4417777914, 11019.0, 11055.391953442477, 11178.552857885756, 11206.439678016066, 11475.196736228383, 21165.57668846645, 21315.015897774323, 21326.253581124587, 21337.253196138372, 21337.35987920365, 8106.918930810734, 8158.796030099176, 8177.059638141571, 8214.712485063113, 8270.582768286782, 4584.15193189261, 4595.012072404449, 4601.67788254819, 4663.137319595886, 4782.760861956958, 3397.490376443553, 3426.6573342666034, 3499.772514786531, 3500.6674365935196, 3506.0708912138302, 637.7480895046431, 644.3395519592361, 653.9084528165965, 658.3942772649174, 665.3346653346654, 559.0356634805011, 584.272580637101, 604.5526310530264, 619.8326451857973, 630.4767043354005, 8956.462612243286, 8980.191782739585, 9108.59011344491, 9127.178553930178, 9149.862752058725, 593.7892048322783, 614.0850133301439, 629.6945981199115, 629.7103332467117, 643.9388258115565, 4309.935350969738, 4429.136318417877, 4461.24158892989, 4462.352958820953, 4568.954310456919, 92819.0, 127732.36133819271, 133951.0, 146678.0, 147680.0, 128254.0, 131252.0, 133638.0, 133868.66131338757, 134386.0, 111821.0, 114737.4263128679, 116564.0, 117236.8276317243, 117376.41311793386, 8406.915930840612, 8537.445066070686, 8611.82776344482, 8791.428557143765, 8800.647974080965, 61192.0, 62112.068318976155, 62260.0, 62486.0, 62933.0, 67376.66311668606, 78855.81716274146, 86143.13856861602, 92605.07394925965, 93369.0, 11297.0, 11401.600943966921, 11809.645710628694, 11853.34806585646, 11855.940720296343, 12406.875931240573, 12420.053231637272, 12453.564125255572, 12454.875451245372, 12913.677158071123, 11928.522859085539, 12010.519579216734, 12035.75928481408, 12315.69210769738, 12337.013038956682, 12039.0, 12090.093243006986, 12091.214071085351, 12375.381230938237, 12467.875321247035, 8247.218396726495, 8505.319574434154, 8654.567271636268, 9963.302568820403, 10184.949075254874, 8791.560421978747, 9724.659636912675, 10036.849447258443, 10144.188464922936, 10414.21893357986, 9406.952965235403, 9683.806323873343, 10088.142507886912, 10130.848037279595, 10148.0], "value": 7657.591066862104, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 107.0, 117.0, 116.0, 115.0, 114.0, 116.0, 118.0, 117.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 111.0, 128.0, 158.0, 108.0, 128.0, 147.0, 142.0, 159.0, 131.0], "value": 135.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 200.0, 198.0, 198.0, 213.0, 219.0, 195.0, 201.0, 200.0, 195.0], "value": 201.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 80.0, 76.0, 112.0, 59.0, 60.0, 58.0, 64.0, 133.0, 66.0], "value": 77.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 122.0, 72.0, 73.0, 84.0, 110.0, 69.0, 73.0, 113.0], "value": 85.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 89.0, 91.0, 89.0, 91.0, 88.0, 92.0, 90.0, 91.0, 86.0], "value": 89.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 97.0, 101.0, 97.0, 116.0, 122.0, 102.0, 98.0, 97.0], "value": 102.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 143.0, 90.0, 91.0, 91.0, 92.0, 91.0, 115.0, 147.0, 147.0], "value": 115.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 53.0, 56.0, 58.0, 55.0, 55.0, 55.0, 56.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 69.0, 79.0, 90.0, 79.0, 76.0, 71.0, 76.0, 74.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 86.0, 76.0, 95.0, 102.0, 102.0, 101.0, 75.0], "value": 89.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 155.0, 143.0, 137.0, 134.0, 134.0, 135.0, 138.0, 179.0, 136.0], "value": 143.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 171.0, 194.0, 165.0, 229.0, 204.0, 168.0, 163.0, 167.0, 163.0], "value": 179.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 87.0, 90.0, 84.0, 66.0, 68.0, 64.0, 68.0, 70.0], "value": 71.8, "unit": "score"}]}]} 13:14:09 INFO - Return code: 0 13:14:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:14:09 ERROR - # TBPL SUCCESS # 13:14:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:14:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:14:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:14:09 INFO - 2016-07-19 13:14:09.131 screenresolution[1671:10292] starting screenresolution argv=screenresolution get 13:14:09 INFO - 2016-07-19 13:14:09.135 screenresolution[1671:10292] Display 0: 1600x1200x32@60 13:14:09 INFO - 2016-07-19 13:14:09.141 screenresolution[1672:10295] starting screenresolution argv=screenresolution list 13:14:09 INFO - Available Modes on Display 0 13:14:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:14:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:14:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:14:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:14:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:14:09 INFO - Intel Iris: 13:14:09 INFO - Chipset Model: Intel Iris 13:14:09 INFO - Type: GPU 13:14:09 INFO - Bus: Built-In 13:14:09 INFO - VRAM (Dynamic, Max): 1536 MB 13:14:09 INFO - Vendor: Intel (0x8086) 13:14:09 INFO - Device ID: 0x0a2e 13:14:09 INFO - Revision ID: 0x0009 13:14:09 INFO - Displays: 13:14:09 INFO - Display: 13:14:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:14:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:14:09 INFO - Display Serial Number: 1600x1200 60 13:14:09 INFO - Main Display: Yes 13:14:09 INFO - Mirror: Off 13:14:09 INFO - Online: Yes 13:14:09 INFO - Rotation: Supported 13:14:09 INFO - Return code: 0 13:14:09 INFO - Running post-action listener: _resource_record_post_action 13:14:09 INFO - [mozharness: 2016-07-19 20:14:09.380213Z] Finished run-tests step (success) 13:14:09 INFO - Running post-run listener: _resource_record_post_run 13:14:09 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 37987328; Write bytes: 710481920; Read time: 388; Write time: 2003 13:14:09 INFO - TinderboxPrint: CPU usage
54.3% 13:14:09 INFO - TinderboxPrint: I/O read bytes / time
37,987,328 / 388 13:14:09 INFO - TinderboxPrint: I/O write bytes / time
710,481,920 / 2,003 13:14:09 INFO - TinderboxPrint: CPU idle
2,209.4 (45.7%) 13:14:09 INFO - TinderboxPrint: CPU system
974.0 (20.1%) 13:14:09 INFO - TinderboxPrint: CPU user
1,654.2 (34.2%) 13:14:09 INFO - TinderboxPrint: Swap in / out
445,767,680 / 0 13:14:09 INFO - install - Wall time: 36s; CPU: 55.0%; Read bytes: 400620032; Write bytes: 391628288; Read time: 30324; Write time: 751 13:14:09 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 31140864; Write bytes: 296102400; Read time: 301; Write time: 1196 13:14:09 INFO - Running post-run listener: _upload_blobber_files 13:14:09 INFO - Blob upload gear active. 13:14:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:14:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:14:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:14:10 INFO - (blobuploader) - INFO - Open directory for files ... 13:14:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:14:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:14:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:10 INFO - (blobuploader) - INFO - Done attempting. 13:14:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:14:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:14:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:11 INFO - (blobuploader) - INFO - Done attempting. 13:14:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:14:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:14:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:14 INFO - (blobuploader) - INFO - Done attempting. 13:14:14 INFO - (blobuploader) - INFO - Iteration through files over. 13:14:14 INFO - Return code: 0 13:14:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:14:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:14:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/55ad3cc88cb45bfd4d6052710e5649225facddf85a7fd1a460725ac717a00ff002f7cec22bf6ab5242565bc05d37b7a623dcdb263e4e53f163650a7347d9f517", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/74af1be362b7b18887835eb6d0d2a213e145dd20e3bad1de0895f6fb3550bf8fa96ee29b2fd2cbe384fbebc1b61bb1a074bb3cadeb2b2b27a749dbee1ffd8c27", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5e9fb26038c8b80eda470e26c5198809368d4660fc875ab54fa1feb74988c7eeea6a1fb345839b733f24b6db670225f77b7f8d4d90703a43a2d702b8a57e5b5f"} 13:14:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:14:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:14:14 INFO - Contents: 13:14:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/55ad3cc88cb45bfd4d6052710e5649225facddf85a7fd1a460725ac717a00ff002f7cec22bf6ab5242565bc05d37b7a623dcdb263e4e53f163650a7347d9f517", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/74af1be362b7b18887835eb6d0d2a213e145dd20e3bad1de0895f6fb3550bf8fa96ee29b2fd2cbe384fbebc1b61bb1a074bb3cadeb2b2b27a749dbee1ffd8c27", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5e9fb26038c8b80eda470e26c5198809368d4660fc875ab54fa1feb74988c7eeea6a1fb345839b733f24b6db670225f77b7f8d4d90703a43a2d702b8a57e5b5f"} 13:14:14 INFO - Running post-run listener: copy_logs_to_upload_dir 13:14:14 INFO - Copying logs to upload dir... 13:14:14 INFO - mkdir: /builds/slave/test/build/upload/logs 13:14:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.026969 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-19 13:14:14.718756) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 13:14:14.722281) ========= 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.Cx2EN2xwHC/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.fk2qm3Vqkj/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/55ad3cc88cb45bfd4d6052710e5649225facddf85a7fd1a460725ac717a00ff002f7cec22bf6ab5242565bc05d37b7a623dcdb263e4e53f163650a7347d9f517", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/74af1be362b7b18887835eb6d0d2a213e145dd20e3bad1de0895f6fb3550bf8fa96ee29b2fd2cbe384fbebc1b61bb1a074bb3cadeb2b2b27a749dbee1ffd8c27", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5e9fb26038c8b80eda470e26c5198809368d4660fc875ab54fa1feb74988c7eeea6a1fb345839b733f24b6db670225f77b7f8d4d90703a43a2d702b8a57e5b5f"} build_url:https://queue.taskcluster.net/v1/task/M7WjRPkBT76otnGyLrjIgg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011223 build_url: 'https://queue.taskcluster.net/v1/task/M7WjRPkBT76otnGyLrjIgg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/55ad3cc88cb45bfd4d6052710e5649225facddf85a7fd1a460725ac717a00ff002f7cec22bf6ab5242565bc05d37b7a623dcdb263e4e53f163650a7347d9f517", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/74af1be362b7b18887835eb6d0d2a213e145dd20e3bad1de0895f6fb3550bf8fa96ee29b2fd2cbe384fbebc1b61bb1a074bb3cadeb2b2b27a749dbee1ffd8c27", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5e9fb26038c8b80eda470e26c5198809368d4660fc875ab54fa1feb74988c7eeea6a1fb345839b733f24b6db670225f77b7f8d4d90703a43a2d702b8a57e5b5f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 13:14:14.754288) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 13:14:14.754607) ========= 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.Cx2EN2xwHC/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.fk2qm3Vqkj/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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.005153 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 13:14:14.804605) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 13:14:14.805290) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 13:14:14.805930) ========= ========= Total master_lag: 0.17 =========