builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0224 starttime: 1468027966.95 results: success (0) buildid: 20160708152725 builduid: 1a73598bcd764572bb2282ef95fa4385 revision: 4287a45df22d86765e15561a8834f6f3d00c24ec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 18:32:46.947299) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 18:32:46.947773) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 18:32:46.948053) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 18:32:46.973468) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 18:32:46.974053) ========= 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.r7YRl7JlBc/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.hTxsveKSG8/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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-08 18:32:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.4M=0.001s 2016-07-08 18:32:47 (13.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109633 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 18:32:47.107287) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 18:32:47.107673) ========= 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.r7YRl7JlBc/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.hTxsveKSG8/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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.025141 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 18:32:47.157285) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 18:32:47.157695) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 4287a45df22d86765e15561a8834f6f3d00c24ec --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 4287a45df22d86765e15561a8834f6f3d00c24ec --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.r7YRl7JlBc/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.hTxsveKSG8/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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-08 18:32:47,241 truncating revision to first 12 chars 2016-07-08 18:32:47,241 Setting DEBUG logging. 2016-07-08 18:32:47,241 attempt 1/10 2016-07-08 18:32:47,241 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/4287a45df22d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 18:32:48,316 unpacking tar archive at: autoland-4287a45df22d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.343581 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 18:32:48.523304) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 18:32:48.523650) ========= script_repo_revision: 4287a45df22d86765e15561a8834f6f3d00c24ec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 18:32:48.524093) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 18:32:48.524446) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 18:32:48.544360) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-07-08 18:32:48.544787) ========= /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.r7YRl7JlBc/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.hTxsveKSG8/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 18:32:48 INFO - MultiFileLogger online at 20160708 18:32:48 in /builds/slave/test 18:32:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 18:32:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:32:48 INFO - {'append_to_log': False, 18:32:48 INFO - 'base_work_dir': '/builds/slave/test', 18:32:48 INFO - 'blob_upload_branch': 'Autoland', 18:32:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:32:48 INFO - 'branch': 'Autoland', 18:32:48 INFO - 'buildbot_json_path': 'buildprops.json', 18:32:48 INFO - 'config_files': ('talos/mac_config.py',), 18:32:48 INFO - 'default_actions': ('clobber', 18:32:48 INFO - 'read-buildbot-config', 18:32:48 INFO - 'download-and-extract', 18:32:48 INFO - 'populate-webroot', 18:32:48 INFO - 'create-virtualenv', 18:32:48 INFO - 'install', 18:32:48 INFO - 'run-tests'), 18:32:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:32:48 INFO - 'download_minidump_stackwalk': True, 18:32:48 INFO - 'download_symbols': 'ondemand', 18:32:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:32:48 INFO - 'tooltool.py': '/tools/tooltool.py', 18:32:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:32:48 INFO - '/tools/misc-python/virtualenv.py')}, 18:32:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:32:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:32:48 INFO - 'installer_path': 'installer.exe', 18:32:48 INFO - 'log_level': 'info', 18:32:48 INFO - 'log_name': 'talos', 18:32:48 INFO - 'log_to_console': True, 18:32:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:32:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:32:48 INFO - 'opt_config_files': (), 18:32:48 INFO - 'pip_index': False, 18:32:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:32:48 INFO - 'cmd': ('bash', 18:32:48 INFO - '-c', 18:32:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:32:48 INFO - 'enabled': True, 18:32:48 INFO - 'halt_on_failure': False, 18:32:48 INFO - 'name': 'check_screen_resolution'},), 18:32:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:32:48 INFO - 'cmd': ('bash', 18:32:48 INFO - '-c', 18:32:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:32:48 INFO - 'enabled': True, 18:32:48 INFO - 'halt_on_failure': False, 18:32:48 INFO - 'name': 'check_screen_resolution'},), 18:32:48 INFO - 'run_cmd_checks_enabled': True, 18:32:48 INFO - 'sps_profile': False, 18:32:48 INFO - 'sps_profile_interval': 0, 18:32:48 INFO - 'suite': 'dromaeojs-e10s', 18:32:48 INFO - 'system_bits': '32', 18:32:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:32:48 INFO - 'title': 't-yosemite-r7-0224', 18:32:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:32:48 INFO - 'use_talos_json': True, 18:32:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:32:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:32:48 INFO - 'work_dir': 'build'} 18:32:48 INFO - ##### 18:32:48 INFO - ##### Running clobber step. 18:32:48 INFO - ##### 18:32:48 INFO - Running pre-action listener: _resource_record_pre_action 18:32:48 INFO - Running main action method: clobber 18:32:48 INFO - rmtree: /builds/slave/test/build 18:32:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:32:50 INFO - Running post-action listener: _resource_record_post_action 18:32:50 INFO - ##### 18:32:50 INFO - ##### Finished clobber step (success) 18:32:50 INFO - ##### 18:32:50 INFO - ##### 18:32:50 INFO - ##### Running read-buildbot-config step. 18:32:50 INFO - ##### 18:32:50 INFO - Running pre-action listener: _resource_record_pre_action 18:32:50 INFO - Running main action method: read_buildbot_config 18:32:50 INFO - Using buildbot properties: 18:32:50 INFO - { 18:32:50 INFO - "project": "", 18:32:50 INFO - "product": "firefox", 18:32:50 INFO - "script_repo_revision": "production", 18:32:50 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 18:32:50 INFO - "repository": "", 18:32:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 18:32:50 INFO - "buildid": "20160708152725", 18:32:50 INFO - "pgo_build": "False", 18:32:50 INFO - "basedir": "/builds/slave/test", 18:32:50 INFO - "buildnumber": 31, 18:32:50 INFO - "slavename": "t-yosemite-r7-0224", 18:32:50 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 18:32:50 INFO - "platform": "yosemite_r7", 18:32:50 INFO - "scheduler": "tests-autoland-macosx64-talos", 18:32:50 INFO - "branch": "autoland", 18:32:50 INFO - "repo_path": "integration/autoland", 18:32:50 INFO - "revision": "4287a45df22d86765e15561a8834f6f3d00c24ec", 18:32:50 INFO - "stage_platform": "macosx64", 18:32:50 INFO - "builduid": "1a73598bcd764572bb2282ef95fa4385", 18:32:50 INFO - "slavebuilddir": "test" 18:32:50 INFO - } 18:32:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 18:32:50 INFO - Running post-action listener: _resource_record_post_action 18:32:50 INFO - ##### 18:32:50 INFO - ##### Finished read-buildbot-config step (success) 18:32:50 INFO - ##### 18:32:50 INFO - ##### 18:32:50 INFO - ##### Running download-and-extract step. 18:32:50 INFO - ##### 18:32:50 INFO - Running pre-action listener: _resource_record_pre_action 18:32:50 INFO - Running main action method: download_and_extract 18:32:50 INFO - mkdir: /builds/slave/test/build/tests 18:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:50 INFO - https://queue.taskcluster.net/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 18:32:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 18:32:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 18:32:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 18:32:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 18:32:51 INFO - Downloaded 1199 bytes. 18:32:51 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 18:32:51 INFO - Using the following test package requirements: 18:32:51 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 18:32:51 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:32:51 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 18:32:51 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:32:51 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 18:32:51 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:32:51 INFO - u'jsshell-mac.zip'], 18:32:51 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:32:51 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 18:32:51 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 18:32:51 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:32:51 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 18:32:51 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:32:51 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 18:32:51 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:32:51 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 18:32:51 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:32:51 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 18:32:51 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:51 INFO - https://queue.taskcluster.net/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:32:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:32:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:32:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:32:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:32:53 INFO - Downloaded 18805120 bytes. 18:32:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:32:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:32:56 INFO - Return code: 0 18:32:56 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:56 INFO - https://queue.taskcluster.net/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:32:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:32:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:32:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:32:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:33:00 INFO - Downloaded 18805120 bytes. 18:33:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:33:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:33:04 INFO - Return code: 0 18:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:04 INFO - https://queue.taskcluster.net/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:33:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 18:33:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 18:33:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 18:33:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:33:05 INFO - Downloaded 14403333 bytes. 18:33:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:33:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 18:33:05 INFO - Return code: 0 18:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:05 INFO - https://queue.taskcluster.net/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:33:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 18:33:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 18:33:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 18:33:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 18:33:08 INFO - Downloaded 112496134 bytes. 18:33:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 18:33:08 INFO - mkdir: /builds/slave/test/properties 18:33:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:33:08 INFO - Writing to file /builds/slave/test/properties/build_url 18:33:08 INFO - Contents: 18:33:08 INFO - build_url:https://queue.taskcluster.net/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 18:33:09 INFO - Running post-action listener: _resource_record_post_action 18:33:09 INFO - Running post-action listener: set_extra_try_arguments 18:33:09 INFO - ##### 18:33:09 INFO - ##### Finished download-and-extract step (success) 18:33:09 INFO - ##### 18:33:09 INFO - ##### 18:33:09 INFO - ##### Running populate-webroot step. 18:33:09 INFO - ##### 18:33:09 INFO - Running pre-action listener: _resource_record_pre_action 18:33:09 INFO - Running main action method: populate_webroot 18:33:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:33:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:33:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:33:09 INFO - '--tppagecycles', 18:33:09 INFO - '7'], 18:33:09 INFO - 'tests': ['tsvgm']}}, 18:33:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:33:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:33:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:33:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:33:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:33:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:33:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:09 INFO - 'talos_options': ['--disable-e10s'], 18:33:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:33:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:33:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:09 INFO - 'talos_options': ['--disable-e10s'], 18:33:09 INFO - 'tests': ['damp', 'tps']}, 18:33:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:09 INFO - 'tests': ['damp', 'tps']}, 18:33:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:33:09 INFO - 'tests': ['dromaeo_dom']}, 18:33:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:33:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:33:09 INFO - 'tests': ['basic_compositor_video']}, 18:33:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:33:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:33:09 INFO - 'tests': ['a11yr', 18:33:09 INFO - 'ts_paint', 18:33:09 INFO - 'tpaint', 18:33:09 INFO - 'sessionrestore', 18:33:09 INFO - 'sessionrestore_no_auto_restore', 18:33:09 INFO - 'tabpaint']}, 18:33:09 INFO - 'other-e10s': {'tests': ['a11yr', 18:33:09 INFO - 'ts_paint', 18:33:09 INFO - 'tpaint', 18:33:09 INFO - 'sessionrestore', 18:33:09 INFO - 'sessionrestore_no_auto_restore', 18:33:09 INFO - 'tabpaint']}, 18:33:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:33:09 INFO - 'ts_paint', 18:33:09 INFO - 'tpaint', 18:33:09 INFO - 'sessionrestore', 18:33:09 INFO - 'sessionrestore_no_auto_restore', 18:33:09 INFO - 'tabpaint']}, 18:33:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:33:09 INFO - 'ts_paint', 18:33:09 INFO - 'tpaint', 18:33:09 INFO - 'sessionrestore', 18:33:09 INFO - 'sessionrestore_no_auto_restore', 18:33:09 INFO - 'tabpaint']}, 18:33:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:33:09 INFO - 'tests': ['a11yr', 18:33:09 INFO - 'ts_paint', 18:33:09 INFO - 'tpaint', 18:33:09 INFO - 'sessionrestore', 18:33:09 INFO - 'sessionrestore_no_auto_restore', 18:33:09 INFO - 'tabpaint']}, 18:33:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:33:09 INFO - 'tests': ['a11yr', 18:33:09 INFO - 'ts_paint', 18:33:09 INFO - 'tpaint', 18:33:09 INFO - 'sessionrestore', 18:33:09 INFO - 'sessionrestore_no_auto_restore', 18:33:09 INFO - 'tabpaint']}, 18:33:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:33:09 INFO - 'tests': ['tsvgx', 18:33:09 INFO - 'tsvgr_opacity', 18:33:09 INFO - 'tart', 18:33:09 INFO - 'tscrollx', 18:33:09 INFO - 'cart']}, 18:33:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:33:09 INFO - 'tsvgr_opacity', 18:33:09 INFO - 'tart', 18:33:09 INFO - 'tscrollx', 18:33:09 INFO - 'cart']}, 18:33:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:09 INFO - 'talos_options': ['--disable-e10s'], 18:33:09 INFO - 'tests': ['tp5o']}, 18:33:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:09 INFO - 'tests': ['tp5o']}, 18:33:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:09 INFO - 'talos_options': ['--disable-e10s', 18:33:09 INFO - '--xperf_path', 18:33:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:33:09 INFO - 'tests': ['tp5n']}, 18:33:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:09 INFO - 'talos_options': ['--xperf_path', 18:33:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:33:09 INFO - 'tests': ['tp5n']}}, 18:33:09 INFO - 'talos.zip': {'path': '', 18:33:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:33:09 INFO - Running post-action listener: _resource_record_post_action 18:33:09 INFO - ##### 18:33:09 INFO - ##### Finished populate-webroot step (success) 18:33:09 INFO - ##### 18:33:09 INFO - ##### 18:33:09 INFO - ##### Running create-virtualenv step. 18:33:09 INFO - ##### 18:33:09 INFO - Running pre-action listener: _resource_record_pre_action 18:33:09 INFO - Running main action method: create_virtualenv 18:33:09 INFO - Creating virtualenv /builds/slave/test/build/venv 18:33:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:33:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:33:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:33:09 INFO - Using real prefix '/tools/python27' 18:33:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:33:10 INFO - Installing distribute.............................................................................................................................................................................................done. 18:33:12 INFO - Installing pip.................done. 18:33:12 INFO - Return code: 0 18:33:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:33: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')]} 18:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33: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')]} 18:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:12 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 0x10b302a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b397618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8420d6ca80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b266d30>, '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 0x10afcbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b25eb20>, '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.r7YRl7JlBc/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.hTxsveKSG8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:33:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:33:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:33:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7YRl7JlBc/Render', 18:33:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:12 INFO - 'HOME': '/Users/cltbld', 18:33:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:12 INFO - 'LOGNAME': 'cltbld', 18:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:12 INFO - 'MOZ_NO_REMOTE': '1', 18:33:12 INFO - 'NO_EM_RESTART': '1', 18:33:12 INFO - 'PAGER': '/bin/cat', 18:33:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:12 INFO - 'PWD': '/builds/slave/test', 18:33:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:12 INFO - 'SHELL': '/bin/bash', 18:33:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hTxsveKSG8/Listeners', 18:33:12 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 18:33:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:12 INFO - 'USER': 'cltbld', 18:33:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:12 INFO - 'XPC_FLAGS': '0x0', 18:33:12 INFO - 'XPC_SERVICE_NAME': '0', 18:33:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:33:13 INFO - Cleaning up... 18:33:13 INFO - Return code: 0 18:33:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b302a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b397618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8420d6ca80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b266d30>, '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 0x10afcbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b25eb20>, '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.r7YRl7JlBc/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.hTxsveKSG8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:33:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:33:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7YRl7JlBc/Render', 18:33:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:13 INFO - 'HOME': '/Users/cltbld', 18:33:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:13 INFO - 'LOGNAME': 'cltbld', 18:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:13 INFO - 'MOZ_NO_REMOTE': '1', 18:33:13 INFO - 'NO_EM_RESTART': '1', 18:33:13 INFO - 'PAGER': '/bin/cat', 18:33:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:13 INFO - 'PWD': '/builds/slave/test', 18:33:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:13 INFO - 'SHELL': '/bin/bash', 18:33:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hTxsveKSG8/Listeners', 18:33:13 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 18:33:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:13 INFO - 'USER': 'cltbld', 18:33:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:13 INFO - 'XPC_FLAGS': '0x0', 18:33:13 INFO - 'XPC_SERVICE_NAME': '0', 18:33:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:13 INFO - Downloading/unpacking psutil>=3.1.1 18:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:33:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:33:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:33:16 INFO - Installing collected packages: psutil 18:33:16 INFO - Running setup.py install for psutil 18:33:16 INFO - building 'psutil._psutil_osx' extension 18:33:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 18:33:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 18:33:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 18:33:17 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 18:33:17 INFO - building 'psutil._psutil_posix' extension 18:33:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 18:33:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:33:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:33:17 INFO - ^ 18:33:17 INFO - 1 warning generated. 18:33:17 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 18:33:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:33:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:33:17 INFO - Successfully installed psutil 18:33:17 INFO - Cleaning up... 18:33:17 INFO - Return code: 0 18:33:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b302a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b397618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8420d6ca80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b266d30>, '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 0x10afcbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b25eb20>, '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.r7YRl7JlBc/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.hTxsveKSG8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:33:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:33:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7YRl7JlBc/Render', 18:33:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:17 INFO - 'HOME': '/Users/cltbld', 18:33:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:17 INFO - 'LOGNAME': 'cltbld', 18:33:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:17 INFO - 'MOZ_NO_REMOTE': '1', 18:33:17 INFO - 'NO_EM_RESTART': '1', 18:33:17 INFO - 'PAGER': '/bin/cat', 18:33:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:17 INFO - 'PWD': '/builds/slave/test', 18:33:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:17 INFO - 'SHELL': '/bin/bash', 18:33:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hTxsveKSG8/Listeners', 18:33:17 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 18:33:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:17 INFO - 'USER': 'cltbld', 18:33:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:17 INFO - 'XPC_FLAGS': '0x0', 18:33:17 INFO - 'XPC_SERVICE_NAME': '0', 18:33:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:33:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:33:20 INFO - Installing collected packages: mozsystemmonitor 18:33:20 INFO - Running setup.py install for mozsystemmonitor 18:33:20 INFO - Successfully installed mozsystemmonitor 18:33:20 INFO - Cleaning up... 18:33:20 INFO - Return code: 0 18:33:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:20 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 0x10b302a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b397618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8420d6ca80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b266d30>, '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 0x10afcbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b25eb20>, '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.r7YRl7JlBc/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.hTxsveKSG8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:33:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:33:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:33:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7YRl7JlBc/Render', 18:33:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:20 INFO - 'HOME': '/Users/cltbld', 18:33:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:20 INFO - 'LOGNAME': 'cltbld', 18:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:20 INFO - 'MOZ_NO_REMOTE': '1', 18:33:20 INFO - 'NO_EM_RESTART': '1', 18:33:20 INFO - 'PAGER': '/bin/cat', 18:33:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:20 INFO - 'PWD': '/builds/slave/test', 18:33:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:20 INFO - 'SHELL': '/bin/bash', 18:33:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hTxsveKSG8/Listeners', 18:33:20 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 18:33:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:20 INFO - 'USER': 'cltbld', 18:33:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:20 INFO - 'XPC_FLAGS': '0x0', 18:33:20 INFO - 'XPC_SERVICE_NAME': '0', 18:33:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:20 INFO - Downloading/unpacking jsonschema==2.5.1 18:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:33:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:23 INFO - Downloading functools32-3.2.3-2.tar.gz 18:33:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:33:23 INFO - warning: no files found matching '*.txt' 18:33:23 INFO - no previously-included directories found matching 'build' 18:33:23 INFO - no previously-included directories found matching 'dist' 18:33:23 INFO - no previously-included directories found matching '.git*' 18:33:23 INFO - Installing collected packages: jsonschema, functools32 18:33:23 INFO - Running setup.py install for functools32 18:33:23 INFO - warning: no files found matching '*.txt' 18:33:23 INFO - no previously-included directories found matching 'build' 18:33:23 INFO - no previously-included directories found matching 'dist' 18:33:23 INFO - no previously-included directories found matching '.git*' 18:33:24 INFO - Successfully installed jsonschema functools32 18:33:24 INFO - Cleaning up... 18:33:24 INFO - Return code: 0 18:33:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:33: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')]} 18:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33: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')]} 18:33:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b302a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b397618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8420d6ca80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b266d30>, '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 0x10afcbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b25eb20>, '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.r7YRl7JlBc/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.hTxsveKSG8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:33:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:33:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:33:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7YRl7JlBc/Render', 18:33:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:24 INFO - 'HOME': '/Users/cltbld', 18:33:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:24 INFO - 'LOGNAME': 'cltbld', 18:33:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:24 INFO - 'MOZ_NO_REMOTE': '1', 18:33:24 INFO - 'NO_EM_RESTART': '1', 18:33:24 INFO - 'PAGER': '/bin/cat', 18:33:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:24 INFO - 'PWD': '/builds/slave/test', 18:33:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:24 INFO - 'SHELL': '/bin/bash', 18:33:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hTxsveKSG8/Listeners', 18:33:24 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 18:33:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:24 INFO - 'USER': 'cltbld', 18:33:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:24 INFO - 'XPC_FLAGS': '0x0', 18:33:24 INFO - 'XPC_SERVICE_NAME': '0', 18:33:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:24 INFO - Downloading/unpacking blobuploader==1.2.4 18:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:26 INFO - Downloading blobuploader-1.2.4.tar.gz 18:33:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:33:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:33:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:33:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:27 INFO - Downloading docopt-0.6.1.tar.gz 18:33:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:33:28 INFO - Installing collected packages: blobuploader, requests, docopt 18:33:28 INFO - Running setup.py install for blobuploader 18:33:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:33:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:33:28 INFO - Running setup.py install for requests 18:33:28 INFO - Running setup.py install for docopt 18:33:28 INFO - Successfully installed blobuploader requests docopt 18:33:28 INFO - Cleaning up... 18:33:28 INFO - Return code: 0 18:33:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:28 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 0x10b302a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b397618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8420d6ca80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b266d30>, '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 0x10afcbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b25eb20>, '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.r7YRl7JlBc/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.hTxsveKSG8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:33:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:33:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:33:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7YRl7JlBc/Render', 18:33:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:28 INFO - 'HOME': '/Users/cltbld', 18:33:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:28 INFO - 'LOGNAME': 'cltbld', 18:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:28 INFO - 'MOZ_NO_REMOTE': '1', 18:33:28 INFO - 'NO_EM_RESTART': '1', 18:33:28 INFO - 'PAGER': '/bin/cat', 18:33:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:28 INFO - 'PWD': '/builds/slave/test', 18:33:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:28 INFO - 'SHELL': '/bin/bash', 18:33:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hTxsveKSG8/Listeners', 18:33:28 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 18:33:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:28 INFO - 'USER': 'cltbld', 18:33:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:28 INFO - 'XPC_FLAGS': '0x0', 18:33:28 INFO - 'XPC_SERVICE_NAME': '0', 18:33:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:33:29 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-UTSO61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:33:29 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-ay6Tc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:33:29 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-YE7QGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:33:29 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-9PipSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:33:29 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-y_MROO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:33:29 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-0Dx_fO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:33:29 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-JOIKIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:33:29 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-lhXpFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:33:30 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-fEn0Ir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:33:30 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-I5AaBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:33:30 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-AgITTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:33:30 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-YebyJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:33:30 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-Dr3SvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:33:30 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-Qy9lqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:30 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-3uAGoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:33:30 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-lsM2pU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:33:30 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-WiDzr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:33:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:33:30 INFO - Running setup.py install for manifestparser 18:33:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:33:31 INFO - Running setup.py install for mozcrash 18:33:31 INFO - Running setup.py install for mozdebug 18:33:31 INFO - Running setup.py install for mozdevice 18:33:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:33:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:33:31 INFO - Running setup.py install for mozfile 18:33:31 INFO - Running setup.py install for mozhttpd 18:33:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:33:31 INFO - Running setup.py install for mozinfo 18:33:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:33:31 INFO - Running setup.py install for mozInstall 18:33:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:33:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:33:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:33:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:33:32 INFO - Running setup.py install for mozleak 18:33:32 INFO - Running setup.py install for mozlog 18:33:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:33:32 INFO - Running setup.py install for moznetwork 18:33:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:33:32 INFO - Running setup.py install for mozprocess 18:33:32 INFO - Running setup.py install for mozprofile 18:33:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:33:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:33:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:33:32 INFO - Running setup.py install for mozrunner 18:33:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:33:33 INFO - Running setup.py install for mozscreenshot 18:33:33 INFO - Running setup.py install for moztest 18:33:33 INFO - Running setup.py install for mozversion 18:33:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:33:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:33:33 INFO - Cleaning up... 18:33:33 INFO - Return code: 0 18:33:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:33: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')]} 18:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33: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')]} 18:33:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:33 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 0x10b302a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b397618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8420d6ca80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b266d30>, '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 0x10afcbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b25eb20>, '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.r7YRl7JlBc/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.hTxsveKSG8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:33:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:33:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:33:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7YRl7JlBc/Render', 18:33:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:33 INFO - 'HOME': '/Users/cltbld', 18:33:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:33 INFO - 'LOGNAME': 'cltbld', 18:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:33 INFO - 'MOZ_NO_REMOTE': '1', 18:33:33 INFO - 'NO_EM_RESTART': '1', 18:33:33 INFO - 'PAGER': '/bin/cat', 18:33:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:33 INFO - 'PWD': '/builds/slave/test', 18:33:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:33 INFO - 'SHELL': '/bin/bash', 18:33:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hTxsveKSG8/Listeners', 18:33:33 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 18:33:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:33 INFO - 'USER': 'cltbld', 18:33:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:33 INFO - 'XPC_FLAGS': '0x0', 18:33:33 INFO - 'XPC_SERVICE_NAME': '0', 18:33:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:33:33 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-z9RpQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:33:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:33:33 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-ZBqQfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:33:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:33:34 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-866IDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:33:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:33:34 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-SoDUZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:33:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:33:34 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-Bef1Wa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:33:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:33:34 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-SlKvPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:33:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:33:34 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-nxOb43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:33:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:33:34 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-5Z_7SM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:33:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:33:34 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-Q6jzX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:33:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:33:34 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-vkHItl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:33:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:33:34 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-Z0AMv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:33:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:33:34 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-17TepL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:33:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:33:35 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-95GrqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:33:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:33:35 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-EZf6e5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:33:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:35 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-VlkNXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:33:35 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-SZSWeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:33:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:33:35 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-CWX2XZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:33:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:33:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:33:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:33:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:33:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:33:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:33:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:38 INFO - Downloading blessings-1.6.tar.gz 18:33:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:33:38 INFO - Installing collected packages: blessings 18:33:38 INFO - Running setup.py install for blessings 18:33:38 INFO - Successfully installed blessings 18:33:38 INFO - Cleaning up... 18:33:38 INFO - Return code: 0 18:33:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:33:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:33:38 INFO - Reading from file tmpfile_stdout 18:33:38 INFO - Current package versions: 18:33:38 INFO - blessings == 1.6 18:33:38 INFO - blobuploader == 1.2.4 18:33:38 INFO - docopt == 0.6.1 18:33:38 INFO - functools32 == 3.2.3-2 18:33:38 INFO - jsonschema == 2.5.1 18:33:38 INFO - manifestparser == 1.1 18:33:38 INFO - mozInstall == 1.12 18:33:38 INFO - mozcrash == 0.17 18:33:38 INFO - mozdebug == 0.1 18:33:38 INFO - mozdevice == 0.48 18:33:38 INFO - mozfile == 1.2 18:33:38 INFO - mozhttpd == 0.7 18:33:38 INFO - mozinfo == 0.9 18:33:38 INFO - mozleak == 0.1 18:33:38 INFO - mozlog == 3.2 18:33:38 INFO - moznetwork == 0.27 18:33:38 INFO - mozprocess == 0.23 18:33:38 INFO - mozprofile == 0.28 18:33:38 INFO - mozrunner == 6.12 18:33:38 INFO - mozscreenshot == 0.1 18:33:38 INFO - mozsystemmonitor == 0.3 18:33:38 INFO - moztest == 0.7 18:33:38 INFO - mozversion == 1.4 18:33:38 INFO - psutil == 3.1.1 18:33:38 INFO - requests == 1.2.3 18:33:38 INFO - wsgiref == 0.1.2 18:33:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b302a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b397618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8420d6ca80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b266d30>, '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 0x10afcbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b25eb20>, '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.r7YRl7JlBc/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.hTxsveKSG8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:33:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:33:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7YRl7JlBc/Render', 18:33:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:39 INFO - 'HOME': '/Users/cltbld', 18:33:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:39 INFO - 'LOGNAME': 'cltbld', 18:33:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:39 INFO - 'MOZ_NO_REMOTE': '1', 18:33:39 INFO - 'NO_EM_RESTART': '1', 18:33:39 INFO - 'PAGER': '/bin/cat', 18:33:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:39 INFO - 'PWD': '/builds/slave/test', 18:33:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:39 INFO - 'SHELL': '/bin/bash', 18:33:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hTxsveKSG8/Listeners', 18:33:39 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 18:33:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:39 INFO - 'USER': 'cltbld', 18:33:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:39 INFO - 'XPC_FLAGS': '0x0', 18:33:39 INFO - 'XPC_SERVICE_NAME': '0', 18:33:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:33:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:33:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:33:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:33:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:33:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:33:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:33:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:33:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:33:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:33:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:33:39 INFO - Cleaning up... 18:33:39 INFO - Return code: 0 18:33:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:33:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b302a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b397618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8420d6ca80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b266d30>, '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 0x10afcbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b25eb20>, '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.r7YRl7JlBc/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.hTxsveKSG8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:33:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:33:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7YRl7JlBc/Render', 18:33:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:39 INFO - 'HOME': '/Users/cltbld', 18:33:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:39 INFO - 'LOGNAME': 'cltbld', 18:33:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:39 INFO - 'MOZ_NO_REMOTE': '1', 18:33:39 INFO - 'NO_EM_RESTART': '1', 18:33:39 INFO - 'PAGER': '/bin/cat', 18:33:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:39 INFO - 'PWD': '/builds/slave/test', 18:33:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:39 INFO - 'SHELL': '/bin/bash', 18:33:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hTxsveKSG8/Listeners', 18:33:39 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 18:33:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:39 INFO - 'USER': 'cltbld', 18:33:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:39 INFO - 'XPC_FLAGS': '0x0', 18:33:39 INFO - 'XPC_SERVICE_NAME': '0', 18:33:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:33:39 INFO - Cleaning up... 18:33:39 INFO - Return code: 0 18:33:39 INFO - Running post-action listener: _resource_record_post_action 18:33:39 INFO - Running post-action listener: _start_resource_monitoring 18:33:39 INFO - Starting resource monitoring. 18:33:39 INFO - ##### 18:33:39 INFO - ##### Finished create-virtualenv step (success) 18:33:39 INFO - ##### 18:33:39 INFO - ##### 18:33:39 INFO - ##### Running install step. 18:33:39 INFO - ##### 18:33:39 INFO - Running pre-action listener: _resource_record_pre_action 18:33:39 INFO - Running main action method: install 18:33:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:33:39 INFO - Reading from file tmpfile_stdout 18:33:39 INFO - Detecting whether we're running mozinstall >=1.0... 18:33:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:33:40 INFO - Reading from file tmpfile_stdout 18:33:40 INFO - Output received: 18:33:40 INFO - Usage: mozinstall [options] installer 18:33:40 INFO - Options: 18:33:40 INFO - -h, --help show this help message and exit 18:33:40 INFO - -d DEST, --destination=DEST 18:33:40 INFO - Directory to install application into. [default: 18:33:40 INFO - "/builds/slave/test"] 18:33:40 INFO - --app=APP Application being installed. [default: firefox] 18:33:40 INFO - mkdir: /builds/slave/test/build/application 18:33:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:33:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:34:14 INFO - Reading from file tmpfile_stdout 18:34:14 INFO - Output received: 18:34:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:34:14 INFO - Running post-action listener: _resource_record_post_action 18:34:14 INFO - ##### 18:34:14 INFO - ##### Finished install step (success) 18:34:14 INFO - ##### 18:34:14 INFO - ##### 18:34:14 INFO - ##### Running run-tests step. 18:34:14 INFO - ##### 18:34:14 INFO - Running pre-action listener: _resource_record_pre_action 18:34:14 INFO - Running main action method: run_tests 18:34:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:34:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:34:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:34:14 INFO - 2016-07-08 18:34:14.301 screenresolution[1641:7603] starting screenresolution argv=screenresolution get 18:34:14 INFO - 2016-07-08 18:34:14.304 screenresolution[1641:7603] Display 0: 1600x1200x32@60 18:34:14 INFO - 2016-07-08 18:34:14.310 screenresolution[1642:7605] starting screenresolution argv=screenresolution list 18:34:14 INFO - Available Modes on Display 0 18:34:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:34:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:34:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:34:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:34:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:34:14 INFO - Intel Iris: 18:34:14 INFO - Chipset Model: Intel Iris 18:34:14 INFO - Type: GPU 18:34:14 INFO - Bus: Built-In 18:34:14 INFO - VRAM (Dynamic, Max): 1536 MB 18:34:14 INFO - Vendor: Intel (0x8086) 18:34:14 INFO - Device ID: 0x0a2e 18:34:14 INFO - Revision ID: 0x0009 18:34:14 INFO - Displays: 18:34:14 INFO - Display: 18:34:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:34:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:34:14 INFO - Display Serial Number: 1600x1200 60 18:34:14 INFO - Main Display: Yes 18:34:14 INFO - Mirror: Off 18:34:14 INFO - Online: Yes 18:34:14 INFO - Rotation: Supported 18:34:14 INFO - Return code: 0 18:34:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:34:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:34:14 INFO - Python 2.7.3 18:34:14 INFO - Return code: 0 18:34:14 INFO - grabbing minidump binary from tooltool 18:34:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:34:14 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b266d30>, '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 0x10afcbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b25eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:34:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:34:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 18:34:14 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:34:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:34:14 INFO - Return code: 0 18:34:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:34:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:34:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:34:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:34:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:34:14 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/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0224', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:34:14 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/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0224 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:34:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7YRl7JlBc/Render', 18:34:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:34:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:34:14 INFO - 'HOME': '/Users/cltbld', 18:34:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:34:14 INFO - 'LOGNAME': 'cltbld', 18:34:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:34:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:14 INFO - 'MOZ_NO_REMOTE': '1', 18:34:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:34:14 INFO - 'NO_EM_RESTART': '1', 18:34:14 INFO - 'PAGER': '/bin/cat', 18:34:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:14 INFO - 'PWD': '/builds/slave/test', 18:34:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:34:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:34:14 INFO - 'SHELL': '/bin/bash', 18:34:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hTxsveKSG8/Listeners', 18:34:14 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 18:34:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:34:14 INFO - 'USER': 'cltbld', 18:34:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:34:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:14 INFO - 'XPC_FLAGS': '0x0', 18:34:14 INFO - 'XPC_SERVICE_NAME': '0', 18:34:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:34:14 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/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0224', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:34:14 INFO - mozversion application_buildid: 20160708152725 18:34:14 INFO - mozversion application_changeset: 4287a45df22d86765e15561a8834f6f3d00c24ec 18:34:14 INFO - mozversion application_display_name: Nightly 18:34:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:34:14 INFO - mozversion application_name: Firefox 18:34:14 INFO - mozversion application_remotingname: firefox 18:34:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 18:34:14 INFO - mozversion application_vendor: Mozilla 18:34:14 INFO - mozversion application_version: 50.0a1 18:34:14 INFO - mozversion platform_buildid: 20160708152725 18:34:14 INFO - mozversion platform_changeset: 4287a45df22d86765e15561a8834f6f3d00c24ec 18:34:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 18:34:14 INFO - mozversion platform_version: 50.0a1 18:34:14 INFO - using testdate: 1468028054 18:34:14 INFO - actual date: 1468028054 18:34:14 INFO - starting webserver on 'localhost:49271' 18:34:14 INFO - SUITE-START | Running 2 tests 18:34:14 INFO - TEST-START | dromaeo_css 18:34:14 INFO - operating with platform_type : mac_ 18:34:14 INFO - Initialising browser for dromaeo_css test... 18:34:14 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmplye4Dc/profile http://localhost:49271/getInfo.html) 18:34:18 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 18:34:18 INFO - PROCESS | 1652 | colorDepth:24 18:34:18 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 18:34:18 INFO - PROCESS | 1652 | __metrics 18:34:18 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 18:34:18 INFO - TEST-INFO | 1652: exit 0 18:34:18 INFO - Browser initialized. 18:34:18 INFO - Running cycle 1/1 for dromaeo_css test... 18:34:18 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmplye4Dc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:34:30 INFO - PROCESS | 1655 | RSS: Main: 254271488 18:34:30 INFO - PROCESS | 1655 | 18:35:20 INFO - PROCESS | 1655 | 1468028120668 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:37:32 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 18:37:33 INFO - PROCESS | 1655 | RSS: Main: 266649600 18:37:33 INFO - PROCESS | 1655 | 18:40:35 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 18:40:36 INFO - PROCESS | 1655 | RSS: Main: 275390464 18:40:36 INFO - PROCESS | 1655 | 18:43:38 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 18:43:39 INFO - PROCESS | 1655 | RSS: Main: 279846912 18:43:39 INFO - PROCESS | 1655 | 18:46:40 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 18:46:41 INFO - PROCESS | 1655 | RSS: Main: 278794240 18:46:41 INFO - PROCESS | 1655 | 18:49:44 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 18:49:44 INFO - PROCESS | 1655 | RSS: Main: 282513408 18:49:44 INFO - PROCESS | 1655 | 18:52:47 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 18:52:47 INFO - PROCESS | 1655 | RSS: Main: 282632192 18:52:47 INFO - PROCESS | 1655 | 18:52:47 INFO - PROCESS | 1655 | __start_tp_report 18:52:47 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 18:52:47 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 18:52:47 INFO - PROCESS | 1655 | |i|pagename|runs| 18:52:47 INFO - PROCESS | 1655 | |0;dojo.html;3372.4772660237654;3375.4430518964373;3391.203067279189;3404.659534046594;3412.7099196568292;4989.875253118674;5350.571954243661;5692.231548740924;5806.983777838872;5814.970925145373;5595.580331475136;5711.543076553876;5783.103618939061;5804.651720896749;5895.646261224319;5184.326037615114;5227.63406561539;5238.607104467161;5332.493413125747;5375.220593014011;5365.3293338332705;5368.62419630626;5371.892562148755;5379.1662292344745;5435.456454354553;4332.696711230215;5146.433892271847;5191.091558977201;5238.240455133984;5293.894122117575;5258.474152584749;5261.552768014723;5263.105272103751;5263.34208223972;5277.395140843666;5141.10030744622;5226.451222621646;5243.213517972296;5268.0517506848755;5313.521783039507;4821.903561928777;5321.669582604349;5731.283589551306;5823.126531020339;5831.358550559435;6188.721507532172;6260.968695156541;6267.62394256346;6271.090691849702;6301.023341382093;6097.766665674493;6159.938400616026;6248.125262463259;6262.749490020394;6288.748450061992;5019.447860735316;5888.175655408247;5950.404959504015;5964.194833697482;5976.402359764076;6368.4586810121655;6376.202974628171;6390.84022899422;6405.743770249138;6411.647359395185;6070.2412198475195;6140.938590614126;6152.292486364126;6164.7842325518395;6209.875802483925;6201.534884883562;6227.09707092469;6228.252609686867;6259.0924315973925;6259.530535209878;6132.998044146438;6135.815925522242;6144.5084393248435;6148.508119350441;6234.096056071844;6106.938930610637;6172.876542469216;6190;6244;6270.498360131179;5014.498550144956;5020.623453240948;5040.092783299041;5041.445441001487;5058.494150584986;4446.466424029072;4502.594766471033;4506.459224892968;4567.406237189144;4616.446026476844;5374.220737993047;5790.36306006339;5850.0932355484965;5869.354371019184;5878.647281163058;6202.596831205957;6209.068639704081;6240.344763799736;6244.1570387997945;6266.843328916722;5901.085331773582;5906.114082887601;5919.289685237713;5928.911066334009;5946.929552680473;5386.596005299618;5484.506394424521;5498.862528436821;5510.393856675762;5518.144687573433;6341.302456729848;6380.521460890452;6395.1046853441485;6418.26189988148;6456.580322279036;6162.106494558354;6232.688365581612;6247.0629405589525;6258.561900667091;6264.812055638338;6317.842053948504;6349.396807303298;6396.296407395276;6420.903686444613;6444.742210311535;6148.231471066117;6200.844978875384;6236.968815156077;6243.250809902841;6249.218847644044;6143.788236235041;6152.384761523812;6216.968915155395;6241.812745617639;6248.312685604489;6114.996965385453;6124.777645458507;6126.571140020156;6190.0405437157315;6201.689915504297;6172.8765424690355;6200.658963757037;6204.038374052029;6205.906911396242;6235.220597425322;5840.766369345179;5851.1223316502865;6099.725512352044;6117.357677443804;6136.754529818757;5598.720063996702;5943.554233432424;6107.552954153525;6117.675163990694;6178;5170.97414512925;5770.163326317745;6003.189569408074;6027.21646185993;6054.485368743706 18:52:47 INFO - PROCESS | 1655 | |1;ext.html;469.85199662106436;480.071062494074;528.6326003427617;547.6522408270748;577.4254616656427;27564;29747.57902841174;34103.317933641345;38908;39219.215615687666;40816.979575510624;41702.79148604253;41755.37366939498;41763.37354939671;41844;9147.719319295304;9216;9361.344705870591;9374.390664606814;9404.670836520723;8503.95748021259;9537.33238673293;9542.522873856315;9642.2768292378;9661.323707340489;8217.7123800667;9575.329726919119;9623.182029527463;9669.033096690346;9719.659811906584;9590.472524011177;9636.614535418576;9672.854907176397;9676.080772326653;9679.709608711784;9487.051294870527;9534.141927226514;9631.988641192715;9632;9655.32412731109;39315.41026884599;39550;39685.801570991964;39842.80078599617;40006.99982500431;2746.1898739871585;3300.603927528712;3363.9663603363897;3571.62497937718;3956.1692044670654;31277.218069548217;31414.528782068286;31531;31543.36913261745;32324.676753232638;2767.39117394175;3171.888983885553;3184.4745616973173;3201.7598680099086;3295.126791400281;441890;446110;448821;449907;449909.99999999674;27678.169654910384;34426.96719098381;34450;34481.31037379288;34488.655113449044;35371.29257414837;35385;35800.641993580255;36240;36661.81669091638;17155.485335439957;17254.309827607005;17297.65404691899;17306.82693173052;17344.566385840455;13017.609471715863;13047.739045219043;13051.869481305255;13081.411336489691;13088.345582721016;19386.127624256944;19392.321268755524;19435.90282048609;19485.512862178275;19579.021048947496;6169.5064394848305;7767.53394796314;7854.136045035041;7867.488613240235;7931.484453510503;855.5593869157389;927.5686805635412;948.9193418559362;1001.4241810958582;1017.1608423051013;29915.700842991726;29968.40063198724;30293.69706302953;30818.383632327226;31021.379572408427;966.7679756858444;1014.9900848655635;1098.6813823991113;1103.9668809935715;1115.6206889657556;15657.921710391374;15838;15859.444919427764;15918.204089795463;16116;638503;646925;650283;651382;653244.6039928214;60418;60877.39122608717;61068.778624427265;61094;61116.694416527636;1203.9518419263131;1380.1443105274793;1400.0759498730788;1413.1732936232213;1424.9643758905902;27839.44321113607;30317.545236821905;30455;30512.694873050987;30868;53087.73456132694;53168.936621266585;53331.46668533265;53920.65198370072;53998.460015399345;645526;649824;651766;654034;654594;26566.601500977114;27395.589066164423;27692.861535693;27969.580456292766;28860.278493037003;46802.53197467982;47192.52807472018;47724.522754773396;48087;48114.79713007203;31172.68827311698;41194;41498.1700365997;41572;41688.1662366757;32131.51802723008;40144;41238.76283711493;41627.167456650095;41778.37332440077;39424.605753942094;39450.40824387579;39963.40054899237;39967.600323997554;41756.95607609713;28733;33613;35805;36483.452748209325;36567;23914.641280381155;26641.733582663925;26706.332341691614;26756.732432675424;27235.727642724112 18:52:47 INFO - PROCESS | 1655 | |2;jquery.html;377.3923982388354;378.4701418014779;379.46874375873784;393.4216701448869;397.8998070335521;20128.69806952895;21678.458038549044;21860;21981;22197.44506387339;21061.894690526526;21096;21413.464663383424;21551.461213469673;22028;5982.8803423931495;6117.602355846856;6194.659293738842;6196.473299769503;6205.193324867761;4262.445882035331;6152.3847615238565;6544.952807550792;6807.761728339509;6831;6717.966410167966;6764.830879228034;6799.76200832971;6823.351781580742;6823.692933817965;6671.5997040177745;6689.632070236135;6789.25318214996;6814.727410903558;6828.6927088281145;5865.648061116347;5897.52819774417;5939.940600594025;5941.55438342126;5966.820995370146;20288.782673039517;20657.380278591667;23700.76299237003;26799.330016749544;26838.194854154408;2285.8399912006166;2336.1356298169785;2500.1624455807328;2604.50514402263;3039.285767844555;14135.12218495445;16508.42220522276;16775.2451139699;17440;18261.817381826146;1636.8035835699793;1914.4161030885575;2032.309014934929;2032.3293313206607;2036.470517665403;82116;115418.26872597002;117224;117559;120943;17596.91201543984;17597;21412.0364583591;22383.61340757546;22560.503122016115;36095.81952090223;36174.8191259042;36813.44779828305;36829.63170368315;36876.893693189246;10947.726306842393;11259.774804504028;11398.259113157617;11491.712707182387;11558.479868405942;7635.160132385433;9256.398334108262;9310.208632266333;9319.207867331354;9418.717438476857;8338.666453341919;9113.951895532098;9848.901510984942;9971.551280192409;10227.28409011362;1434.7345741037732;1500.8424115467938;1695.118538360046;1731.4805558332703;1744.8255174482704;927.4620719982529;935.7847695030181;964.9131578157859;1007.8790545134631;1014.8426993815971;18255.543611409554;21713.56572868534;22163.206421628955;22512.212072577382;22515;983.5426526664992;985.6895078050392;992.811365840488;998.4259051045677;1052.7894421115807;10373.58505659765;11163.553457861595;11494.712632184095;11686.415679216005;11872.465739041763;599733;612216;615800;631757;636710;96926.57683557968;131563;131978;134711.65288347186;135576;907.8456662367413;1026.2508368890751;1028.4857571214393;1032.2877214721818;1085.6200329884634;19313.227470901005;19523.8047619522;19633.70549441788;19671;19726.816391016586;53681.731591343356;54459.63850903759;56071.43928560662;56627;56746.14880776874;75688;77945.61027194827;79475;82783.5860820692;88297.55851220703;6350.237971443456;7556.395488360808;7645.694172233048;7709.766437369994;8128.674853005814;9539;13678.042537022313;13834.792478113037;13866.722665546835;13917.930410347883;9986.201103911524;11603.419829008684;11710.70723231926;11871.287722736663;11889.940550297193;10781.460926953778;11518.57028753987;11541.422928853692;11768.470418831344;11779.587714429954;11827;11874.940625297164;12022.579209727617;12050.75898482043;12085.879141208827;7572.204918483701;7581.355584775135;7627.313541781266;7646.464747467624;7740.26467485588;9727.270454715783;11639.941800290944;11749.353785541878;11797.469113890067;11817.172797904064 18:52:47 INFO - PROCESS | 1655 | |3;mootools.html;1548.496738559968;1594.0674705297401;1828.5977085041295;1924.836388906942;1936;8111.188881111886;8636.222739953402;8673.479591224523;9172.678956236541;9200.309976751745;8647.0488246293;8655.69705060323;8732.91267087329;8827;8833.734987950373;2256.717910261217;2274.2494976657745;2283.5889539882896;2285.542891421714;2290.9083636654514;2294.5640328337645;2295.2999335202758;2314.143766806276;2345.636426353918;2350.4828937633692;2326.732425771041;2332.755060718617;2337.9479234344526;2349.9412514687097;2356;1911.923523059076;2290.1297506947253;2325.9184479217247;2327.8719670418122;2329.5108027314286;2316.9073237070497;2326.581215381231;2327.6857624220684;2327.94180145496;2328.5110126873205;7329.963350183269;8718.651253949834;8732.345074119403;8801.207891289814;8900.73297801067;5231.843044708665;5306.151015837448;5336.959292937879;5352.571794256489;5361.785528578852;3433.896983090511;3502.387082260594;3511.5083888255663;3540.76984995977;3575.606683264839;1056.5140035583563;1071.4963966935527;1085.5603480590294;1102.2835157147838;1107.8393632923262;9208.723738287863;11640.883591164065;12018.87981120195;12056.578019769266;12069.27584344942;3868.6324799144036;4251.256030194703;4505.842295519641;4751.857444276678;4771.188897887368;10077;10081.19350451962;10083.495825208856;10089.142422893989;10093.747656308651;5289.788408463695;5360.463953604608;5370.677759334374;5373;5379.515843574019;4388.605025547716;4730.716157030589;4880.1215781159735;4917;4929.359183306147;3851.287511810324;3879.739084797452;3936.566977632458;3946.092398748304;3986.581408952018;1244.7386048929645;1246.5886257535174;1248.5754843353304;1251.3117785218094;1253.5173958026226;920.6409500294891;926.1340646495548;932.1889955738416;935.8362286599818;978.7210644966151;5046.419661738947;5931.288245410578;5952.1847484630725;5959.523238140939;6112.419320164578;413.7620868000851;418.671342995753;426.37961765630934;429.1695569073852;441.933709943511;4018.799060046986;4032.0927791246736;4100.282450571138;4106.3635136553885;4113.629773320416;10236.948815255875;10587.100096491731;10668.786624267472;10686.946565267124;10695.83956240657;10354.223433242538;10556.472176391304;10641.467926603638;10652.254342195973;10710.518026688818;8053.436259461781;8170.591470426455;8274.751757447286;8324.209200125979;8333.874991875005;5731.656100633975;5921;5933.792317268875;5972.820815375546;5976.9103463448955;9721.368111073041;9940.652077177265;9977.700668979653;9981.151602113901;9996.350237234556;9871.851922221029;9916.900830991886;10205.846912296172;10208.285420020527;10267.691969240936;6965.33829286217;7393.07586551681;7474.327310542078;7557.168711441847;7569.697212111454;8453.830923381622;8548.316134709085;8560.785980350542;8620.956895215484;8624.78438039054;7467.626618669154;7583.810404739926;7614.885776713464;7636.389088872766;7703.651860924428;7456.7390141344795;7472.364848987897;7492.213317601573;7515.398768098648;7717.961410192913;6978.825529361807;6992.860142797217;7074.575525468488;7145.142582889878;7146.892796607951;4983.551480366785;5088.084144853962;5147.897042059063;5161.561267292323;5178.97410512945;4180.707350485437;5162.070827251131;5163.845084647466;5240.973795131;5292.470752924677 18:52:47 INFO - PROCESS | 1655 | |4;prototype.html;303.20408926567757;310.9133578144386;311.46894544801114;314.82527197405443;318.14260567769867;5000.624703265947;5675.751334706363;5772.653640781556;5779.942200577993;5790.826275211745;5370.489803468674;5661.433856614337;5667.518260947814;5675.325778895225;5719.513841323493;3798.335291324021;4080.3879418087377;4277.871663850074;4304.557973079022;4317.4819021717285;3723.4228694552253;3725.2735716535285;3910.6703720734945;3938.6652134568594;4314.597755729401;4310.762908040057;4313.503947046099;4316.287812510932;4332.591907630017;4339.848105316315;4093.9969707421574;4300.376445415429;4304.956950430487;4327.956720432819;4330.74801103426;3667.266546690646;3679.3442950672306;3695.447911877018;3707.2400157967554;3712.9443058354145;5047.671901326402;5527.668339899619;5533.201709444446;5548.167774833807;5556.666600004012;4086.753540170247;4779.737114458703;4927.77824997876;4953.563466594684;4960.925586116211;4767.427908650984;5027.622928280357;5534.667919924817;5537.363203231599;6030.457258846681;3416.02643246676;3420.785621104497;3886.222755448893;4097.774622395767;4120.690948178899;4845.781939812717;5073.082977288074;5680.034394152963;6278.623282603013;6310.432061114522;3109.2693217093965;3835.271298453285;4163.709250132469;4170.457840480779;4204.5375008749015;3804.4483549885113;3929.7838618875667;4238.745675259494;4241.830326786894;4266.637335826427;4556.883563526891;4737.407824021997;4914;4982.427020892644;4992;4495.527969563149;5295.523402893758;5934.05055191176;6139.815805525842;6150.292716337678;1386.8489154002154;1415.1155527795129;1418.1349376880096;1419.347100333858;1424.722179175051;859.862422012475;869.9652013919499;876.0538618292229;876.3252295732378;914.6524320758069;5250.606204534675;5464.153056276284;5508.779648814003;5528.668279903139;5581.888362232733;5342.572594192456;5987.1318658794235;6090.969545152246;6141.877162456726;6183.598066125687;5012.8496145115705;5067.087924173684;5468.453154684579;5693.715314234271;5714.228579141763;2672.465506898589;2743.670759508872;2878.8560571971316;3189.9951515272614;3271.0023442849683;5371.785128594891;5405.864853378697;5483.533899618577;6199.132121502993;6273.937260627426;5031.836310386569;5861.684634569321;6072.574919755575;6374.904376434357;6383;6192.885280649526;6403.327650596807;6406.615603063831;6418.871622567429;6502.252240992252;5167.354080739908;5232.581393488588;5783.392743761844;5830.096335068071;6248.625082495065;5891.469767720926;5970.910436343372;6085.6348619083;6139.539534534839;6305.432511074026;5166.45752196029;5248.055350036877;5576.944230557642;6225.3774622537385;6281.874362512633;4004.899877503086;4017.176478821776;4018.6383225509844;4020.597940205956;4071.75569465833;6177.660228687465;6245.906311405423;6255.218097737783;6298.559100862895;6306.873862522815;5063.468335824833;5489.39253854416;5923.851903702442;5957.212836149224;6035.728392222449;5130.846074617767;5573.637713548768;5914.67469289176;5943.959807033838;5974.910376344272;5011.7494125294315;5525.4474552546035;5573.359063707563;5582.817793857625;5881.97065513542;5453.427390123979;5815.76736930518;6074.750008745476;6081.878362432815;6108.236470441195;5431.669241035971;5874;5905.822825315247;5913.526917846476;5938.435848594377 18:52:47 INFO - PROCESS | 1655 | |5;yui.html;615.3047056825787;633.7825927649757;745.9925400745991;761.9695212191509;771.4252881603206;15220.771688424682;15241.390344386211;15294.617634559141;15871.761923571155;15955.601109972242;14548;14574.708505829904;14639.487617933375;14694.779578306307;14695.779563306533;713.0231582731665;904.7331037343966;913.4245425382001;930.7486978515797;948.9857652135223;885.3315746611299;929.6235024814961;931.352709866643;931.4876817750244;939.4551160327028;829.1459796409678;976.3312131190122;977.7457860956167;994.9850752238686;997.6458357283169;974.064897698207;980.715592478184;983.1299300119446;985.8126955878361;987.6000219910911;708.950373473857;730.2733779888991;731.8948387934205;732.9450291228179;736.1975446763054;14695.191764452951;14731.484398046017;15082.622934426727;15275.770863437057;15278.694426111526;15029;15050.548483545512;15070.472533461276;15123;15231;11862.347570883598;12203;12230.388480576024;12399.876001239962;12455.875441245562;3864.246471937973;3866.072142685763;4065.0243941453837;4091.652209562191;4103.384492326145;102547.48726256321;116053.41973290165;116905;117300;121512.56974860541;10958.890411095947;11264.324140551593;11304.943475282571;11352.432378381049;11617;23288.65067023996;23876.40308992289;24685.753142468704;24700.25899223026;24798.752012479643;8216.548089854996;8297.751067467985;8357.707480238163;8375.45559538628;8476.576171191538;4509.620921781574;4511.8646440606835;4572.588467037983;4647.767611619405;4733.029728905566;3555.768875023115;3614.801185934746;3651.2514934438377;3653.5798383185743;3667.7799332040163;661.5170925224613;673.0678010954765;673.7776533743853;675.6824292582478;687.9174499060144;522.5427750718121;560.3360018378235;642.6070348559613;649.2598437780933;669.1401549009499;9285.814283714422;9385.296102792317;9446.669366572274;9879.259055570861;9911.207103431709;636.3604577399684;667.259342130235;698.1900994846055;704.9506534542635;715.5599306426615;4625.8843528911375;4744.715317080986;4758.357621721023;4797.088553174885;4800.015996720664;154944;164432;165684.17157914134;165969.17015414845;168799.15600422164;114359;141429;144838;145430;145893;118826.40586797183;119350;119603;121425;123181;8918.687845925362;9083.706630657585;9138.543072846463;9156.175944165057;9270;53527.19709204287;54245.18632220441;54387.72806135944;59984.700076499335;62241;72926.63536682283;73822;87609.56195218983;103232.48383758034;103735;12836.935815320863;13461.932690336485;13727.45090196381;13809.51666691661;14034.578962631138;15456;16015.519534413987;16138.596535086717;16302.429414970418;16397;13782.65543361424;14078.507252246121;14088.15471071739;14289.42842286297;14413.639659008608;11573.363465009505;14139.36372863203;14151.363188656329;14367.784483232968;14972;11963.401829908644;13740.175589464265;13847.169169849842;14015.929920350332;14102.788458173341;11454.713632159262;11589.362585057566;11763.294202347886;11827.408629568316;11993.820092698443;11492.310461372344;11573;11678.584438201351;11733.35466549348;11925.0459963201 18:52:47 INFO - PROCESS | 1655 | __end_tp_report 18:52:47 INFO - PROCESS | 1655 | __start_cc_report 18:52:47 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,432 18:52:47 INFO - PROCESS | 1655 | __end_cc_report 18:52:47 INFO - PROCESS | 1655 | __startTimestamp1468029167966__endTimestamp 18:52:47 INFO - PROCESS | 1655 | 18:52:47 INFO - PROCESS | 1655 | ------- Summary: start ------- 18:52:47 INFO - PROCESS | 1655 | Number of tests: 6 18:52:47 INFO - PROCESS | 1655 | 18:52:47 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5766.20 Median:6027.22 stddev:647.67 (10.7%) stddev-sans-first:621.84 18:52:47 INFO - PROCESS | 1655 | Values: 3372.5 3375.4 3391.2 3404.7 3412.7 4989.9 5350.6 5692.2 5807.0 5815.0 5595.6 5711.5 5783.1 5804.7 5895.6 5184.3 5227.6 5238.6 5332.5 5375.2 5365.3 5368.6 5371.9 5379.2 5435.5 4332.7 5146.4 5191.1 5238.2 5293.9 5258.5 5261.6 5263.1 5263.3 5277.4 5141.1 5226.5 5243.2 5268.1 5313.5 4821.9 5321.7 5731.3 5823.1 5831.4 6188.7 6261.0 6267.6 6271.1 6301.0 6097.8 6159.9 6248.1 6262.7 6288.7 5019.4 5888.2 5950.4 5964.2 5976.4 6368.5 6376.2 6390.8 6405.7 6411.6 6070.2 6140.9 6152.3 6164.8 6209.9 6201.5 6227.1 6228.3 6259.1 6259.5 6133.0 6135.8 6144.5 6148.5 6234.1 6106.9 6172.9 6190.0 6244.0 6270.5 5014.5 5020.6 5040.1 5041.4 5058.5 4446.5 4502.6 4506.5 4567.4 4616.4 5374.2 5790.4 5850.1 5869.4 5878.6 6202.6 6209.1 6240.3 6244.2 6266.8 5901.1 5906.1 5919.3 5928.9 5946.9 5386.6 5484.5 5498.9 5510.4 5518.1 6341.3 6380.5 6395.1 6418.3 6456.6 6162.1 6232.7 6247.1 6258.6 6264.8 6317.8 6349.4 6396.3 6420.9 6444.7 6148.2 6200.8 6237.0 6243.3 6249.2 6143.8 6152.4 6217.0 6241.8 6248.3 6115.0 6124.8 6126.6 6190.0 6201.7 6172.9 6200.7 6204.0 6205.9 6235.2 5840.8 5851.1 6099.7 6117.4 6136.8 5598.7 5943.6 6107.6 6117.7 6178.0 5171.0 5770.2 6003.2 6027.2 6054.5 18:52:47 INFO - PROCESS | 1655 | 18:52:47 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:70075.09 Median:21753.08 stddev:158105.22 (726.8%) stddev-sans-first:158462.37 18:52:47 INFO - PROCESS | 1655 | Values: 469.9 480.1 528.6 547.7 577.4 27564.0 29747.6 34103.3 38908.0 39219.2 40817.0 41702.8 41755.4 41763.4 41844.0 9147.7 9216.0 9361.3 9374.4 9404.7 8504.0 9537.3 9542.5 9642.3 9661.3 8217.7 9575.3 9623.2 9669.0 9719.7 9590.5 9636.6 9672.9 9676.1 9679.7 9487.1 9534.1 9632.0 9632.0 9655.3 39315.4 39550.0 39685.8 39842.8 40007.0 2746.2 3300.6 3364.0 3571.6 3956.2 31277.2 31414.5 31531.0 31543.4 32324.7 2767.4 3171.9 3184.5 3201.8 3295.1 441890.0 446110.0 448821.0 449907.0 449910.0 27678.2 34427.0 34450.0 34481.3 34488.7 35371.3 35385.0 35800.6 36240.0 36661.8 17155.5 17254.3 17297.7 17306.8 17344.6 13017.6 13047.7 13051.9 13081.4 13088.3 19386.1 19392.3 19435.9 19485.5 19579.0 6169.5 7767.5 7854.1 7867.5 7931.5 855.6 927.6 948.9 1001.4 1017.2 29915.7 29968.4 30293.7 30818.4 31021.4 966.8 1015.0 1098.7 1104.0 1115.6 15657.9 15838.0 15859.4 15918.2 16116.0 638503.0 646925.0 650283.0 651382.0 653244.6 60418.0 60877.4 61068.8 61094.0 61116.7 1204.0 1380.1 1400.1 1413.2 1425.0 27839.4 30317.5 30455.0 30512.7 30868.0 53087.7 53168.9 53331.5 53920.7 53998.5 645526.0 649824.0 651766.0 654034.0 654594.0 26566.6 27395.6 27692.9 27969.6 28860.3 46802.5 47192.5 47724.5 48087.0 48114.8 31172.7 41194.0 41498.2 41572.0 41688.2 32131.5 40144.0 41238.8 41627.2 41778.4 39424.6 39450.4 39963.4 39967.6 41757.0 28733.0 33613.0 35805.0 36483.5 36567.0 23914.6 26641.7 26706.3 26756.7 27235.7 18:52:47 INFO - PROCESS | 1655 | 18:52:47 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:36949.61 Median:2310.99 stddev:102830.14 (4449.6%) stddev-sans-first:103081.94 18:52:47 INFO - PROCESS | 1655 | Values: 377.4 378.5 379.5 393.4 397.9 20128.7 21678.5 21860.0 21981.0 22197.4 21061.9 21096.0 21413.5 21551.5 22028.0 5982.9 6117.6 6194.7 6196.5 6205.2 4262.4 6152.4 6545.0 6807.8 6831.0 6718.0 6764.8 6799.8 6823.4 6823.7 6671.6 6689.6 6789.3 6814.7 6828.7 5865.6 5897.5 5939.9 5941.6 5966.8 20288.8 20657.4 23700.8 26799.3 26838.2 2285.8 2336.1 2500.2 2604.5 3039.3 14135.1 16508.4 16775.2 17440.0 18261.8 1636.8 1914.4 2032.3 2032.3 2036.5 82116.0 115418.3 117224.0 117559.0 120943.0 17596.9 17597.0 21412.0 22383.6 22560.5 36095.8 36174.8 36813.4 36829.6 36876.9 10947.7 11259.8 11398.3 11491.7 11558.5 7635.2 9256.4 9310.2 9319.2 9418.7 8338.7 9114.0 9848.9 9971.6 10227.3 1434.7 1500.8 1695.1 1731.5 1744.8 927.5 935.8 964.9 1007.9 1014.8 18255.5 21713.6 22163.2 22512.2 22515.0 983.5 985.7 992.8 998.4 1052.8 10373.6 11163.6 11494.7 11686.4 11872.5 599733.0 612216.0 615800.0 631757.0 636710.0 96926.6 131563.0 131978.0 134711.7 135576.0 907.8 1026.3 1028.5 1032.3 1085.6 19313.2 19523.8 19633.7 19671.0 19726.8 53681.7 54459.6 56071.4 56627.0 56746.1 75688.0 77945.6 79475.0 82783.6 88297.6 6350.2 7556.4 7645.7 7709.8 8128.7 9539.0 13678.0 13834.8 13866.7 13917.9 9986.2 11603.4 11710.7 11871.3 11889.9 10781.5 11518.6 11541.4 11768.5 11779.6 11827.0 11874.9 12022.6 12050.8 12085.9 7572.2 7581.4 7627.3 7646.5 7740.3 9727.3 11639.9 11749.4 11797.5 11817.2 18:52:47 INFO - PROCESS | 1655 | 18:52:47 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5700.32 Median:4898.56 stddev:3217.95 (65.7%) stddev-sans-first:3211.86 18:52:47 INFO - PROCESS | 1655 | Values: 1548.5 1594.1 1828.6 1924.8 1936.0 8111.2 8636.2 8673.5 9172.7 9200.3 8647.0 8655.7 8732.9 8827.0 8833.7 2256.7 2274.2 2283.6 2285.5 2290.9 2294.6 2295.3 2314.1 2345.6 2350.5 2326.7 2332.8 2337.9 2349.9 2356.0 1911.9 2290.1 2325.9 2327.9 2329.5 2316.9 2326.6 2327.7 2327.9 2328.5 7330.0 8718.7 8732.3 8801.2 8900.7 5231.8 5306.2 5337.0 5352.6 5361.8 3433.9 3502.4 3511.5 3540.8 3575.6 1056.5 1071.5 1085.6 1102.3 1107.8 9208.7 11640.9 12018.9 12056.6 12069.3 3868.6 4251.3 4505.8 4751.9 4771.2 10077.0 10081.2 10083.5 10089.1 10093.7 5289.8 5360.5 5370.7 5373.0 5379.5 4388.6 4730.7 4880.1 4917.0 4929.4 3851.3 3879.7 3936.6 3946.1 3986.6 1244.7 1246.6 1248.6 1251.3 1253.5 920.6 926.1 932.2 935.8 978.7 5046.4 5931.3 5952.2 5959.5 6112.4 413.8 418.7 426.4 429.2 441.9 4018.8 4032.1 4100.3 4106.4 4113.6 10236.9 10587.1 10668.8 10686.9 10695.8 10354.2 10556.5 10641.5 10652.3 10710.5 8053.4 8170.6 8274.8 8324.2 8333.9 5731.7 5921.0 5933.8 5972.8 5976.9 9721.4 9940.7 9977.7 9981.2 9996.4 9871.9 9916.9 10205.8 10208.3 10267.7 6965.3 7393.1 7474.3 7557.2 7569.7 8453.8 8548.3 8560.8 8621.0 8624.8 7467.6 7583.8 7614.9 7636.4 7703.7 7456.7 7472.4 7492.2 7515.4 7718.0 6978.8 6992.9 7074.6 7145.1 7146.9 4983.6 5088.1 5147.9 5161.6 5179.0 4180.7 5162.1 5163.8 5241.0 5292.5 18:52:47 INFO - PROCESS | 1655 | 18:52:47 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4772.20 Median:5371.14 stddev:1488.44 (27.7%) stddev-sans-first:1454.33 18:52:47 INFO - PROCESS | 1655 | Values: 303.2 310.9 311.5 314.8 318.1 5000.6 5675.8 5772.7 5779.9 5790.8 5370.5 5661.4 5667.5 5675.3 5719.5 3798.3 4080.4 4277.9 4304.6 4317.5 3723.4 3725.3 3910.7 3938.7 4314.6 4310.8 4313.5 4316.3 4332.6 4339.8 4094.0 4300.4 4305.0 4328.0 4330.7 3667.3 3679.3 3695.4 3707.2 3712.9 5047.7 5527.7 5533.2 5548.2 5556.7 4086.8 4779.7 4927.8 4953.6 4960.9 4767.4 5027.6 5534.7 5537.4 6030.5 3416.0 3420.8 3886.2 4097.8 4120.7 4845.8 5073.1 5680.0 6278.6 6310.4 3109.3 3835.3 4163.7 4170.5 4204.5 3804.4 3929.8 4238.7 4241.8 4266.6 4556.9 4737.4 4914.0 4982.4 4992.0 4495.5 5295.5 5934.1 6139.8 6150.3 1386.8 1415.1 1418.1 1419.3 1424.7 859.9 870.0 876.1 876.3 914.7 5250.6 5464.2 5508.8 5528.7 5581.9 5342.6 5987.1 6091.0 6141.9 6183.6 5012.8 5067.1 5468.5 5693.7 5714.2 2672.5 2743.7 2878.9 3190.0 3271.0 5371.8 5405.9 5483.5 6199.1 6273.9 5031.8 5861.7 6072.6 6374.9 6383.0 6192.9 6403.3 6406.6 6418.9 6502.3 5167.4 5232.6 5783.4 5830.1 6248.6 5891.5 5970.9 6085.6 6139.5 6305.4 5166.5 5248.1 5576.9 6225.4 6281.9 4004.9 4017.2 4018.6 4020.6 4071.8 6177.7 6245.9 6255.2 6298.6 6306.9 5063.5 5489.4 5923.9 5957.2 6035.7 5130.8 5573.6 5914.7 5944.0 5974.9 5011.7 5525.4 5573.4 5582.8 5882.0 5453.4 5815.8 6074.8 6081.9 6108.2 5431.7 5874.0 5905.8 5913.5 5938.4 18:52:47 INFO - PROCESS | 1655 | 18:52:47 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:26016.61 Median:24749.51 stddev:42348.07 (171.1%) stddev-sans-first:42423.92 18:52:47 INFO - PROCESS | 1655 | Values: 615.3 633.8 746.0 762.0 771.4 15220.8 15241.4 15294.6 15871.8 15955.6 14548.0 14574.7 14639.5 14694.8 14695.8 713.0 904.7 913.4 930.7 949.0 885.3 929.6 931.4 931.5 939.5 829.1 976.3 977.7 995.0 997.6 974.1 980.7 983.1 985.8 987.6 709.0 730.3 731.9 732.9 736.2 14695.2 14731.5 15082.6 15275.8 15278.7 15029.0 15050.5 15070.5 15123.0 15231.0 11862.3 12203.0 12230.4 12399.9 12455.9 3864.2 3866.1 4065.0 4091.7 4103.4 102547.5 116053.4 116905.0 117300.0 121512.6 10958.9 11264.3 11304.9 11352.4 11617.0 23288.7 23876.4 24685.8 24700.3 24798.8 8216.5 8297.8 8357.7 8375.5 8476.6 4509.6 4511.9 4572.6 4647.8 4733.0 3555.8 3614.8 3651.3 3653.6 3667.8 661.5 673.1 673.8 675.7 687.9 522.5 560.3 642.6 649.3 669.1 9285.8 9385.3 9446.7 9879.3 9911.2 636.4 667.3 698.2 705.0 715.6 4625.9 4744.7 4758.4 4797.1 4800.0 154944.0 164432.0 165684.2 165969.2 168799.2 114359.0 141429.0 144838.0 145430.0 145893.0 118826.4 119350.0 119603.0 121425.0 123181.0 8918.7 9083.7 9138.5 9156.2 9270.0 53527.2 54245.2 54387.7 59984.7 62241.0 72926.6 73822.0 87609.6 103232.5 103735.0 12836.9 13461.9 13727.5 13809.5 14034.6 15456.0 16015.5 16138.6 16302.4 16397.0 13782.7 14078.5 14088.2 14289.4 14413.6 11573.4 14139.4 14151.4 14367.8 14972.0 11963.4 13740.2 13847.2 14015.9 14102.8 11454.7 11589.4 11763.3 11827.4 11993.8 11492.3 11573.0 11678.6 11733.4 11925.0 18:52:47 INFO - PROCESS | 1655 | -------- Summary: end -------- 18:52:47 INFO - PROCESS | 1655 | 18:52:48 INFO - TEST-INFO | 1655: exit 0 18:52:48 INFO - TEST-OK | dromaeo_css | took 1113705ms 18:52:48 INFO - TEST-START | kraken 18:52:48 INFO - operating with platform_type : mac_ 18:52:48 INFO - Initialising browser for kraken test... 18:52:48 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmpqjDwlY/profile http://localhost:49271/getInfo.html) 18:52:51 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 18:52:51 INFO - PROCESS | 1664 | colorDepth:24 18:52:51 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 18:52:51 INFO - PROCESS | 1664 | __metrics 18:52:51 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 18:52:52 INFO - TEST-INFO | 1664: exit 0 18:52:52 INFO - Browser initialized. 18:52:52 INFO - Running cycle 1/1 for kraken test... 18:52:52 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmpqjDwlY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:53:04 INFO - PROCESS | 1666 | RSS: Main: 254066688 18:53:04 INFO - PROCESS | 1666 | 18:53:06 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 18:53:07 INFO - PROCESS | 1666 | RSS: Main: 266862592 18:53:07 INFO - PROCESS | 1666 | 18:53:10 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 18:53:11 INFO - PROCESS | 1666 | RSS: Main: 270954496 18:53:11 INFO - PROCESS | 1666 | 18:53:14 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 18:53:15 INFO - PROCESS | 1666 | RSS: Main: 271269888 18:53:15 INFO - PROCESS | 1666 | 18:53:17 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 18:53:17 INFO - PROCESS | 1666 | RSS: Main: 272269312 18:53:17 INFO - PROCESS | 1666 | 18:53:19 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:53:20 INFO - PROCESS | 1666 | RSS: Main: 272879616 18:53:20 INFO - PROCESS | 1666 | 18:53:23 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 18:53:23 INFO - PROCESS | 1666 | RSS: Main: 273215488 18:53:23 INFO - PROCESS | 1666 | 18:53:26 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 18:53:27 INFO - PROCESS | 1666 | RSS: Main: 273477632 18:53:27 INFO - PROCESS | 1666 | 18:53:30 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 18:53:31 INFO - PROCESS | 1666 | RSS: Main: 273604608 18:53:31 INFO - PROCESS | 1666 | 18:53:32 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:53:33 INFO - PROCESS | 1666 | RSS: Main: 272998400 18:53:33 INFO - PROCESS | 1666 | 18:53:35 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:53:35 INFO - PROCESS | 1666 | RSS: Main: 273125376 18:53:35 INFO - PROCESS | 1666 | 18:53:37 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:53:38 INFO - PROCESS | 1666 | RSS: Main: 273412096 18:53:38 INFO - PROCESS | 1666 | 18:53:41 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:53:42 INFO - PROCESS | 1666 | RSS: Main: 273633280 18:53:42 INFO - PROCESS | 1666 | 18:53:44 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:53:45 INFO - PROCESS | 1666 | RSS: Main: 273555456 18:53:45 INFO - PROCESS | 1666 | 18:53:47 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 18:53:47 INFO - PROCESS | 1666 | RSS: Main: 274624512 18:53:47 INFO - PROCESS | 1666 | 18:53:47 INFO - PROCESS | 1666 | __start_tp_report 18:53:47 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 18:53:47 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 18:53:47 INFO - PROCESS | 1666 | |i|pagename|runs| 18:53:47 INFO - PROCESS | 1666 | |0;ai-astar;101;164;105;115;115;114;111;115;116;116 18:53:47 INFO - PROCESS | 1666 | |1;audio-beat-detection;145;150;121;181;97;114;158;153;194;141 18:53:47 INFO - PROCESS | 1666 | |2;audio-dft;196;199;196;210;220;194;194;195;194;196 18:53:47 INFO - PROCESS | 1666 | |3;audio-fft;86;115;67;167;85;83;71;59;140;86 18:53:47 INFO - PROCESS | 1666 | |4;audio-oscillator;69;69;120;73;70;82;112;70;73;115 18:53:47 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;106;130;100;86;88;86;89;85;89;86 18:53:47 INFO - PROCESS | 1666 | |6;imaging-darkroom;95;94;94;119;94;150;152;98;95;94 18:53:47 INFO - PROCESS | 1666 | |7;imaging-desaturate;144;142;98;89;88;128;149;94;86;91 18:53:47 INFO - PROCESS | 1666 | |8;json-parse-financial;55;55;56;55;57;54;56;55;57;56 18:53:47 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;66;69;67;71;71;77;74;68;68;70 18:53:47 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;89;84;81;84;86;87;87;83;84;83 18:53:47 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;142;128;134;147;153;139;150;160;245;153 18:53:47 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;166;165;174;168;164;163;163;166;164;164 18:53:47 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;69;67;67;65;68;65;66;67;65;67 18:53:47 INFO - PROCESS | 1666 | __end_tp_report 18:53:47 INFO - PROCESS | 1666 | __start_cc_report 18:53:47 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1115 18:53:47 INFO - PROCESS | 1666 | __end_cc_report 18:53:47 INFO - PROCESS | 1666 | __startTimestamp1468029227563__endTimestamp 18:53:47 INFO - PROCESS | 1666 | 18:53:47 INFO - PROCESS | 1666 | ------- Summary: start ------- 18:53:47 INFO - PROCESS | 1666 | Number of tests: 14 18:53:47 INFO - PROCESS | 1666 | 18:53:47 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:117.20 Median:115.00 stddev:17.22 (15.0%) stddev-sans-first:17.23 18:53:47 INFO - PROCESS | 1666 | Values: 101.0 164.0 105.0 115.0 115.0 114.0 111.0 115.0 116.0 116.0 18:53:47 INFO - PROCESS | 1666 | 18:53:47 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:155.50 stddev:29.46 (18.9%) stddev-sans-first:31.25 18:53:47 INFO - PROCESS | 1666 | Values: 145.0 150.0 121.0 181.0 97.0 114.0 158.0 153.0 194.0 141.0 18:53:47 INFO - PROCESS | 1666 | 18:53:47 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:199.40 Median:196.00 stddev:8.68 (4.4%) stddev-sans-first:9.12 18:53:47 INFO - PROCESS | 1666 | Values: 196.0 199.0 196.0 210.0 220.0 194.0 194.0 195.0 194.0 196.0 18:53:47 INFO - PROCESS | 1666 | 18:53:47 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:95.90 Median:77.00 stddev:34.42 (44.7%) stddev-sans-first:36.32 18:53:47 INFO - PROCESS | 1666 | Values: 86.0 115.0 67.0 167.0 85.0 83.0 71.0 59.0 140.0 86.0 18:53:47 INFO - PROCESS | 1666 | 18:53:47 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:85.30 Median:70.00 stddev:21.38 (30.5%) stddev-sans-first:21.84 18:53:47 INFO - PROCESS | 1666 | Values: 69.0 69.0 120.0 73.0 70.0 82.0 112.0 70.0 73.0 115.0 18:53:47 INFO - PROCESS | 1666 | 18:53:47 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:94.50 Median:86.00 stddev:14.27 (16.6%) stddev-sans-first:14.52 18:53:47 INFO - PROCESS | 1666 | Values: 106.0 130.0 100.0 86.0 88.0 86.0 89.0 85.0 89.0 86.0 18:53:47 INFO - PROCESS | 1666 | 18:53:47 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:108.50 Median:94.00 stddev:23.67 (25.2%) stddev-sans-first:24.59 18:53:47 INFO - PROCESS | 1666 | Values: 95.0 94.0 94.0 119.0 94.0 150.0 152.0 98.0 95.0 94.0 18:53:47 INFO - PROCESS | 1666 | 18:53:47 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:110.90 Median:88.50 stddev:26.41 (29.8%) stddev-sans-first:25.15 18:53:47 INFO - PROCESS | 1666 | Values: 144.0 142.0 98.0 89.0 88.0 128.0 149.0 94.0 86.0 91.0 18:53:47 INFO - PROCESS | 1666 | 18:53:47 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:0.97 (1.7%) stddev-sans-first:1.00 18:53:47 INFO - PROCESS | 1666 | Values: 55.0 55.0 56.0 55.0 57.0 54.0 56.0 55.0 57.0 56.0 18:53:47 INFO - PROCESS | 1666 | 18:53:47 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.50 stddev:3.35 (4.7%) stddev-sans-first:3.21 18:53:47 INFO - PROCESS | 1666 | Values: 66.0 69.0 67.0 71.0 71.0 77.0 74.0 68.0 68.0 70.0 18:53:47 INFO - PROCESS | 1666 | 18:53:47 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.00 stddev:2.39 (2.8%) stddev-sans-first:2.00 18:53:47 INFO - PROCESS | 1666 | Values: 89.0 84.0 81.0 84.0 86.0 87.0 87.0 83.0 84.0 83.0 18:53:47 INFO - PROCESS | 1666 | 18:53:47 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:155.10 Median:151.50 stddev:33.03 (21.8%) stddev-sans-first:34.69 18:53:47 INFO - PROCESS | 1666 | Values: 142.0 128.0 134.0 147.0 153.0 139.0 150.0 160.0 245.0 153.0 18:53:47 INFO - PROCESS | 1666 | 18:53:47 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.70 Median:165.50 stddev:3.30 (2.0%) stddev-sans-first:3.50 18:53:47 INFO - PROCESS | 1666 | Values: 166.0 165.0 174.0 168.0 164.0 163.0 163.0 166.0 164.0 164.0 18:53:47 INFO - PROCESS | 1666 | 18:53:47 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.35 (2.0%) stddev-sans-first:1.12 18:53:47 INFO - PROCESS | 1666 | Values: 69.0 67.0 67.0 65.0 68.0 65.0 66.0 67.0 65.0 67.0 18:53:47 INFO - PROCESS | 1666 | -------- Summary: end -------- 18:53:47 INFO - PROCESS | 1666 | 18:53:48 INFO - TEST-INFO | 1666: exit 0 18:53:48 INFO - TEST-OK | kraken | took 59779ms 18:53:48 INFO - SUITE-END | took 1173s 18:53:48 INFO - Completed test suite (00:19:33) 18:53:48 INFO - javascript benchmark 18:53:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7557.1855692994, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3372.4772660237654, 3375.4430518964373, 3391.203067279189, 3404.659534046594, 3412.7099196568292, 4989.875253118674, 5350.571954243661, 5692.231548740924, 5806.983777838872, 5814.970925145373, 5595.580331475136, 5711.543076553876, 5783.103618939061, 5804.651720896749, 5895.646261224319, 5184.326037615114, 5227.63406561539, 5238.607104467161, 5332.493413125747, 5375.220593014011, 5365.3293338332705, 5368.62419630626, 5371.892562148755, 5379.1662292344745, 5435.456454354553, 4332.696711230215, 5146.433892271847, 5191.091558977201, 5238.240455133984, 5293.894122117575, 5258.474152584749, 5261.552768014723, 5263.105272103751, 5263.34208223972, 5277.395140843666, 5141.10030744622, 5226.451222621646, 5243.213517972296, 5268.0517506848755, 5313.521783039507, 4821.903561928777, 5321.669582604349, 5731.283589551306, 5823.126531020339, 5831.358550559435, 6188.721507532172, 6260.968695156541, 6267.62394256346, 6271.090691849702, 6301.023341382093, 6097.766665674493, 6159.938400616026, 6248.125262463259, 6262.749490020394, 6288.748450061992, 5019.447860735316, 5888.175655408247, 5950.404959504015, 5964.194833697482, 5976.402359764076, 6368.4586810121655, 6376.202974628171, 6390.84022899422, 6405.743770249138, 6411.647359395185, 6070.2412198475195, 6140.938590614126, 6152.292486364126, 6164.7842325518395, 6209.875802483925, 6201.534884883562, 6227.09707092469, 6228.252609686867, 6259.0924315973925, 6259.530535209878, 6132.998044146438, 6135.815925522242, 6144.5084393248435, 6148.508119350441, 6234.096056071844, 6106.938930610637, 6172.876542469216, 6190.0, 6244.0, 6270.498360131179, 5014.498550144956, 5020.623453240948, 5040.092783299041, 5041.445441001487, 5058.494150584986, 4446.466424029072, 4502.594766471033, 4506.459224892968, 4567.406237189144, 4616.446026476844, 5374.220737993047, 5790.36306006339, 5850.0932355484965, 5869.354371019184, 5878.647281163058, 6202.596831205957, 6209.068639704081, 6240.344763799736, 6244.1570387997945, 6266.843328916722, 5901.085331773582, 5906.114082887601, 5919.289685237713, 5928.911066334009, 5946.929552680473, 5386.596005299618, 5484.506394424521, 5498.862528436821, 5510.393856675762, 5518.144687573433, 6341.302456729848, 6380.521460890452, 6395.1046853441485, 6418.26189988148, 6456.580322279036, 6162.106494558354, 6232.688365581612, 6247.0629405589525, 6258.561900667091, 6264.812055638338, 6317.842053948504, 6349.396807303298, 6396.296407395276, 6420.903686444613, 6444.742210311535, 6148.231471066117, 6200.844978875384, 6236.968815156077, 6243.250809902841, 6249.218847644044, 6143.788236235041, 6152.384761523812, 6216.968915155395, 6241.812745617639, 6248.312685604489, 6114.996965385453, 6124.777645458507, 6126.571140020156, 6190.0405437157315, 6201.689915504297, 6172.8765424690355, 6200.658963757037, 6204.038374052029, 6205.906911396242, 6235.220597425322, 5840.766369345179, 5851.1223316502865, 6099.725512352044, 6117.357677443804, 6136.754529818757, 5598.720063996702, 5943.554233432424, 6107.552954153525, 6117.675163990694, 6178.0, 5170.97414512925, 5770.163326317745, 6003.189569408074, 6027.21646185993, 6054.485368743706], "value": 5725.68359706346, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [469.85199662106436, 480.071062494074, 528.6326003427617, 547.6522408270748, 577.4254616656427, 27564.0, 29747.57902841174, 34103.317933641345, 38908.0, 39219.215615687666, 40816.979575510624, 41702.79148604253, 41755.37366939498, 41763.37354939671, 41844.0, 9147.719319295304, 9216.0, 9361.344705870591, 9374.390664606814, 9404.670836520723, 8503.95748021259, 9537.33238673293, 9542.522873856315, 9642.2768292378, 9661.323707340489, 8217.7123800667, 9575.329726919119, 9623.182029527463, 9669.033096690346, 9719.659811906584, 9590.472524011177, 9636.614535418576, 9672.854907176397, 9676.080772326653, 9679.709608711784, 9487.051294870527, 9534.141927226514, 9631.988641192715, 9632.0, 9655.32412731109, 39315.41026884599, 39550.0, 39685.801570991964, 39842.80078599617, 40006.99982500431, 2746.1898739871585, 3300.603927528712, 3363.9663603363897, 3571.62497937718, 3956.1692044670654, 31277.218069548217, 31414.528782068286, 31531.0, 31543.36913261745, 32324.676753232638, 2767.39117394175, 3171.888983885553, 3184.4745616973173, 3201.7598680099086, 3295.126791400281, 441890.0, 446110.0, 448821.0, 449907.0, 449909.99999999674, 27678.169654910384, 34426.96719098381, 34450.0, 34481.31037379288, 34488.655113449044, 35371.29257414837, 35385.0, 35800.641993580255, 36240.0, 36661.81669091638, 17155.485335439957, 17254.309827607005, 17297.65404691899, 17306.82693173052, 17344.566385840455, 13017.609471715863, 13047.739045219043, 13051.869481305255, 13081.411336489691, 13088.345582721016, 19386.127624256944, 19392.321268755524, 19435.90282048609, 19485.512862178275, 19579.021048947496, 6169.5064394848305, 7767.53394796314, 7854.136045035041, 7867.488613240235, 7931.484453510503, 855.5593869157389, 927.5686805635412, 948.9193418559362, 1001.4241810958582, 1017.1608423051013, 29915.700842991726, 29968.40063198724, 30293.69706302953, 30818.383632327226, 31021.379572408427, 966.7679756858444, 1014.9900848655635, 1098.6813823991113, 1103.9668809935715, 1115.6206889657556, 15657.921710391374, 15838.0, 15859.444919427764, 15918.204089795463, 16116.0, 638503.0, 646925.0, 650283.0, 651382.0, 653244.6039928214, 60418.0, 60877.39122608717, 61068.778624427265, 61094.0, 61116.694416527636, 1203.9518419263131, 1380.1443105274793, 1400.0759498730788, 1413.1732936232213, 1424.9643758905902, 27839.44321113607, 30317.545236821905, 30455.0, 30512.694873050987, 30868.0, 53087.73456132694, 53168.936621266585, 53331.46668533265, 53920.65198370072, 53998.460015399345, 645526.0, 649824.0, 651766.0, 654034.0, 654594.0, 26566.601500977114, 27395.589066164423, 27692.861535693, 27969.580456292766, 28860.278493037003, 46802.53197467982, 47192.52807472018, 47724.522754773396, 48087.0, 48114.79713007203, 31172.68827311698, 41194.0, 41498.1700365997, 41572.0, 41688.1662366757, 32131.51802723008, 40144.0, 41238.76283711493, 41627.167456650095, 41778.37332440077, 39424.605753942094, 39450.40824387579, 39963.40054899237, 39967.600323997554, 41756.95607609713, 28733.0, 33613.0, 35805.0, 36483.452748209325, 36567.0, 23914.641280381155, 26641.733582663925, 26706.332341691614, 26756.732432675424, 27235.727642724112], "value": 19471.409234716764, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.3923982388354, 378.4701418014779, 379.46874375873784, 393.4216701448869, 397.8998070335521, 20128.69806952895, 21678.458038549044, 21860.0, 21981.0, 22197.44506387339, 21061.894690526526, 21096.0, 21413.464663383424, 21551.461213469673, 22028.0, 5982.8803423931495, 6117.602355846856, 6194.659293738842, 6196.473299769503, 6205.193324867761, 4262.445882035331, 6152.3847615238565, 6544.952807550792, 6807.761728339509, 6831.0, 6717.966410167966, 6764.830879228034, 6799.76200832971, 6823.351781580742, 6823.692933817965, 6671.5997040177745, 6689.632070236135, 6789.25318214996, 6814.727410903558, 6828.6927088281145, 5865.648061116347, 5897.52819774417, 5939.940600594025, 5941.55438342126, 5966.820995370146, 20288.782673039517, 20657.380278591667, 23700.76299237003, 26799.330016749544, 26838.194854154408, 2285.8399912006166, 2336.1356298169785, 2500.1624455807328, 2604.50514402263, 3039.285767844555, 14135.12218495445, 16508.42220522276, 16775.2451139699, 17440.0, 18261.817381826146, 1636.8035835699793, 1914.4161030885575, 2032.309014934929, 2032.3293313206607, 2036.470517665403, 82116.0, 115418.26872597002, 117224.0, 117559.0, 120943.0, 17596.91201543984, 17597.0, 21412.0364583591, 22383.61340757546, 22560.503122016115, 36095.81952090223, 36174.8191259042, 36813.44779828305, 36829.63170368315, 36876.893693189246, 10947.726306842393, 11259.774804504028, 11398.259113157617, 11491.712707182387, 11558.479868405942, 7635.160132385433, 9256.398334108262, 9310.208632266333, 9319.207867331354, 9418.717438476857, 8338.666453341919, 9113.951895532098, 9848.901510984942, 9971.551280192409, 10227.28409011362, 1434.7345741037732, 1500.8424115467938, 1695.118538360046, 1731.4805558332703, 1744.8255174482704, 927.4620719982529, 935.7847695030181, 964.9131578157859, 1007.8790545134631, 1014.8426993815971, 18255.543611409554, 21713.56572868534, 22163.206421628955, 22512.212072577382, 22515.0, 983.5426526664992, 985.6895078050392, 992.811365840488, 998.4259051045677, 1052.7894421115807, 10373.58505659765, 11163.553457861595, 11494.712632184095, 11686.415679216005, 11872.465739041763, 599733.0, 612216.0, 615800.0, 631757.0, 636710.0, 96926.57683557968, 131563.0, 131978.0, 134711.65288347186, 135576.0, 907.8456662367413, 1026.2508368890751, 1028.4857571214393, 1032.2877214721818, 1085.6200329884634, 19313.227470901005, 19523.8047619522, 19633.70549441788, 19671.0, 19726.816391016586, 53681.731591343356, 54459.63850903759, 56071.43928560662, 56627.0, 56746.14880776874, 75688.0, 77945.61027194827, 79475.0, 82783.5860820692, 88297.55851220703, 6350.237971443456, 7556.395488360808, 7645.694172233048, 7709.766437369994, 8128.674853005814, 9539.0, 13678.042537022313, 13834.792478113037, 13866.722665546835, 13917.930410347883, 9986.201103911524, 11603.419829008684, 11710.70723231926, 11871.287722736663, 11889.940550297193, 10781.460926953778, 11518.57028753987, 11541.422928853692, 11768.470418831344, 11779.587714429954, 11827.0, 11874.940625297164, 12022.579209727617, 12050.75898482043, 12085.879141208827, 7572.204918483701, 7581.355584775135, 7627.313541781266, 7646.464747467624, 7740.26467485588, 9727.270454715783, 11639.941800290944, 11749.353785541878, 11797.469113890067, 11817.172797904064], "value": 10657.543633088993, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1548.496738559968, 1594.0674705297401, 1828.5977085041295, 1924.836388906942, 1936.0, 8111.188881111886, 8636.222739953402, 8673.479591224523, 9172.678956236541, 9200.309976751745, 8647.0488246293, 8655.69705060323, 8732.91267087329, 8827.0, 8833.734987950373, 2256.717910261217, 2274.2494976657745, 2283.5889539882896, 2285.542891421714, 2290.9083636654514, 2294.5640328337645, 2295.2999335202758, 2314.143766806276, 2345.636426353918, 2350.4828937633692, 2326.732425771041, 2332.755060718617, 2337.9479234344526, 2349.9412514687097, 2356.0, 1911.923523059076, 2290.1297506947253, 2325.9184479217247, 2327.8719670418122, 2329.5108027314286, 2316.9073237070497, 2326.581215381231, 2327.6857624220684, 2327.94180145496, 2328.5110126873205, 7329.963350183269, 8718.651253949834, 8732.345074119403, 8801.207891289814, 8900.73297801067, 5231.843044708665, 5306.151015837448, 5336.959292937879, 5352.571794256489, 5361.785528578852, 3433.896983090511, 3502.387082260594, 3511.5083888255663, 3540.76984995977, 3575.606683264839, 1056.5140035583563, 1071.4963966935527, 1085.5603480590294, 1102.2835157147838, 1107.8393632923262, 9208.723738287863, 11640.883591164065, 12018.87981120195, 12056.578019769266, 12069.27584344942, 3868.6324799144036, 4251.256030194703, 4505.842295519641, 4751.857444276678, 4771.188897887368, 10077.0, 10081.19350451962, 10083.495825208856, 10089.142422893989, 10093.747656308651, 5289.788408463695, 5360.463953604608, 5370.677759334374, 5373.0, 5379.515843574019, 4388.605025547716, 4730.716157030589, 4880.1215781159735, 4917.0, 4929.359183306147, 3851.287511810324, 3879.739084797452, 3936.566977632458, 3946.092398748304, 3986.581408952018, 1244.7386048929645, 1246.5886257535174, 1248.5754843353304, 1251.3117785218094, 1253.5173958026226, 920.6409500294891, 926.1340646495548, 932.1889955738416, 935.8362286599818, 978.7210644966151, 5046.419661738947, 5931.288245410578, 5952.1847484630725, 5959.523238140939, 6112.419320164578, 413.7620868000851, 418.671342995753, 426.37961765630934, 429.1695569073852, 441.933709943511, 4018.799060046986, 4032.0927791246736, 4100.282450571138, 4106.3635136553885, 4113.629773320416, 10236.948815255875, 10587.100096491731, 10668.786624267472, 10686.946565267124, 10695.83956240657, 10354.223433242538, 10556.472176391304, 10641.467926603638, 10652.254342195973, 10710.518026688818, 8053.436259461781, 8170.591470426455, 8274.751757447286, 8324.209200125979, 8333.874991875005, 5731.656100633975, 5921.0, 5933.792317268875, 5972.820815375546, 5976.9103463448955, 9721.368111073041, 9940.652077177265, 9977.700668979653, 9981.151602113901, 9996.350237234556, 9871.851922221029, 9916.900830991886, 10205.846912296172, 10208.285420020527, 10267.691969240936, 6965.33829286217, 7393.07586551681, 7474.327310542078, 7557.168711441847, 7569.697212111454, 8453.830923381622, 8548.316134709085, 8560.785980350542, 8620.956895215484, 8624.78438039054, 7467.626618669154, 7583.810404739926, 7614.885776713464, 7636.389088872766, 7703.651860924428, 7456.7390141344795, 7472.364848987897, 7492.213317601573, 7515.398768098648, 7717.961410192913, 6978.825529361807, 6992.860142797217, 7074.575525468488, 7145.142582889878, 7146.892796607951, 4983.551480366785, 5088.084144853962, 5147.897042059063, 5161.561267292323, 5178.97410512945, 4180.707350485437, 5162.070827251131, 5163.845084647466, 5240.973795131, 5292.470752924677], "value": 4498.2906929242, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.20408926567757, 310.9133578144386, 311.46894544801114, 314.82527197405443, 318.14260567769867, 5000.624703265947, 5675.751334706363, 5772.653640781556, 5779.942200577993, 5790.826275211745, 5370.489803468674, 5661.433856614337, 5667.518260947814, 5675.325778895225, 5719.513841323493, 3798.335291324021, 4080.3879418087377, 4277.871663850074, 4304.557973079022, 4317.4819021717285, 3723.4228694552253, 3725.2735716535285, 3910.6703720734945, 3938.6652134568594, 4314.597755729401, 4310.762908040057, 4313.503947046099, 4316.287812510932, 4332.591907630017, 4339.848105316315, 4093.9969707421574, 4300.376445415429, 4304.956950430487, 4327.956720432819, 4330.74801103426, 3667.266546690646, 3679.3442950672306, 3695.447911877018, 3707.2400157967554, 3712.9443058354145, 5047.671901326402, 5527.668339899619, 5533.201709444446, 5548.167774833807, 5556.666600004012, 4086.753540170247, 4779.737114458703, 4927.77824997876, 4953.563466594684, 4960.925586116211, 4767.427908650984, 5027.622928280357, 5534.667919924817, 5537.363203231599, 6030.457258846681, 3416.02643246676, 3420.785621104497, 3886.222755448893, 4097.774622395767, 4120.690948178899, 4845.781939812717, 5073.082977288074, 5680.034394152963, 6278.623282603013, 6310.432061114522, 3109.2693217093965, 3835.271298453285, 4163.709250132469, 4170.457840480779, 4204.5375008749015, 3804.4483549885113, 3929.7838618875667, 4238.745675259494, 4241.830326786894, 4266.637335826427, 4556.883563526891, 4737.407824021997, 4914.0, 4982.427020892644, 4992.0, 4495.527969563149, 5295.523402893758, 5934.05055191176, 6139.815805525842, 6150.292716337678, 1386.8489154002154, 1415.1155527795129, 1418.1349376880096, 1419.347100333858, 1424.722179175051, 859.862422012475, 869.9652013919499, 876.0538618292229, 876.3252295732378, 914.6524320758069, 5250.606204534675, 5464.153056276284, 5508.779648814003, 5528.668279903139, 5581.888362232733, 5342.572594192456, 5987.1318658794235, 6090.969545152246, 6141.877162456726, 6183.598066125687, 5012.8496145115705, 5067.087924173684, 5468.453154684579, 5693.715314234271, 5714.228579141763, 2672.465506898589, 2743.670759508872, 2878.8560571971316, 3189.9951515272614, 3271.0023442849683, 5371.785128594891, 5405.864853378697, 5483.533899618577, 6199.132121502993, 6273.937260627426, 5031.836310386569, 5861.684634569321, 6072.574919755575, 6374.904376434357, 6383.0, 6192.885280649526, 6403.327650596807, 6406.615603063831, 6418.871622567429, 6502.252240992252, 5167.354080739908, 5232.581393488588, 5783.392743761844, 5830.096335068071, 6248.625082495065, 5891.469767720926, 5970.910436343372, 6085.6348619083, 6139.539534534839, 6305.432511074026, 5166.45752196029, 5248.055350036877, 5576.944230557642, 6225.3774622537385, 6281.874362512633, 4004.899877503086, 4017.176478821776, 4018.6383225509844, 4020.597940205956, 4071.75569465833, 6177.660228687465, 6245.906311405423, 6255.218097737783, 6298.559100862895, 6306.873862522815, 5063.468335824833, 5489.39253854416, 5923.851903702442, 5957.212836149224, 6035.728392222449, 5130.846074617767, 5573.637713548768, 5914.67469289176, 5943.959807033838, 5974.910376344272, 5011.7494125294315, 5525.4474552546035, 5573.359063707563, 5582.817793857625, 5881.97065513542, 5453.427390123979, 5815.76736930518, 6074.750008745476, 6081.878362432815, 6108.236470441195, 5431.669241035971, 5874.0, 5905.822825315247, 5913.526917846476, 5938.435848594377], "value": 4292.198747857628, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.3047056825787, 633.7825927649757, 745.9925400745991, 761.9695212191509, 771.4252881603206, 15220.771688424682, 15241.390344386211, 15294.617634559141, 15871.761923571155, 15955.601109972242, 14548.0, 14574.708505829904, 14639.487617933375, 14694.779578306307, 14695.779563306533, 713.0231582731665, 904.7331037343966, 913.4245425382001, 930.7486978515797, 948.9857652135223, 885.3315746611299, 929.6235024814961, 931.352709866643, 931.4876817750244, 939.4551160327028, 829.1459796409678, 976.3312131190122, 977.7457860956167, 994.9850752238686, 997.6458357283169, 974.064897698207, 980.715592478184, 983.1299300119446, 985.8126955878361, 987.6000219910911, 708.950373473857, 730.2733779888991, 731.8948387934205, 732.9450291228179, 736.1975446763054, 14695.191764452951, 14731.484398046017, 15082.622934426727, 15275.770863437057, 15278.694426111526, 15029.0, 15050.548483545512, 15070.472533461276, 15123.0, 15231.0, 11862.347570883598, 12203.0, 12230.388480576024, 12399.876001239962, 12455.875441245562, 3864.246471937973, 3866.072142685763, 4065.0243941453837, 4091.652209562191, 4103.384492326145, 102547.48726256321, 116053.41973290165, 116905.0, 117300.0, 121512.56974860541, 10958.890411095947, 11264.324140551593, 11304.943475282571, 11352.432378381049, 11617.0, 23288.65067023996, 23876.40308992289, 24685.753142468704, 24700.25899223026, 24798.752012479643, 8216.548089854996, 8297.751067467985, 8357.707480238163, 8375.45559538628, 8476.576171191538, 4509.620921781574, 4511.8646440606835, 4572.588467037983, 4647.767611619405, 4733.029728905566, 3555.768875023115, 3614.801185934746, 3651.2514934438377, 3653.5798383185743, 3667.7799332040163, 661.5170925224613, 673.0678010954765, 673.7776533743853, 675.6824292582478, 687.9174499060144, 522.5427750718121, 560.3360018378235, 642.6070348559613, 649.2598437780933, 669.1401549009499, 9285.814283714422, 9385.296102792317, 9446.669366572274, 9879.259055570861, 9911.207103431709, 636.3604577399684, 667.259342130235, 698.1900994846055, 704.9506534542635, 715.5599306426615, 4625.8843528911375, 4744.715317080986, 4758.357621721023, 4797.088553174885, 4800.015996720664, 154944.0, 164432.0, 165684.17157914134, 165969.17015414845, 168799.15600422164, 114359.0, 141429.0, 144838.0, 145430.0, 145893.0, 118826.40586797183, 119350.0, 119603.0, 121425.0, 123181.0, 8918.687845925362, 9083.706630657585, 9138.543072846463, 9156.175944165057, 9270.0, 53527.19709204287, 54245.18632220441, 54387.72806135944, 59984.700076499335, 62241.0, 72926.63536682283, 73822.0, 87609.56195218983, 103232.48383758034, 103735.0, 12836.935815320863, 13461.932690336485, 13727.45090196381, 13809.51666691661, 14034.578962631138, 15456.0, 16015.519534413987, 16138.596535086717, 16302.429414970418, 16397.0, 13782.65543361424, 14078.507252246121, 14088.15471071739, 14289.42842286297, 14413.639659008608, 11573.363465009505, 14139.36372863203, 14151.363188656329, 14367.784483232968, 14972.0, 11963.401829908644, 13740.175589464265, 13847.169169849842, 14015.929920350332, 14102.788458173341, 11454.713632159262, 11589.362585057566, 11763.294202347886, 11827.408629568316, 11993.820092698443, 11492.310461372344, 11573.0, 11678.584438201351, 11733.35466549348, 11925.0459963201], "value": 8119.065112396751, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1554.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 164.0, 105.0, 115.0, 115.0, 114.0, 111.0, 115.0, 116.0, 116.0], "value": 117.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 150.0, 121.0, 181.0, 97.0, 114.0, 158.0, 153.0, 194.0, 141.0], "value": 145.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 199.0, 196.0, 210.0, 220.0, 194.0, 194.0, 195.0, 194.0, 196.0], "value": 199.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 115.0, 67.0, 167.0, 85.0, 83.0, 71.0, 59.0, 140.0, 86.0], "value": 95.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 120.0, 73.0, 70.0, 82.0, 112.0, 70.0, 73.0, 115.0], "value": 85.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 130.0, 100.0, 86.0, 88.0, 86.0, 89.0, 85.0, 89.0, 86.0], "value": 94.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 119.0, 94.0, 150.0, 152.0, 98.0, 95.0, 94.0], "value": 108.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 142.0, 98.0, 89.0, 88.0, 128.0, 149.0, 94.0, 86.0, 91.0], "value": 110.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 55.0, 57.0, 54.0, 56.0, 55.0, 57.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 67.0, 71.0, 71.0, 77.0, 74.0, 68.0, 68.0, 70.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 84.0, 81.0, 84.0, 86.0, 87.0, 87.0, 83.0, 84.0, 83.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 128.0, 134.0, 147.0, 153.0, 139.0, 150.0, 160.0, 245.0, 153.0], "value": 155.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 174.0, 168.0, 164.0, 163.0, 163.0, 166.0, 164.0, 164.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 65.0, 68.0, 65.0, 66.0, 67.0, 65.0, 67.0], "value": 66.6, "unit": "score"}]}]} 18:53:48 INFO - Return code: 0 18:53:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:53:48 ERROR - # TBPL SUCCESS # 18:53:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:53:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:53:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:53:48 INFO - 2016-07-08 18:53:48.856 screenresolution[1671:10409] starting screenresolution argv=screenresolution get 18:53:48 INFO - 2016-07-08 18:53:48.858 screenresolution[1671:10409] Display 0: 1600x1200x32@60 18:53:48 INFO - 2016-07-08 18:53:48.864 screenresolution[1672:10412] starting screenresolution argv=screenresolution list 18:53:48 INFO - Available Modes on Display 0 18:53:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:53:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:53:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:53:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:53:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:53:49 INFO - Intel Iris: 18:53:49 INFO - Chipset Model: Intel Iris 18:53:49 INFO - Type: GPU 18:53:49 INFO - Bus: Built-In 18:53:49 INFO - VRAM (Dynamic, Max): 1536 MB 18:53:49 INFO - Vendor: Intel (0x8086) 18:53:49 INFO - Device ID: 0x0a2e 18:53:49 INFO - Revision ID: 0x0009 18:53:49 INFO - Displays: 18:53:49 INFO - Display: 18:53:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:53:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:53:49 INFO - Display Serial Number: 1600x1200 60 18:53:49 INFO - Main Display: Yes 18:53:49 INFO - Mirror: Off 18:53:49 INFO - Online: Yes 18:53:49 INFO - Rotation: Supported 18:53:49 INFO - Return code: 0 18:53:49 INFO - Running post-action listener: _resource_record_post_action 18:53:49 INFO - ##### 18:53:49 INFO - ##### Finished run-tests step (success) 18:53:49 INFO - ##### 18:53:49 INFO - Running post-run listener: _resource_record_post_run 18:53:49 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 36906496; Write bytes: 704572928; Read time: 240; Write time: 2007 18:53:49 INFO - TinderboxPrint: CPU usage
54.1% 18:53:49 INFO - TinderboxPrint: I/O read bytes / time
36,906,496 / 240 18:53:49 INFO - TinderboxPrint: I/O write bytes / time
704,572,928 / 2,007 18:53:49 INFO - TinderboxPrint: CPU idle
2,216.8 (45.9%) 18:53:49 INFO - TinderboxPrint: CPU system
970.1 (20.1%) 18:53:49 INFO - TinderboxPrint: CPU user
1,646.8 (34.1%) 18:53:49 INFO - TinderboxPrint: Swap in / out
443,887,616 / 0 18:53:49 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 401867264; Write bytes: 389795328; Read time: 29426; Write time: 840 18:53:49 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 29888000; Write bytes: 293003264; Read time: 181; Write time: 1115 18:53:49 INFO - Running post-run listener: _upload_blobber_files 18:53:49 INFO - Blob upload gear active. 18:53:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:53:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:53:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:53:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:53:49 INFO - (blobuploader) - INFO - Open directory for files ... 18:53:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:53:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:53:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:53:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:53:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:53:51 INFO - (blobuploader) - INFO - Done attempting. 18:53:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:53:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:53:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:53:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:53:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:53:52 INFO - (blobuploader) - INFO - Done attempting. 18:53:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:53:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:53:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:53:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:53:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:53:54 INFO - (blobuploader) - INFO - Done attempting. 18:53:54 INFO - (blobuploader) - INFO - Iteration through files over. 18:53:54 INFO - Return code: 0 18:53:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:53:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:53:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6e4dac48562301d60c7d07d40b437906c5f0c13e13e13f60967f66e07a4df3e1b9eba1174e9cb913ca8c439ab4f58d0af05df9fd3cef7cfc1b107625daf07891", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b7d76a74720b177cfb1288732ce43fe2871047377f6d4d5e7ab0539ab0962b23258a4566f5421d632ce0d671d6315483dbff0451bb9bbd5f355c7a69fea3b2a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/024a012c0d4848e052f1dc033833e128b1e1d0467603a3f07bd5338b21e5c7490d440e3b2e0c28548a53f0359e16f7f5e1f4a685f3b31505a75e98242210b757"} 18:53:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:53:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:53:54 INFO - Contents: 18:53:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6e4dac48562301d60c7d07d40b437906c5f0c13e13e13f60967f66e07a4df3e1b9eba1174e9cb913ca8c439ab4f58d0af05df9fd3cef7cfc1b107625daf07891", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b7d76a74720b177cfb1288732ce43fe2871047377f6d4d5e7ab0539ab0962b23258a4566f5421d632ce0d671d6315483dbff0451bb9bbd5f355c7a69fea3b2a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/024a012c0d4848e052f1dc033833e128b1e1d0467603a3f07bd5338b21e5c7490d440e3b2e0c28548a53f0359e16f7f5e1f4a685f3b31505a75e98242210b757"} 18:53:54 INFO - Running post-run listener: copy_logs_to_upload_dir 18:53:54 INFO - Copying logs to upload dir... 18:53:54 INFO - mkdir: /builds/slave/test/build/upload/logs 18:53:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.145361 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-07-08 18:53:54.730905) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 18:53:54.734038) ========= 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.r7YRl7JlBc/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.hTxsveKSG8/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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/6e4dac48562301d60c7d07d40b437906c5f0c13e13e13f60967f66e07a4df3e1b9eba1174e9cb913ca8c439ab4f58d0af05df9fd3cef7cfc1b107625daf07891", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b7d76a74720b177cfb1288732ce43fe2871047377f6d4d5e7ab0539ab0962b23258a4566f5421d632ce0d671d6315483dbff0451bb9bbd5f355c7a69fea3b2a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/024a012c0d4848e052f1dc033833e128b1e1d0467603a3f07bd5338b21e5c7490d440e3b2e0c28548a53f0359e16f7f5e1f4a685f3b31505a75e98242210b757"} build_url:https://queue.taskcluster.net/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011040 build_url: 'https://queue.taskcluster.net/v1/task/eyknSQtiRO6IH1NLHukxRQ/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/6e4dac48562301d60c7d07d40b437906c5f0c13e13e13f60967f66e07a4df3e1b9eba1174e9cb913ca8c439ab4f58d0af05df9fd3cef7cfc1b107625daf07891", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b7d76a74720b177cfb1288732ce43fe2871047377f6d4d5e7ab0539ab0962b23258a4566f5421d632ce0d671d6315483dbff0451bb9bbd5f355c7a69fea3b2a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/024a012c0d4848e052f1dc033833e128b1e1d0467603a3f07bd5338b21e5c7490d440e3b2e0c28548a53f0359e16f7f5e1f4a685f3b31505a75e98242210b757"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 18:53:54.766536) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 18:53:54.766867) ========= 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.r7YRl7JlBc/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.hTxsveKSG8/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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.005070 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 18:53:54.815668) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 18:53:54.815981) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 18:53:54.816297) ========= ========= Total master_lag: 0.18 =========