builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0237 starttime: 1467253336.69 results: success (0) buildid: 20160629170725 builduid: b73c21929e0e485d9aef26a3fa7778c7 revision: 22cfff15c199abe0aef76b306603a4acb8c5eded ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 19:22:16.689290) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 19:22:16.689727) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 19:22:16.689998) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 19:22:16.736261) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 19:22:16.736587) ========= 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.pMegErvKXI/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.gcIwwKtDlr/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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-06-29 19:22:16-- 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% 7.66M=0.002s 2016-06-29 19:22:16 (7.66 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131163 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 19:22:16.889490) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 19:22:16.889836) ========= 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.pMegErvKXI/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.gcIwwKtDlr/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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.020332 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 19:22:16.938438) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-29 19:22:16.938786) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 22cfff15c199abe0aef76b306603a4acb8c5eded --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 22cfff15c199abe0aef76b306603a4acb8c5eded --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pMegErvKXI/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.gcIwwKtDlr/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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-06-29 19:22:17,017 truncating revision to first 12 chars 2016-06-29 19:22:17,017 Setting DEBUG logging. 2016-06-29 19:22:17,017 attempt 1/10 2016-06-29 19:22:17,017 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/22cfff15c199?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 19:22:18,036 unpacking tar archive at: autoland-22cfff15c199/testing/mozharness/ program finished with exit code 0 elapsedTime=1.291659 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-29 19:22:18.252246) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 19:22:18.252561) ========= script_repo_revision: 22cfff15c199abe0aef76b306603a4acb8c5eded ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 19:22:18.252950) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 19:22:18.253218) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 19:22:18.271697) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-06-29 19:22:18.271992) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.pMegErvKXI/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.gcIwwKtDlr/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 19:22:18 INFO - MultiFileLogger online at 20160629 19:22:18 in /builds/slave/test 19:22:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 19:22:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:22:18 INFO - {'append_to_log': False, 19:22:18 INFO - 'base_work_dir': '/builds/slave/test', 19:22:18 INFO - 'blob_upload_branch': 'Autoland', 19:22:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:22:18 INFO - 'branch': 'Autoland', 19:22:18 INFO - 'buildbot_json_path': 'buildprops.json', 19:22:18 INFO - 'config_files': ('talos/mac_config.py',), 19:22:18 INFO - 'default_actions': ('clobber', 19:22:18 INFO - 'read-buildbot-config', 19:22:18 INFO - 'download-and-extract', 19:22:18 INFO - 'populate-webroot', 19:22:18 INFO - 'create-virtualenv', 19:22:18 INFO - 'install', 19:22:18 INFO - 'run-tests'), 19:22:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:22:18 INFO - 'download_minidump_stackwalk': True, 19:22:18 INFO - 'download_symbols': 'ondemand', 19:22:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:22:18 INFO - 'tooltool.py': '/tools/tooltool.py', 19:22:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:22:18 INFO - '/tools/misc-python/virtualenv.py')}, 19:22:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:22:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:22:18 INFO - 'installer_path': 'installer.exe', 19:22:18 INFO - 'log_level': 'info', 19:22:18 INFO - 'log_name': 'talos', 19:22:18 INFO - 'log_to_console': True, 19:22:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:22:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:22:18 INFO - 'opt_config_files': (), 19:22:18 INFO - 'pip_index': False, 19:22:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:22:18 INFO - 'cmd': ('bash', 19:22:18 INFO - '-c', 19:22:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:22:18 INFO - 'enabled': True, 19:22:18 INFO - 'halt_on_failure': False, 19:22:18 INFO - 'name': 'check_screen_resolution'},), 19:22:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:22:18 INFO - 'cmd': ('bash', 19:22:18 INFO - '-c', 19:22:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:22:18 INFO - 'enabled': True, 19:22:18 INFO - 'halt_on_failure': False, 19:22:18 INFO - 'name': 'check_screen_resolution'},), 19:22:18 INFO - 'run_cmd_checks_enabled': True, 19:22:18 INFO - 'sps_profile': False, 19:22:18 INFO - 'sps_profile_interval': 0, 19:22:18 INFO - 'suite': 'dromaeojs', 19:22:18 INFO - 'system_bits': '32', 19:22:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:22:18 INFO - 'title': 't-yosemite-r7-0237', 19:22:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:22:18 INFO - 'use_talos_json': True, 19:22:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:22:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:22:18 INFO - 'work_dir': 'build'} 19:22:18 INFO - ##### 19:22:18 INFO - ##### Running clobber step. 19:22:18 INFO - ##### 19:22:18 INFO - Running pre-action listener: _resource_record_pre_action 19:22:18 INFO - Running main action method: clobber 19:22:18 INFO - rmtree: /builds/slave/test/build 19:22:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:22:18 INFO - Running post-action listener: _resource_record_post_action 19:22:18 INFO - ##### 19:22:18 INFO - ##### Finished clobber step (success) 19:22:18 INFO - ##### 19:22:18 INFO - ##### 19:22:18 INFO - ##### Running read-buildbot-config step. 19:22:18 INFO - ##### 19:22:18 INFO - Running pre-action listener: _resource_record_pre_action 19:22:18 INFO - Running main action method: read_buildbot_config 19:22:18 INFO - Using buildbot properties: 19:22:18 INFO - { 19:22:18 INFO - "project": "", 19:22:18 INFO - "product": "firefox", 19:22:18 INFO - "script_repo_revision": "production", 19:22:18 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 19:22:18 INFO - "repository": "", 19:22:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 19:22:18 INFO - "buildid": "20160629170725", 19:22:18 INFO - "pgo_build": "False", 19:22:18 INFO - "basedir": "/builds/slave/test", 19:22:18 INFO - "buildnumber": 18, 19:22:18 INFO - "slavename": "t-yosemite-r7-0237", 19:22:18 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 19:22:18 INFO - "platform": "yosemite_r7", 19:22:18 INFO - "scheduler": "tests-autoland-macosx64-talos", 19:22:18 INFO - "branch": "autoland", 19:22:18 INFO - "repo_path": "integration/autoland", 19:22:18 INFO - "revision": "22cfff15c199abe0aef76b306603a4acb8c5eded", 19:22:18 INFO - "stage_platform": "macosx64", 19:22:18 INFO - "builduid": "b73c21929e0e485d9aef26a3fa7778c7", 19:22:18 INFO - "slavebuilddir": "test" 19:22:18 INFO - } 19:22:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/e3x1lTsvQPSU3hbxw72caw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 19:22:18 INFO - Running post-action listener: _resource_record_post_action 19:22:18 INFO - ##### 19:22:18 INFO - ##### Finished read-buildbot-config step (success) 19:22:18 INFO - ##### 19:22:18 INFO - ##### 19:22:18 INFO - ##### Running download-and-extract step. 19:22:18 INFO - ##### 19:22:18 INFO - Running pre-action listener: _resource_record_pre_action 19:22:18 INFO - Running main action method: download_and_extract 19:22:18 INFO - mkdir: /builds/slave/test/build/tests 19:22:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:18 INFO - https://queue.taskcluster.net/v1/task/e3x1lTsvQPSU3hbxw72caw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 19:22:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3x1lTsvQPSU3hbxw72caw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 19:22:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3x1lTsvQPSU3hbxw72caw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 19:22:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3x1lTsvQPSU3hbxw72caw/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 19:22:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3x1lTsvQPSU3hbxw72caw/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 19:22:19 INFO - Downloaded 1199 bytes. 19:22:19 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 19:22:19 INFO - Using the following test package requirements: 19:22:19 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 19:22:19 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:22:19 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 19:22:19 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:22:19 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 19:22:19 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:22:19 INFO - u'jsshell-mac.zip'], 19:22:19 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:22:19 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 19:22:19 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 19:22:19 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:22:19 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 19:22:19 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:22:19 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 19:22:19 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:22:19 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 19:22:19 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:22:19 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 19:22:19 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:22:19 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')]} 19:22:19 INFO - https://queue.taskcluster.net/v1/task/e3x1lTsvQPSU3hbxw72caw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:22:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3x1lTsvQPSU3hbxw72caw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:22:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3x1lTsvQPSU3hbxw72caw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:22:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3x1lTsvQPSU3hbxw72caw/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 19:22:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3x1lTsvQPSU3hbxw72caw/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 19:22:20 INFO - Downloaded 18788469 bytes. 19:22:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:22:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:22:24 INFO - Return code: 0 19:22:24 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 19:22: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')]} 19:22:24 INFO - https://queue.taskcluster.net/v1/task/e3x1lTsvQPSU3hbxw72caw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:22:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3x1lTsvQPSU3hbxw72caw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:22:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3x1lTsvQPSU3hbxw72caw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:22:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3x1lTsvQPSU3hbxw72caw/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 19:22:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3x1lTsvQPSU3hbxw72caw/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 19:22:25 INFO - Downloaded 18788469 bytes. 19:22:25 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'] 19:22:25 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 19:22:29 INFO - Return code: 0 19:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:29 INFO - https://queue.taskcluster.net/v1/task/e3x1lTsvQPSU3hbxw72caw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:22:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3x1lTsvQPSU3hbxw72caw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 19:22:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3x1lTsvQPSU3hbxw72caw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 19:22:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3x1lTsvQPSU3hbxw72caw/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 19:22:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3x1lTsvQPSU3hbxw72caw/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 19:22:30 INFO - Downloaded 14405245 bytes. 19:22:30 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'] 19:22:30 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 19:22:30 INFO - Return code: 0 19:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:30 INFO - https://queue.taskcluster.net/v1/task/e3x1lTsvQPSU3hbxw72caw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 19:22:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3x1lTsvQPSU3hbxw72caw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 19:22:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3x1lTsvQPSU3hbxw72caw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 19:22:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3x1lTsvQPSU3hbxw72caw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 19:22:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3x1lTsvQPSU3hbxw72caw/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 19:22:37 INFO - Downloaded 112461352 bytes. 19:22:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e3x1lTsvQPSU3hbxw72caw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 19:22:37 INFO - mkdir: /builds/slave/test/properties 19:22:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:22:37 INFO - Writing to file /builds/slave/test/properties/build_url 19:22:37 INFO - Contents: 19:22:37 INFO - build_url:https://queue.taskcluster.net/v1/task/e3x1lTsvQPSU3hbxw72caw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 19:22:38 INFO - Running post-action listener: _resource_record_post_action 19:22:38 INFO - Running post-action listener: set_extra_try_arguments 19:22:38 INFO - ##### 19:22:38 INFO - ##### Finished download-and-extract step (success) 19:22:38 INFO - ##### 19:22:38 INFO - ##### 19:22:38 INFO - ##### Running populate-webroot step. 19:22:38 INFO - ##### 19:22:38 INFO - Running pre-action listener: _resource_record_pre_action 19:22:38 INFO - Running main action method: populate_webroot 19:22:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:22:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:22:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:22:38 INFO - '--tppagecycles', 19:22:38 INFO - '7'], 19:22:38 INFO - 'tests': ['tsvgm']}}, 19:22:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:22:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:22:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:22:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:22:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:22:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:22:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:22:38 INFO - 'talos_options': ['--disable-e10s'], 19:22:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:22:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:22:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:22:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:22:38 INFO - 'talos_options': ['--disable-e10s'], 19:22:38 INFO - 'tests': ['damp', 'tps']}, 19:22:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:22:38 INFO - 'tests': ['damp', 'tps']}, 19:22:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:22:38 INFO - 'tests': ['dromaeo_dom']}, 19:22:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:22:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:22:38 INFO - 'tests': ['basic_compositor_video']}, 19:22:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:22:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:22:38 INFO - 'tests': ['a11yr', 19:22:38 INFO - 'ts_paint', 19:22:38 INFO - 'tpaint', 19:22:38 INFO - 'sessionrestore', 19:22:38 INFO - 'sessionrestore_no_auto_restore', 19:22:38 INFO - 'tabpaint']}, 19:22:38 INFO - 'other-e10s': {'tests': ['a11yr', 19:22:38 INFO - 'ts_paint', 19:22:38 INFO - 'tpaint', 19:22:38 INFO - 'sessionrestore', 19:22:38 INFO - 'sessionrestore_no_auto_restore', 19:22:38 INFO - 'tabpaint']}, 19:22:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:22:38 INFO - 'ts_paint', 19:22:38 INFO - 'tpaint', 19:22:38 INFO - 'sessionrestore', 19:22:38 INFO - 'sessionrestore_no_auto_restore', 19:22:38 INFO - 'tabpaint']}, 19:22:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:22:38 INFO - 'ts_paint', 19:22:38 INFO - 'tpaint', 19:22:38 INFO - 'sessionrestore', 19:22:38 INFO - 'sessionrestore_no_auto_restore', 19:22:38 INFO - 'tabpaint']}, 19:22:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:22:38 INFO - 'tests': ['a11yr', 19:22:38 INFO - 'ts_paint', 19:22:38 INFO - 'tpaint', 19:22:38 INFO - 'sessionrestore', 19:22:38 INFO - 'sessionrestore_no_auto_restore', 19:22:38 INFO - 'tabpaint']}, 19:22:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:22:38 INFO - 'tests': ['a11yr', 19:22:38 INFO - 'ts_paint', 19:22:38 INFO - 'tpaint', 19:22:38 INFO - 'sessionrestore', 19:22:38 INFO - 'sessionrestore_no_auto_restore', 19:22:38 INFO - 'tabpaint']}, 19:22:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:22:38 INFO - 'tests': ['tsvgx', 19:22:38 INFO - 'tsvgr_opacity', 19:22:38 INFO - 'tart', 19:22:38 INFO - 'tscrollx', 19:22:38 INFO - 'cart']}, 19:22:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:22:38 INFO - 'tsvgr_opacity', 19:22:38 INFO - 'tart', 19:22:38 INFO - 'tscrollx', 19:22:38 INFO - 'cart']}, 19:22:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:22:38 INFO - 'talos_options': ['--disable-e10s'], 19:22:38 INFO - 'tests': ['tp5o']}, 19:22:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:22:38 INFO - 'tests': ['tp5o']}, 19:22:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:22:38 INFO - 'talos_options': ['--disable-e10s', 19:22:38 INFO - '--xperf_path', 19:22:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:22:38 INFO - 'tests': ['tp5n']}, 19:22:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:22:38 INFO - 'talos_options': ['--xperf_path', 19:22:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:22:38 INFO - 'tests': ['tp5n']}}, 19:22:38 INFO - 'talos.zip': {'path': '', 19:22:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:22:38 INFO - Running post-action listener: _resource_record_post_action 19:22:38 INFO - ##### 19:22:38 INFO - ##### Finished populate-webroot step (success) 19:22:38 INFO - ##### 19:22:38 INFO - ##### 19:22:38 INFO - ##### Running create-virtualenv step. 19:22:38 INFO - ##### 19:22:38 INFO - Running pre-action listener: _resource_record_pre_action 19:22:38 INFO - Running main action method: create_virtualenv 19:22:38 INFO - Creating virtualenv /builds/slave/test/build/venv 19:22:38 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 19:22:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:22:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:22:38 INFO - Using real prefix '/tools/python27' 19:22:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:22:39 INFO - Installing distribute.............................................................................................................................................................................................done. 19:22:42 INFO - Installing pip.................done. 19:22:42 INFO - Return code: 0 19:22:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d7b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d84d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9fbc8ccd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d71cd30>, '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 0x10d481db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d714b20>, '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.pMegErvKXI/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.gcIwwKtDlr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 19:22:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:22:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:22:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pMegErvKXI/Render', 19:22:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:22:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:22:42 INFO - 'HOME': '/Users/cltbld', 19:22:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:22:42 INFO - 'LOGNAME': 'cltbld', 19:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:42 INFO - 'MOZ_NO_REMOTE': '1', 19:22:42 INFO - 'NO_EM_RESTART': '1', 19:22:42 INFO - 'PAGER': '/bin/cat', 19:22:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:42 INFO - 'PWD': '/builds/slave/test', 19:22:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:22:42 INFO - 'SHELL': '/bin/bash', 19:22:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gcIwwKtDlr/Listeners', 19:22:42 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 19:22:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:22:42 INFO - 'USER': 'cltbld', 19:22:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:22:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:42 INFO - 'XPC_FLAGS': '0x0', 19:22:42 INFO - 'XPC_SERVICE_NAME': '0', 19:22:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:22:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:42 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 19:22:42 INFO - Cleaning up... 19:22:42 INFO - Return code: 0 19:22:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d7b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d84d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9fbc8ccd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d71cd30>, '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 0x10d481db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d714b20>, '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.pMegErvKXI/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.gcIwwKtDlr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 19:22:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:22:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:22:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pMegErvKXI/Render', 19:22:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:22:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:22:42 INFO - 'HOME': '/Users/cltbld', 19:22:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:22:42 INFO - 'LOGNAME': 'cltbld', 19:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:42 INFO - 'MOZ_NO_REMOTE': '1', 19:22:42 INFO - 'NO_EM_RESTART': '1', 19:22:42 INFO - 'PAGER': '/bin/cat', 19:22:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:42 INFO - 'PWD': '/builds/slave/test', 19:22:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:22:42 INFO - 'SHELL': '/bin/bash', 19:22:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gcIwwKtDlr/Listeners', 19:22:42 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 19:22:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:22:42 INFO - 'USER': 'cltbld', 19:22:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:22:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:42 INFO - 'XPC_FLAGS': '0x0', 19:22:42 INFO - 'XPC_SERVICE_NAME': '0', 19:22:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:22:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:42 INFO - Downloading/unpacking psutil>=3.1.1 19:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:22:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:22:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:22:45 INFO - Installing collected packages: psutil 19:22:45 INFO - Running setup.py install for psutil 19:22:45 INFO - building 'psutil._psutil_osx' extension 19:22:45 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 19:22:46 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 19:22:46 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 19:22:46 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 19:22:46 INFO - building 'psutil._psutil_posix' extension 19:22:46 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 19:22:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:22:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:22:46 INFO - ^ 19:22:46 INFO - 1 warning generated. 19:22:46 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 19:22:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:22:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:22:46 INFO - Successfully installed psutil 19:22:46 INFO - Cleaning up... 19:22:46 INFO - Return code: 0 19:22:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:46 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 0x10d7b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d84d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9fbc8ccd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d71cd30>, '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 0x10d481db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d714b20>, '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.pMegErvKXI/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.gcIwwKtDlr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 19:22:46 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 19:22:46 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 19:22:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pMegErvKXI/Render', 19:22:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:22:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:22:46 INFO - 'HOME': '/Users/cltbld', 19:22:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:22:46 INFO - 'LOGNAME': 'cltbld', 19:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:46 INFO - 'MOZ_NO_REMOTE': '1', 19:22:46 INFO - 'NO_EM_RESTART': '1', 19:22:46 INFO - 'PAGER': '/bin/cat', 19:22:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:46 INFO - 'PWD': '/builds/slave/test', 19:22:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:22:46 INFO - 'SHELL': '/bin/bash', 19:22:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gcIwwKtDlr/Listeners', 19:22:46 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 19:22:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:22:46 INFO - 'USER': 'cltbld', 19:22:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:22:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:46 INFO - 'XPC_FLAGS': '0x0', 19:22:46 INFO - 'XPC_SERVICE_NAME': '0', 19:22:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:22:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:22:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:22:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:22:49 INFO - Installing collected packages: mozsystemmonitor 19:22:49 INFO - Running setup.py install for mozsystemmonitor 19:22:49 INFO - Successfully installed mozsystemmonitor 19:22:49 INFO - Cleaning up... 19:22:49 INFO - Return code: 0 19:22:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:49 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 0x10d7b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d84d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9fbc8ccd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d71cd30>, '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 0x10d481db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d714b20>, '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.pMegErvKXI/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.gcIwwKtDlr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 19:22:49 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 19:22:49 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 19:22:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pMegErvKXI/Render', 19:22:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:22:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:22:49 INFO - 'HOME': '/Users/cltbld', 19:22:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:22:49 INFO - 'LOGNAME': 'cltbld', 19:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:49 INFO - 'MOZ_NO_REMOTE': '1', 19:22:49 INFO - 'NO_EM_RESTART': '1', 19:22:49 INFO - 'PAGER': '/bin/cat', 19:22:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:49 INFO - 'PWD': '/builds/slave/test', 19:22:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:22:49 INFO - 'SHELL': '/bin/bash', 19:22:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gcIwwKtDlr/Listeners', 19:22:49 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 19:22:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:22:49 INFO - 'USER': 'cltbld', 19:22:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:22:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:49 INFO - 'XPC_FLAGS': '0x0', 19:22:49 INFO - 'XPC_SERVICE_NAME': '0', 19:22:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:50 INFO - Downloading/unpacking jsonschema==2.5.1 19:22:50 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 19:22:50 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 19:22:50 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 19:22:50 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 19:22:50 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 19:22:50 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 19:22:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:22:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:22:52 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 19:22:52 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 19:22:52 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 19:22:52 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 19:22:52 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 19:22:52 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 19:22:52 INFO - Downloading functools32-3.2.3-2.tar.gz 19:22:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:22:52 INFO - warning: no files found matching '*.txt' 19:22:52 INFO - no previously-included directories found matching 'build' 19:22:52 INFO - no previously-included directories found matching 'dist' 19:22:52 INFO - no previously-included directories found matching '.git*' 19:22:52 INFO - Installing collected packages: jsonschema, functools32 19:22:53 INFO - Running setup.py install for functools32 19:22:53 INFO - warning: no files found matching '*.txt' 19:22:53 INFO - no previously-included directories found matching 'build' 19:22:53 INFO - no previously-included directories found matching 'dist' 19:22:53 INFO - no previously-included directories found matching '.git*' 19:22:53 INFO - Successfully installed jsonschema functools32 19:22:53 INFO - Cleaning up... 19:22:53 INFO - Return code: 0 19:22:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:53 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 0x10d7b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d84d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9fbc8ccd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d71cd30>, '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 0x10d481db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d714b20>, '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.pMegErvKXI/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.gcIwwKtDlr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 19:22:53 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 19:22:53 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 19:22:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pMegErvKXI/Render', 19:22:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:22:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:22:53 INFO - 'HOME': '/Users/cltbld', 19:22:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:22:53 INFO - 'LOGNAME': 'cltbld', 19:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:53 INFO - 'MOZ_NO_REMOTE': '1', 19:22:53 INFO - 'NO_EM_RESTART': '1', 19:22:53 INFO - 'PAGER': '/bin/cat', 19:22:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:53 INFO - 'PWD': '/builds/slave/test', 19:22:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:22:53 INFO - 'SHELL': '/bin/bash', 19:22:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gcIwwKtDlr/Listeners', 19:22:53 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 19:22:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:22:53 INFO - 'USER': 'cltbld', 19:22:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:22:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:53 INFO - 'XPC_FLAGS': '0x0', 19:22:53 INFO - 'XPC_SERVICE_NAME': '0', 19:22:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:53 INFO - Downloading/unpacking blobuploader==1.2.4 19:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:55 INFO - Downloading blobuploader-1.2.4.tar.gz 19:22:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:22:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:22:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:57 INFO - Downloading docopt-0.6.1.tar.gz 19:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:22:57 INFO - Installing collected packages: blobuploader, requests, docopt 19:22:57 INFO - Running setup.py install for blobuploader 19:22:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:22:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:22:57 INFO - Running setup.py install for requests 19:22:57 INFO - Running setup.py install for docopt 19:22:57 INFO - Successfully installed blobuploader requests docopt 19:22:57 INFO - Cleaning up... 19:22:58 INFO - Return code: 0 19:22:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:22:58 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')]} 19:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:58 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')]} 19:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:58 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 0x10d7b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d84d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9fbc8ccd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d71cd30>, '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 0x10d481db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d714b20>, '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.pMegErvKXI/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.gcIwwKtDlr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 19:22:58 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 19:22:58 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 19:22:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pMegErvKXI/Render', 19:22:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:22:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:22:58 INFO - 'HOME': '/Users/cltbld', 19:22:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:22:58 INFO - 'LOGNAME': 'cltbld', 19:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:58 INFO - 'MOZ_NO_REMOTE': '1', 19:22:58 INFO - 'NO_EM_RESTART': '1', 19:22:58 INFO - 'PAGER': '/bin/cat', 19:22:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:58 INFO - 'PWD': '/builds/slave/test', 19:22:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:22:58 INFO - 'SHELL': '/bin/bash', 19:22:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gcIwwKtDlr/Listeners', 19:22:58 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 19:22:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:22:58 INFO - 'USER': 'cltbld', 19:22:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:22:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:58 INFO - 'XPC_FLAGS': '0x0', 19:22:58 INFO - 'XPC_SERVICE_NAME': '0', 19:22:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:22:58 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-VOca0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:22:58 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-HJZ7Bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:22:58 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-AAHDO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:22:58 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-LJY0OR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:22:58 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-dy118p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:22:58 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-Ztd9rX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:22:58 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-SdOJ9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:22:59 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-Fqt0vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:22:59 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-VZDOyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:22:59 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-057jca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:22:59 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-hbDVy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:22:59 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-TGYgd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:22:59 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-Mv57s7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:22:59 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-Fs33uC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:22:59 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-5EQn6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:22:59 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-xSNxC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:23:00 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-SPxLCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:23:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:23:00 INFO - Running setup.py install for manifestparser 19:23:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:23:00 INFO - Running setup.py install for mozcrash 19:23:00 INFO - Running setup.py install for mozdebug 19:23:00 INFO - Running setup.py install for mozdevice 19:23:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:23:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:23:00 INFO - Running setup.py install for mozfile 19:23:00 INFO - Running setup.py install for mozhttpd 19:23:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:23:01 INFO - Running setup.py install for mozinfo 19:23:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:23:01 INFO - Running setup.py install for mozInstall 19:23:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:23:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:23:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:23:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:23:01 INFO - Running setup.py install for mozleak 19:23:01 INFO - Running setup.py install for mozlog 19:23:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:23:01 INFO - Running setup.py install for moznetwork 19:23:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:23:01 INFO - Running setup.py install for mozprocess 19:23:01 INFO - Running setup.py install for mozprofile 19:23:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:23:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:23:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:23:02 INFO - Running setup.py install for mozrunner 19:23:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:23:02 INFO - Running setup.py install for mozscreenshot 19:23:02 INFO - Running setup.py install for moztest 19:23:02 INFO - Running setup.py install for mozversion 19:23:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:23:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:23:02 INFO - Cleaning up... 19:23:02 INFO - Return code: 0 19:23:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:23:02 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')]} 19:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:02 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')]} 19:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:02 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 0x10d7b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d84d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9fbc8ccd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d71cd30>, '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 0x10d481db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d714b20>, '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.pMegErvKXI/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.gcIwwKtDlr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 19:23:02 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 19:23:02 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 19:23:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pMegErvKXI/Render', 19:23:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:23:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:23:02 INFO - 'HOME': '/Users/cltbld', 19:23:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:23:02 INFO - 'LOGNAME': 'cltbld', 19:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:02 INFO - 'MOZ_NO_REMOTE': '1', 19:23:02 INFO - 'NO_EM_RESTART': '1', 19:23:02 INFO - 'PAGER': '/bin/cat', 19:23:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:02 INFO - 'PWD': '/builds/slave/test', 19:23:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:23:02 INFO - 'SHELL': '/bin/bash', 19:23:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gcIwwKtDlr/Listeners', 19:23:02 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 19:23:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:23:02 INFO - 'USER': 'cltbld', 19:23:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:23:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:02 INFO - 'XPC_FLAGS': '0x0', 19:23:02 INFO - 'XPC_SERVICE_NAME': '0', 19:23:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:23:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:23:03 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-DAuze3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:23:03 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)) 19:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:23:03 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-lT_mmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:23:03 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)) 19:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:23:03 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-3iIAhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:23:03 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)) 19:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:23:03 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-zYgHD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:23:03 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)) 19:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:23:03 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-FZjnEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:23:03 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)) 19:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:23:03 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-o88qT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:23:03 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)) 19:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:23:03 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-xZbwYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:23:03 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)) 19:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:23:03 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-dD73bK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:23:03 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)) 19:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:23:03 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-FAkfn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:23:03 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)) 19:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:23:04 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-W5mpUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:23:04 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)) 19:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:23:04 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-wXBQvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:23:04 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)) 19:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:23:04 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-v3yw2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:23:04 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-cuDsGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:23:04 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)) 19:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:23:04 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-CQep94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:23:04 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-iaGvZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:23:04 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)) 19:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:23:04 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-GFoG0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:23:04 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)) 19:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:23:04 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-czOfCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:23:04 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)) 19:23:04 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)) 19:23:04 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)) 19:23:04 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)) 19:23:04 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)) 19:23:04 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)) 19:23:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:23:04 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 19:23:04 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 19:23:04 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 19:23:04 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 19:23:04 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 19:23:04 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 19:23:07 INFO - Downloading blessings-1.6.tar.gz 19:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:23:07 INFO - Installing collected packages: blessings 19:23:07 INFO - Running setup.py install for blessings 19:23:07 INFO - Successfully installed blessings 19:23:07 INFO - Cleaning up... 19:23:07 INFO - Return code: 0 19:23:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:23:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:23:08 INFO - Reading from file tmpfile_stdout 19:23:08 INFO - Current package versions: 19:23:08 INFO - blessings == 1.6 19:23:08 INFO - blobuploader == 1.2.4 19:23:08 INFO - docopt == 0.6.1 19:23:08 INFO - functools32 == 3.2.3-2 19:23:08 INFO - jsonschema == 2.5.1 19:23:08 INFO - manifestparser == 1.1 19:23:08 INFO - mozInstall == 1.12 19:23:08 INFO - mozcrash == 0.17 19:23:08 INFO - mozdebug == 0.1 19:23:08 INFO - mozdevice == 0.48 19:23:08 INFO - mozfile == 1.2 19:23:08 INFO - mozhttpd == 0.7 19:23:08 INFO - mozinfo == 0.9 19:23:08 INFO - mozleak == 0.1 19:23:08 INFO - mozlog == 3.2 19:23:08 INFO - moznetwork == 0.27 19:23:08 INFO - mozprocess == 0.22 19:23:08 INFO - mozprofile == 0.28 19:23:08 INFO - mozrunner == 6.11 19:23:08 INFO - mozscreenshot == 0.1 19:23:08 INFO - mozsystemmonitor == 0.3 19:23:08 INFO - moztest == 0.7 19:23:08 INFO - mozversion == 1.4 19:23:08 INFO - psutil == 3.1.1 19:23:08 INFO - requests == 1.2.3 19:23:08 INFO - wsgiref == 0.1.2 19:23:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:23:08 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')]} 19:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:08 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')]} 19:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:08 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 0x10d7b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d84d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9fbc8ccd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d71cd30>, '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 0x10d481db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d714b20>, '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.pMegErvKXI/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.gcIwwKtDlr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 19:23:08 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 19:23:08 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 19:23:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pMegErvKXI/Render', 19:23:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:23:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:23:08 INFO - 'HOME': '/Users/cltbld', 19:23:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:23:08 INFO - 'LOGNAME': 'cltbld', 19:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:08 INFO - 'MOZ_NO_REMOTE': '1', 19:23:08 INFO - 'NO_EM_RESTART': '1', 19:23:08 INFO - 'PAGER': '/bin/cat', 19:23:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:08 INFO - 'PWD': '/builds/slave/test', 19:23:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:23:08 INFO - 'SHELL': '/bin/bash', 19:23:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gcIwwKtDlr/Listeners', 19:23:08 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 19:23:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:23:08 INFO - 'USER': 'cltbld', 19:23:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:23:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:08 INFO - 'XPC_FLAGS': '0x0', 19:23:08 INFO - 'XPC_SERVICE_NAME': '0', 19:23:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:08 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)) 19:23:08 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)) 19:23:08 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)) 19:23:08 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)) 19:23:08 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)) 19:23:08 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)) 19:23:08 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)) 19:23:08 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)) 19:23:08 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)) 19:23:08 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)) 19:23:08 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)) 19:23:08 INFO - Cleaning up... 19:23:08 INFO - Return code: 0 19:23:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:23:08 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')]} 19:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:08 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')]} 19:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:08 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 0x10d7b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d84d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9fbc8ccd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d71cd30>, '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 0x10d481db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d714b20>, '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.pMegErvKXI/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.gcIwwKtDlr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 19:23:08 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 19:23:08 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 19:23:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pMegErvKXI/Render', 19:23:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:23:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:23:08 INFO - 'HOME': '/Users/cltbld', 19:23:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:23:08 INFO - 'LOGNAME': 'cltbld', 19:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:08 INFO - 'MOZ_NO_REMOTE': '1', 19:23:08 INFO - 'NO_EM_RESTART': '1', 19:23:08 INFO - 'PAGER': '/bin/cat', 19:23:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:08 INFO - 'PWD': '/builds/slave/test', 19:23:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:23:08 INFO - 'SHELL': '/bin/bash', 19:23:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gcIwwKtDlr/Listeners', 19:23:08 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 19:23:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:23:08 INFO - 'USER': 'cltbld', 19:23:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:23:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:08 INFO - 'XPC_FLAGS': '0x0', 19:23:08 INFO - 'XPC_SERVICE_NAME': '0', 19:23:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:23:08 INFO - Cleaning up... 19:23:08 INFO - Return code: 0 19:23:08 INFO - Running post-action listener: _resource_record_post_action 19:23:08 INFO - Running post-action listener: _start_resource_monitoring 19:23:08 INFO - Starting resource monitoring. 19:23:08 INFO - ##### 19:23:08 INFO - ##### Finished create-virtualenv step (success) 19:23:08 INFO - ##### 19:23:08 INFO - ##### 19:23:08 INFO - ##### Running install step. 19:23:08 INFO - ##### 19:23:08 INFO - Running pre-action listener: _resource_record_pre_action 19:23:08 INFO - Running main action method: install 19:23:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:23:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:23:09 INFO - Reading from file tmpfile_stdout 19:23:09 INFO - Detecting whether we're running mozinstall >=1.0... 19:23:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:23:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:23:09 INFO - Reading from file tmpfile_stdout 19:23:09 INFO - Output received: 19:23:09 INFO - Usage: mozinstall [options] installer 19:23:09 INFO - Options: 19:23:09 INFO - -h, --help show this help message and exit 19:23:09 INFO - -d DEST, --destination=DEST 19:23:09 INFO - Directory to install application into. [default: 19:23:09 INFO - "/builds/slave/test"] 19:23:09 INFO - --app=APP Application being installed. [default: firefox] 19:23:09 INFO - mkdir: /builds/slave/test/build/application 19:23:09 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'] 19:23:09 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 19:23:43 INFO - Reading from file tmpfile_stdout 19:23:43 INFO - Output received: 19:23:43 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:23:43 INFO - Running post-action listener: _resource_record_post_action 19:23:43 INFO - ##### 19:23:43 INFO - ##### Finished install step (success) 19:23:43 INFO - ##### 19:23:43 INFO - ##### 19:23:43 INFO - ##### Running run-tests step. 19:23:43 INFO - ##### 19:23:43 INFO - Running pre-action listener: _resource_record_pre_action 19:23:43 INFO - Running main action method: run_tests 19:23:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:23:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:23:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:23:43 INFO - 2016-06-29 19:23:43.388 screenresolution[2054:11760] starting screenresolution argv=screenresolution get 19:23:43 INFO - 2016-06-29 19:23:43.390 screenresolution[2054:11760] Display 0: 1600x1200x32@60 19:23:43 INFO - 2016-06-29 19:23:43.396 screenresolution[2055:11762] starting screenresolution argv=screenresolution list 19:23:43 INFO - Available Modes on Display 0 19:23:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:23:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:23:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:23:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:23:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:23:43 INFO - Intel Iris: 19:23:43 INFO - Chipset Model: Intel Iris 19:23:43 INFO - Type: GPU 19:23:43 INFO - Bus: Built-In 19:23:43 INFO - VRAM (Dynamic, Max): 1536 MB 19:23:43 INFO - Vendor: Intel (0x8086) 19:23:43 INFO - Device ID: 0x0a2e 19:23:43 INFO - Revision ID: 0x0009 19:23:43 INFO - Displays: 19:23:43 INFO - Display: 19:23:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:23:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:23:43 INFO - Display Serial Number: 1600x1200 60 19:23:43 INFO - Main Display: Yes 19:23:43 INFO - Mirror: Off 19:23:43 INFO - Online: Yes 19:23:43 INFO - Rotation: Supported 19:23:43 INFO - Return code: 0 19:23:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:23:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:23:43 INFO - Python 2.7.3 19:23:43 INFO - Return code: 0 19:23:43 INFO - grabbing minidump binary from tooltool 19:23:43 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')]} 19:23:43 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 0x10d71cd30>, '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 0x10d481db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d714b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:23:43 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 19:23:43 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 19:23:43 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 19:23:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:23:43 INFO - Return code: 0 19:23:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:23:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:23:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:23:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:23:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:23:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e3x1lTsvQPSU3hbxw72caw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0237', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:23:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e3x1lTsvQPSU3hbxw72caw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0237 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:23:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pMegErvKXI/Render', 19:23:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:23:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:23:43 INFO - 'HOME': '/Users/cltbld', 19:23:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:23:43 INFO - 'LOGNAME': 'cltbld', 19:23:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:23:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:43 INFO - 'MOZ_NO_REMOTE': '1', 19:23:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:23:43 INFO - 'NO_EM_RESTART': '1', 19:23:43 INFO - 'PAGER': '/bin/cat', 19:23:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:43 INFO - 'PWD': '/builds/slave/test', 19:23:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:23:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:23:43 INFO - 'SHELL': '/bin/bash', 19:23:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gcIwwKtDlr/Listeners', 19:23:43 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 19:23:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:23:43 INFO - 'USER': 'cltbld', 19:23:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:23:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:43 INFO - 'XPC_FLAGS': '0x0', 19:23:43 INFO - 'XPC_SERVICE_NAME': '0', 19:23:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:23:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e3x1lTsvQPSU3hbxw72caw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0237', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:23:43 INFO - mozversion application_buildid: 20160629170725 19:23:43 INFO - mozversion application_changeset: 22cfff15c199abe0aef76b306603a4acb8c5eded 19:23:43 INFO - mozversion application_display_name: Nightly 19:23:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:23:43 INFO - mozversion application_name: Firefox 19:23:43 INFO - mozversion application_remotingname: firefox 19:23:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 19:23:43 INFO - mozversion application_vendor: Mozilla 19:23:43 INFO - mozversion application_version: 50.0a1 19:23:43 INFO - mozversion platform_buildid: 20160629170725 19:23:43 INFO - mozversion platform_changeset: 22cfff15c199abe0aef76b306603a4acb8c5eded 19:23:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 19:23:43 INFO - mozversion platform_version: 50.0a1 19:23:43 INFO - using testdate: 1467253423 19:23:43 INFO - actual date: 1467253423 19:23:43 INFO - starting webserver on 'localhost:49347' 19:23:43 INFO - SUITE-START | Running 2 tests 19:23:43 INFO - TEST-START | dromaeo_css 19:23:43 INFO - operating with platform_type : mac_ 19:23:43 INFO - Initialising browser for dromaeo_css test... 19:23:44 INFO - TEST-INFO | started process 2065 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/tmppIYTa2/profile http://localhost:49347/getInfo.html) 19:23:46 INFO - PROCESS | 2065 | __metrics Screen width/height:1600/1200 19:23:46 INFO - PROCESS | 2065 | colorDepth:24 19:23:46 INFO - PROCESS | 2065 | Browser inner width/height: 1024/689 19:23:46 INFO - PROCESS | 2065 | __metrics 19:23:46 INFO - PROCESS | 2065 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:23:46 INFO - PROCESS | 2065 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:23:46 INFO - TEST-INFO | 2065: exit 0 19:23:46 INFO - Browser initialized. 19:23:46 INFO - Running cycle 1/1 for dromaeo_css test... 19:23:46 INFO - TEST-INFO | started process 2068 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/tmppIYTa2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:23:58 INFO - PROCESS | 2068 | RSS: Main: 243658752 19:23:58 INFO - PROCESS | 2068 | 19:24:50 INFO - PROCESS | 2068 | 1467253490416 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] 19:27:00 INFO - PROCESS | 2068 | Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49347/tests/dromaeo/cssquery-ext.html) 19:27:02 INFO - PROCESS | 2068 | RSS: Main: 404221952 19:27:02 INFO - PROCESS | 2068 | 19:30:05 INFO - PROCESS | 2068 | Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-ext.html (next: http://localhost:49347/tests/dromaeo/cssquery-jquery.html) 19:30:06 INFO - PROCESS | 2068 | RSS: Main: 373899264 19:30:06 INFO - PROCESS | 2068 | 19:33:08 INFO - PROCESS | 2068 | Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49347/tests/dromaeo/cssquery-mootools.html) 19:33:09 INFO - PROCESS | 2068 | RSS: Main: 370184192 19:33:09 INFO - PROCESS | 2068 | 19:36:11 INFO - PROCESS | 2068 | Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49347/tests/dromaeo/cssquery-prototype.html) 19:36:12 INFO - PROCESS | 2068 | RSS: Main: 366768128 19:36:12 INFO - PROCESS | 2068 | 19:39:15 INFO - PROCESS | 2068 | Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49347/tests/dromaeo/cssquery-yui.html) 19:39:15 INFO - PROCESS | 2068 | RSS: Main: 338735104 19:39:15 INFO - PROCESS | 2068 | 19:42:18 INFO - PROCESS | 2068 | Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-yui.html (next: http://localhost:49347/tests/dromaeo/cssquery-dojo.html) 19:42:19 INFO - PROCESS | 2068 | RSS: Main: 420651008 19:42:19 INFO - PROCESS | 2068 | 19:42:19 INFO - PROCESS | 2068 | __start_tp_report 19:42:19 INFO - PROCESS | 2068 | _x_x_mozilla_page_load 19:42:19 INFO - PROCESS | 2068 | _x_x_mozilla_page_load_details 19:42:19 INFO - PROCESS | 2068 | |i|pagename|runs| 19:42:19 INFO - PROCESS | 2068 | |0;dojo.html;3152.3852848694505;3339.4990751387304;3365.276465559904;3373.814440205788;3400.268942177431;5662.688552129631;5665.575081868861;5736.397678243787;5800.53595712343;5813.912791308123;5719.19931209631;5723.456271654197;5730.68481233532;5809.883802323951;5814.709264536767;5102.489751024905;5147.922781158267;5197.662151960129;5204.037253108168;5320.334958130234;5300.310959575269;5337.653052551591;5341.172118321666;5345.278387417708;5381.784728610851;5146.176611742141;5150.0472412603785;5185.688858668492;5195.818146364859;5237.6071794615555;5153.819616313411;5164.870878228036;5165.992631436871;5175.663581867167;5189.818356357547;5145.691258524501;5172.715500647463;5194.662346947436;5207.583393328562;5241.842744717665;5647.717614119278;5702.714864256771;5754.251947246873;5773.826785196409;5777.364489906107;6276.435120839146;6295.748170073238;6311.93688063118;6342.365763423667;6363.459105975951;4957.876053098666;6355.332690067523;6368.522360822957;6370.585911915757;6405.263394709621;5713.685747283897;5761.740721667535;5771.451712087345;5806.709664516758;5814.9709251454315;6293.433590976742;6299.590526615755;6310.990241561328;6328.6519241442165;6335.714892829834;6190.938090619036;6193.907091393633;6204.906926396107;6207.410296021871;6214.1921550198185;6142.560166306883;6236;6254.74981000764;6290.591111577733;6296.65368404733;6265.404786545271;6281.685915704196;6287.465565426898;6318.399752023551;6323.241211054611;6300.306966233802;6301.873962520724;6307.053941908659;6313.273973493016;6321.557490975588;4893.168161412568;4913.091078150482;4953.529414705597;4996.675216110941;5030.019146266516;4056.5334986476932;4131.8224306073225;4447.577480139382;4528.682992190515;4536.909261814745;5695.886082278331;5708.80019199326;5738.311402631711;5753.539716822645;5763.8559036024435;6322.810315690536;6337.461315788118;6365.172527571479;6374.840628984312;6383.106365108889;5799.449052340021;5804.564657650609;5815.912761308584;5825.621334613236;5850.063989761617;5378.838634840961;5424.511793938565;5448.237246785453;5472.972635136799;5497.0105381031;6343.809685709436;6355.428011478989;6358.173437453194;6359.141515895388;6365.077063825812;5651.615354238238;6284.448206328409;6353.682315884095;6357.713902874474;6378.2346118466085;6127.220070483952;6233.937660623335;6251.124842522141;6279.215098112736;6360.554761166859;5509.972450137724;6221.3156552780065;6235.96882015587;6242.126102345766;6256.499480041677;6294.874102518015;6311.274203466476;6313.08460273267;6336.524760642878;6338.429541341301;5993.340732519507;6041.972864612939;6042.637441753509;6086.6348019119;6135.447809697149;6092.238470191226;6114.844865410725;6136.877262454636;6146.907796382969;6197.752089916533;5896.70516474166;5971.28344598651;5973.880522389615;6001.639901605918;6029.8191054268445;5902.055671092605;5937.2578427696535;6143.096367768309;6183.103449999635;6209.689515524296;5880.882382352414;5888.175655408332;5889.116632505158;5903.085021821625;5909.674967876808 19:42:19 INFO - PROCESS | 2068 | |1;ext.html;498.42431991050324;510.6042816816967;525.1309083466859;549.8069189858007;571.1860598646929;29564.704352956465;41735.582644173584;42246.57753422461;42375;44828.77585612075;43981.78009109958;44123;44202.778986105026;44291.77854110733;44380.778096109476;9308.674196403128;9421.717348479557;9443.150116489514;9444;9451.810963780721;9518.619255229782;9644.987276335989;9648.855267170999;9652.469114198717;9670.854937175947;9608.567614457366;9651.131398174162;9657.130858222794;9668.419894806299;9686.418814871131;9565.856512152322;9631.71104866855;9647.276454265888;9650.276229282832;9656.710298691016;9555.283353748497;9644.75888102796;9648.228141748643;9659.32384733069;9665.178459830853;41366.44969053402;41738.373924391155;41781.37327940083;41787.7910610445;41894.371584426255;3394.0666316763086;3446.7414943879307;3449.4308439107517;3482.320947415255;3588.372034893909;25255.87372063128;25550.361240968938;25642.87178564114;25663.48673026548;26024.609630855553;3260.8695652174124;3286.457734473809;3287.3589650018257;3290.44062509374;3441.15691655546;502187;505838.4708076473;507432;508027;508206;62578;62723;62801;62806.371936280964;62897.371026290064;32603.67396326054;32625.51061734076;32641.51037734436;32659.510107348407;65788;16714.331426743036;16775.832241677428;16865.494035178963;16888.493345199662;16889.071101089314;12804.80792788109;12931.418086186144;12942.188093666895;12943.611691649265;12959.352032398343;19348.70976935347;19376.12807423641;19377;19402.320918767775;19403.4178974631;7472.962635186789;7576.204498527685;7601.619919004028;7624.504407213624;7634.656440460192;899.2176806178536;938.3619138985555;956.7751578379075;968.2254196642658;1022.2639699416409;30221.395572088437;30455.69544304573;30548.389032219675;30668.923202883467;31030.22424439362;1058.5501162006117;1097.5280629329466;1126.7464820415505;1139.9772004559863;1185.3480585677842;15910.920445397698;16147.434839780552;16188.271527781279;16256.918715406347;16295.755563666555;669542;671418;673762;677912;678016;59182.40817591855;61367.38632613617;61416.69291653513;61561;61562.69218653878;1237.3565745812127;1239.4422509870415;1357.5045108535512;1367.705943222212;1400.5588239704462;29734.405311894072;31383.84308078445;31477.685223147477;31928;32172.356552869278;52142;53018.73490632676;53035.73482132565;53039.73480132574;53148.67128321668;504121;522415;522616;527172;528692;23841.284761457184;24107.91514381822;26589.069382571517;26984;27381;45443.09113817771;48170;48461.41163421594;49043;49146.508534914195;29951;38202.8821701038;39716.40425393564;41109.58890411177;41613;34119.31761364808;37297.81351093227;39205.431782728374;39219.41170882382;40585.78242652725;30340.696593033786;33086;33249.511315972035;38608.6139138605;39064.41403378895;30521.542176866922;31633.683663163993;33168.50247246341;33807.830960846026;35253.47119793154;24595;26029.739702602732;26076.478470430866;26402.603960940218;26598 19:42:19 INFO - PROCESS | 2068 | |2;jquery.html;358.98564057437704;379.9392097264437;389.09923527034914;390.3403248510018;409.7193422505584;15589;15607.985480943731;20929.686054709153;20937;21000;19259.422217333467;19666.901665491652;19990.800091999077;20004.49988750282;20619.38141855743;4748.3589715388325;5217.869553261161;5392.164214546751;5392.352917649868;5983.9102413463615;3622.619624939383;3849.5957924417953;4256.829726810924;5878.382769809151;6135.662538560399;5133.383993920735;6092.573519853612;6099.7865074722395;6104.969475152618;6122.816315510519;5801.390853960336;5865.8240252792275;5878.2358293421585;5889.411058894119;5890.381509941437;5509.889802203974;5685.744141513642;5702.45826646468;5721.370649228582;5723.51350135239;13051.216926984316;13122.950163986858;20954.580908381748;25015.49969000628;25183.37041573957;2002.6395248855201;2100.5588826346484;2257.887105644711;2291.3584196425027;2383.988080059606;10208.336458130272;11952.043836493147;12534.74930501385;15883.841161588352;16088.115153666544;1821.080354421009;1845.6677797996356;1852.536865783554;1936.6610843102542;2123.5434381607874;111877;120093.39953300265;126230.10654840185;129024;129645;9062.773430664287;11388.772224555463;11696.70758231034;11703.590374336858;11785.587504437304;14589.05171163871;14636.341364638616;14670.706585868224;14700.852991470163;14734.968552201242;6922.7923162305215;8599.269062129664;8695.956520217358;8709.564521773886;8776.517291548898;7104.751333703295;8650.43772154808;8650.740477785677;8772.385932984758;8804.955975220082;4540.477845047796;4601.493835678073;4611.677182597186;4611.969869258038;4678.345031695565;1777.9288828446718;1821.3625231168985;1879.8590105742123;1933.719610656475;1939.8933058681625;884.827458645558;953.50894289441;958.8260082794096;1014.4217795856291;1039.2465462539749;21139.943002850105;21308.36074917755;21454.57090858174;21549.353519394444;21569.67645485319;930.8650245714333;937.5593471068587;944.3059351376733;951.0822056715303;1006.7496863206102;10978.560857565608;11240.775184496264;11363.829542556869;11374.488148033359;11390.97481226677;545113;566955;582125.0893745504;607381;607745;128147;128375.35812321065;129160;129163;131835;979.7697541077841;981.2689546288061;992.4591097851688;1012.8430093335545;1015.1574193419444;16777.496675099766;16793.580160495596;17052.147392630566;18760.6247875039;18790.906045469685;57402.42597573971;58774.11838822335;59192.70403647954;59215.519612010045;59851;77173;79618;80823.3835323302;81849.59075204586;82900;7908.920910790818;8035.919640803517;8160.26557609818;8190.2800411911785;8290.129536398832;11297.548098076313;13279.535216267384;13286.069975101651;13559.661008474866;13577;11244.55021799119;11454.484548195518;11536.192466527262;11540.653780386601;11659.825102623297;10924.12606991423;11503.252288601214;11700.2979821211;11823.102441944644;11823.290602563873;11793.351365674971;11813.40932953366;11831.46758395857;11979.34113623759;12056.578019769266;8298.668053277801;8298.792530186794;8403.70587029451;8580.227779499875;8592.183742544448;11447.656570302905;11537;11729.589464368706;11859.525618975144;11931.940340298243 19:42:19 INFO - PROCESS | 2068 | |3;mootools.html;1360.4082224232466;1430.6280367104557;1466.7898983338746;1679.3786299069345;1883.4726276642537;7653.617319134042;8427.452215605988;8598.441101328417;8613.009503907037;8712.912870871289;8402.49585024899;8610.56947152643;8631.91368086319;8635.69775057873;8638.17937295956;2064.4838790302424;2132.616129096762;2136.2523116909033;2280.5894938910988;2308.6725133048562;2127.425595089325;2153.321703663341;2288.9885550572226;2360;2364.7044119485063;2323.8605683659034;2324.0703718512646;2324.8488848224897;2329.0567320235245;2329.580675478413;1969.7340858984069;2254.0195015168456;2310.2145270607907;2315.664228686831;2316.108298305148;2060.9690854637192;2275.1354485295647;2332.6734257204007;2335.1243283768586;2336.2523992322463;8649.610767515476;8723.956380218122;8741.956290218572;8752.168543988311;8763.56182190888;5143.614228932845;5266.97366513165;5271.86820329491;5273.288106105665;5279.076161671731;3445.7243420526297;3532.1875968527384;3584.8207589620674;3585.103724068983;3601.027722514906;1035.30634474902;1049.1659130990881;1086.4296244471636;1088.37418484371;1092.94535273236;11288.548458061668;11361.261518001304;11361.602343918006;11377.317360958368;11379.975802177843;4450.577195166454;4523.547645235451;4708.105459962596;4712.175369310357;4716.95283047172;9732.90267097334;9778.07108324708;9794.069563391466;9821.459819709984;9822.65620703272;5258.106121959276;5269.104252277122;5269.710165940834;5273.2617433559335;5279.1817268323475;4727.787249573777;4822.42130944289;4835.081334546425;4844.031193761261;4849.442314133919;3847.61523847613;3850.5186851643543;3875.534935807721;3923.313420151462;3940.029985007496;1239.7582471417986;1240.8262843201958;1246.2024304445163;1255.1465003797505;1256.1207154991544;750.8723517002122;893.5621545442816;915.4346068223413;923.1767259662114;953.6662168241198;5504.091824848935;5711.485966263056;5909.615874968199;5911.438413350725;5954.315253745788;418.7529357678984;423.792341752539;429.64124955662373;430.8169028163018;442.2702540807693;3670.137517683342;3893.2213557288087;3929.724919255682;3983.5219773626773;3989.8005099744896;10169.644062457779;10590.205734569938;10684.51919663617;10691.984261495145;10770.676879693621;10334.276600637882;10628.946855265674;10641.893581064245;10658.840117398246;10660.786784264426;7909.24862138096;8088.312493438006;8099.352051835839;8111.3916456266015;8127.268545830903;5562.5549956002615;5670.206171136127;5723.828285151452;5745.368009518866;5794.971025144847;9956.850647240153;9957.402555846673;9975.60097596117;9980.850287245843;9986.3508871926;9090.318226132935;9590.136887680143;10078.596856125672;10092.444915529422;10105.747356316151;6631.502637302318;7179.533330333512;7227.530210536298;7283.8543229136185;7316.780496585111;8102.7569172924905;8195.95902020486;8209;8257.876131858147;8279.95860020696;7456.7390141344795;7476.887846682195;7539.472236943361;7565.319121279112;7599.1261004982925;6236.781712640036;7163.4269258460245;7348.301911318416;7399.1490978536;7402.962985185255;5676.659400435987;6681.632510211791;6736;6757.087793148059;6761.560498567577;4863.319135320987;4876.341693871282;4878.195097808822;4938.654294199371;4958.975205123951;4511.639068874548;4704.694194877322;4954.628402869727;4959.5536401722575;5031.823886163967 19:42:19 INFO - PROCESS | 2068 | |4;prototype.html;257.3771473035255;298.6296991730255;307.9091667957952;313.7960325788239;314.2097624474447;4702.576768090871;4880.585150262227;4963.205887058067;5039.370078740158;5338.546223571001;5140.254663073862;5345.652532585379;5357.330333708286;5385.515303622673;5396.352437707471;3553.502509648651;4101.938470922923;4112.342025275956;4117.382392641105;4151.169766046788;3634.218642991756;3753.5924028489317;4114.732542384751;4123.525794533637;4164.958350416502;3716.684081853046;4029.2948733971584;4040.616141466556;4056.553779084298;4098.200850834089;3470.8958731238104;3576.695980841632;4065.451164092839;4092.386142078712;4130.793460327001;2682.570788673803;3159.8894038708536;3561.9643803562153;3572.8749493767855;3592.5329707138167;4332.480102387703;5005.724685142316;5199.272101905736;5277.947220527784;5292.073887069786;4163.458750362463;4372.584604462571;4637.768111594441;4662.300654901758;4669.766511674403;4569;5488.506034456878;5595;5619.747111379957;5671.035923892948;3768.284026035072;3935.5670876203594;3964;4010.358342665189;4023.97988010061;5469.15228139639;5949.6727679977585;5962.522998160181;5971.402859714038;6045.33501314855;4047.453593764863;4055.7160998730396;4061.1065565575527;4066.3290557058344;4086.346184610448;3870.4581358609817;4120.587941205856;4137.524184718735;4138.255114079434;4161.625453709181;4128.195001974646;4471.932921006188;4657;4701.811927522929;4766.308885211625;5352.2506849041165;5644.604877658525;5683.175939488751;5719.256496655408;5780.364159942403;1321.5837011341396;1337.2645045225088;1398.3427788939182;1402.5652047865194;1416.2847761880184;940.1585580905188;945.2438049560325;962.5139304651107;964.4261664309724;969.9515024248759;4419.447569053868;5239.29269548606;5267.736613169326;5282.4717528246865;5294.841154765286;4817.710937343771;5746;5760.798372056958;5761.366249712528;5809.593328467051;4246.851360202378;4927.975360123248;5255.39562950258;5293.444188360167;5305.532927188876;2332.8483648562787;2451.1983691986375;2537.835040722347;2542.5423423783527;2546.7580579844885;4310.935335969963;4946.530079642428;5014.84955451337;5040.596752259884;5049.343585333883;4164.333706606928;4476.865694029184;4596.770161491979;4940.283658869515;4944;4843;4885.487023862514;4989.575886049726;5051.87370315745;5073.7716802743225;4232.947020695022;4508.512190977035;4706.3760904102965;4836.637252206028;4938.555530002317;4086.223617512663;4187.560306167808;4466.932996004997;4754.809807607657;4805.8077676892535;5175.456577059505;5455.972720136374;5485.9725701371235;5852.209951656472;6136.619260666314;3865.903352416212;3888.5528164261473;3909.1204478992;3925;3935.2326296371934;5531.059719847555;5573.442655734394;5979.4917432018765;5990.610610310316;5996.280446346292;5265.763040663102;5719.799807006735;5745.683987380567;5756.625819321731;5763.625364351304;5694.402087780723;5728.255326807488;5730.455606717355;5738.454846789548;5746.597738158456;5309.36287645485;5555;5604.038586494694;5658.632188907708;5666.631668941671;4714.292856071616;4888.95111048885;5623.971880140573;5752.367239603724;5752.654840709571;5292.100342941632;5627.52166065889;5627.803026894039;5634.661920284796;5650.683219879994 19:42:19 INFO - PROCESS | 2068 | |5;yui.html;717.3543810570486;764.8623247815391;793.7777422321749;819.856525108106;848.3171047306919;14740.33668484918;15582.688346233068;16280.185990700462;16306.266218020188;16477.91761041196;12162.331071791048;14889.404423823034;14904.031237969552;14904.701905961874;15005.324760385782;681.199590481185;699.5033526196406;822.7655118291289;848.3298194426395;853.8121613245107;841.3101256969287;842.4566154830162;847.7541512961234;878.2008372381134;878.2403221213668;909.1181553892714;912.9041450647653;913.3423934766957;913.8811954445946;918.1461241045824;716.158513746346;745.6048294403975;747.7719295614835;904.6019751309435;908.9363744537885;520.9348831396076;542.0541155683319;647.1522305779444;671.516508114157;676.4757313082351;14908.776368354484;14933.805295576436;14997.550073497812;15122.924385378114;15194.696106077816;13783.241921694304;13945.860541394659;13972.091814032055;14113.223772692498;14167.645808854759;12879.098463107492;12896.032797540222;12983.610491685264;13013.21920684762;13198;4624.190766615862;4661.86014419568;4693.389859318267;4779.641526885497;4819.542143496362;105139.94860051379;105563;106454;107232;107674;10695.197860160519;11120.165987550967;11320.26418282809;11439.913208245203;11567.88432115685;22146.446338841335;22148;22159.889200553895;22178.778212217672;22202.668719784513;7833.882491762628;8083.919160808434;8090.7168249111;8141.755747327589;8150;4372.254266160598;4597.3793537872625;4606.907861842745;4636.095961287517;4768.737719425465;3403.6596340365763;3562.4300111981956;3563.4476656118345;3565.144365352297;3566.696830769362;637.5951270942892;665.2981104934244;666.6966530228734;671.2113266911359;681.6285124607101;605.5851741557047;610.5420934299276;620.3486339343762;627.4133685004535;641.5477088652489;8498.872516912252;8810.800592958083;8907.55462226886;8952.23905967987;9025.864612030824;516.5273774496369;566.6543408520799;588.8998870192078;622.7197761007565;631.6936285901335;3544.043108360728;3779.848806047727;3831.1954489556947;3939.4287828265315;3947.1908258806875;109691;138061;141386.5861341394;144483;150869;85741.14258857457;109192.4540377293;113043;116049;116132.41933790277;99975;104321;109180;111267.44366278117;111567;7455.211422021691;7510.39916806665;7614.543127412373;7690.115636701851;7749;45044;59156.40843591509;60559.69720151371;62624.68687656533;62654;83294;88595;89072.55463722639;89557.55221223852;94290.04244596753;13357.53248636293;13402;13485.932570337085;13536.79694804559;13785.241811700453;12603.810942836048;15334;15489;15546.455874044354;16005.19974001272;14155;14256.42974281017;14285.214313212873;14679.633009174857;14718.852811471748;12803.74392512126;13345.798878101017;13864.792028119788;14024.929875350557;14405.639859003608;13870.861291386957;13896.37466313998;13908.095973761672;14063.859361406256;14078.225697586322;9903.207743380368;11397;11406.201565890307;11604;11698.70753231176;11369.2609980351;11387.316760994036;11487.942560287145;11697.824532631847;11740.647780566596 19:42:19 INFO - PROCESS | 2068 | __end_tp_report 19:42:19 INFO - PROCESS | 2068 | __start_cc_report 19:42:19 INFO - PROCESS | 2068 | _x_x_mozilla_cycle_collect,1630 19:42:19 INFO - PROCESS | 2068 | __end_cc_report 19:42:19 INFO - PROCESS | 2068 | __startTimestamp1467254539023__endTimestamp 19:42:19 INFO - PROCESS | 2068 | 19:42:19 INFO - PROCESS | 2068 | ------- Summary: start ------- 19:42:19 INFO - PROCESS | 2068 | Number of tests: 6 19:42:19 INFO - PROCESS | 2068 | 19:42:19 INFO - PROCESS | 2068 | [#0] dojo.html Cycles:165 Average:5763.54 Median:5902.06 stddev:664.72 (11.3%) stddev-sans-first:634.41 19:42:19 INFO - PROCESS | 2068 | Values: 3152.4 3339.5 3365.3 3373.8 3400.3 5662.7 5665.6 5736.4 5800.5 5813.9 5719.2 5723.5 5730.7 5809.9 5814.7 5102.5 5147.9 5197.7 5204.0 5320.3 5300.3 5337.7 5341.2 5345.3 5381.8 5146.2 5150.0 5185.7 5195.8 5237.6 5153.8 5164.9 5166.0 5175.7 5189.8 5145.7 5172.7 5194.7 5207.6 5241.8 5647.7 5702.7 5754.3 5773.8 5777.4 6276.4 6295.7 6311.9 6342.4 6363.5 4957.9 6355.3 6368.5 6370.6 6405.3 5713.7 5761.7 5771.5 5806.7 5815.0 6293.4 6299.6 6311.0 6328.7 6335.7 6190.9 6193.9 6204.9 6207.4 6214.2 6142.6 6236.0 6254.7 6290.6 6296.7 6265.4 6281.7 6287.5 6318.4 6323.2 6300.3 6301.9 6307.1 6313.3 6321.6 4893.2 4913.1 4953.5 4996.7 5030.0 4056.5 4131.8 4447.6 4528.7 4536.9 5695.9 5708.8 5738.3 5753.5 5763.9 6322.8 6337.5 6365.2 6374.8 6383.1 5799.4 5804.6 5815.9 5825.6 5850.1 5378.8 5424.5 5448.2 5473.0 5497.0 6343.8 6355.4 6358.2 6359.1 6365.1 5651.6 6284.4 6353.7 6357.7 6378.2 6127.2 6233.9 6251.1 6279.2 6360.6 5510.0 6221.3 6236.0 6242.1 6256.5 6294.9 6311.3 6313.1 6336.5 6338.4 5993.3 6042.0 6042.6 6086.6 6135.4 6092.2 6114.8 6136.9 6146.9 6197.8 5896.7 5971.3 5973.9 6001.6 6029.8 5902.1 5937.3 6143.1 6183.1 6209.7 5880.9 5888.2 5889.1 5903.1 5909.7 19:42:19 INFO - PROCESS | 2068 | 19:42:19 INFO - PROCESS | 2068 | [#1] ext.html Cycles:180 Average:69618.60 Median:41489.72 stddev:153041.04 (368.9%) stddev-sans-first:153382.37 19:42:19 INFO - PROCESS | 2068 | Values: 498.4 510.6 525.1 549.8 571.2 29564.7 41735.6 42246.6 42375.0 44828.8 43981.8 44123.0 44202.8 44291.8 44380.8 9308.7 9421.7 9443.2 9444.0 9451.8 9518.6 9645.0 9648.9 9652.5 9670.9 9608.6 9651.1 9657.1 9668.4 9686.4 9565.9 9631.7 9647.3 9650.3 9656.7 9555.3 9644.8 9648.2 9659.3 9665.2 41366.4 41738.4 41781.4 41787.8 41894.4 3394.1 3446.7 3449.4 3482.3 3588.4 25255.9 25550.4 25642.9 25663.5 26024.6 3260.9 3286.5 3287.4 3290.4 3441.2 502187.0 505838.5 507432.0 508027.0 508206.0 62578.0 62723.0 62801.0 62806.4 62897.4 32603.7 32625.5 32641.5 32659.5 65788.0 16714.3 16775.8 16865.5 16888.5 16889.1 12804.8 12931.4 12942.2 12943.6 12959.4 19348.7 19376.1 19377.0 19402.3 19403.4 7473.0 7576.2 7601.6 7624.5 7634.7 899.2 938.4 956.8 968.2 1022.3 30221.4 30455.7 30548.4 30668.9 31030.2 1058.6 1097.5 1126.7 1140.0 1185.3 15910.9 16147.4 16188.3 16256.9 16295.8 669542.0 671418.0 673762.0 677912.0 678016.0 59182.4 61367.4 61416.7 61561.0 61562.7 1237.4 1239.4 1357.5 1367.7 1400.6 29734.4 31383.8 31477.7 31928.0 32172.4 52142.0 53018.7 53035.7 53039.7 53148.7 504121.0 522415.0 522616.0 527172.0 528692.0 23841.3 24107.9 26589.1 26984.0 27381.0 45443.1 48170.0 48461.4 49043.0 49146.5 29951.0 38202.9 39716.4 41109.6 41613.0 34119.3 37297.8 39205.4 39219.4 40585.8 30340.7 33086.0 33249.5 38608.6 39064.4 30521.5 31633.7 33168.5 33807.8 35253.5 24595.0 26029.7 26076.5 26402.6 26598.0 19:42:19 INFO - PROCESS | 2068 | 19:42:19 INFO - PROCESS | 2068 | [#2] jquery.html Cycles:180 Average:34887.01 Median:21381.47 stddev:97602.53 (456.5%) stddev-sans-first:97841.89 19:42:19 INFO - PROCESS | 2068 | Values: 359.0 379.9 389.1 390.3 409.7 15589.0 15608.0 20929.7 20937.0 21000.0 19259.4 19666.9 19990.8 20004.5 20619.4 4748.4 5217.9 5392.2 5392.4 5983.9 3622.6 3849.6 4256.8 5878.4 6135.7 5133.4 6092.6 6099.8 6105.0 6122.8 5801.4 5865.8 5878.2 5889.4 5890.4 5509.9 5685.7 5702.5 5721.4 5723.5 13051.2 13123.0 20954.6 25015.5 25183.4 2002.6 2100.6 2257.9 2291.4 2384.0 10208.3 11952.0 12534.7 15883.8 16088.1 1821.1 1845.7 1852.5 1936.7 2123.5 111877.0 120093.4 126230.1 129024.0 129645.0 9062.8 11388.8 11696.7 11703.6 11785.6 14589.1 14636.3 14670.7 14700.9 14735.0 6922.8 8599.3 8696.0 8709.6 8776.5 7104.8 8650.4 8650.7 8772.4 8805.0 4540.5 4601.5 4611.7 4612.0 4678.3 1777.9 1821.4 1879.9 1933.7 1939.9 884.8 953.5 958.8 1014.4 1039.2 21139.9 21308.4 21454.6 21549.4 21569.7 930.9 937.6 944.3 951.1 1006.7 10978.6 11240.8 11363.8 11374.5 11391.0 545113.0 566955.0 582125.1 607381.0 607745.0 128147.0 128375.4 129160.0 129163.0 131835.0 979.8 981.3 992.5 1012.8 1015.2 16777.5 16793.6 17052.1 18760.6 18790.9 57402.4 58774.1 59192.7 59215.5 59851.0 77173.0 79618.0 80823.4 81849.6 82900.0 7908.9 8035.9 8160.3 8190.3 8290.1 11297.5 13279.5 13286.1 13559.7 13577.0 11244.6 11454.5 11536.2 11540.7 11659.8 10924.1 11503.3 11700.3 11823.1 11823.3 11793.4 11813.4 11831.5 11979.3 12056.6 8298.7 8298.8 8403.7 8580.2 8592.2 11447.7 11537.0 11729.6 11859.5 11931.9 19:42:19 INFO - PROCESS | 2068 | 19:42:19 INFO - PROCESS | 2068 | [#3] mootools.html Cycles:180 Average:5592.67 Median:4869.83 stddev:3172.39 (65.1%) stddev-sans-first:3165.35 19:42:19 INFO - PROCESS | 2068 | Values: 1360.4 1430.6 1466.8 1679.4 1883.5 7653.6 8427.5 8598.4 8613.0 8712.9 8402.5 8610.6 8631.9 8635.7 8638.2 2064.5 2132.6 2136.3 2280.6 2308.7 2127.4 2153.3 2289.0 2360.0 2364.7 2323.9 2324.1 2324.8 2329.1 2329.6 1969.7 2254.0 2310.2 2315.7 2316.1 2061.0 2275.1 2332.7 2335.1 2336.3 8649.6 8724.0 8742.0 8752.2 8763.6 5143.6 5267.0 5271.9 5273.3 5279.1 3445.7 3532.2 3584.8 3585.1 3601.0 1035.3 1049.2 1086.4 1088.4 1092.9 11288.5 11361.3 11361.6 11377.3 11380.0 4450.6 4523.5 4708.1 4712.2 4717.0 9732.9 9778.1 9794.1 9821.5 9822.7 5258.1 5269.1 5269.7 5273.3 5279.2 4727.8 4822.4 4835.1 4844.0 4849.4 3847.6 3850.5 3875.5 3923.3 3940.0 1239.8 1240.8 1246.2 1255.1 1256.1 750.9 893.6 915.4 923.2 953.7 5504.1 5711.5 5909.6 5911.4 5954.3 418.8 423.8 429.6 430.8 442.3 3670.1 3893.2 3929.7 3983.5 3989.8 10169.6 10590.2 10684.5 10692.0 10770.7 10334.3 10628.9 10641.9 10658.8 10660.8 7909.2 8088.3 8099.4 8111.4 8127.3 5562.6 5670.2 5723.8 5745.4 5795.0 9956.9 9957.4 9975.6 9980.9 9986.4 9090.3 9590.1 10078.6 10092.4 10105.7 6631.5 7179.5 7227.5 7283.9 7316.8 8102.8 8196.0 8209.0 8257.9 8280.0 7456.7 7476.9 7539.5 7565.3 7599.1 6236.8 7163.4 7348.3 7399.1 7403.0 5676.7 6681.6 6736.0 6757.1 6761.6 4863.3 4876.3 4878.2 4938.7 4959.0 4511.6 4704.7 4954.6 4959.6 5031.8 19:42:19 INFO - PROCESS | 2068 | 19:42:19 INFO - PROCESS | 2068 | [#4] prototype.html Cycles:180 Average:4446.24 Median:4861.79 stddev:1355.39 (27.9%) stddev-sans-first:1322.22 19:42:19 INFO - PROCESS | 2068 | Values: 257.4 298.6 307.9 313.8 314.2 4702.6 4880.6 4963.2 5039.4 5338.5 5140.3 5345.7 5357.3 5385.5 5396.4 3553.5 4101.9 4112.3 4117.4 4151.2 3634.2 3753.6 4114.7 4123.5 4165.0 3716.7 4029.3 4040.6 4056.6 4098.2 3470.9 3576.7 4065.5 4092.4 4130.8 2682.6 3159.9 3562.0 3572.9 3592.5 4332.5 5005.7 5199.3 5277.9 5292.1 4163.5 4372.6 4637.8 4662.3 4669.8 4569.0 5488.5 5595.0 5619.7 5671.0 3768.3 3935.6 3964.0 4010.4 4024.0 5469.2 5949.7 5962.5 5971.4 6045.3 4047.5 4055.7 4061.1 4066.3 4086.3 3870.5 4120.6 4137.5 4138.3 4161.6 4128.2 4471.9 4657.0 4701.8 4766.3 5352.3 5644.6 5683.2 5719.3 5780.4 1321.6 1337.3 1398.3 1402.6 1416.3 940.2 945.2 962.5 964.4 970.0 4419.4 5239.3 5267.7 5282.5 5294.8 4817.7 5746.0 5760.8 5761.4 5809.6 4246.9 4928.0 5255.4 5293.4 5305.5 2332.8 2451.2 2537.8 2542.5 2546.8 4310.9 4946.5 5014.8 5040.6 5049.3 4164.3 4476.9 4596.8 4940.3 4944.0 4843.0 4885.5 4989.6 5051.9 5073.8 4232.9 4508.5 4706.4 4836.6 4938.6 4086.2 4187.6 4466.9 4754.8 4805.8 5175.5 5456.0 5486.0 5852.2 6136.6 3865.9 3888.6 3909.1 3925.0 3935.2 5531.1 5573.4 5979.5 5990.6 5996.3 5265.8 5719.8 5745.7 5756.6 5763.6 5694.4 5728.3 5730.5 5738.5 5746.6 5309.4 5555.0 5604.0 5658.6 5666.6 4714.3 4889.0 5624.0 5752.4 5752.7 5292.1 5627.5 5627.8 5634.7 5650.7 19:42:19 INFO - PROCESS | 2068 | 19:42:19 INFO - PROCESS | 2068 | [#5] yui.html Cycles:180 Average:23676.26 Median:3564.30 stddev:36598.98 (1026.8%) stddev-sans-first:36661.05 19:42:19 INFO - PROCESS | 2068 | Values: 717.4 764.9 793.8 819.9 848.3 14740.3 15582.7 16280.2 16306.3 16477.9 12162.3 14889.4 14904.0 14904.7 15005.3 681.2 699.5 822.8 848.3 853.8 841.3 842.5 847.8 878.2 878.2 909.1 912.9 913.3 913.9 918.1 716.2 745.6 747.8 904.6 908.9 520.9 542.1 647.2 671.5 676.5 14908.8 14933.8 14997.6 15122.9 15194.7 13783.2 13945.9 13972.1 14113.2 14167.6 12879.1 12896.0 12983.6 13013.2 13198.0 4624.2 4661.9 4693.4 4779.6 4819.5 105139.9 105563.0 106454.0 107232.0 107674.0 10695.2 11120.2 11320.3 11439.9 11567.9 22146.4 22148.0 22159.9 22178.8 22202.7 7833.9 8083.9 8090.7 8141.8 8150.0 4372.3 4597.4 4606.9 4636.1 4768.7 3403.7 3562.4 3563.4 3565.1 3566.7 637.6 665.3 666.7 671.2 681.6 605.6 610.5 620.3 627.4 641.5 8498.9 8810.8 8907.6 8952.2 9025.9 516.5 566.7 588.9 622.7 631.7 3544.0 3779.8 3831.2 3939.4 3947.2 109691.0 138061.0 141386.6 144483.0 150869.0 85741.1 109192.5 113043.0 116049.0 116132.4 99975.0 104321.0 109180.0 111267.4 111567.0 7455.2 7510.4 7614.5 7690.1 7749.0 45044.0 59156.4 60559.7 62624.7 62654.0 83294.0 88595.0 89072.6 89557.6 94290.0 13357.5 13402.0 13485.9 13536.8 13785.2 12603.8 15334.0 15489.0 15546.5 16005.2 14155.0 14256.4 14285.2 14679.6 14718.9 12803.7 13345.8 13864.8 14024.9 14405.6 13870.9 13896.4 13908.1 14063.9 14078.2 9903.2 11397.0 11406.2 11604.0 11698.7 11369.3 11387.3 11487.9 11697.8 11740.6 19:42:19 INFO - PROCESS | 2068 | -------- Summary: end -------- 19:42:19 INFO - PROCESS | 2068 | 19:42:19 INFO - TEST-INFO | 2068: exit 0 19:42:19 INFO - TEST-OK | dromaeo_css | took 1115599ms 19:42:19 INFO - TEST-START | kraken 19:42:19 INFO - operating with platform_type : mac_ 19:42:19 INFO - Initialising browser for kraken test... 19:42:19 INFO - TEST-INFO | started process 2072 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/tmph41knz/profile http://localhost:49347/getInfo.html) 19:42:21 INFO - PROCESS | 2072 | __metrics Screen width/height:1600/1200 19:42:21 INFO - PROCESS | 2072 | colorDepth:24 19:42:21 INFO - PROCESS | 2072 | Browser inner width/height: 1024/689 19:42:21 INFO - PROCESS | 2072 | __metrics 19:42:21 INFO - PROCESS | 2072 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:42:21 INFO - PROCESS | 2072 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:42:22 INFO - TEST-INFO | 2072: exit 0 19:42:22 INFO - Browser initialized. 19:42:22 INFO - Running cycle 1/1 for kraken test... 19:42:22 INFO - TEST-INFO | started process 2073 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/tmph41knz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:42:34 INFO - PROCESS | 2073 | RSS: Main: 243744768 19:42:34 INFO - PROCESS | 2073 | 19:42:36 INFO - PROCESS | 2073 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49347/tests/kraken/driver.html?testName=audio-beat-detection) 19:42:37 INFO - PROCESS | 2073 | RSS: Main: 293949440 19:42:37 INFO - PROCESS | 2073 | 19:42:40 INFO - PROCESS | 2073 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49347/tests/kraken/driver.html?testName=audio-dft) 19:42:41 INFO - PROCESS | 2073 | RSS: Main: 304599040 19:42:41 INFO - PROCESS | 2073 | 19:42:44 INFO - PROCESS | 2073 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49347/tests/kraken/driver.html?testName=audio-fft) 19:42:45 INFO - PROCESS | 2073 | RSS: Main: 386265088 19:42:45 INFO - PROCESS | 2073 | 19:42:47 INFO - PROCESS | 2073 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49347/tests/kraken/driver.html?testName=audio-oscillator) 19:42:47 INFO - PROCESS | 2073 | RSS: Main: 290156544 19:42:47 INFO - PROCESS | 2073 | 19:42:49 INFO - PROCESS | 2073 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49347/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:42:50 INFO - PROCESS | 2073 | RSS: Main: 293613568 19:42:50 INFO - PROCESS | 2073 | 19:42:53 INFO - PROCESS | 2073 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49347/tests/kraken/driver.html?testName=imaging-darkroom) 19:42:53 INFO - PROCESS | 2073 | RSS: Main: 330387456 19:42:53 INFO - PROCESS | 2073 | 19:42:56 INFO - PROCESS | 2073 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49347/tests/kraken/driver.html?testName=imaging-desaturate) 19:42:57 INFO - PROCESS | 2073 | RSS: Main: 333791232 19:42:57 INFO - PROCESS | 2073 | 19:43:00 INFO - PROCESS | 2073 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49347/tests/kraken/driver.html?testName=json-parse-financial) 19:43:00 INFO - PROCESS | 2073 | RSS: Main: 330088448 19:43:00 INFO - PROCESS | 2073 | 19:43:02 INFO - PROCESS | 2073 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49347/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:43:03 INFO - PROCESS | 2073 | RSS: Main: 311631872 19:43:03 INFO - PROCESS | 2073 | 19:43:05 INFO - PROCESS | 2073 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:43:05 INFO - PROCESS | 2073 | RSS: Main: 319254528 19:43:05 INFO - PROCESS | 2073 | 19:43:07 INFO - PROCESS | 2073 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:43:08 INFO - PROCESS | 2073 | RSS: Main: 316440576 19:43:08 INFO - PROCESS | 2073 | 19:43:11 INFO - PROCESS | 2073 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:43:12 INFO - PROCESS | 2073 | RSS: Main: 324718592 19:43:12 INFO - PROCESS | 2073 | 19:43:14 INFO - PROCESS | 2073 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:43:15 INFO - PROCESS | 2073 | RSS: Main: 326230016 19:43:15 INFO - PROCESS | 2073 | 19:43:17 INFO - PROCESS | 2073 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49347/tests/kraken/driver.html?testName=ai-astar) 19:43:17 INFO - PROCESS | 2073 | RSS: Main: 369188864 19:43:17 INFO - PROCESS | 2073 | 19:43:17 INFO - PROCESS | 2073 | __start_tp_report 19:43:17 INFO - PROCESS | 2073 | _x_x_mozilla_page_load 19:43:17 INFO - PROCESS | 2073 | _x_x_mozilla_page_load_details 19:43:17 INFO - PROCESS | 2073 | |i|pagename|runs| 19:43:17 INFO - PROCESS | 2073 | |0;ai-astar;101;111;112;111;113;110;113;112;113;113 19:43:17 INFO - PROCESS | 2073 | |1;audio-beat-detection;145;107;105;158;108;106;143;135;135;125 19:43:17 INFO - PROCESS | 2073 | |2;audio-dft;185;185;183;184;175;183;179;181;183;183 19:43:17 INFO - PROCESS | 2073 | |3;audio-fft;82;94;58;86;57;57;60;59;133;79 19:43:17 INFO - PROCESS | 2073 | |4;audio-oscillator;81;85;96;69;71;69;95;70;68;98 19:43:17 INFO - PROCESS | 2073 | |5;imaging-gaussian-blur;88;86;88;84;87;84;95;84;87;84 19:43:17 INFO - PROCESS | 2073 | |6;imaging-darkroom;94;93;93;94;93;105;151;127;94;93 19:43:17 INFO - PROCESS | 2073 | |7;imaging-desaturate;85;85;91;87;87;84;84;83;87;110 19:43:17 INFO - PROCESS | 2073 | |8;json-parse-financial;56;54;55;54;56;53;53;54;54;54 19:43:17 INFO - PROCESS | 2073 | |9;json-stringify-tinderbox;68;73;79;71;73;70;69;88;103;104 19:43:17 INFO - PROCESS | 2073 | |10;stanford-crypto-aes;83;83;82;85;80;85;88;102;98;85 19:43:17 INFO - PROCESS | 2073 | |11;stanford-crypto-ccm;137;137;136;135;135;135;133;137;176;142 19:43:17 INFO - PROCESS | 2073 | |12;stanford-crypto-pbkdf2;168;165;166;167;165;165;165;168;163;165 19:43:17 INFO - PROCESS | 2073 | |13;stanford-crypto-sha256-iterative;67;69;68;66;76;86;88;67;68;78 19:43:17 INFO - PROCESS | 2073 | __end_tp_report 19:43:17 INFO - PROCESS | 2073 | __start_cc_report 19:43:17 INFO - PROCESS | 2073 | _x_x_mozilla_cycle_collect,2060 19:43:17 INFO - PROCESS | 2073 | __end_cc_report 19:43:17 INFO - PROCESS | 2073 | __startTimestamp1467254597652__endTimestamp 19:43:17 INFO - PROCESS | 2073 | 19:43:17 INFO - PROCESS | 2073 | ------- Summary: start ------- 19:43:17 INFO - PROCESS | 2073 | Number of tests: 14 19:43:17 INFO - PROCESS | 2073 | 19:43:17 INFO - PROCESS | 2073 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.50 stddev:3.63 (3.2%) stddev-sans-first:1.12 19:43:17 INFO - PROCESS | 2073 | Values: 101.0 111.0 112.0 111.0 113.0 110.0 113.0 112.0 113.0 113.0 19:43:17 INFO - PROCESS | 2073 | 19:43:17 INFO - PROCESS | 2073 | [#1] audio-beat-detection Cycles:10 Average:126.70 Median:135.00 stddev:19.32 (14.3%) stddev-sans-first:19.32 19:43:17 INFO - PROCESS | 2073 | Values: 145.0 107.0 105.0 158.0 108.0 106.0 143.0 135.0 135.0 125.0 19:43:17 INFO - PROCESS | 2073 | 19:43:17 INFO - PROCESS | 2073 | [#2] audio-dft Cycles:10 Average:182.10 Median:183.00 stddev:3.07 (1.7%) stddev-sans-first:3.07 19:43:17 INFO - PROCESS | 2073 | Values: 185.0 185.0 183.0 184.0 175.0 183.0 179.0 181.0 183.0 183.0 19:43:17 INFO - PROCESS | 2073 | 19:43:17 INFO - PROCESS | 2073 | [#3] audio-fft Cycles:10 Average:76.50 Median:69.50 stddev:24.28 (34.9%) stddev-sans-first:25.67 19:43:17 INFO - PROCESS | 2073 | Values: 82.0 94.0 58.0 86.0 57.0 57.0 60.0 59.0 133.0 79.0 19:43:17 INFO - PROCESS | 2073 | 19:43:17 INFO - PROCESS | 2073 | [#4] audio-oscillator Cycles:10 Average:80.20 Median:83.00 stddev:12.46 (15.0%) stddev-sans-first:13.21 19:43:17 INFO - PROCESS | 2073 | Values: 81.0 85.0 96.0 69.0 71.0 69.0 95.0 70.0 68.0 98.0 19:43:17 INFO - PROCESS | 2073 | 19:43:17 INFO - PROCESS | 2073 | [#5] imaging-gaussian-blur Cycles:10 Average:86.70 Median:87.00 stddev:3.37 (3.9%) stddev-sans-first:3.54 19:43:17 INFO - PROCESS | 2073 | Values: 88.0 86.0 88.0 84.0 87.0 84.0 95.0 84.0 87.0 84.0 19:43:17 INFO - PROCESS | 2073 | 19:43:17 INFO - PROCESS | 2073 | [#6] imaging-darkroom Cycles:10 Average:103.70 Median:93.00 stddev:19.78 (21.3%) stddev-sans-first:20.67 19:43:17 INFO - PROCESS | 2073 | Values: 94.0 93.0 93.0 94.0 93.0 105.0 151.0 127.0 94.0 93.0 19:43:17 INFO - PROCESS | 2073 | 19:43:17 INFO - PROCESS | 2073 | [#7] imaging-desaturate Cycles:10 Average:88.30 Median:86.00 stddev:7.96 (9.3%) stddev-sans-first:8.35 19:43:17 INFO - PROCESS | 2073 | Values: 85.0 85.0 91.0 87.0 87.0 84.0 84.0 83.0 87.0 110.0 19:43:17 INFO - PROCESS | 2073 | 19:43:17 INFO - PROCESS | 2073 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.00 stddev:1.06 (2.0%) stddev-sans-first:0.93 19:43:17 INFO - PROCESS | 2073 | Values: 56.0 54.0 55.0 54.0 56.0 53.0 53.0 54.0 54.0 54.0 19:43:17 INFO - PROCESS | 2073 | 19:43:17 INFO - PROCESS | 2073 | [#9] json-stringify-tinderbox Cycles:10 Average:79.80 Median:72.00 stddev:13.80 (19.2%) stddev-sans-first:13.96 19:43:17 INFO - PROCESS | 2073 | Values: 68.0 73.0 79.0 71.0 73.0 70.0 69.0 88.0 103.0 104.0 19:43:17 INFO - PROCESS | 2073 | 19:43:17 INFO - PROCESS | 2073 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:85.00 stddev:7.19 (8.5%) stddev-sans-first:7.47 19:43:17 INFO - PROCESS | 2073 | Values: 83.0 83.0 82.0 85.0 80.0 85.0 88.0 102.0 98.0 85.0 19:43:17 INFO - PROCESS | 2073 | 19:43:17 INFO - PROCESS | 2073 | [#11] stanford-crypto-ccm Cycles:10 Average:140.30 Median:137.00 stddev:12.76 (9.3%) stddev-sans-first:13.48 19:43:17 INFO - PROCESS | 2073 | Values: 137.0 137.0 136.0 135.0 135.0 135.0 133.0 137.0 176.0 142.0 19:43:17 INFO - PROCESS | 2073 | 19:43:17 INFO - PROCESS | 2073 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.70 Median:165.50 stddev:1.57 (0.9%) stddev-sans-first:1.42 19:43:17 INFO - PROCESS | 2073 | Values: 168.0 165.0 166.0 167.0 165.0 165.0 165.0 168.0 163.0 165.0 19:43:17 INFO - PROCESS | 2073 | 19:43:17 INFO - PROCESS | 2073 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:72.50 stddev:8.26 (11.4%) stddev-sans-first:8.44 19:43:17 INFO - PROCESS | 2073 | Values: 67.0 69.0 68.0 66.0 76.0 86.0 88.0 67.0 68.0 78.0 19:43:17 INFO - PROCESS | 2073 | -------- Summary: end -------- 19:43:17 INFO - PROCESS | 2073 | 19:43:18 INFO - TEST-INFO | 2073: exit 0 19:43:18 INFO - TEST-OK | kraken | took 59136ms 19:43:18 INFO - SUITE-END | took 1174s 19:43:18 INFO - Completed test suite (00:19:34) 19:43:18 INFO - javascript benchmark 19:43:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3152.3852848694505, 3339.4990751387304, 3365.276465559904, 3373.814440205788, 3400.268942177431, 5662.688552129631, 5665.575081868861, 5736.397678243787, 5800.53595712343, 5813.912791308123, 5719.19931209631, 5723.456271654197, 5730.68481233532, 5809.883802323951, 5814.709264536767, 5102.489751024905, 5147.922781158267, 5197.662151960129, 5204.037253108168, 5320.334958130234, 5300.310959575269, 5337.653052551591, 5341.172118321666, 5345.278387417708, 5381.784728610851, 5146.176611742141, 5150.0472412603785, 5185.688858668492, 5195.818146364859, 5237.6071794615555, 5153.819616313411, 5164.870878228036, 5165.992631436871, 5175.663581867167, 5189.818356357547, 5145.691258524501, 5172.715500647463, 5194.662346947436, 5207.583393328562, 5241.842744717665, 5647.717614119278, 5702.714864256771, 5754.251947246873, 5773.826785196409, 5777.364489906107, 6276.435120839146, 6295.748170073238, 6311.93688063118, 6342.365763423667, 6363.459105975951, 4957.876053098666, 6355.332690067523, 6368.522360822957, 6370.585911915757, 6405.263394709621, 5713.685747283897, 5761.740721667535, 5771.451712087345, 5806.709664516758, 5814.9709251454315, 6293.433590976742, 6299.590526615755, 6310.990241561328, 6328.6519241442165, 6335.714892829834, 6190.938090619036, 6193.907091393633, 6204.906926396107, 6207.410296021871, 6214.1921550198185, 6142.560166306883, 6236.0, 6254.74981000764, 6290.591111577733, 6296.65368404733, 6265.404786545271, 6281.685915704196, 6287.465565426898, 6318.399752023551, 6323.241211054611, 6300.306966233802, 6301.873962520724, 6307.053941908659, 6313.273973493016, 6321.557490975588, 4893.168161412568, 4913.091078150482, 4953.529414705597, 4996.675216110941, 5030.019146266516, 4056.5334986476932, 4131.8224306073225, 4447.577480139382, 4528.682992190515, 4536.909261814745, 5695.886082278331, 5708.80019199326, 5738.311402631711, 5753.539716822645, 5763.8559036024435, 6322.810315690536, 6337.461315788118, 6365.172527571479, 6374.840628984312, 6383.106365108889, 5799.449052340021, 5804.564657650609, 5815.912761308584, 5825.621334613236, 5850.063989761617, 5378.838634840961, 5424.511793938565, 5448.237246785453, 5472.972635136799, 5497.0105381031, 6343.809685709436, 6355.428011478989, 6358.173437453194, 6359.141515895388, 6365.077063825812, 5651.615354238238, 6284.448206328409, 6353.682315884095, 6357.713902874474, 6378.2346118466085, 6127.220070483952, 6233.937660623335, 6251.124842522141, 6279.215098112736, 6360.554761166859, 5509.972450137724, 6221.3156552780065, 6235.96882015587, 6242.126102345766, 6256.499480041677, 6294.874102518015, 6311.274203466476, 6313.08460273267, 6336.524760642878, 6338.429541341301, 5993.340732519507, 6041.972864612939, 6042.637441753509, 6086.6348019119, 6135.447809697149, 6092.238470191226, 6114.844865410725, 6136.877262454636, 6146.907796382969, 6197.752089916533, 5896.70516474166, 5971.28344598651, 5973.880522389615, 6001.639901605918, 6029.8191054268445, 5902.055671092605, 5937.2578427696535, 6143.096367768309, 6183.103449999635, 6209.689515524296, 5880.882382352414, 5888.175655408332, 5889.116632505158, 5903.085021821625, 5909.674967876808], "value": 5719.611767336618, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.42431991050324, 510.6042816816967, 525.1309083466859, 549.8069189858007, 571.1860598646929, 29564.704352956465, 41735.582644173584, 42246.57753422461, 42375.0, 44828.77585612075, 43981.78009109958, 44123.0, 44202.778986105026, 44291.77854110733, 44380.778096109476, 9308.674196403128, 9421.717348479557, 9443.150116489514, 9444.0, 9451.810963780721, 9518.619255229782, 9644.987276335989, 9648.855267170999, 9652.469114198717, 9670.854937175947, 9608.567614457366, 9651.131398174162, 9657.130858222794, 9668.419894806299, 9686.418814871131, 9565.856512152322, 9631.71104866855, 9647.276454265888, 9650.276229282832, 9656.710298691016, 9555.283353748497, 9644.75888102796, 9648.228141748643, 9659.32384733069, 9665.178459830853, 41366.44969053402, 41738.373924391155, 41781.37327940083, 41787.7910610445, 41894.371584426255, 3394.0666316763086, 3446.7414943879307, 3449.4308439107517, 3482.320947415255, 3588.372034893909, 25255.87372063128, 25550.361240968938, 25642.87178564114, 25663.48673026548, 26024.609630855553, 3260.8695652174124, 3286.457734473809, 3287.3589650018257, 3290.44062509374, 3441.15691655546, 502187.0, 505838.4708076473, 507432.0, 508027.0, 508206.0, 62578.0, 62723.0, 62801.0, 62806.371936280964, 62897.371026290064, 32603.67396326054, 32625.51061734076, 32641.51037734436, 32659.510107348407, 65788.0, 16714.331426743036, 16775.832241677428, 16865.494035178963, 16888.493345199662, 16889.071101089314, 12804.80792788109, 12931.418086186144, 12942.188093666895, 12943.611691649265, 12959.352032398343, 19348.70976935347, 19376.12807423641, 19377.0, 19402.320918767775, 19403.4178974631, 7472.962635186789, 7576.204498527685, 7601.619919004028, 7624.504407213624, 7634.656440460192, 899.2176806178536, 938.3619138985555, 956.7751578379075, 968.2254196642658, 1022.2639699416409, 30221.395572088437, 30455.69544304573, 30548.389032219675, 30668.923202883467, 31030.22424439362, 1058.5501162006117, 1097.5280629329466, 1126.7464820415505, 1139.9772004559863, 1185.3480585677842, 15910.920445397698, 16147.434839780552, 16188.271527781279, 16256.918715406347, 16295.755563666555, 669542.0, 671418.0, 673762.0, 677912.0, 678016.0, 59182.40817591855, 61367.38632613617, 61416.69291653513, 61561.0, 61562.69218653878, 1237.3565745812127, 1239.4422509870415, 1357.5045108535512, 1367.705943222212, 1400.5588239704462, 29734.405311894072, 31383.84308078445, 31477.685223147477, 31928.0, 32172.356552869278, 52142.0, 53018.73490632676, 53035.73482132565, 53039.73480132574, 53148.67128321668, 504121.0, 522415.0, 522616.0, 527172.0, 528692.0, 23841.284761457184, 24107.91514381822, 26589.069382571517, 26984.0, 27381.0, 45443.09113817771, 48170.0, 48461.41163421594, 49043.0, 49146.508534914195, 29951.0, 38202.8821701038, 39716.40425393564, 41109.58890411177, 41613.0, 34119.31761364808, 37297.81351093227, 39205.431782728374, 39219.41170882382, 40585.78242652725, 30340.696593033786, 33086.0, 33249.511315972035, 38608.6139138605, 39064.41403378895, 30521.542176866922, 31633.683663163993, 33168.50247246341, 33807.830960846026, 35253.47119793154, 24595.0, 26029.739702602732, 26076.478470430866, 26402.603960940218, 26598.0], "value": 19825.452801447624, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.98564057437704, 379.9392097264437, 389.09923527034914, 390.3403248510018, 409.7193422505584, 15589.0, 15607.985480943731, 20929.686054709153, 20937.0, 21000.0, 19259.422217333467, 19666.901665491652, 19990.800091999077, 20004.49988750282, 20619.38141855743, 4748.3589715388325, 5217.869553261161, 5392.164214546751, 5392.352917649868, 5983.9102413463615, 3622.619624939383, 3849.5957924417953, 4256.829726810924, 5878.382769809151, 6135.662538560399, 5133.383993920735, 6092.573519853612, 6099.7865074722395, 6104.969475152618, 6122.816315510519, 5801.390853960336, 5865.8240252792275, 5878.2358293421585, 5889.411058894119, 5890.381509941437, 5509.889802203974, 5685.744141513642, 5702.45826646468, 5721.370649228582, 5723.51350135239, 13051.216926984316, 13122.950163986858, 20954.580908381748, 25015.49969000628, 25183.37041573957, 2002.6395248855201, 2100.5588826346484, 2257.887105644711, 2291.3584196425027, 2383.988080059606, 10208.336458130272, 11952.043836493147, 12534.74930501385, 15883.841161588352, 16088.115153666544, 1821.080354421009, 1845.6677797996356, 1852.536865783554, 1936.6610843102542, 2123.5434381607874, 111877.0, 120093.39953300265, 126230.10654840185, 129024.0, 129645.0, 9062.773430664287, 11388.772224555463, 11696.70758231034, 11703.590374336858, 11785.587504437304, 14589.05171163871, 14636.341364638616, 14670.706585868224, 14700.852991470163, 14734.968552201242, 6922.7923162305215, 8599.269062129664, 8695.956520217358, 8709.564521773886, 8776.517291548898, 7104.751333703295, 8650.43772154808, 8650.740477785677, 8772.385932984758, 8804.955975220082, 4540.477845047796, 4601.493835678073, 4611.677182597186, 4611.969869258038, 4678.345031695565, 1777.9288828446718, 1821.3625231168985, 1879.8590105742123, 1933.719610656475, 1939.8933058681625, 884.827458645558, 953.50894289441, 958.8260082794096, 1014.4217795856291, 1039.2465462539749, 21139.943002850105, 21308.36074917755, 21454.57090858174, 21549.353519394444, 21569.67645485319, 930.8650245714333, 937.5593471068587, 944.3059351376733, 951.0822056715303, 1006.7496863206102, 10978.560857565608, 11240.775184496264, 11363.829542556869, 11374.488148033359, 11390.97481226677, 545113.0, 566955.0, 582125.0893745504, 607381.0, 607745.0, 128147.0, 128375.35812321065, 129160.0, 129163.0, 131835.0, 979.7697541077841, 981.2689546288061, 992.4591097851688, 1012.8430093335545, 1015.1574193419444, 16777.496675099766, 16793.580160495596, 17052.147392630566, 18760.6247875039, 18790.906045469685, 57402.42597573971, 58774.11838822335, 59192.70403647954, 59215.519612010045, 59851.0, 77173.0, 79618.0, 80823.3835323302, 81849.59075204586, 82900.0, 7908.920910790818, 8035.919640803517, 8160.26557609818, 8190.2800411911785, 8290.129536398832, 11297.548098076313, 13279.535216267384, 13286.069975101651, 13559.661008474866, 13577.0, 11244.55021799119, 11454.484548195518, 11536.192466527262, 11540.653780386601, 11659.825102623297, 10924.12606991423, 11503.252288601214, 11700.2979821211, 11823.102441944644, 11823.290602563873, 11793.351365674971, 11813.40932953366, 11831.46758395857, 11979.34113623759, 12056.578019769266, 8298.668053277801, 8298.792530186794, 8403.70587029451, 8580.227779499875, 8592.183742544448, 11447.656570302905, 11537.0, 11729.589464368706, 11859.525618975144, 11931.940340298243], "value": 9591.188028970946, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1360.4082224232466, 1430.6280367104557, 1466.7898983338746, 1679.3786299069345, 1883.4726276642537, 7653.617319134042, 8427.452215605988, 8598.441101328417, 8613.009503907037, 8712.912870871289, 8402.49585024899, 8610.56947152643, 8631.91368086319, 8635.69775057873, 8638.17937295956, 2064.4838790302424, 2132.616129096762, 2136.2523116909033, 2280.5894938910988, 2308.6725133048562, 2127.425595089325, 2153.321703663341, 2288.9885550572226, 2360.0, 2364.7044119485063, 2323.8605683659034, 2324.0703718512646, 2324.8488848224897, 2329.0567320235245, 2329.580675478413, 1969.7340858984069, 2254.0195015168456, 2310.2145270607907, 2315.664228686831, 2316.108298305148, 2060.9690854637192, 2275.1354485295647, 2332.6734257204007, 2335.1243283768586, 2336.2523992322463, 8649.610767515476, 8723.956380218122, 8741.956290218572, 8752.168543988311, 8763.56182190888, 5143.614228932845, 5266.97366513165, 5271.86820329491, 5273.288106105665, 5279.076161671731, 3445.7243420526297, 3532.1875968527384, 3584.8207589620674, 3585.103724068983, 3601.027722514906, 1035.30634474902, 1049.1659130990881, 1086.4296244471636, 1088.37418484371, 1092.94535273236, 11288.548458061668, 11361.261518001304, 11361.602343918006, 11377.317360958368, 11379.975802177843, 4450.577195166454, 4523.547645235451, 4708.105459962596, 4712.175369310357, 4716.95283047172, 9732.90267097334, 9778.07108324708, 9794.069563391466, 9821.459819709984, 9822.65620703272, 5258.106121959276, 5269.104252277122, 5269.710165940834, 5273.2617433559335, 5279.1817268323475, 4727.787249573777, 4822.42130944289, 4835.081334546425, 4844.031193761261, 4849.442314133919, 3847.61523847613, 3850.5186851643543, 3875.534935807721, 3923.313420151462, 3940.029985007496, 1239.7582471417986, 1240.8262843201958, 1246.2024304445163, 1255.1465003797505, 1256.1207154991544, 750.8723517002122, 893.5621545442816, 915.4346068223413, 923.1767259662114, 953.6662168241198, 5504.091824848935, 5711.485966263056, 5909.615874968199, 5911.438413350725, 5954.315253745788, 418.7529357678984, 423.792341752539, 429.64124955662373, 430.8169028163018, 442.2702540807693, 3670.137517683342, 3893.2213557288087, 3929.724919255682, 3983.5219773626773, 3989.8005099744896, 10169.644062457779, 10590.205734569938, 10684.51919663617, 10691.984261495145, 10770.676879693621, 10334.276600637882, 10628.946855265674, 10641.893581064245, 10658.840117398246, 10660.786784264426, 7909.24862138096, 8088.312493438006, 8099.352051835839, 8111.3916456266015, 8127.268545830903, 5562.5549956002615, 5670.206171136127, 5723.828285151452, 5745.368009518866, 5794.971025144847, 9956.850647240153, 9957.402555846673, 9975.60097596117, 9980.850287245843, 9986.3508871926, 9090.318226132935, 9590.136887680143, 10078.596856125672, 10092.444915529422, 10105.747356316151, 6631.502637302318, 7179.533330333512, 7227.530210536298, 7283.8543229136185, 7316.780496585111, 8102.7569172924905, 8195.95902020486, 8209.0, 8257.876131858147, 8279.95860020696, 7456.7390141344795, 7476.887846682195, 7539.472236943361, 7565.319121279112, 7599.1261004982925, 6236.781712640036, 7163.4269258460245, 7348.301911318416, 7399.1490978536, 7402.962985185255, 5676.659400435987, 6681.632510211791, 6736.0, 6757.087793148059, 6761.560498567577, 4863.319135320987, 4876.341693871282, 4878.195097808822, 4938.654294199371, 4958.975205123951, 4511.639068874548, 4704.694194877322, 4954.628402869727, 4959.5536401722575, 5031.823886163967], "value": 4404.535746289181, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [257.3771473035255, 298.6296991730255, 307.9091667957952, 313.7960325788239, 314.2097624474447, 4702.576768090871, 4880.585150262227, 4963.205887058067, 5039.370078740158, 5338.546223571001, 5140.254663073862, 5345.652532585379, 5357.330333708286, 5385.515303622673, 5396.352437707471, 3553.502509648651, 4101.938470922923, 4112.342025275956, 4117.382392641105, 4151.169766046788, 3634.218642991756, 3753.5924028489317, 4114.732542384751, 4123.525794533637, 4164.958350416502, 3716.684081853046, 4029.2948733971584, 4040.616141466556, 4056.553779084298, 4098.200850834089, 3470.8958731238104, 3576.695980841632, 4065.451164092839, 4092.386142078712, 4130.793460327001, 2682.570788673803, 3159.8894038708536, 3561.9643803562153, 3572.8749493767855, 3592.5329707138167, 4332.480102387703, 5005.724685142316, 5199.272101905736, 5277.947220527784, 5292.073887069786, 4163.458750362463, 4372.584604462571, 4637.768111594441, 4662.300654901758, 4669.766511674403, 4569.0, 5488.506034456878, 5595.0, 5619.747111379957, 5671.035923892948, 3768.284026035072, 3935.5670876203594, 3964.0, 4010.358342665189, 4023.97988010061, 5469.15228139639, 5949.6727679977585, 5962.522998160181, 5971.402859714038, 6045.33501314855, 4047.453593764863, 4055.7160998730396, 4061.1065565575527, 4066.3290557058344, 4086.346184610448, 3870.4581358609817, 4120.587941205856, 4137.524184718735, 4138.255114079434, 4161.625453709181, 4128.195001974646, 4471.932921006188, 4657.0, 4701.811927522929, 4766.308885211625, 5352.2506849041165, 5644.604877658525, 5683.175939488751, 5719.256496655408, 5780.364159942403, 1321.5837011341396, 1337.2645045225088, 1398.3427788939182, 1402.5652047865194, 1416.2847761880184, 940.1585580905188, 945.2438049560325, 962.5139304651107, 964.4261664309724, 969.9515024248759, 4419.447569053868, 5239.29269548606, 5267.736613169326, 5282.4717528246865, 5294.841154765286, 4817.710937343771, 5746.0, 5760.798372056958, 5761.366249712528, 5809.593328467051, 4246.851360202378, 4927.975360123248, 5255.39562950258, 5293.444188360167, 5305.532927188876, 2332.8483648562787, 2451.1983691986375, 2537.835040722347, 2542.5423423783527, 2546.7580579844885, 4310.935335969963, 4946.530079642428, 5014.84955451337, 5040.596752259884, 5049.343585333883, 4164.333706606928, 4476.865694029184, 4596.770161491979, 4940.283658869515, 4944.0, 4843.0, 4885.487023862514, 4989.575886049726, 5051.87370315745, 5073.7716802743225, 4232.947020695022, 4508.512190977035, 4706.3760904102965, 4836.637252206028, 4938.555530002317, 4086.223617512663, 4187.560306167808, 4466.932996004997, 4754.809807607657, 4805.8077676892535, 5175.456577059505, 5455.972720136374, 5485.9725701371235, 5852.209951656472, 6136.619260666314, 3865.903352416212, 3888.5528164261473, 3909.1204478992, 3925.0, 3935.2326296371934, 5531.059719847555, 5573.442655734394, 5979.4917432018765, 5990.610610310316, 5996.280446346292, 5265.763040663102, 5719.799807006735, 5745.683987380567, 5756.625819321731, 5763.625364351304, 5694.402087780723, 5728.255326807488, 5730.455606717355, 5738.454846789548, 5746.597738158456, 5309.36287645485, 5555.0, 5604.038586494694, 5658.632188907708, 5666.631668941671, 4714.292856071616, 4888.95111048885, 5623.971880140573, 5752.367239603724, 5752.654840709571, 5292.100342941632, 5627.52166065889, 5627.803026894039, 5634.661920284796, 5650.683219879994], "value": 4020.9354053634697, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.3543810570486, 764.8623247815391, 793.7777422321749, 819.856525108106, 848.3171047306919, 14740.33668484918, 15582.688346233068, 16280.185990700462, 16306.266218020188, 16477.91761041196, 12162.331071791048, 14889.404423823034, 14904.031237969552, 14904.701905961874, 15005.324760385782, 681.199590481185, 699.5033526196406, 822.7655118291289, 848.3298194426395, 853.8121613245107, 841.3101256969287, 842.4566154830162, 847.7541512961234, 878.2008372381134, 878.2403221213668, 909.1181553892714, 912.9041450647653, 913.3423934766957, 913.8811954445946, 918.1461241045824, 716.158513746346, 745.6048294403975, 747.7719295614835, 904.6019751309435, 908.9363744537885, 520.9348831396076, 542.0541155683319, 647.1522305779444, 671.516508114157, 676.4757313082351, 14908.776368354484, 14933.805295576436, 14997.550073497812, 15122.924385378114, 15194.696106077816, 13783.241921694304, 13945.860541394659, 13972.091814032055, 14113.223772692498, 14167.645808854759, 12879.098463107492, 12896.032797540222, 12983.610491685264, 13013.21920684762, 13198.0, 4624.190766615862, 4661.86014419568, 4693.389859318267, 4779.641526885497, 4819.542143496362, 105139.94860051379, 105563.0, 106454.0, 107232.0, 107674.0, 10695.197860160519, 11120.165987550967, 11320.26418282809, 11439.913208245203, 11567.88432115685, 22146.446338841335, 22148.0, 22159.889200553895, 22178.778212217672, 22202.668719784513, 7833.882491762628, 8083.919160808434, 8090.7168249111, 8141.755747327589, 8150.0, 4372.254266160598, 4597.3793537872625, 4606.907861842745, 4636.095961287517, 4768.737719425465, 3403.6596340365763, 3562.4300111981956, 3563.4476656118345, 3565.144365352297, 3566.696830769362, 637.5951270942892, 665.2981104934244, 666.6966530228734, 671.2113266911359, 681.6285124607101, 605.5851741557047, 610.5420934299276, 620.3486339343762, 627.4133685004535, 641.5477088652489, 8498.872516912252, 8810.800592958083, 8907.55462226886, 8952.23905967987, 9025.864612030824, 516.5273774496369, 566.6543408520799, 588.8998870192078, 622.7197761007565, 631.6936285901335, 3544.043108360728, 3779.848806047727, 3831.1954489556947, 3939.4287828265315, 3947.1908258806875, 109691.0, 138061.0, 141386.5861341394, 144483.0, 150869.0, 85741.14258857457, 109192.4540377293, 113043.0, 116049.0, 116132.41933790277, 99975.0, 104321.0, 109180.0, 111267.44366278117, 111567.0, 7455.211422021691, 7510.39916806665, 7614.543127412373, 7690.115636701851, 7749.0, 45044.0, 59156.40843591509, 60559.69720151371, 62624.68687656533, 62654.0, 83294.0, 88595.0, 89072.55463722639, 89557.55221223852, 94290.04244596753, 13357.53248636293, 13402.0, 13485.932570337085, 13536.79694804559, 13785.241811700453, 12603.810942836048, 15334.0, 15489.0, 15546.455874044354, 16005.19974001272, 14155.0, 14256.42974281017, 14285.214313212873, 14679.633009174857, 14718.852811471748, 12803.74392512126, 13345.798878101017, 13864.792028119788, 14024.929875350557, 14405.639859003608, 13870.861291386957, 13896.37466313998, 13908.095973761672, 14063.859361406256, 14078.225697586322, 9903.207743380368, 11397.0, 11406.201565890307, 11604.0, 11698.70753231176, 11369.2609980351, 11387.316760994036, 11487.942560287145, 11697.824532631847, 11740.647780566596], "value": 7718.5899366920075, "unit": "score"}], "name": "dromaeo_css", "value": 7278.566847923077, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 112.0, 111.0, 113.0, 110.0, 113.0, 112.0, 113.0, 113.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 107.0, 105.0, 158.0, 108.0, 106.0, 143.0, 135.0, 135.0, 125.0], "value": 126.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 183.0, 184.0, 175.0, 183.0, 179.0, 181.0, 183.0, 183.0], "value": 182.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 94.0, 58.0, 86.0, 57.0, 57.0, 60.0, 59.0, 133.0, 79.0], "value": 76.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 85.0, 96.0, 69.0, 71.0, 69.0, 95.0, 70.0, 68.0, 98.0], "value": 80.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 84.0, 87.0, 84.0, 95.0, 84.0, 87.0, 84.0], "value": 86.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 94.0, 93.0, 105.0, 151.0, 127.0, 94.0, 93.0], "value": 103.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 91.0, 87.0, 87.0, 84.0, 84.0, 83.0, 87.0, 110.0], "value": 88.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 55.0, 54.0, 56.0, 53.0, 53.0, 54.0, 54.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 79.0, 71.0, 73.0, 70.0, 69.0, 88.0, 103.0, 104.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 85.0, 80.0, 85.0, 88.0, 102.0, 98.0, 85.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 137.0, 136.0, 135.0, 135.0, 135.0, 133.0, 137.0, 176.0, 142.0], "value": 140.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 166.0, 167.0, 165.0, 165.0, 165.0, 168.0, 163.0, 165.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 66.0, 76.0, 86.0, 88.0, 67.0, 68.0, 78.0], "value": 73.3, "unit": "score"}], "name": "kraken", "value": 1455.6, "alertThreshold": 2.0}]} 19:43:18 INFO - Return code: 0 19:43:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:43:18 INFO - # TBPL SUCCESS # 19:43:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:43:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:43:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:43:18 INFO - 2016-06-29 19:43:18.980 screenresolution[2080:13707] starting screenresolution argv=screenresolution get 19:43:18 INFO - 2016-06-29 19:43:18.983 screenresolution[2080:13707] Display 0: 1600x1200x32@60 19:43:18 INFO - 2016-06-29 19:43:18.988 screenresolution[2081:13709] starting screenresolution argv=screenresolution list 19:43:18 INFO - Available Modes on Display 0 19:43:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:43:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:43:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:43:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:43:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:43:19 INFO - Intel Iris: 19:43:19 INFO - Chipset Model: Intel Iris 19:43:19 INFO - Type: GPU 19:43:19 INFO - Bus: Built-In 19:43:19 INFO - VRAM (Dynamic, Max): 1536 MB 19:43:19 INFO - Vendor: Intel (0x8086) 19:43:19 INFO - Device ID: 0x0a2e 19:43:19 INFO - Revision ID: 0x0009 19:43:19 INFO - Displays: 19:43:19 INFO - Display: 19:43:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:43:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:43:19 INFO - Display Serial Number: 1600x1200 60 19:43:19 INFO - Main Display: Yes 19:43:19 INFO - Mirror: Off 19:43:19 INFO - Online: Yes 19:43:19 INFO - Rotation: Supported 19:43:19 INFO - Return code: 0 19:43:19 INFO - Running post-action listener: _resource_record_post_action 19:43:19 INFO - ##### 19:43:19 INFO - ##### Finished run-tests step (success) 19:43:19 INFO - ##### 19:43:19 INFO - Running post-run listener: _resource_record_post_run 19:43:19 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 29621760; Write bytes: 701881856; Read time: 176; Write time: 1974 19:43:19 INFO - TinderboxPrint: CPU usage
53.5% 19:43:19 INFO - TinderboxPrint: I/O read bytes / time
29,621,760 / 176 19:43:19 INFO - TinderboxPrint: I/O write bytes / time
701,881,856 / 1,974 19:43:19 INFO - TinderboxPrint: CPU idle
2,248.0 (46.5%) 19:43:19 INFO - TinderboxPrint: CPU system
966.8 (20.0%) 19:43:19 INFO - TinderboxPrint: CPU user
1,622.8 (33.5%) 19:43:19 INFO - TinderboxPrint: Swap in / out
431,816,704 / 0 19:43:19 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 398293504; Write bytes: 392256512; Read time: 29586; Write time: 849 19:43:19 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 29511168; Write bytes: 291889664; Read time: 174; Write time: 1081 19:43:19 INFO - Running post-run listener: _upload_blobber_files 19:43:19 INFO - Blob upload gear active. 19:43:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:43:19 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 19:43:19 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'] 19:43:19 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 19:43:20 INFO - (blobuploader) - INFO - Open directory for files ... 19:43:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:43:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:43:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:43:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:43:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:43:21 INFO - (blobuploader) - INFO - Done attempting. 19:43:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:43:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:43:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:43:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:43:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:43:22 INFO - (blobuploader) - INFO - Done attempting. 19:43:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:43:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:43:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:43:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:43:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:43:24 INFO - (blobuploader) - INFO - Done attempting. 19:43:24 INFO - (blobuploader) - INFO - Iteration through files over. 19:43:24 INFO - Return code: 0 19:43:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:43:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:43:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9cc203bff48f1033cf11829f761a47da59411921f0eaf9c681856f02dee2e88f8bee3c003589a0c1bcc589017dc4b7437246e24f0bbf924f35567320b6eb8429", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dcd73669ade58485d24e9da8df722ada8e430ee011e4eccca1c74835fa1b5205247c90808c5a93780e96bae713331c1372fab44f591846987def2424dea856e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/efe70d70debeb6f8c26892b7baa921a9abad632d687ff8ac69c1a42ac7d0a839863d5ba10781844eb43ecbf4113e831720a14b0e1ff3b65fbcb4f52eee65004a"} 19:43:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:43:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:43:24 INFO - Contents: 19:43:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9cc203bff48f1033cf11829f761a47da59411921f0eaf9c681856f02dee2e88f8bee3c003589a0c1bcc589017dc4b7437246e24f0bbf924f35567320b6eb8429", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dcd73669ade58485d24e9da8df722ada8e430ee011e4eccca1c74835fa1b5205247c90808c5a93780e96bae713331c1372fab44f591846987def2424dea856e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/efe70d70debeb6f8c26892b7baa921a9abad632d687ff8ac69c1a42ac7d0a839863d5ba10781844eb43ecbf4113e831720a14b0e1ff3b65fbcb4f52eee65004a"} 19:43:24 INFO - Running post-run listener: copy_logs_to_upload_dir 19:43:24 INFO - Copying logs to upload dir... 19:43:24 INFO - mkdir: /builds/slave/test/build/upload/logs 19:43:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.396833 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-06-29 19:43:24.706561) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 19:43:24.710178) ========= 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.pMegErvKXI/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.gcIwwKtDlr/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9cc203bff48f1033cf11829f761a47da59411921f0eaf9c681856f02dee2e88f8bee3c003589a0c1bcc589017dc4b7437246e24f0bbf924f35567320b6eb8429", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dcd73669ade58485d24e9da8df722ada8e430ee011e4eccca1c74835fa1b5205247c90808c5a93780e96bae713331c1372fab44f591846987def2424dea856e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/efe70d70debeb6f8c26892b7baa921a9abad632d687ff8ac69c1a42ac7d0a839863d5ba10781844eb43ecbf4113e831720a14b0e1ff3b65fbcb4f52eee65004a"} build_url:https://queue.taskcluster.net/v1/task/e3x1lTsvQPSU3hbxw72caw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009967 build_url: 'https://queue.taskcluster.net/v1/task/e3x1lTsvQPSU3hbxw72caw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9cc203bff48f1033cf11829f761a47da59411921f0eaf9c681856f02dee2e88f8bee3c003589a0c1bcc589017dc4b7437246e24f0bbf924f35567320b6eb8429", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dcd73669ade58485d24e9da8df722ada8e430ee011e4eccca1c74835fa1b5205247c90808c5a93780e96bae713331c1372fab44f591846987def2424dea856e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/efe70d70debeb6f8c26892b7baa921a9abad632d687ff8ac69c1a42ac7d0a839863d5ba10781844eb43ecbf4113e831720a14b0e1ff3b65fbcb4f52eee65004a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 19:43:24.740158) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 19:43:24.740490) ========= 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.pMegErvKXI/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.gcIwwKtDlr/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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.004893 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 19:43:24.790161) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 19:43:24.790491) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 19:43:24.790819) ========= ========= Total master_lag: 0.17 =========