builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0134 starttime: 1467735157.17 results: success (0) buildid: 20160705070128 builduid: dddabf17a2214e01aedc59bd7a97a602 revision: f47a1bc057ff5a6084e776040425da258a2851ca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 09:12:37.167088) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 09:12:37.167573) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 09:12:37.167879) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 09:12:37.193261) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:12:37.193639) ========= 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.Y1qSsKYrxN/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.IstenzZUWC/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-05 09:12:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.45M=0.001s 2016-07-05 09:12:37 (9.45 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081762 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:12:37.297897) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:12:37.298230) ========= 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.Y1qSsKYrxN/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.IstenzZUWC/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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.028646 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:12:37.347095) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-05 09:12:37.347447) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f47a1bc057ff5a6084e776040425da258a2851ca --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f47a1bc057ff5a6084e776040425da258a2851ca --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Y1qSsKYrxN/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.IstenzZUWC/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-05 09:12:37,423 truncating revision to first 12 chars 2016-07-05 09:12:37,423 Setting DEBUG logging. 2016-07-05 09:12:37,423 attempt 1/10 2016-07-05 09:12:37,423 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f47a1bc057ff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 09:12:39,189 unpacking tar archive at: mozilla-central-f47a1bc057ff/testing/mozharness/ program finished with exit code 0 elapsedTime=2.041557 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-05 09:12:39.410403) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 09:12:39.410705) ========= script_repo_revision: f47a1bc057ff5a6084e776040425da258a2851ca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 09:12:39.411093) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 09:12:39.411390) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 09:12:39.429166) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-07-05 09:12:39.429473) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Y1qSsKYrxN/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.IstenzZUWC/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 09:12:39 INFO - MultiFileLogger online at 20160705 09:12:39 in /builds/slave/test 09:12:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:12:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:12:39 INFO - {'append_to_log': False, 09:12:39 INFO - 'base_work_dir': '/builds/slave/test', 09:12:39 INFO - 'blob_upload_branch': 'Firefox', 09:12:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:12:39 INFO - 'branch': 'Firefox', 09:12:39 INFO - 'buildbot_json_path': 'buildprops.json', 09:12:39 INFO - 'config_files': ('talos/mac_config.py',), 09:12:39 INFO - 'default_actions': ('clobber', 09:12:39 INFO - 'read-buildbot-config', 09:12:39 INFO - 'download-and-extract', 09:12:39 INFO - 'populate-webroot', 09:12:39 INFO - 'create-virtualenv', 09:12:39 INFO - 'install', 09:12:39 INFO - 'run-tests'), 09:12:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:12:39 INFO - 'download_minidump_stackwalk': True, 09:12:39 INFO - 'download_symbols': 'ondemand', 09:12:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:12:39 INFO - 'tooltool.py': '/tools/tooltool.py', 09:12:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:12:39 INFO - '/tools/misc-python/virtualenv.py')}, 09:12:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:12:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:12:39 INFO - 'installer_path': 'installer.exe', 09:12:39 INFO - 'log_level': 'info', 09:12:39 INFO - 'log_name': 'talos', 09:12:39 INFO - 'log_to_console': True, 09:12:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:12:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:12:39 INFO - 'opt_config_files': (), 09:12:39 INFO - 'pip_index': False, 09:12:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:12:39 INFO - 'cmd': ('bash', 09:12:39 INFO - '-c', 09:12:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:12:39 INFO - 'enabled': True, 09:12:39 INFO - 'halt_on_failure': False, 09:12:39 INFO - 'name': 'check_screen_resolution'},), 09:12:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:12:39 INFO - 'cmd': ('bash', 09:12:39 INFO - '-c', 09:12:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:12:39 INFO - 'enabled': True, 09:12:39 INFO - 'halt_on_failure': False, 09:12:39 INFO - 'name': 'check_screen_resolution'},), 09:12:39 INFO - 'run_cmd_checks_enabled': True, 09:12:39 INFO - 'sps_profile': False, 09:12:39 INFO - 'sps_profile_interval': 0, 09:12:39 INFO - 'suite': 'dromaeojs', 09:12:39 INFO - 'system_bits': '32', 09:12:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:12:39 INFO - 'title': 't-yosemite-r7-0134', 09:12:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:12:39 INFO - 'use_talos_json': True, 09:12:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:12:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:12:39 INFO - 'work_dir': 'build'} 09:12:39 INFO - ##### 09:12:39 INFO - ##### Running clobber step. 09:12:39 INFO - ##### 09:12:39 INFO - Running pre-action listener: _resource_record_pre_action 09:12:39 INFO - Running main action method: clobber 09:12:39 INFO - rmtree: /builds/slave/test/build 09:12:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:12:41 INFO - Running post-action listener: _resource_record_post_action 09:12:41 INFO - ##### 09:12:41 INFO - ##### Finished clobber step (success) 09:12:41 INFO - ##### 09:12:41 INFO - ##### 09:12:41 INFO - ##### Running read-buildbot-config step. 09:12:41 INFO - ##### 09:12:41 INFO - Running pre-action listener: _resource_record_pre_action 09:12:41 INFO - Running main action method: read_buildbot_config 09:12:41 INFO - Using buildbot properties: 09:12:41 INFO - { 09:12:41 INFO - "project": "", 09:12:41 INFO - "product": "firefox", 09:12:41 INFO - "script_repo_revision": "production", 09:12:41 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:12:41 INFO - "repository": "", 09:12:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:12:41 INFO - "buildid": "20160705070128", 09:12:41 INFO - "pgo_build": "False", 09:12:41 INFO - "basedir": "/builds/slave/test", 09:12:41 INFO - "buildnumber": 276, 09:12:41 INFO - "slavename": "t-yosemite-r7-0134", 09:12:41 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:12:41 INFO - "platform": "yosemite_r7", 09:12:41 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:12:41 INFO - "branch": "mozilla-central", 09:12:41 INFO - "repo_path": "mozilla-central", 09:12:41 INFO - "revision": "f47a1bc057ff5a6084e776040425da258a2851ca", 09:12:41 INFO - "stage_platform": "macosx64", 09:12:41 INFO - "builduid": "dddabf17a2214e01aedc59bd7a97a602", 09:12:41 INFO - "slavebuilddir": "test" 09:12:41 INFO - } 09:12:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 09:12:41 INFO - Running post-action listener: _resource_record_post_action 09:12:41 INFO - ##### 09:12:41 INFO - ##### Finished read-buildbot-config step (success) 09:12:41 INFO - ##### 09:12:41 INFO - ##### 09:12:41 INFO - ##### Running download-and-extract step. 09:12:41 INFO - ##### 09:12:41 INFO - Running pre-action listener: _resource_record_pre_action 09:12:41 INFO - Running main action method: download_and_extract 09:12:41 INFO - mkdir: /builds/slave/test/build/tests 09:12:41 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')]} 09:12:41 INFO - https://queue.taskcluster.net/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:12:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 09:12:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 09:12:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/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 09:12:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/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 09:12:42 INFO - Downloaded 1199 bytes. 09:12:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 09:12:42 INFO - Using the following test package requirements: 09:12:42 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 09:12:42 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:12:42 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 09:12:42 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:12:42 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 09:12:42 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:12:42 INFO - u'jsshell-mac.zip'], 09:12:42 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:12:42 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 09:12:42 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 09:12:42 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:12:42 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 09:12:42 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:12:42 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 09:12:42 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:12:42 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 09:12:42 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:12:42 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 09:12:42 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:12: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')]} 09:12:42 INFO - https://queue.taskcluster.net/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:12:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:12:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:12:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/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 09:12:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/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 09:12:44 INFO - Downloaded 18800215 bytes. 09:12:44 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'] 09:12:44 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 09:12:47 INFO - Return code: 0 09:12:47 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 09:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:47 INFO - https://queue.taskcluster.net/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:12:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:12:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:12:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/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 09:12:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/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 09:12:49 INFO - Downloaded 18800215 bytes. 09:12:49 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'] 09:12:49 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 09:12:52 INFO - Return code: 0 09:12:52 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')]} 09:12:52 INFO - https://queue.taskcluster.net/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:12:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 09:12:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 09:12:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/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 09:12:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/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 09:12:53 INFO - Downloaded 14403333 bytes. 09:12:53 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'] 09:12:53 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 09:12:53 INFO - Return code: 0 09:12: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')]} 09:12:53 INFO - https://queue.taskcluster.net/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:12:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:12:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:12:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 09:12:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/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 09:12:57 INFO - Downloaded 112443925 bytes. 09:12:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:12:57 INFO - mkdir: /builds/slave/test/properties 09:12:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:12:57 INFO - Writing to file /builds/slave/test/properties/build_url 09:12:57 INFO - Contents: 09:12:57 INFO - build_url:https://queue.taskcluster.net/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:12:58 INFO - Running post-action listener: _resource_record_post_action 09:12:58 INFO - Running post-action listener: set_extra_try_arguments 09:12:58 INFO - ##### 09:12:58 INFO - ##### Finished download-and-extract step (success) 09:12:58 INFO - ##### 09:12:58 INFO - ##### 09:12:58 INFO - ##### Running populate-webroot step. 09:12:58 INFO - ##### 09:12:58 INFO - Running pre-action listener: _resource_record_pre_action 09:12:58 INFO - Running main action method: populate_webroot 09:12:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:12:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:12:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:12:58 INFO - '--tppagecycles', 09:12:58 INFO - '7'], 09:12:58 INFO - 'tests': ['tsvgm']}}, 09:12:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:12:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:12:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:12:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:12:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:12:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:12:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:58 INFO - 'talos_options': ['--disable-e10s'], 09:12:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:12:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:12:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:58 INFO - 'talos_options': ['--disable-e10s'], 09:12:58 INFO - 'tests': ['damp', 'tps']}, 09:12:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:58 INFO - 'tests': ['damp', 'tps']}, 09:12:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:12:58 INFO - 'tests': ['dromaeo_dom']}, 09:12:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:12:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:12:58 INFO - 'tests': ['basic_compositor_video']}, 09:12:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:12:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:12:58 INFO - 'tests': ['a11yr', 09:12:58 INFO - 'ts_paint', 09:12:58 INFO - 'tpaint', 09:12:58 INFO - 'sessionrestore', 09:12:58 INFO - 'sessionrestore_no_auto_restore', 09:12:58 INFO - 'tabpaint']}, 09:12:58 INFO - 'other-e10s': {'tests': ['a11yr', 09:12:58 INFO - 'ts_paint', 09:12:58 INFO - 'tpaint', 09:12:58 INFO - 'sessionrestore', 09:12:58 INFO - 'sessionrestore_no_auto_restore', 09:12:58 INFO - 'tabpaint']}, 09:12:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:12:58 INFO - 'ts_paint', 09:12:58 INFO - 'tpaint', 09:12:58 INFO - 'sessionrestore', 09:12:58 INFO - 'sessionrestore_no_auto_restore', 09:12:58 INFO - 'tabpaint']}, 09:12:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:12:58 INFO - 'ts_paint', 09:12:58 INFO - 'tpaint', 09:12:58 INFO - 'sessionrestore', 09:12:58 INFO - 'sessionrestore_no_auto_restore', 09:12:58 INFO - 'tabpaint']}, 09:12:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:12:58 INFO - 'tests': ['a11yr', 09:12:58 INFO - 'ts_paint', 09:12:58 INFO - 'tpaint', 09:12:58 INFO - 'sessionrestore', 09:12:58 INFO - 'sessionrestore_no_auto_restore', 09:12:58 INFO - 'tabpaint']}, 09:12:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:12:58 INFO - 'tests': ['a11yr', 09:12:58 INFO - 'ts_paint', 09:12:58 INFO - 'tpaint', 09:12:58 INFO - 'sessionrestore', 09:12:58 INFO - 'sessionrestore_no_auto_restore', 09:12:58 INFO - 'tabpaint']}, 09:12:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:12:58 INFO - 'tests': ['tsvgx', 09:12:58 INFO - 'tsvgr_opacity', 09:12:58 INFO - 'tart', 09:12:58 INFO - 'tscrollx', 09:12:58 INFO - 'cart']}, 09:12:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:12:58 INFO - 'tsvgr_opacity', 09:12:58 INFO - 'tart', 09:12:58 INFO - 'tscrollx', 09:12:58 INFO - 'cart']}, 09:12:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:58 INFO - 'talos_options': ['--disable-e10s'], 09:12:58 INFO - 'tests': ['tp5o']}, 09:12:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:58 INFO - 'tests': ['tp5o']}, 09:12:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:58 INFO - 'talos_options': ['--disable-e10s', 09:12:58 INFO - '--xperf_path', 09:12:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:12:58 INFO - 'tests': ['tp5n']}, 09:12:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:58 INFO - 'talos_options': ['--xperf_path', 09:12:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:12:58 INFO - 'tests': ['tp5n']}}, 09:12:58 INFO - 'talos.zip': {'path': '', 09:12:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:12:58 INFO - Running post-action listener: _resource_record_post_action 09:12:58 INFO - ##### 09:12:58 INFO - ##### Finished populate-webroot step (success) 09:12:58 INFO - ##### 09:12:58 INFO - ##### 09:12:58 INFO - ##### Running create-virtualenv step. 09:12:58 INFO - ##### 09:12:58 INFO - Running pre-action listener: _resource_record_pre_action 09:12:58 INFO - Running main action method: create_virtualenv 09:12:58 INFO - Creating virtualenv /builds/slave/test/build/venv 09:12:58 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 09:12:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:12:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:12:58 INFO - Using real prefix '/tools/python27' 09:12:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:12:59 INFO - Installing distribute.............................................................................................................................................................................................done. 09:13:02 INFO - Installing pip.................done. 09:13:02 INFO - Return code: 0 09:13:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:13: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')]} 09:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13: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')]} 09:13:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:02 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 0x106785a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10681a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff47bd9b6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066e9d30>, '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 0x10644edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066e1b20>, '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.Y1qSsKYrxN/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.IstenzZUWC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 09:13:02 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 09:13:02 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 09:13:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y1qSsKYrxN/Render', 09:13:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:02 INFO - 'HOME': '/Users/cltbld', 09:13:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:02 INFO - 'LOGNAME': 'cltbld', 09:13:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:02 INFO - 'MOZ_NO_REMOTE': '1', 09:13:02 INFO - 'NO_EM_RESTART': '1', 09:13:02 INFO - 'PAGER': '/bin/cat', 09:13:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:02 INFO - 'PWD': '/builds/slave/test', 09:13:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:02 INFO - 'SHELL': '/bin/bash', 09:13:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IstenzZUWC/Listeners', 09:13:02 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 09:13:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:02 INFO - 'USER': 'cltbld', 09:13:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:02 INFO - 'XPC_FLAGS': '0x0', 09:13:02 INFO - 'XPC_SERVICE_NAME': '0', 09:13:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:02 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 09:13:02 INFO - Cleaning up... 09:13:02 INFO - Return code: 0 09:13:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:13: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')]} 09:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13: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')]} 09:13:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:02 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 0x106785a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10681a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff47bd9b6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066e9d30>, '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 0x10644edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066e1b20>, '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.Y1qSsKYrxN/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.IstenzZUWC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 09:13:02 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 09:13:02 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 09:13:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y1qSsKYrxN/Render', 09:13:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:02 INFO - 'HOME': '/Users/cltbld', 09:13:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:02 INFO - 'LOGNAME': 'cltbld', 09:13:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:02 INFO - 'MOZ_NO_REMOTE': '1', 09:13:02 INFO - 'NO_EM_RESTART': '1', 09:13:02 INFO - 'PAGER': '/bin/cat', 09:13:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:02 INFO - 'PWD': '/builds/slave/test', 09:13:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:02 INFO - 'SHELL': '/bin/bash', 09:13:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IstenzZUWC/Listeners', 09:13:02 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 09:13:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:02 INFO - 'USER': 'cltbld', 09:13:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:02 INFO - 'XPC_FLAGS': '0x0', 09:13:02 INFO - 'XPC_SERVICE_NAME': '0', 09:13:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:02 INFO - Downloading/unpacking psutil>=3.1.1 09:13:02 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 09:13:02 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 09:13:02 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 09:13:02 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 09:13:02 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 09:13:02 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 09:13:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:13:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:13:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:13:05 INFO - Installing collected packages: psutil 09:13:05 INFO - Running setup.py install for psutil 09:13:05 INFO - building 'psutil._psutil_osx' extension 09:13:05 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 09:13:06 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 09:13:06 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 09:13:06 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 09:13:06 INFO - building 'psutil._psutil_posix' extension 09:13:06 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 09:13:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:13:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:13:06 INFO - ^ 09:13:06 INFO - 1 warning generated. 09:13:06 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 09:13:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:13:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:13:06 INFO - Successfully installed psutil 09:13:06 INFO - Cleaning up... 09:13:06 INFO - Return code: 0 09:13:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:13:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:06 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 0x106785a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10681a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff47bd9b6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066e9d30>, '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 0x10644edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066e1b20>, '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.Y1qSsKYrxN/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.IstenzZUWC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 09:13:06 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 09:13:06 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 09:13:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y1qSsKYrxN/Render', 09:13:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:06 INFO - 'HOME': '/Users/cltbld', 09:13:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:06 INFO - 'LOGNAME': 'cltbld', 09:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:06 INFO - 'MOZ_NO_REMOTE': '1', 09:13:06 INFO - 'NO_EM_RESTART': '1', 09:13:06 INFO - 'PAGER': '/bin/cat', 09:13:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:06 INFO - 'PWD': '/builds/slave/test', 09:13:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:06 INFO - 'SHELL': '/bin/bash', 09:13:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IstenzZUWC/Listeners', 09:13:06 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 09:13:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:06 INFO - 'USER': 'cltbld', 09:13:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:06 INFO - 'XPC_FLAGS': '0x0', 09:13:06 INFO - 'XPC_SERVICE_NAME': '0', 09:13:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:13:07 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 09:13:07 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 09:13:07 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 09:13:07 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 09:13:07 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 09:13:07 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 09:13:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:13:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:13:09 INFO - Installing collected packages: mozsystemmonitor 09:13:09 INFO - Running setup.py install for mozsystemmonitor 09:13:09 INFO - Successfully installed mozsystemmonitor 09:13:09 INFO - Cleaning up... 09:13:09 INFO - Return code: 0 09:13:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:13:09 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')]} 09:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:09 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')]} 09:13:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:09 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 0x106785a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10681a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff47bd9b6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066e9d30>, '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 0x10644edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066e1b20>, '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.Y1qSsKYrxN/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.IstenzZUWC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 09:13:09 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 09:13:09 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 09:13:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y1qSsKYrxN/Render', 09:13:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:09 INFO - 'HOME': '/Users/cltbld', 09:13:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:09 INFO - 'LOGNAME': 'cltbld', 09:13:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:09 INFO - 'MOZ_NO_REMOTE': '1', 09:13:09 INFO - 'NO_EM_RESTART': '1', 09:13:09 INFO - 'PAGER': '/bin/cat', 09:13:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:09 INFO - 'PWD': '/builds/slave/test', 09:13:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:09 INFO - 'SHELL': '/bin/bash', 09:13:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IstenzZUWC/Listeners', 09:13:09 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 09:13:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:09 INFO - 'USER': 'cltbld', 09:13:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:09 INFO - 'XPC_FLAGS': '0x0', 09:13:09 INFO - 'XPC_SERVICE_NAME': '0', 09:13:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:10 INFO - Downloading/unpacking jsonschema==2.5.1 09:13:10 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 09:13:10 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 09:13:10 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 09:13:10 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 09:13:10 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 09:13:10 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 09:13:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:13:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:13:12 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 09:13:12 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 09:13:12 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 09:13:12 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 09:13:12 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 09:13:12 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 09:13:12 INFO - Downloading functools32-3.2.3-2.tar.gz 09:13:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:13:13 INFO - warning: no files found matching '*.txt' 09:13:13 INFO - no previously-included directories found matching 'build' 09:13:13 INFO - no previously-included directories found matching 'dist' 09:13:13 INFO - no previously-included directories found matching '.git*' 09:13:13 INFO - Installing collected packages: jsonschema, functools32 09:13:13 INFO - Running setup.py install for functools32 09:13:13 INFO - warning: no files found matching '*.txt' 09:13:13 INFO - no previously-included directories found matching 'build' 09:13:13 INFO - no previously-included directories found matching 'dist' 09:13:13 INFO - no previously-included directories found matching '.git*' 09:13:13 INFO - Successfully installed jsonschema functools32 09:13:13 INFO - Cleaning up... 09:13:13 INFO - Return code: 0 09:13:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106785a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10681a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff47bd9b6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066e9d30>, '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 0x10644edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066e1b20>, '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.Y1qSsKYrxN/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.IstenzZUWC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 09:13:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:13:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:13:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y1qSsKYrxN/Render', 09:13:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:13 INFO - 'HOME': '/Users/cltbld', 09:13:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:13 INFO - 'LOGNAME': 'cltbld', 09:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:13 INFO - 'MOZ_NO_REMOTE': '1', 09:13:13 INFO - 'NO_EM_RESTART': '1', 09:13:13 INFO - 'PAGER': '/bin/cat', 09:13:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:13 INFO - 'PWD': '/builds/slave/test', 09:13:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:13 INFO - 'SHELL': '/bin/bash', 09:13:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IstenzZUWC/Listeners', 09:13:13 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 09:13:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:13 INFO - 'USER': 'cltbld', 09:13:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:13 INFO - 'XPC_FLAGS': '0x0', 09:13:13 INFO - 'XPC_SERVICE_NAME': '0', 09:13:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:13 INFO - Downloading/unpacking blobuploader==1.2.4 09:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:15 INFO - Downloading blobuploader-1.2.4.tar.gz 09:13:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:13:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:13:16 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 09:13:16 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 09:13:16 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 09:13:16 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 09:13:16 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 09:13:16 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 09:13:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:13:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:13:16 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 09:13:16 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 09:13:16 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 09:13:16 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 09:13:16 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 09:13:16 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 09:13:17 INFO - Downloading docopt-0.6.1.tar.gz 09:13:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:13:17 INFO - Installing collected packages: blobuploader, requests, docopt 09:13:17 INFO - Running setup.py install for blobuploader 09:13:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:13:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:13:17 INFO - Running setup.py install for requests 09:13:17 INFO - Running setup.py install for docopt 09:13:18 INFO - Successfully installed blobuploader requests docopt 09:13:18 INFO - Cleaning up... 09:13:18 INFO - Return code: 0 09:13:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:13: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')]} 09:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13: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')]} 09:13:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:18 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 0x106785a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10681a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff47bd9b6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066e9d30>, '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 0x10644edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066e1b20>, '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.Y1qSsKYrxN/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.IstenzZUWC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 09:13:18 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 09:13:18 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 09:13:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y1qSsKYrxN/Render', 09:13:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:18 INFO - 'HOME': '/Users/cltbld', 09:13:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:18 INFO - 'LOGNAME': 'cltbld', 09:13:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:18 INFO - 'MOZ_NO_REMOTE': '1', 09:13:18 INFO - 'NO_EM_RESTART': '1', 09:13:18 INFO - 'PAGER': '/bin/cat', 09:13:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:18 INFO - 'PWD': '/builds/slave/test', 09:13:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:18 INFO - 'SHELL': '/bin/bash', 09:13:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IstenzZUWC/Listeners', 09:13:18 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 09:13:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:18 INFO - 'USER': 'cltbld', 09:13:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:18 INFO - 'XPC_FLAGS': '0x0', 09:13:18 INFO - 'XPC_SERVICE_NAME': '0', 09:13:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:13:18 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-1wnM31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:13:18 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-NIhcor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:13:18 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-4RXkaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:13:18 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-judWye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:13:18 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-p6qei8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:13:18 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-7JFPRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:13:19 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-DDTaNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:13:19 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-j2MUoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:13:19 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-bnJkp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:13:19 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-numoh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:13:19 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-6o5Mzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:13:19 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-NXYdwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:13:19 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-zCQsCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:13:19 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-5XEJBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:13:19 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-Q2_D8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:13:19 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-kEaMqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:13:20 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-n9q3KF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:13:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:13:20 INFO - Running setup.py install for manifestparser 09:13:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:13:20 INFO - Running setup.py install for mozcrash 09:13:20 INFO - Running setup.py install for mozdebug 09:13:20 INFO - Running setup.py install for mozdevice 09:13:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:13:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:13:20 INFO - Running setup.py install for mozfile 09:13:20 INFO - Running setup.py install for mozhttpd 09:13:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:13:21 INFO - Running setup.py install for mozinfo 09:13:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:13:21 INFO - Running setup.py install for mozInstall 09:13:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:13:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:13:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:13:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:13:21 INFO - Running setup.py install for mozleak 09:13:21 INFO - Running setup.py install for mozlog 09:13:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:13:21 INFO - Running setup.py install for moznetwork 09:13:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:13:21 INFO - Running setup.py install for mozprocess 09:13:21 INFO - Running setup.py install for mozprofile 09:13:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:13:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:13:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:13:22 INFO - Running setup.py install for mozrunner 09:13:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:13:22 INFO - Running setup.py install for mozscreenshot 09:13:22 INFO - Running setup.py install for moztest 09:13:22 INFO - Running setup.py install for mozversion 09:13:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:13:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:13:22 INFO - Cleaning up... 09:13:22 INFO - Return code: 0 09:13:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:13:22 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')]} 09:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:22 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')]} 09:13:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:22 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 0x106785a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10681a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff47bd9b6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066e9d30>, '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 0x10644edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066e1b20>, '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.Y1qSsKYrxN/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.IstenzZUWC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 09:13:22 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 09:13:22 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 09:13:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y1qSsKYrxN/Render', 09:13:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:22 INFO - 'HOME': '/Users/cltbld', 09:13:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:22 INFO - 'LOGNAME': 'cltbld', 09:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:22 INFO - 'MOZ_NO_REMOTE': '1', 09:13:22 INFO - 'NO_EM_RESTART': '1', 09:13:22 INFO - 'PAGER': '/bin/cat', 09:13:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:22 INFO - 'PWD': '/builds/slave/test', 09:13:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:22 INFO - 'SHELL': '/bin/bash', 09:13:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IstenzZUWC/Listeners', 09:13:22 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 09:13:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:22 INFO - 'USER': 'cltbld', 09:13:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:22 INFO - 'XPC_FLAGS': '0x0', 09:13:22 INFO - 'XPC_SERVICE_NAME': '0', 09:13:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:13:23 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-WHAqkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:13:23 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)) 09:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:13:23 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-kaCL5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:13:23 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)) 09:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:13:23 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-CbcSSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:13:23 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)) 09:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:13:23 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-xUNawt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:13:23 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)) 09:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:13:23 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-QlYNBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:13:23 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)) 09:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:13:23 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-bmnWZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:13:23 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)) 09:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:13:23 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-MeAj_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:13:23 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)) 09:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:13:23 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-HG1kLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:13:23 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)) 09:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:13:23 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-SPeIWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:13:23 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)) 09:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:13:23 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-C1cRsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:13:24 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)) 09:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:13:24 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-jJxpsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:13:24 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)) 09:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:13:24 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-nd7x2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:13:24 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)) 09:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:13:24 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-lztCRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:13:24 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)) 09:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:13:24 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-BeKRuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:13:24 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)) 09:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:13:24 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-7bDL4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:13:24 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)) 09:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:13:24 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-2Xw9XJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:13:24 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)) 09:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:13:24 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-crYBce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:13:24 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)) 09:13:24 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)) 09:13:24 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)) 09:13:24 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)) 09:13:24 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)) 09:13:24 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)) 09:13:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:27 INFO - Downloading blessings-1.6.tar.gz 09:13:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:13:27 INFO - Installing collected packages: blessings 09:13:27 INFO - Running setup.py install for blessings 09:13:27 INFO - Successfully installed blessings 09:13:27 INFO - Cleaning up... 09:13:27 INFO - Return code: 0 09:13:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:13:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:13:27 INFO - Reading from file tmpfile_stdout 09:13:27 INFO - Current package versions: 09:13:27 INFO - blessings == 1.6 09:13:27 INFO - blobuploader == 1.2.4 09:13:27 INFO - docopt == 0.6.1 09:13:27 INFO - functools32 == 3.2.3-2 09:13:27 INFO - jsonschema == 2.5.1 09:13:27 INFO - manifestparser == 1.1 09:13:27 INFO - mozInstall == 1.12 09:13:27 INFO - mozcrash == 0.17 09:13:27 INFO - mozdebug == 0.1 09:13:27 INFO - mozdevice == 0.48 09:13:27 INFO - mozfile == 1.2 09:13:27 INFO - mozhttpd == 0.7 09:13:27 INFO - mozinfo == 0.9 09:13:27 INFO - mozleak == 0.1 09:13:27 INFO - mozlog == 3.2 09:13:27 INFO - moznetwork == 0.27 09:13:27 INFO - mozprocess == 0.22 09:13:27 INFO - mozprofile == 0.28 09:13:27 INFO - mozrunner == 6.11 09:13:27 INFO - mozscreenshot == 0.1 09:13:27 INFO - mozsystemmonitor == 0.3 09:13:27 INFO - moztest == 0.7 09:13:27 INFO - mozversion == 1.4 09:13:27 INFO - psutil == 3.1.1 09:13:27 INFO - requests == 1.2.3 09:13:27 INFO - wsgiref == 0.1.2 09:13:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:13:27 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')]} 09:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:27 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')]} 09:13:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:27 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 0x106785a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10681a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff47bd9b6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066e9d30>, '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 0x10644edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066e1b20>, '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.Y1qSsKYrxN/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.IstenzZUWC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 09:13:27 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 09:13:27 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 09:13:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y1qSsKYrxN/Render', 09:13:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:27 INFO - 'HOME': '/Users/cltbld', 09:13:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:27 INFO - 'LOGNAME': 'cltbld', 09:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:27 INFO - 'MOZ_NO_REMOTE': '1', 09:13:27 INFO - 'NO_EM_RESTART': '1', 09:13:27 INFO - 'PAGER': '/bin/cat', 09:13:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:27 INFO - 'PWD': '/builds/slave/test', 09:13:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:27 INFO - 'SHELL': '/bin/bash', 09:13:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IstenzZUWC/Listeners', 09:13:27 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 09:13:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:27 INFO - 'USER': 'cltbld', 09:13:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:27 INFO - 'XPC_FLAGS': '0x0', 09:13:27 INFO - 'XPC_SERVICE_NAME': '0', 09:13:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:28 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)) 09:13:28 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)) 09:13:28 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)) 09:13:28 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)) 09:13:28 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)) 09:13:28 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)) 09:13:28 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)) 09:13:28 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)) 09:13:28 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)) 09:13:28 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)) 09:13:28 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)) 09:13:28 INFO - Cleaning up... 09:13:28 INFO - Return code: 0 09:13:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:28 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 0x106785a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10681a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff47bd9b6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066e9d30>, '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 0x10644edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066e1b20>, '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.Y1qSsKYrxN/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.IstenzZUWC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 09:13:28 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 09:13:28 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 09:13:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y1qSsKYrxN/Render', 09:13:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:28 INFO - 'HOME': '/Users/cltbld', 09:13:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:28 INFO - 'LOGNAME': 'cltbld', 09:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:28 INFO - 'MOZ_NO_REMOTE': '1', 09:13:28 INFO - 'NO_EM_RESTART': '1', 09:13:28 INFO - 'PAGER': '/bin/cat', 09:13:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:28 INFO - 'PWD': '/builds/slave/test', 09:13:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:28 INFO - 'SHELL': '/bin/bash', 09:13:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IstenzZUWC/Listeners', 09:13:28 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 09:13:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:28 INFO - 'USER': 'cltbld', 09:13:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:28 INFO - 'XPC_FLAGS': '0x0', 09:13:28 INFO - 'XPC_SERVICE_NAME': '0', 09:13:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:13:28 INFO - Cleaning up... 09:13:28 INFO - Return code: 0 09:13:28 INFO - Running post-action listener: _resource_record_post_action 09:13:28 INFO - Running post-action listener: _start_resource_monitoring 09:13:28 INFO - Starting resource monitoring. 09:13:28 INFO - ##### 09:13:28 INFO - ##### Finished create-virtualenv step (success) 09:13:28 INFO - ##### 09:13:28 INFO - ##### 09:13:28 INFO - ##### Running install step. 09:13:28 INFO - ##### 09:13:28 INFO - Running pre-action listener: _resource_record_pre_action 09:13:28 INFO - Running main action method: install 09:13:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:13:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:13:28 INFO - Reading from file tmpfile_stdout 09:13:28 INFO - Detecting whether we're running mozinstall >=1.0... 09:13:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:13:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:13:28 INFO - Reading from file tmpfile_stdout 09:13:28 INFO - Output received: 09:13:28 INFO - Usage: mozinstall [options] installer 09:13:28 INFO - Options: 09:13:28 INFO - -h, --help show this help message and exit 09:13:28 INFO - -d DEST, --destination=DEST 09:13:28 INFO - Directory to install application into. [default: 09:13:28 INFO - "/builds/slave/test"] 09:13:28 INFO - --app=APP Application being installed. [default: firefox] 09:13:28 INFO - mkdir: /builds/slave/test/build/application 09:13:28 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'] 09:13:28 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 09:14:03 INFO - Reading from file tmpfile_stdout 09:14:03 INFO - Output received: 09:14:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:14:03 INFO - Running post-action listener: _resource_record_post_action 09:14:03 INFO - ##### 09:14:03 INFO - ##### Finished install step (success) 09:14:03 INFO - ##### 09:14:03 INFO - ##### 09:14:03 INFO - ##### Running run-tests step. 09:14:03 INFO - ##### 09:14:03 INFO - Running pre-action listener: _resource_record_pre_action 09:14:03 INFO - Running main action method: run_tests 09:14:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:14:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:14:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:14:03 INFO - 2016-07-05 09:14:03.947 screenresolution[1639:7571] starting screenresolution argv=screenresolution get 09:14:03 INFO - 2016-07-05 09:14:03.949 screenresolution[1639:7571] Display 0: 1600x1200x32@60 09:14:03 INFO - 2016-07-05 09:14:03.956 screenresolution[1640:7573] starting screenresolution argv=screenresolution list 09:14:03 INFO - Available Modes on Display 0 09:14:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:14:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:14:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:14:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:14:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:14:04 INFO - Intel Iris: 09:14:04 INFO - Chipset Model: Intel Iris 09:14:04 INFO - Type: GPU 09:14:04 INFO - Bus: Built-In 09:14:04 INFO - VRAM (Dynamic, Max): 1536 MB 09:14:04 INFO - Vendor: Intel (0x8086) 09:14:04 INFO - Device ID: 0x0a2e 09:14:04 INFO - Revision ID: 0x0009 09:14:04 INFO - Displays: 09:14:04 INFO - Display: 09:14:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:14:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:14:04 INFO - Display Serial Number: 1600x1200 60 09:14:04 INFO - Main Display: Yes 09:14:04 INFO - Mirror: Off 09:14:04 INFO - Online: Yes 09:14:04 INFO - Rotation: Supported 09:14:04 INFO - Return code: 0 09:14:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:14:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:14:04 INFO - Python 2.7.3 09:14:04 INFO - Return code: 0 09:14:04 INFO - grabbing minidump binary from tooltool 09:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:04 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 0x1066e9d30>, '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 0x10644edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066e1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:14:04 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 09:14:04 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 09:14:04 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 09:14:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:14:04 INFO - Return code: 0 09:14:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:14:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:14:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:14:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:14:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:14:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0134', '--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 09:14:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0134 --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 09:14:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y1qSsKYrxN/Render', 09:14:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:14:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:14:04 INFO - 'HOME': '/Users/cltbld', 09:14:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:14:04 INFO - 'LOGNAME': 'cltbld', 09:14:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:14:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:04 INFO - 'MOZ_NO_REMOTE': '1', 09:14:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:14:04 INFO - 'NO_EM_RESTART': '1', 09:14:04 INFO - 'PAGER': '/bin/cat', 09:14:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:04 INFO - 'PWD': '/builds/slave/test', 09:14:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:14:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:14:04 INFO - 'SHELL': '/bin/bash', 09:14:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IstenzZUWC/Listeners', 09:14:04 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 09:14:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:14:04 INFO - 'USER': 'cltbld', 09:14:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:14:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:04 INFO - 'XPC_FLAGS': '0x0', 09:14:04 INFO - 'XPC_SERVICE_NAME': '0', 09:14:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:14:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0134', '--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 09:14:04 INFO - mozversion application_buildid: 20160705070128 09:14:04 INFO - mozversion application_changeset: f47a1bc057ff5a6084e776040425da258a2851ca 09:14:04 INFO - mozversion application_display_name: Nightly 09:14:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:14:04 INFO - mozversion application_name: Firefox 09:14:04 INFO - mozversion application_remotingname: firefox 09:14:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:14:04 INFO - mozversion application_vendor: Mozilla 09:14:04 INFO - mozversion application_version: 50.0a1 09:14:04 INFO - mozversion platform_buildid: 20160705070128 09:14:04 INFO - mozversion platform_changeset: f47a1bc057ff5a6084e776040425da258a2851ca 09:14:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:14:04 INFO - mozversion platform_version: 50.0a1 09:14:04 INFO - using testdate: 1467735244 09:14:04 INFO - actual date: 1467735244 09:14:04 INFO - starting webserver on 'localhost:49271' 09:14:04 INFO - SUITE-START | Running 2 tests 09:14:04 INFO - TEST-START | dromaeo_css 09:14:04 INFO - operating with platform_type : mac_ 09:14:04 INFO - Initialising browser for dromaeo_css test... 09:14:04 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmp8YzZkd/profile http://localhost:49271/getInfo.html) 09:14:06 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 09:14:06 INFO - PROCESS | 1650 | colorDepth:24 09:14:06 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 09:14:06 INFO - PROCESS | 1650 | __metrics 09:14:07 INFO - PROCESS | 1650 | 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" 09:14:07 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:14:07 INFO - TEST-INFO | 1650: exit 0 09:14:07 INFO - Browser initialized. 09:14:07 INFO - Running cycle 1/1 for dromaeo_css test... 09:14:07 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmp8YzZkd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:14:19 INFO - PROCESS | 1653 | RSS: Main: 243609600 09:14:19 INFO - PROCESS | 1653 | 09:15:10 INFO - PROCESS | 1653 | 1467735310571 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] 09:17:22 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 09:17:23 INFO - PROCESS | 1653 | RSS: Main: 363368448 09:17:23 INFO - PROCESS | 1653 | 09:20:26 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 09:20:27 INFO - PROCESS | 1653 | RSS: Main: 380395520 09:20:27 INFO - PROCESS | 1653 | 09:23:29 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 09:23:30 INFO - PROCESS | 1653 | RSS: Main: 374059008 09:23:30 INFO - PROCESS | 1653 | 09:26:32 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 09:26:33 INFO - PROCESS | 1653 | RSS: Main: 374325248 09:26:33 INFO - PROCESS | 1653 | 09:29:36 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 09:29:37 INFO - PROCESS | 1653 | RSS: Main: 343748608 09:29:37 INFO - PROCESS | 1653 | 09:32:40 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 09:32:40 INFO - PROCESS | 1653 | RSS: Main: 388386816 09:32:40 INFO - PROCESS | 1653 | 09:32:40 INFO - PROCESS | 1653 | __start_tp_report 09:32:40 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 09:32:40 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 09:32:40 INFO - PROCESS | 1653 | |i|pagename|runs| 09:32:40 INFO - PROCESS | 1653 | |0;dojo.html;3309.3381323735252;3320.4355259605863;3322.4185767490685;3368.9157771055734;3387.6612338766126;5575.888482230353;5672.829815105543;5716.342620598627;5774.220480235167;5844.152597873306;5663.5186009189165;5706.1440783882335;5710.343310519292;5722.084466485363;5733.627314224573;5095.617828662856;5154.4072431670465;5159.71621560814;5160.071187186305;5218.947810521903;5225.294585230983;5253.947460525404;5257.23770053342;5257.421683614818;5260.368755749297;5153.227015947619;5175.948240517603;5181.818636347729;5194.68831870089;5247.212918062283;5245.318108645852;5246.711430871301;5261.289725886994;5265.183896496049;5315.627906046579;5060.67105638136;5083.974580127113;5107.719075450848;5174.896502069975;5176.870578235536;5653.265075540154;5660.688662123582;5686.829395118111;5716.685582292972;5746.138079288098;6202.596831205957;6202.627842329474;6205;6208.50331973441;6222.253329600431;6050.48570871472;6125.235451818339;6128.136482154514;6225.221847269091;6227.408396202353;5742.368339482654;5772.191893134965;5787.160861675034;5805.274340707411;5806.59353845231;6191.00943848982;6219.968900155561;6221.2845522764555;6231.813045608548;6232.096346029891;6018.00702884028;6082.1789058477425;6088.908666370008;6108.664023478663;6129.356417576179;6204.286507051656;6216.7824126155365;6249.75000999964;6253.062040693932;6255.843603909848;6136.447719705158;6153.538484613582;6167.352427995085;6182.845428864224;6184.103305020837;6105.550726437353;6109.358517355702;6130.703893785035;6249.281332646713;6274.874502510015;4837.129316723023;4860.052289803454;4862.270659401118;4866.562009419169;4873.658843880894;4363.410939523187;4391.582799634093;4400.009997750544;4414.359917811964;4440.245158323093;5716.542676585863;5729.942700572941;5731.8567035824435;5743.195952566644;5778;6208.255009398811;6282.4883464363165;6299.149614801943;6341.460975817107;6347.270063942706;5582.888342233133;5651.547876169897;5663;5705.001624715741;5772.942270577324;5394.406615272317;5417.6478528895495;5427.213054107211;5434.021876062267;5469.206964990054;6224.470919971853;6257.78097766576;6271.122042913996;6279.591826531261;6297.464715499143;6145.586515101641;6219.782307619212;6275.246970363585;6302.747890084345;6327.145835312358;6263.686815659108;6287;6290.874182516232;6292.905606415999;6298.307186209422;6144.10910417978;6169.01295792671;6174.289956655042;6189.071639253968;6202.2867370253;6086.939130608637;6144.41628045335;6157.291911430243;6264.31092579825;6304.05439184126;6069.635821850703;6093.360197179232;6111.755529778937;6119.082137679384;6120.143179954899;5941.732622031933;6109.84725381869;6124.510039196943;6136.171616831671;6139.017757158833;5862.882742345044;5914.881702365842;5935.169076329231;5941.435563621449;6015.037593984942;6110.365674210153;6113.98035644981;6120.26428866606;6129.022607377628;6139.737467782926;5812.73842677089;5888.3228428731245;5934.495567876779;5945.435183657545;5946.73239704223 09:32:40 INFO - PROCESS | 1653 | |1;ext.html;489.48359480747797;512.8769095417099;517.3972322244585;530.2629345210157;543.9881819815143;30321.24196895076;31129.066128016166;42978.99999999996;43862.56137438625;43971.56028439714;45019.54980450195;45386.092278154414;45483.54516454835;45570.860728481806;45662.771686141605;9701.757456063602;9864.654737084204;9884.159846413064;9890.901090989106;9892.752681182956;8711.346649001318;8920.10798920106;8940.06129356418;8996.8650470243;9001.954990225073;11826.994705450046;12043.939780301087;12069.517219311218;12228.633141005785;12251.142420030601;12021.639350819445;12103.636890893287;12112.757744845097;12127.151099423045;12131.878681213164;8627.180417860356;8831.116888311182;11797.587084452003;11917.404129793476;11939.940300298444;33080.338393232;33412.665873341444;36656.633433665585;41761.53834615774;42028.78985605083;3519.683228509421;3546.4680297955256;3600.5499312585926;3688.3360995020885;3843.7885916274595;32310;32581.348373032408;32604;32938.50592241118;33393.332133357195;3253.6746325367512;3265.5591495148087;3306.9007929762147;3373.595168579762;3431.759776815624;551857;553536;553636;554388;554593;55763;64261.67869160718;65317.346826531124;65430.01854972179;69507;66630.00054999179;66825.33174668289;66846;67035.66482167559;67047.32952670509;16613.50159495217;16707.33170673184;16846.24191911367;16851.662966740598;16890.662186756195;12772.169808962388;12894;12935.611931642066;13066.54267100647;13076.280804555841;12964.481420743065;16323.183840807913;16342.182890855409;17960.820391795914;17991.460256192335;5876.503480429138;7115.430765538745;7228.674709638079;7257.782266532013;7277.854442911218;834.7620928035602;870.8345414371249;996.3922007575374;1036.6423583863555;1137.0562433180605;26500.337491562866;27276;28489.43021139607;29550.37472939009;29605.407891842042;1035.0477560644226;1104.6078642082107;1112.6272698645882;1196.1626861197024;1214.5809695655162;12731.93634031824;12977.740445191042;15278.31247593861;15378;15422;591258;596268;602548;603949;604475;54500.72749636226;61211;61414.38585614086;62855.74288514296;62921;1401.7757158854533;1407.5214427094836;1429.957101286963;1435.8707716305373;1436.4613270023742;31276.374472510877;32431.837840810644;32632.184195395304;32643.836780815946;33382.49778759913;54769.452305476436;55323.44676553183;55445;55448;55510.72244638751;847810;877661;879686;879704;883386;39781.60218397895;39808.40287395634;40660.79669601751;40938.701436348754;40952.1809563813;48236;48336;48635;48796.5120348792;48818;32975.8351208252;39947;39977.80011100042;40007;40660.59339406568;37512.249755005294;40098.1980360397;40293.99265018398;40787.705369229705;40830.591694083865;38161.23677526489;38334;39135.41296880492;39156;39267.018324542114;29792.70207297986;34444.13889652779;35133.297334053685;35260.82369588238;36913.07717307089;25776.484470310115;25909.14973469628;26017.479650407266;26246;26421.33946651349 09:32:40 INFO - PROCESS | 1653 | |2;jquery.html;361.38744827517337;382.8640832504461;389.39060370520133;392.8428628548581;410.1509874559663;15353.385864565418;15675.29461174247;19304.227830886783;21307.57384852302;21321.786782132174;21102;21252.57494850102;22121.225757098506;22179.11283548656;22242.999065042073;5210.348706411699;5825.941740582603;6078.088286756978;6085.752420753757;6116.633002019871;5746.48281654651;5793.681347525884;5813.796517121901;5819.127130930352;5821.214136091637;5781.913271300934;5831.30024397073;6151.077338399231;6155.938440615604;6189.38106189382;5302.946970530323;6126.509879209675;6149.538784591129;6155.19982402287;6179.073139029137;5882.941170588282;5961.076033214858;5981.102834574848;5990.670513121777;5994.040953447471;13644;17286.740698889527;18912.243510259574;25610.48779024428;25648;2238.2725614175456;2395.2574701842486;2454.1778504200934;2508.5610018246734;2883.4521440926364;9280.489573073479;10749.355038697704;12959.67600809978;13746.381412836346;16288.42990495327;1829.2591500442343;1920.807919208082;1947.1529884500287;1958.0405601255425;1997.800219978005;124485;129462.3526882369;131309.6869031307;132282.677173228;133728;11447.313161210188;11636.301821890713;11649.184557080924;11668.358240296695;11814.645560633024;14626.926865365605;14657.780133297796;14674.266286685623;14693.55919322422;14694.412223511154;7057.258987806309;8655.6537738491;8721.563921803885;8755.56222188888;8806.77983050416;8723.214910657944;8748.34387420946;8763.518006509576;8831.3376496763;8879.422837515542;3764.7741135531955;4554;4556.316552517149;4573.382593349856;4663.253879379283;1875.4467432107288;1909.9140538675792;1914.5117994911486;1916.4729699332795;1925.663008973424;713.4542075312287;850.3919697416377;953.7329547726648;996.9651062212788;1008.4503945349802;16844.663106737797;20493.18027278922;21066.578668426544;21095.367138985854;21107.155713771583;937.1659223291276;951.7097285328041;960.188640598693;969.5927710361665;995.0994350113159;10953.2072762087;11189.272697274651;11469.88530114705;11491.42542872853;11497.770044599229;581390;581698;588073;591471;625352;106715;144780;145446.5455345454;146050;148222;968.1286841842398;985.393982700634;1032.6592224565875;1053.6733612580124;1060.1359891688248;19900.303489377802;20258;20280.89859550752;20323.882186479885;20398;52509;56068.878622428136;56972;60560;61878.690606546676;69842.65078674574;87078;91025.6346154795;92474.37628118701;92485.07514924764;8018.518888866687;8180.9590952044855;8365.707200248205;8405;8592.828143437222;11400.771984560097;13139.934300328438;13302;13330.933345333211;13569.253691047088;9436.386634868712;11522.481488333213;11638.6508404748;11822.586209482626;11892.405379730806;11017.28387654832;11216.719582010188;11335.979761821145;11488.368139752394;11567.652970410902;11402.315861048364;11753.706157346134;11890.643280701594;11923.880761192277;12068.51725930988;8261.586920653823;8315.417920745489;8352.791180220544;8364.247217750431;8391.8251444799;8484.236418722345;11229.213955023397;11520.251183673034;11573.900479454775;11717.824232636687 09:32:40 INFO - PROCESS | 1653 | |3;mootools.html;1545.505438259757;1578.7079390312792;1827.4243613261822;1966.2528239269093;1998.7201791749148;8530.03809123901;8798.86801697975;8962.641494340234;8979.551022448875;8985.23625491833;7854.489458185214;8099.473534220271;8499.957500212506;8767;8781.736547903573;2334.556434277486;2361.3388251289666;2363.6690863279155;2366.1954935321987;2366.3610825077217;2331.62693968965;2335.509542995973;2380.33350661815;2384.7972922301624;2391.3184742348435;2082.5938941906334;2156.816670583002;2161.5676864627058;2172.196287373674;2173.1307477009245;2302.631578947369;2374.5132247889314;2380.916682909272;2381.892814823337;2384.1297926256966;2351.341624345186;2370.2415227127326;2376.989779343772;2379.9286021419384;2388.3073908566494;7837.373010159174;8054.718084867001;8056.436049476539;8860.822783544292;8928.910710892873;4841.394825646794;5193.584513238932;5362.410134885159;5391.191321301797;5403.054465468527;3539.9292014159573;3549.8580056797696;3614.9096272593397;3616.33097876891;3626.9818650906577;1052.6000119954444;1056.7622284985894;1060.734816295926;1080.2168427889796;1082.1991726122692;11628.476718547685;11745.412729363497;11749.4712737927;11756.294622322688;11772.705682357924;4566.908661826745;4575.24508456101;4801.735904525284;4804.591609713144;4806.279058141306;9983.400995940267;9994.700158995242;10006.54970526328;10006.599736010477;10027;5370;5378.489043540857;5379.54273886724;5379.704116273642;5381.300430943952;4693.131770622445;4872.4883887192045;4889.266610008527;4903.926441103386;4919.114559379346;3723.590405055442;3772.13240954582;3809.9141744603207;3829.636184562462;3868.5357757069332;1001.0540039662449;1156.7108222944264;1164.5341863254766;1171.8886705762939;1175.7589694112687;843.1947490146895;854.8204876975781;923.8845144356956;938.7183844846655;960.4943633886755;5860.326062502867;6092.994655881818;6095.2685677718955;6176.718370583298;6262.2172228471445;423.30577852322216;432.9567043295645;433.90655548018816;444.8887778055486;457.2866328527441;3770.66141519762;3980.8407663693706;4106;4170.311898536768;4190.308599081118;9509;10633.255672102878;10676.626318078985;10763;10839;10617.84073238902;10720.41037742916;10725.30285531438;10752.19358548112;10778.784424311627;7973.800654983555;8173.060098088677;8179.977502812268;8182.590870456454;8229.588520573947;5785.942140578709;6033.637981721111;6053.848653783691;6242.687865606611;6274.403931626488;9361.344705870524;10010.749731256778;10044.598216071276;10046.095851373411;10060;9875.703728888146;9954.850677239992;9991.800163996533;10006.29955903109;10017.69946901594;7306.780796576111;7411.925880741339;7461.888071679038;7486.288802563748;7505.4746167767735;7147.678354473957;8273.131321211427;8320.500769953822;8396.790080248044;8403.327733781161;6060.39396060408;7469.253074692488;7543.115295622868;7616.124145723091;7737.0715514138665;7165.3551180394015;7310.96344518274;7311.4516411268305;7379.557226566423;7403.074615673041;6938.5836849789175;6979.441644668313;7039.260877607778;7040.5071644984355;7045.471589630901;4926.014797040678;5076.416212135652;5130.179171332569;5167.095758242368;5203.609729270244;5104.157813960804;5107.719075450886;5138.3833939927445;5182.714950677598;5337.706426146599 09:32:40 INFO - PROCESS | 1653 | |4;prototype.html;258.9054994926852;301.3987095743991;314.10010320431957;318.5683398994361;319.5382672038905;5131.743412829353;5361.356637203531;5421.638584077872;5435.043384381619;5437.6465529740535;5061.6962982221;5185;5350.892982140354;5384.811531596395;5391.676499410039;4073.144639625682;4074.30736774749;4079.2663118174805;4087.9182416351655;4109.589041095882;3879.573246942834;4076.4700588923397;4119.773412462313;4124.340105583107;4147.523034850986;3978.582248863871;4004.579519150491;4028.436018957348;4033.475648165734;4037.777922214277;3236.4983427568764;4018.1160144768105;4022.6781857451333;4058.6753059755147;4072.409500622408;3488.790672559629;3496.513981557853;3505.7545971781988;3509.91225219369;3529.135361836341;4879.268109783526;5166.793328266865;5198.4801519847715;5245.26566280721;5286.36563612369;3817.9045523861846;4513.977430112861;4569.2689169732685;4572.651067934968;4588.334691469751;4612.654050946159;4855.708657480563;5048.1418158913075;5436.912617476521;5602.38373778888;2917.3144311086876;3314.972308645008;3764.1342491226897;3820.2168555446065;3845.9615403845883;5052.661044823088;5666.801661941812;5843;5865.354810970747;5889.234399528077;3232.7413806895393;3856.2480316338047;3868.7485313454536;3869.845206191777;3875.7093218008763;3608.6376222634062;3833.1758671885123;3913.2173565287057;3913.6673382762783;3933.350997085449;3804.7907365094634;4183.5398106208295;4444.066745983379;4531.957649740512;4564.672017271216;4614.446266448048;4885.386318319682;5292.92060619091;5548.0845660466375;5608;1277.0805020385308;1301.2322729589587;1337.4115389228903;1339.337028171042;1345.7039451320888;870.5473153959905;883.9337049721297;896.7309807057857;900.5546098511925;903.584351198443;4506.797194126272;4797.56821886032;5113.64204505681;5210.76551555181;5224.817131400383;5675.1487276907965;5691.723310675763;5696.601237913306;5713.228714123623;5718.799842005593;4855.95144048555;4905.435874874435;5195.506426889439;5224.869378265574;5225.294585231021;2267.648514480258;2410.1564452441507;2432.8565574180107;2537.974620253811;2551.5838709516024;3985.342418500973;4395.472543294825;4417.580329868657;4478.2386994211065;4991.301217829507;3909.9609003909595;4309.978450107729;4889.926651100236;4918.532739389752;5334.279872217201;4843.6367272454;5128.743562821844;5257.185136303879;6011.759529618854;6111.96944015277;4980.726060066586;5317.952588253473;5394.973025134849;5603.607747457639;5830;5404.459554044564;5790.478856902899;5814.5348372130975;5839.912401314069;5854.385289544536;5005.974970125126;5013.9721357122435;5897.171876718231;6085.66528840918;6089.725962331794;3850.9807450962567;3922.666573341298;3928.2929072767174;3941.11324951895;3957.0107473131716;5376.978374108907;5501.477359650827;5819.76720931158;5886.970565147318;6031.819045428644;4767.404074490689;5298.231756395224;5312.36251649789;5535.557155427637;5772.5959182856795;5686.886262274814;5700.800471983461;5704.942950570441;5707.800226992035;5713.7428815704225;4678.087772884255;5080.568151707146;5273.075327505509;5564;5607.467290607386;4945.208766597471;5663.575231857545;5709.857253568694;5713;5760.6255593386295;5572.080606699849;5586.804461843816;5595.5731288521165;5596.796688711946;5601.80393686219 09:32:40 INFO - PROCESS | 1653 | |5;yui.html;689.5173378634956;718.0987860235404;724.3155218318689;740.4187712645574;791.4420333664765;15177.696446071071;15715.764263536055;16014.279357428915;16023.798215133867;16077.678446431064;14960.925195374035;15132.092074475539;15158.393664253445;15178.924105379485;15249.237538123105;629.8142048095823;731.3125661877845;869.7738587967127;894.9373543851933;899.1907283444887;876.7369789063288;902.7517432705993;908.4776253654143;910.3491003932187;911.9498427586481;899.0649724286734;907.2696479334134;908.1690253418114;908.9727308180766;909.1454033208796;735.2500449541437;904.7828521154942;905.027095871937;917.431192660548;941.6139382852997;695.2873304862505;695.6452209373256;696.0255642101099;696.2689176364796;697.2051860878552;14997.400103995828;15067.849321506754;15079.773803392958;15104.093754374662;15125.924370378078;13877.444902203899;13963.860361396357;13994.860051399559;14015.018948673596;14372.35324410404;11837.348945807977;11879.287242765375;11930.88069119315;11971.102167337398;12053.698657533545;4555.74943378114;4574.794134263966;4579.977100114478;4735.952640473585;4776.737279449629;109249.16757491784;110219;116648;117188.82811171864;117202;11068.501917413736;11117.332960022424;11173.608923687632;11203.551857925755;11516.481758320895;21761.673574896387;21895;21919.123235070736;21928.671069933964;22127;7888.32949199313;7899.289063984269;7998.400119990907;8090.393220508486;8201.79495512617;4401.515833258339;4602.217623004098;4611.5619016193405;4698.342232087511;4718.528147185322;3523.3129539739502;3656.7988760618423;3659.2315613720884;3661.8901432957055;3668.0646435158865;562.3532937122342;668.6523008035891;678.1726293921408;678.5996262205323;688.7245101959256;471.3683663890335;597.9940200598026;620.8106527509153;654.6824789976857;668.5420486966443;7757.883631745528;8523.190296921783;8758.124187581318;9001.18989290967;9172.54137293146;588.802751078385;614.8493619063358;623.3953065526432;637.1398611873933;647.064991087883;3685.649863262986;4211.894702632459;4466.3747075409465;4500.144972455223;4536.931946020746;109182.45408772906;121347.39326303313;151105.73341399888;151688;152236.2388188074;64495.677521612095;81326;83382.16617833744;83911.5804420974;114562;68493;69305.65347173232;87380.99999999873;100147.99852001533;104888;8400.28597569189;8444.240018398374;8456.196661317164;8531;8746.431481953652;60632.69683651553;61748.69125654523;61764;62632;63618.36381636124;68238.65880670564;94135;94732;94809;97488.5125574396;10841.95859872624;10885.52054248118;11011.61459348919;11063.336199828036;11244.100471962387;10123.64567240143;12199.51201951912;12248.632541023784;12260.693482663004;12669.049821263257;11699.824502632637;11739.595517299887;11899.46452409661;11984.221025633306;12366.938165309115;11365.715857103638;11448.198626096426;11542.653720388402;11807.992641250836;11975.221610595283;11488.495539901405;11735;11735.589254376056;11765.470553824927;11989.520419183134;8324.750257492286;9205.86191207119;9565.234781217625;9777.168940640126;9932.155766759906;9180.311476639145;9666.081722236377;9667.371620844622;9802.731109164732;9887.950560247153 09:32:40 INFO - PROCESS | 1653 | __end_tp_report 09:32:40 INFO - PROCESS | 1653 | __start_cc_report 09:32:40 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1261 09:32:40 INFO - PROCESS | 1653 | __end_cc_report 09:32:40 INFO - PROCESS | 1653 | __startTimestamp1467736360566__endTimestamp 09:32:40 INFO - PROCESS | 1653 | 09:32:40 INFO - PROCESS | 1653 | ------- Summary: start ------- 09:32:40 INFO - PROCESS | 1653 | Number of tests: 6 09:32:40 INFO - PROCESS | 1653 | 09:32:40 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5733.24 Median:5941.73 stddev:637.50 (10.7%) stddev-sans-first:610.44 09:32:40 INFO - PROCESS | 1653 | Values: 3309.3 3320.4 3322.4 3368.9 3387.7 5575.9 5672.8 5716.3 5774.2 5844.2 5663.5 5706.1 5710.3 5722.1 5733.6 5095.6 5154.4 5159.7 5160.1 5218.9 5225.3 5253.9 5257.2 5257.4 5260.4 5153.2 5175.9 5181.8 5194.7 5247.2 5245.3 5246.7 5261.3 5265.2 5315.6 5060.7 5084.0 5107.7 5174.9 5176.9 5653.3 5660.7 5686.8 5716.7 5746.1 6202.6 6202.6 6205.0 6208.5 6222.3 6050.5 6125.2 6128.1 6225.2 6227.4 5742.4 5772.2 5787.2 5805.3 5806.6 6191.0 6220.0 6221.3 6231.8 6232.1 6018.0 6082.2 6088.9 6108.7 6129.4 6204.3 6216.8 6249.8 6253.1 6255.8 6136.4 6153.5 6167.4 6182.8 6184.1 6105.6 6109.4 6130.7 6249.3 6274.9 4837.1 4860.1 4862.3 4866.6 4873.7 4363.4 4391.6 4400.0 4414.4 4440.2 5716.5 5729.9 5731.9 5743.2 5778.0 6208.3 6282.5 6299.1 6341.5 6347.3 5582.9 5651.5 5663.0 5705.0 5772.9 5394.4 5417.6 5427.2 5434.0 5469.2 6224.5 6257.8 6271.1 6279.6 6297.5 6145.6 6219.8 6275.2 6302.7 6327.1 6263.7 6287.0 6290.9 6292.9 6298.3 6144.1 6169.0 6174.3 6189.1 6202.3 6086.9 6144.4 6157.3 6264.3 6304.1 6069.6 6093.4 6111.8 6119.1 6120.1 5941.7 6109.8 6124.5 6136.2 6139.0 5862.9 5914.9 5935.2 5941.4 6015.0 6110.4 6114.0 6120.3 6129.0 6139.7 5812.7 5888.3 5934.5 5945.4 5946.7 09:32:40 INFO - PROCESS | 1653 | 09:32:40 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:80202.62 Median:39211.51 stddev:185607.71 (473.4%) stddev-sans-first:186031.89 09:32:40 INFO - PROCESS | 1653 | Values: 489.5 512.9 517.4 530.3 544.0 30321.2 31129.1 42979.0 43862.6 43971.6 45019.5 45386.1 45483.5 45570.9 45662.8 9701.8 9864.7 9884.2 9890.9 9892.8 8711.3 8920.1 8940.1 8996.9 9002.0 11827.0 12043.9 12069.5 12228.6 12251.1 12021.6 12103.6 12112.8 12127.2 12131.9 8627.2 8831.1 11797.6 11917.4 11939.9 33080.3 33412.7 36656.6 41761.5 42028.8 3519.7 3546.5 3600.5 3688.3 3843.8 32310.0 32581.3 32604.0 32938.5 33393.3 3253.7 3265.6 3306.9 3373.6 3431.8 551857.0 553536.0 553636.0 554388.0 554593.0 55763.0 64261.7 65317.3 65430.0 69507.0 66630.0 66825.3 66846.0 67035.7 67047.3 16613.5 16707.3 16846.2 16851.7 16890.7 12772.2 12894.0 12935.6 13066.5 13076.3 12964.5 16323.2 16342.2 17960.8 17991.5 5876.5 7115.4 7228.7 7257.8 7277.9 834.8 870.8 996.4 1036.6 1137.1 26500.3 27276.0 28489.4 29550.4 29605.4 1035.0 1104.6 1112.6 1196.2 1214.6 12731.9 12977.7 15278.3 15378.0 15422.0 591258.0 596268.0 602548.0 603949.0 604475.0 54500.7 61211.0 61414.4 62855.7 62921.0 1401.8 1407.5 1430.0 1435.9 1436.5 31276.4 32431.8 32632.2 32643.8 33382.5 54769.5 55323.4 55445.0 55448.0 55510.7 847810.0 877661.0 879686.0 879704.0 883386.0 39781.6 39808.4 40660.8 40938.7 40952.2 48236.0 48336.0 48635.0 48796.5 48818.0 32975.8 39947.0 39977.8 40007.0 40660.6 37512.2 40098.2 40294.0 40787.7 40830.6 38161.2 38334.0 39135.4 39156.0 39267.0 29792.7 34444.1 35133.3 35260.8 36913.1 25776.5 25909.1 26017.5 26246.0 26421.3 09:32:40 INFO - PROCESS | 1653 | 09:32:40 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:35922.33 Median:2424.72 stddev:99903.22 (4120.2%) stddev-sans-first:100147.80 09:32:40 INFO - PROCESS | 1653 | Values: 361.4 382.9 389.4 392.8 410.2 15353.4 15675.3 19304.2 21307.6 21321.8 21102.0 21252.6 22121.2 22179.1 22243.0 5210.3 5825.9 6078.1 6085.8 6116.6 5746.5 5793.7 5813.8 5819.1 5821.2 5781.9 5831.3 6151.1 6155.9 6189.4 5302.9 6126.5 6149.5 6155.2 6179.1 5882.9 5961.1 5981.1 5990.7 5994.0 13644.0 17286.7 18912.2 25610.5 25648.0 2238.3 2395.3 2454.2 2508.6 2883.5 9280.5 10749.4 12959.7 13746.4 16288.4 1829.3 1920.8 1947.2 1958.0 1997.8 124485.0 129462.4 131309.7 132282.7 133728.0 11447.3 11636.3 11649.2 11668.4 11814.6 14626.9 14657.8 14674.3 14693.6 14694.4 7057.3 8655.7 8721.6 8755.6 8806.8 8723.2 8748.3 8763.5 8831.3 8879.4 3764.8 4554.0 4556.3 4573.4 4663.3 1875.4 1909.9 1914.5 1916.5 1925.7 713.5 850.4 953.7 997.0 1008.5 16844.7 20493.2 21066.6 21095.4 21107.2 937.2 951.7 960.2 969.6 995.1 10953.2 11189.3 11469.9 11491.4 11497.8 581390.0 581698.0 588073.0 591471.0 625352.0 106715.0 144780.0 145446.5 146050.0 148222.0 968.1 985.4 1032.7 1053.7 1060.1 19900.3 20258.0 20280.9 20323.9 20398.0 52509.0 56068.9 56972.0 60560.0 61878.7 69842.7 87078.0 91025.6 92474.4 92485.1 8018.5 8181.0 8365.7 8405.0 8592.8 11400.8 13139.9 13302.0 13330.9 13569.3 9436.4 11522.5 11638.7 11822.6 11892.4 11017.3 11216.7 11336.0 11488.4 11567.7 11402.3 11753.7 11890.6 11923.9 12068.5 8261.6 8315.4 8352.8 8364.2 8391.8 8484.2 11229.2 11520.3 11573.9 11717.8 09:32:40 INFO - PROCESS | 1653 | 09:32:40 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5686.48 Median:4880.88 stddev:3195.00 (65.5%) stddev-sans-first:3188.81 09:32:40 INFO - PROCESS | 1653 | Values: 1545.5 1578.7 1827.4 1966.3 1998.7 8530.0 8798.9 8962.6 8979.6 8985.2 7854.5 8099.5 8500.0 8767.0 8781.7 2334.6 2361.3 2363.7 2366.2 2366.4 2331.6 2335.5 2380.3 2384.8 2391.3 2082.6 2156.8 2161.6 2172.2 2173.1 2302.6 2374.5 2380.9 2381.9 2384.1 2351.3 2370.2 2377.0 2379.9 2388.3 7837.4 8054.7 8056.4 8860.8 8928.9 4841.4 5193.6 5362.4 5391.2 5403.1 3539.9 3549.9 3614.9 3616.3 3627.0 1052.6 1056.8 1060.7 1080.2 1082.2 11628.5 11745.4 11749.5 11756.3 11772.7 4566.9 4575.2 4801.7 4804.6 4806.3 9983.4 9994.7 10006.5 10006.6 10027.0 5370.0 5378.5 5379.5 5379.7 5381.3 4693.1 4872.5 4889.3 4903.9 4919.1 3723.6 3772.1 3809.9 3829.6 3868.5 1001.1 1156.7 1164.5 1171.9 1175.8 843.2 854.8 923.9 938.7 960.5 5860.3 6093.0 6095.3 6176.7 6262.2 423.3 433.0 433.9 444.9 457.3 3770.7 3980.8 4106.0 4170.3 4190.3 9509.0 10633.3 10676.6 10763.0 10839.0 10617.8 10720.4 10725.3 10752.2 10778.8 7973.8 8173.1 8180.0 8182.6 8229.6 5785.9 6033.6 6053.8 6242.7 6274.4 9361.3 10010.7 10044.6 10046.1 10060.0 9875.7 9954.9 9991.8 10006.3 10017.7 7306.8 7411.9 7461.9 7486.3 7505.5 7147.7 8273.1 8320.5 8396.8 8403.3 6060.4 7469.3 7543.1 7616.1 7737.1 7165.4 7311.0 7311.5 7379.6 7403.1 6938.6 6979.4 7039.3 7040.5 7045.5 4926.0 5076.4 5130.2 5167.1 5203.6 5104.2 5107.7 5138.4 5182.7 5337.7 09:32:40 INFO - PROCESS | 1653 | 09:32:40 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4452.83 Median:4962.97 stddev:1385.22 (27.9%) stddev-sans-first:1352.87 09:32:40 INFO - PROCESS | 1653 | Values: 258.9 301.4 314.1 318.6 319.5 5131.7 5361.4 5421.6 5435.0 5437.6 5061.7 5185.0 5350.9 5384.8 5391.7 4073.1 4074.3 4079.3 4087.9 4109.6 3879.6 4076.5 4119.8 4124.3 4147.5 3978.6 4004.6 4028.4 4033.5 4037.8 3236.5 4018.1 4022.7 4058.7 4072.4 3488.8 3496.5 3505.8 3509.9 3529.1 4879.3 5166.8 5198.5 5245.3 5286.4 3817.9 4514.0 4569.3 4572.7 4588.3 4612.7 4855.7 5048.1 5436.9 5602.4 2917.3 3315.0 3764.1 3820.2 3846.0 5052.7 5666.8 5843.0 5865.4 5889.2 3232.7 3856.2 3868.7 3869.8 3875.7 3608.6 3833.2 3913.2 3913.7 3933.4 3804.8 4183.5 4444.1 4532.0 4564.7 4614.4 4885.4 5292.9 5548.1 5608.0 1277.1 1301.2 1337.4 1339.3 1345.7 870.5 883.9 896.7 900.6 903.6 4506.8 4797.6 5113.6 5210.8 5224.8 5675.1 5691.7 5696.6 5713.2 5718.8 4856.0 4905.4 5195.5 5224.9 5225.3 2267.6 2410.2 2432.9 2538.0 2551.6 3985.3 4395.5 4417.6 4478.2 4991.3 3910.0 4310.0 4889.9 4918.5 5334.3 4843.6 5128.7 5257.2 6011.8 6112.0 4980.7 5318.0 5395.0 5603.6 5830.0 5404.5 5790.5 5814.5 5839.9 5854.4 5006.0 5014.0 5897.2 6085.7 6089.7 3851.0 3922.7 3928.3 3941.1 3957.0 5377.0 5501.5 5819.8 5887.0 6031.8 4767.4 5298.2 5312.4 5535.6 5772.6 5686.9 5700.8 5704.9 5707.8 5713.7 4678.1 5080.6 5273.1 5564.0 5607.5 4945.2 5663.6 5709.9 5713.0 5760.6 5572.1 5586.8 5595.6 5596.8 5601.8 09:32:40 INFO - PROCESS | 1653 | 09:32:40 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:22395.80 Median:2594.95 stddev:35127.42 (1353.7%) stddev-sans-first:35188.16 09:32:40 INFO - PROCESS | 1653 | Values: 689.5 718.1 724.3 740.4 791.4 15177.7 15715.8 16014.3 16023.8 16077.7 14960.9 15132.1 15158.4 15178.9 15249.2 629.8 731.3 869.8 894.9 899.2 876.7 902.8 908.5 910.3 911.9 899.1 907.3 908.2 909.0 909.1 735.3 904.8 905.0 917.4 941.6 695.3 695.6 696.0 696.3 697.2 14997.4 15067.8 15079.8 15104.1 15125.9 13877.4 13963.9 13994.9 14015.0 14372.4 11837.3 11879.3 11930.9 11971.1 12053.7 4555.7 4574.8 4580.0 4736.0 4776.7 109249.2 110219.0 116648.0 117188.8 117202.0 11068.5 11117.3 11173.6 11203.6 11516.5 21761.7 21895.0 21919.1 21928.7 22127.0 7888.3 7899.3 7998.4 8090.4 8201.8 4401.5 4602.2 4611.6 4698.3 4718.5 3523.3 3656.8 3659.2 3661.9 3668.1 562.4 668.7 678.2 678.6 688.7 471.4 598.0 620.8 654.7 668.5 7757.9 8523.2 8758.1 9001.2 9172.5 588.8 614.8 623.4 637.1 647.1 3685.6 4211.9 4466.4 4500.1 4536.9 109182.5 121347.4 151105.7 151688.0 152236.2 64495.7 81326.0 83382.2 83911.6 114562.0 68493.0 69305.7 87381.0 100148.0 104888.0 8400.3 8444.2 8456.2 8531.0 8746.4 60632.7 61748.7 61764.0 62632.0 63618.4 68238.7 94135.0 94732.0 94809.0 97488.5 10842.0 10885.5 11011.6 11063.3 11244.1 10123.6 12199.5 12248.6 12260.7 12669.0 11699.8 11739.6 11899.5 11984.2 12366.9 11365.7 11448.2 11542.7 11808.0 11975.2 11488.5 11735.0 11735.6 11765.5 11989.5 8324.8 9205.9 9565.2 9777.2 9932.2 9180.3 9666.1 9667.4 9802.7 9888.0 09:32:40 INFO - PROCESS | 1653 | -------- Summary: end -------- 09:32:40 INFO - PROCESS | 1653 | 09:32:41 INFO - TEST-INFO | 1653: exit 0 09:32:41 INFO - TEST-OK | dromaeo_css | took 1116660ms 09:32:41 INFO - TEST-START | kraken 09:32:41 INFO - operating with platform_type : mac_ 09:32:41 INFO - Initialising browser for kraken test... 09:32:41 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmpnAr1hk/profile http://localhost:49271/getInfo.html) 09:32:43 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 09:32:43 INFO - PROCESS | 1661 | colorDepth:24 09:32:43 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 09:32:43 INFO - PROCESS | 1661 | __metrics 09:32:43 INFO - PROCESS | 1661 | 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" 09:32:43 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:32:44 INFO - TEST-INFO | 1661: exit 0 09:32:44 INFO - Browser initialized. 09:32:44 INFO - Running cycle 1/1 for kraken test... 09:32:44 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmpnAr1hk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:32:56 INFO - PROCESS | 1662 | RSS: Main: 245084160 09:32:56 INFO - PROCESS | 1662 | 09:32:59 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 09:32:59 INFO - PROCESS | 1662 | RSS: Main: 294490112 09:32:59 INFO - PROCESS | 1662 | 09:33:02 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 09:33:03 INFO - PROCESS | 1662 | RSS: Main: 304726016 09:33:03 INFO - PROCESS | 1662 | 09:33:06 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 09:33:07 INFO - PROCESS | 1662 | RSS: Main: 394752000 09:33:07 INFO - PROCESS | 1662 | 09:33:09 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 09:33:09 INFO - PROCESS | 1662 | RSS: Main: 295075840 09:33:09 INFO - PROCESS | 1662 | 09:33:11 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:33:12 INFO - PROCESS | 1662 | RSS: Main: 298418176 09:33:12 INFO - PROCESS | 1662 | 09:33:15 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 09:33:16 INFO - PROCESS | 1662 | RSS: Main: 335884288 09:33:16 INFO - PROCESS | 1662 | 09:33:19 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 09:33:19 INFO - PROCESS | 1662 | RSS: Main: 337289216 09:33:19 INFO - PROCESS | 1662 | 09:33:22 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 09:33:23 INFO - PROCESS | 1662 | RSS: Main: 336953344 09:33:23 INFO - PROCESS | 1662 | 09:33:24 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:33:25 INFO - PROCESS | 1662 | RSS: Main: 314290176 09:33:25 INFO - PROCESS | 1662 | 09:33:27 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:33:28 INFO - PROCESS | 1662 | RSS: Main: 321249280 09:33:28 INFO - PROCESS | 1662 | 09:33:30 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:33:30 INFO - PROCESS | 1662 | RSS: Main: 318636032 09:33:30 INFO - PROCESS | 1662 | 09:33:33 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:33:34 INFO - PROCESS | 1662 | RSS: Main: 327602176 09:33:34 INFO - PROCESS | 1662 | 09:33:37 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:33:37 INFO - PROCESS | 1662 | RSS: Main: 328912896 09:33:37 INFO - PROCESS | 1662 | 09:33:39 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 09:33:39 INFO - PROCESS | 1662 | RSS: Main: 372207616 09:33:39 INFO - PROCESS | 1662 | 09:33:39 INFO - PROCESS | 1662 | __start_tp_report 09:33:39 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 09:33:39 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 09:33:39 INFO - PROCESS | 1662 | |i|pagename|runs| 09:33:39 INFO - PROCESS | 1662 | |0;ai-astar;101;111;114;113;113;112;114;112;113;113 09:33:39 INFO - PROCESS | 1662 | |1;audio-beat-detection;142;108;110;156;106;106;128;105;138;107 09:33:39 INFO - PROCESS | 1662 | |2;audio-dft;183;185;184;183;183;184;185;181;182;184 09:33:39 INFO - PROCESS | 1662 | |3;audio-fft;80;75;56;108;58;57;62;60;123;57 09:33:39 INFO - PROCESS | 1662 | |4;audio-oscillator;81;86;92;71;72;67;96;70;67;99 09:33:39 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;89;87;89;87;87;86;89;86;94;130 09:33:39 INFO - PROCESS | 1662 | |6;imaging-darkroom;95;101;94;96;137;150;95;95;94;94 09:33:39 INFO - PROCESS | 1662 | |7;imaging-desaturate;85;86;90;87;86;85;84;83;103;135 09:33:39 INFO - PROCESS | 1662 | |8;json-parse-financial;58;55;56;56;55;56;53;54;54;56 09:33:39 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;65;65;78;79;74;73;71;71;71;72 09:33:39 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;83;81;83;85;80;81;84;80;80;77 09:33:39 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;135;141;146;136;135;130;133;136;181;137 09:33:39 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;167;161;161;164;163;165;162;160;161;161 09:33:39 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;68;75;85;85;85;67;65;67;66;66 09:33:39 INFO - PROCESS | 1662 | __end_tp_report 09:33:39 INFO - PROCESS | 1662 | __start_cc_report 09:33:39 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1975 09:33:39 INFO - PROCESS | 1662 | __end_cc_report 09:33:39 INFO - PROCESS | 1662 | __startTimestamp1467736419722__endTimestamp 09:33:39 INFO - PROCESS | 1662 | 09:33:39 INFO - PROCESS | 1662 | ------- Summary: start ------- 09:33:39 INFO - PROCESS | 1662 | Number of tests: 14 09:33:39 INFO - PROCESS | 1662 | 09:33:39 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:111.60 Median:113.00 stddev:3.84 (3.4%) stddev-sans-first:0.97 09:33:39 INFO - PROCESS | 1662 | Values: 101.0 111.0 114.0 113.0 113.0 112.0 114.0 112.0 113.0 113.0 09:33:39 INFO - PROCESS | 1662 | 09:33:39 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:120.60 Median:119.00 stddev:18.84 (15.8%) stddev-sans-first:18.32 09:33:39 INFO - PROCESS | 1662 | Values: 142.0 108.0 110.0 156.0 106.0 106.0 128.0 105.0 138.0 107.0 09:33:39 INFO - PROCESS | 1662 | 09:33:39 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:1.26 (0.7%) stddev-sans-first:1.33 09:33:39 INFO - PROCESS | 1662 | Values: 183.0 185.0 184.0 183.0 183.0 184.0 185.0 181.0 182.0 184.0 09:33:39 INFO - PROCESS | 1662 | 09:33:39 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:73.60 Median:59.00 stddev:23.78 (40.3%) stddev-sans-first:25.11 09:33:39 INFO - PROCESS | 1662 | Values: 80.0 75.0 56.0 108.0 58.0 57.0 62.0 60.0 123.0 57.0 09:33:39 INFO - PROCESS | 1662 | 09:33:39 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:80.10 Median:83.50 stddev:12.39 (14.8%) stddev-sans-first:13.13 09:33:39 INFO - PROCESS | 1662 | Values: 81.0 86.0 92.0 71.0 72.0 67.0 96.0 70.0 67.0 99.0 09:33:39 INFO - PROCESS | 1662 | 09:33:39 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:92.40 Median:88.00 stddev:13.42 (15.2%) stddev-sans-first:14.18 09:33:39 INFO - PROCESS | 1662 | Values: 89.0 87.0 89.0 87.0 87.0 86.0 89.0 86.0 94.0 130.0 09:33:39 INFO - PROCESS | 1662 | 09:33:39 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:105.10 Median:94.50 stddev:20.57 (21.8%) stddev-sans-first:21.49 09:33:39 INFO - PROCESS | 1662 | Values: 95.0 101.0 94.0 96.0 137.0 150.0 95.0 95.0 94.0 94.0 09:33:39 INFO - PROCESS | 1662 | 09:33:39 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:92.40 Median:85.50 stddev:16.03 (18.7%) stddev-sans-first:16.78 09:33:39 INFO - PROCESS | 1662 | Values: 85.0 86.0 90.0 87.0 86.0 85.0 84.0 83.0 103.0 135.0 09:33:39 INFO - PROCESS | 1662 | 09:33:39 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:56.00 stddev:1.42 (2.5%) stddev-sans-first:1.12 09:33:39 INFO - PROCESS | 1662 | Values: 58.0 55.0 56.0 56.0 55.0 56.0 53.0 54.0 54.0 56.0 09:33:39 INFO - PROCESS | 1662 | 09:33:39 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:72.50 stddev:4.61 (6.4%) stddev-sans-first:4.15 09:33:39 INFO - PROCESS | 1662 | Values: 65.0 65.0 78.0 79.0 74.0 73.0 71.0 71.0 71.0 72.0 09:33:39 INFO - PROCESS | 1662 | 09:33:39 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:82.00 stddev:2.37 (2.9%) stddev-sans-first:2.44 09:33:39 INFO - PROCESS | 1662 | Values: 83.0 81.0 83.0 85.0 80.0 81.0 84.0 80.0 80.0 77.0 09:33:39 INFO - PROCESS | 1662 | 09:33:39 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:141.00 Median:136.50 stddev:14.71 (10.8%) stddev-sans-first:15.44 09:33:39 INFO - PROCESS | 1662 | Values: 135.0 141.0 146.0 136.0 135.0 130.0 133.0 136.0 181.0 137.0 09:33:39 INFO - PROCESS | 1662 | 09:33:39 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.50 Median:162.50 stddev:2.22 (1.4%) stddev-sans-first:1.66 09:33:39 INFO - PROCESS | 1662 | Values: 167.0 161.0 161.0 164.0 163.0 165.0 162.0 160.0 161.0 161.0 09:33:39 INFO - PROCESS | 1662 | 09:33:39 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.90 Median:71.50 stddev:8.79 (12.3%) stddev-sans-first:9.14 09:33:39 INFO - PROCESS | 1662 | Values: 68.0 75.0 85.0 85.0 85.0 67.0 65.0 67.0 66.0 66.0 09:33:39 INFO - PROCESS | 1662 | -------- Summary: end -------- 09:33:39 INFO - PROCESS | 1662 | 09:33:40 INFO - TEST-INFO | 1662: exit 0 09:33:40 INFO - TEST-OK | kraken | took 59365ms 09:33:40 INFO - SUITE-END | took 1176s 09:33:40 INFO - Completed test suite (00:19:36) 09:33:40 INFO - javascript benchmark 09:33:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3309.3381323735252, 3320.4355259605863, 3322.4185767490685, 3368.9157771055734, 3387.6612338766126, 5575.888482230353, 5672.829815105543, 5716.342620598627, 5774.220480235167, 5844.152597873306, 5663.5186009189165, 5706.1440783882335, 5710.343310519292, 5722.084466485363, 5733.627314224573, 5095.617828662856, 5154.4072431670465, 5159.71621560814, 5160.071187186305, 5218.947810521903, 5225.294585230983, 5253.947460525404, 5257.23770053342, 5257.421683614818, 5260.368755749297, 5153.227015947619, 5175.948240517603, 5181.818636347729, 5194.68831870089, 5247.212918062283, 5245.318108645852, 5246.711430871301, 5261.289725886994, 5265.183896496049, 5315.627906046579, 5060.67105638136, 5083.974580127113, 5107.719075450848, 5174.896502069975, 5176.870578235536, 5653.265075540154, 5660.688662123582, 5686.829395118111, 5716.685582292972, 5746.138079288098, 6202.596831205957, 6202.627842329474, 6205.0, 6208.50331973441, 6222.253329600431, 6050.48570871472, 6125.235451818339, 6128.136482154514, 6225.221847269091, 6227.408396202353, 5742.368339482654, 5772.191893134965, 5787.160861675034, 5805.274340707411, 5806.59353845231, 6191.00943848982, 6219.968900155561, 6221.2845522764555, 6231.813045608548, 6232.096346029891, 6018.00702884028, 6082.1789058477425, 6088.908666370008, 6108.664023478663, 6129.356417576179, 6204.286507051656, 6216.7824126155365, 6249.75000999964, 6253.062040693932, 6255.843603909848, 6136.447719705158, 6153.538484613582, 6167.352427995085, 6182.845428864224, 6184.103305020837, 6105.550726437353, 6109.358517355702, 6130.703893785035, 6249.281332646713, 6274.874502510015, 4837.129316723023, 4860.052289803454, 4862.270659401118, 4866.562009419169, 4873.658843880894, 4363.410939523187, 4391.582799634093, 4400.009997750544, 4414.359917811964, 4440.245158323093, 5716.542676585863, 5729.942700572941, 5731.8567035824435, 5743.195952566644, 5778.0, 6208.255009398811, 6282.4883464363165, 6299.149614801943, 6341.460975817107, 6347.270063942706, 5582.888342233133, 5651.547876169897, 5663.0, 5705.001624715741, 5772.942270577324, 5394.406615272317, 5417.6478528895495, 5427.213054107211, 5434.021876062267, 5469.206964990054, 6224.470919971853, 6257.78097766576, 6271.122042913996, 6279.591826531261, 6297.464715499143, 6145.586515101641, 6219.782307619212, 6275.246970363585, 6302.747890084345, 6327.145835312358, 6263.686815659108, 6287.0, 6290.874182516232, 6292.905606415999, 6298.307186209422, 6144.10910417978, 6169.01295792671, 6174.289956655042, 6189.071639253968, 6202.2867370253, 6086.939130608637, 6144.41628045335, 6157.291911430243, 6264.31092579825, 6304.05439184126, 6069.635821850703, 6093.360197179232, 6111.755529778937, 6119.082137679384, 6120.143179954899, 5941.732622031933, 6109.84725381869, 6124.510039196943, 6136.171616831671, 6139.017757158833, 5862.882742345044, 5914.881702365842, 5935.169076329231, 5941.435563621449, 6015.037593984942, 6110.365674210153, 6113.98035644981, 6120.26428866606, 6129.022607377628, 6139.737467782926, 5812.73842677089, 5888.3228428731245, 5934.495567876779, 5945.435183657545, 5946.73239704223], "value": 5691.224421217836, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.48359480747797, 512.8769095417099, 517.3972322244585, 530.2629345210157, 543.9881819815143, 30321.24196895076, 31129.066128016166, 42978.99999999996, 43862.56137438625, 43971.56028439714, 45019.54980450195, 45386.092278154414, 45483.54516454835, 45570.860728481806, 45662.771686141605, 9701.757456063602, 9864.654737084204, 9884.159846413064, 9890.901090989106, 9892.752681182956, 8711.346649001318, 8920.10798920106, 8940.06129356418, 8996.8650470243, 9001.954990225073, 11826.994705450046, 12043.939780301087, 12069.517219311218, 12228.633141005785, 12251.142420030601, 12021.639350819445, 12103.636890893287, 12112.757744845097, 12127.151099423045, 12131.878681213164, 8627.180417860356, 8831.116888311182, 11797.587084452003, 11917.404129793476, 11939.940300298444, 33080.338393232, 33412.665873341444, 36656.633433665585, 41761.53834615774, 42028.78985605083, 3519.683228509421, 3546.4680297955256, 3600.5499312585926, 3688.3360995020885, 3843.7885916274595, 32310.0, 32581.348373032408, 32604.0, 32938.50592241118, 33393.332133357195, 3253.6746325367512, 3265.5591495148087, 3306.9007929762147, 3373.595168579762, 3431.759776815624, 551857.0, 553536.0, 553636.0, 554388.0, 554593.0, 55763.0, 64261.67869160718, 65317.346826531124, 65430.01854972179, 69507.0, 66630.00054999179, 66825.33174668289, 66846.0, 67035.66482167559, 67047.32952670509, 16613.50159495217, 16707.33170673184, 16846.24191911367, 16851.662966740598, 16890.662186756195, 12772.169808962388, 12894.0, 12935.611931642066, 13066.54267100647, 13076.280804555841, 12964.481420743065, 16323.183840807913, 16342.182890855409, 17960.820391795914, 17991.460256192335, 5876.503480429138, 7115.430765538745, 7228.674709638079, 7257.782266532013, 7277.854442911218, 834.7620928035602, 870.8345414371249, 996.3922007575374, 1036.6423583863555, 1137.0562433180605, 26500.337491562866, 27276.0, 28489.43021139607, 29550.37472939009, 29605.407891842042, 1035.0477560644226, 1104.6078642082107, 1112.6272698645882, 1196.1626861197024, 1214.5809695655162, 12731.93634031824, 12977.740445191042, 15278.31247593861, 15378.0, 15422.0, 591258.0, 596268.0, 602548.0, 603949.0, 604475.0, 54500.72749636226, 61211.0, 61414.38585614086, 62855.74288514296, 62921.0, 1401.7757158854533, 1407.5214427094836, 1429.957101286963, 1435.8707716305373, 1436.4613270023742, 31276.374472510877, 32431.837840810644, 32632.184195395304, 32643.836780815946, 33382.49778759913, 54769.452305476436, 55323.44676553183, 55445.0, 55448.0, 55510.72244638751, 847810.0, 877661.0, 879686.0, 879704.0, 883386.0, 39781.60218397895, 39808.40287395634, 40660.79669601751, 40938.701436348754, 40952.1809563813, 48236.0, 48336.0, 48635.0, 48796.5120348792, 48818.0, 32975.8351208252, 39947.0, 39977.80011100042, 40007.0, 40660.59339406568, 37512.249755005294, 40098.1980360397, 40293.99265018398, 40787.705369229705, 40830.591694083865, 38161.23677526489, 38334.0, 39135.41296880492, 39156.0, 39267.018324542114, 29792.70207297986, 34444.13889652779, 35133.297334053685, 35260.82369588238, 36913.07717307089, 25776.484470310115, 25909.14973469628, 26017.479650407266, 26246.0, 26421.33946651349], "value": 21020.165907058403, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.38744827517337, 382.8640832504461, 389.39060370520133, 392.8428628548581, 410.1509874559663, 15353.385864565418, 15675.29461174247, 19304.227830886783, 21307.57384852302, 21321.786782132174, 21102.0, 21252.57494850102, 22121.225757098506, 22179.11283548656, 22242.999065042073, 5210.348706411699, 5825.941740582603, 6078.088286756978, 6085.752420753757, 6116.633002019871, 5746.48281654651, 5793.681347525884, 5813.796517121901, 5819.127130930352, 5821.214136091637, 5781.913271300934, 5831.30024397073, 6151.077338399231, 6155.938440615604, 6189.38106189382, 5302.946970530323, 6126.509879209675, 6149.538784591129, 6155.19982402287, 6179.073139029137, 5882.941170588282, 5961.076033214858, 5981.102834574848, 5990.670513121777, 5994.040953447471, 13644.0, 17286.740698889527, 18912.243510259574, 25610.48779024428, 25648.0, 2238.2725614175456, 2395.2574701842486, 2454.1778504200934, 2508.5610018246734, 2883.4521440926364, 9280.489573073479, 10749.355038697704, 12959.67600809978, 13746.381412836346, 16288.42990495327, 1829.2591500442343, 1920.807919208082, 1947.1529884500287, 1958.0405601255425, 1997.800219978005, 124485.0, 129462.3526882369, 131309.6869031307, 132282.677173228, 133728.0, 11447.313161210188, 11636.301821890713, 11649.184557080924, 11668.358240296695, 11814.645560633024, 14626.926865365605, 14657.780133297796, 14674.266286685623, 14693.55919322422, 14694.412223511154, 7057.258987806309, 8655.6537738491, 8721.563921803885, 8755.56222188888, 8806.77983050416, 8723.214910657944, 8748.34387420946, 8763.518006509576, 8831.3376496763, 8879.422837515542, 3764.7741135531955, 4554.0, 4556.316552517149, 4573.382593349856, 4663.253879379283, 1875.4467432107288, 1909.9140538675792, 1914.5117994911486, 1916.4729699332795, 1925.663008973424, 713.4542075312287, 850.3919697416377, 953.7329547726648, 996.9651062212788, 1008.4503945349802, 16844.663106737797, 20493.18027278922, 21066.578668426544, 21095.367138985854, 21107.155713771583, 937.1659223291276, 951.7097285328041, 960.188640598693, 969.5927710361665, 995.0994350113159, 10953.2072762087, 11189.272697274651, 11469.88530114705, 11491.42542872853, 11497.770044599229, 581390.0, 581698.0, 588073.0, 591471.0, 625352.0, 106715.0, 144780.0, 145446.5455345454, 146050.0, 148222.0, 968.1286841842398, 985.393982700634, 1032.6592224565875, 1053.6733612580124, 1060.1359891688248, 19900.303489377802, 20258.0, 20280.89859550752, 20323.882186479885, 20398.0, 52509.0, 56068.878622428136, 56972.0, 60560.0, 61878.690606546676, 69842.65078674574, 87078.0, 91025.6346154795, 92474.37628118701, 92485.07514924764, 8018.518888866687, 8180.9590952044855, 8365.707200248205, 8405.0, 8592.828143437222, 11400.771984560097, 13139.934300328438, 13302.0, 13330.933345333211, 13569.253691047088, 9436.386634868712, 11522.481488333213, 11638.6508404748, 11822.586209482626, 11892.405379730806, 11017.28387654832, 11216.719582010188, 11335.979761821145, 11488.368139752394, 11567.652970410902, 11402.315861048364, 11753.706157346134, 11890.643280701594, 11923.880761192277, 12068.51725930988, 8261.586920653823, 8315.417920745489, 8352.791180220544, 8364.247217750431, 8391.8251444799, 8484.236418722345, 11229.213955023397, 11520.251183673034, 11573.900479454775, 11717.824232636687], "value": 9800.663348975284, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1545.505438259757, 1578.7079390312792, 1827.4243613261822, 1966.2528239269093, 1998.7201791749148, 8530.03809123901, 8798.86801697975, 8962.641494340234, 8979.551022448875, 8985.23625491833, 7854.489458185214, 8099.473534220271, 8499.957500212506, 8767.0, 8781.736547903573, 2334.556434277486, 2361.3388251289666, 2363.6690863279155, 2366.1954935321987, 2366.3610825077217, 2331.62693968965, 2335.509542995973, 2380.33350661815, 2384.7972922301624, 2391.3184742348435, 2082.5938941906334, 2156.816670583002, 2161.5676864627058, 2172.196287373674, 2173.1307477009245, 2302.631578947369, 2374.5132247889314, 2380.916682909272, 2381.892814823337, 2384.1297926256966, 2351.341624345186, 2370.2415227127326, 2376.989779343772, 2379.9286021419384, 2388.3073908566494, 7837.373010159174, 8054.718084867001, 8056.436049476539, 8860.822783544292, 8928.910710892873, 4841.394825646794, 5193.584513238932, 5362.410134885159, 5391.191321301797, 5403.054465468527, 3539.9292014159573, 3549.8580056797696, 3614.9096272593397, 3616.33097876891, 3626.9818650906577, 1052.6000119954444, 1056.7622284985894, 1060.734816295926, 1080.2168427889796, 1082.1991726122692, 11628.476718547685, 11745.412729363497, 11749.4712737927, 11756.294622322688, 11772.705682357924, 4566.908661826745, 4575.24508456101, 4801.735904525284, 4804.591609713144, 4806.279058141306, 9983.400995940267, 9994.700158995242, 10006.54970526328, 10006.599736010477, 10027.0, 5370.0, 5378.489043540857, 5379.54273886724, 5379.704116273642, 5381.300430943952, 4693.131770622445, 4872.4883887192045, 4889.266610008527, 4903.926441103386, 4919.114559379346, 3723.590405055442, 3772.13240954582, 3809.9141744603207, 3829.636184562462, 3868.5357757069332, 1001.0540039662449, 1156.7108222944264, 1164.5341863254766, 1171.8886705762939, 1175.7589694112687, 843.1947490146895, 854.8204876975781, 923.8845144356956, 938.7183844846655, 960.4943633886755, 5860.326062502867, 6092.994655881818, 6095.2685677718955, 6176.718370583298, 6262.2172228471445, 423.30577852322216, 432.9567043295645, 433.90655548018816, 444.8887778055486, 457.2866328527441, 3770.66141519762, 3980.8407663693706, 4106.0, 4170.311898536768, 4190.308599081118, 9509.0, 10633.255672102878, 10676.626318078985, 10763.0, 10839.0, 10617.84073238902, 10720.41037742916, 10725.30285531438, 10752.19358548112, 10778.784424311627, 7973.800654983555, 8173.060098088677, 8179.977502812268, 8182.590870456454, 8229.588520573947, 5785.942140578709, 6033.637981721111, 6053.848653783691, 6242.687865606611, 6274.403931626488, 9361.344705870524, 10010.749731256778, 10044.598216071276, 10046.095851373411, 10060.0, 9875.703728888146, 9954.850677239992, 9991.800163996533, 10006.29955903109, 10017.69946901594, 7306.780796576111, 7411.925880741339, 7461.888071679038, 7486.288802563748, 7505.4746167767735, 7147.678354473957, 8273.131321211427, 8320.500769953822, 8396.790080248044, 8403.327733781161, 6060.39396060408, 7469.253074692488, 7543.115295622868, 7616.124145723091, 7737.0715514138665, 7165.3551180394015, 7310.96344518274, 7311.4516411268305, 7379.557226566423, 7403.074615673041, 6938.5836849789175, 6979.441644668313, 7039.260877607778, 7040.5071644984355, 7045.471589630901, 4926.014797040678, 5076.416212135652, 5130.179171332569, 5167.095758242368, 5203.609729270244, 5104.157813960804, 5107.719075450886, 5138.3833939927445, 5182.714950677598, 5337.706426146599], "value": 4487.964847904101, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [258.9054994926852, 301.3987095743991, 314.10010320431957, 318.5683398994361, 319.5382672038905, 5131.743412829353, 5361.356637203531, 5421.638584077872, 5435.043384381619, 5437.6465529740535, 5061.6962982221, 5185.0, 5350.892982140354, 5384.811531596395, 5391.676499410039, 4073.144639625682, 4074.30736774749, 4079.2663118174805, 4087.9182416351655, 4109.589041095882, 3879.573246942834, 4076.4700588923397, 4119.773412462313, 4124.340105583107, 4147.523034850986, 3978.582248863871, 4004.579519150491, 4028.436018957348, 4033.475648165734, 4037.777922214277, 3236.4983427568764, 4018.1160144768105, 4022.6781857451333, 4058.6753059755147, 4072.409500622408, 3488.790672559629, 3496.513981557853, 3505.7545971781988, 3509.91225219369, 3529.135361836341, 4879.268109783526, 5166.793328266865, 5198.4801519847715, 5245.26566280721, 5286.36563612369, 3817.9045523861846, 4513.977430112861, 4569.2689169732685, 4572.651067934968, 4588.334691469751, 4612.654050946159, 4855.708657480563, 5048.1418158913075, 5436.912617476521, 5602.38373778888, 2917.3144311086876, 3314.972308645008, 3764.1342491226897, 3820.2168555446065, 3845.9615403845883, 5052.661044823088, 5666.801661941812, 5843.0, 5865.354810970747, 5889.234399528077, 3232.7413806895393, 3856.2480316338047, 3868.7485313454536, 3869.845206191777, 3875.7093218008763, 3608.6376222634062, 3833.1758671885123, 3913.2173565287057, 3913.6673382762783, 3933.350997085449, 3804.7907365094634, 4183.5398106208295, 4444.066745983379, 4531.957649740512, 4564.672017271216, 4614.446266448048, 4885.386318319682, 5292.92060619091, 5548.0845660466375, 5608.0, 1277.0805020385308, 1301.2322729589587, 1337.4115389228903, 1339.337028171042, 1345.7039451320888, 870.5473153959905, 883.9337049721297, 896.7309807057857, 900.5546098511925, 903.584351198443, 4506.797194126272, 4797.56821886032, 5113.64204505681, 5210.76551555181, 5224.817131400383, 5675.1487276907965, 5691.723310675763, 5696.601237913306, 5713.228714123623, 5718.799842005593, 4855.95144048555, 4905.435874874435, 5195.506426889439, 5224.869378265574, 5225.294585231021, 2267.648514480258, 2410.1564452441507, 2432.8565574180107, 2537.974620253811, 2551.5838709516024, 3985.342418500973, 4395.472543294825, 4417.580329868657, 4478.2386994211065, 4991.301217829507, 3909.9609003909595, 4309.978450107729, 4889.926651100236, 4918.532739389752, 5334.279872217201, 4843.6367272454, 5128.743562821844, 5257.185136303879, 6011.759529618854, 6111.96944015277, 4980.726060066586, 5317.952588253473, 5394.973025134849, 5603.607747457639, 5830.0, 5404.459554044564, 5790.478856902899, 5814.5348372130975, 5839.912401314069, 5854.385289544536, 5005.974970125126, 5013.9721357122435, 5897.171876718231, 6085.66528840918, 6089.725962331794, 3850.9807450962567, 3922.666573341298, 3928.2929072767174, 3941.11324951895, 3957.0107473131716, 5376.978374108907, 5501.477359650827, 5819.76720931158, 5886.970565147318, 6031.819045428644, 4767.404074490689, 5298.231756395224, 5312.36251649789, 5535.557155427637, 5772.5959182856795, 5686.886262274814, 5700.800471983461, 5704.942950570441, 5707.800226992035, 5713.7428815704225, 4678.087772884255, 5080.568151707146, 5273.075327505509, 5564.0, 5607.467290607386, 4945.208766597471, 5663.575231857545, 5709.857253568694, 5713.0, 5760.6255593386295, 5572.080606699849, 5586.804461843816, 5595.5731288521165, 5596.796688711946, 5601.80393686219], "value": 4013.4204616487846, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.5173378634956, 718.0987860235404, 724.3155218318689, 740.4187712645574, 791.4420333664765, 15177.696446071071, 15715.764263536055, 16014.279357428915, 16023.798215133867, 16077.678446431064, 14960.925195374035, 15132.092074475539, 15158.393664253445, 15178.924105379485, 15249.237538123105, 629.8142048095823, 731.3125661877845, 869.7738587967127, 894.9373543851933, 899.1907283444887, 876.7369789063288, 902.7517432705993, 908.4776253654143, 910.3491003932187, 911.9498427586481, 899.0649724286734, 907.2696479334134, 908.1690253418114, 908.9727308180766, 909.1454033208796, 735.2500449541437, 904.7828521154942, 905.027095871937, 917.431192660548, 941.6139382852997, 695.2873304862505, 695.6452209373256, 696.0255642101099, 696.2689176364796, 697.2051860878552, 14997.400103995828, 15067.849321506754, 15079.773803392958, 15104.093754374662, 15125.924370378078, 13877.444902203899, 13963.860361396357, 13994.860051399559, 14015.018948673596, 14372.35324410404, 11837.348945807977, 11879.287242765375, 11930.88069119315, 11971.102167337398, 12053.698657533545, 4555.74943378114, 4574.794134263966, 4579.977100114478, 4735.952640473585, 4776.737279449629, 109249.16757491784, 110219.0, 116648.0, 117188.82811171864, 117202.0, 11068.501917413736, 11117.332960022424, 11173.608923687632, 11203.551857925755, 11516.481758320895, 21761.673574896387, 21895.0, 21919.123235070736, 21928.671069933964, 22127.0, 7888.32949199313, 7899.289063984269, 7998.400119990907, 8090.393220508486, 8201.79495512617, 4401.515833258339, 4602.217623004098, 4611.5619016193405, 4698.342232087511, 4718.528147185322, 3523.3129539739502, 3656.7988760618423, 3659.2315613720884, 3661.8901432957055, 3668.0646435158865, 562.3532937122342, 668.6523008035891, 678.1726293921408, 678.5996262205323, 688.7245101959256, 471.3683663890335, 597.9940200598026, 620.8106527509153, 654.6824789976857, 668.5420486966443, 7757.883631745528, 8523.190296921783, 8758.124187581318, 9001.18989290967, 9172.54137293146, 588.802751078385, 614.8493619063358, 623.3953065526432, 637.1398611873933, 647.064991087883, 3685.649863262986, 4211.894702632459, 4466.3747075409465, 4500.144972455223, 4536.931946020746, 109182.45408772906, 121347.39326303313, 151105.73341399888, 151688.0, 152236.2388188074, 64495.677521612095, 81326.0, 83382.16617833744, 83911.5804420974, 114562.0, 68493.0, 69305.65347173232, 87380.99999999873, 100147.99852001533, 104888.0, 8400.28597569189, 8444.240018398374, 8456.196661317164, 8531.0, 8746.431481953652, 60632.69683651553, 61748.69125654523, 61764.0, 62632.0, 63618.36381636124, 68238.65880670564, 94135.0, 94732.0, 94809.0, 97488.5125574396, 10841.95859872624, 10885.52054248118, 11011.61459348919, 11063.336199828036, 11244.100471962387, 10123.64567240143, 12199.51201951912, 12248.632541023784, 12260.693482663004, 12669.049821263257, 11699.824502632637, 11739.595517299887, 11899.46452409661, 11984.221025633306, 12366.938165309115, 11365.715857103638, 11448.198626096426, 11542.653720388402, 11807.992641250836, 11975.221610595283, 11488.495539901405, 11735.0, 11735.589254376056, 11765.470553824927, 11989.520419183134, 8324.750257492286, 9205.86191207119, 9565.234781217625, 9777.168940640126, 9932.155766759906, 9180.311476639145, 9666.081722236377, 9667.371620844622, 9802.731109164732, 9887.950560247153], "value": 7462.355032496345, "unit": "score"}], "name": "dromaeo_css", "value": 7349.614156031041, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 114.0, 113.0, 113.0, 112.0, 114.0, 112.0, 113.0, 113.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 108.0, 110.0, 156.0, 106.0, 106.0, 128.0, 105.0, 138.0, 107.0], "value": 120.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 184.0, 183.0, 183.0, 184.0, 185.0, 181.0, 182.0, 184.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 75.0, 56.0, 108.0, 58.0, 57.0, 62.0, 60.0, 123.0, 57.0], "value": 73.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 86.0, 92.0, 71.0, 72.0, 67.0, 96.0, 70.0, 67.0, 99.0], "value": 80.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 89.0, 87.0, 87.0, 86.0, 89.0, 86.0, 94.0, 130.0], "value": 92.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 101.0, 94.0, 96.0, 137.0, 150.0, 95.0, 95.0, 94.0, 94.0], "value": 105.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 90.0, 87.0, 86.0, 85.0, 84.0, 83.0, 103.0, 135.0], "value": 92.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 56.0, 56.0, 55.0, 56.0, 53.0, 54.0, 54.0, 56.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 78.0, 79.0, 74.0, 73.0, 71.0, 71.0, 71.0, 72.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 83.0, 85.0, 80.0, 81.0, 84.0, 80.0, 80.0, 77.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 141.0, 146.0, 136.0, 135.0, 130.0, 133.0, 136.0, 181.0, 137.0], "value": 141.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 161.0, 161.0, 164.0, 163.0, 165.0, 162.0, 160.0, 161.0, 161.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 75.0, 85.0, 85.0, 85.0, 67.0, 65.0, 67.0, 66.0, 66.0], "value": 72.9, "unit": "score"}], "name": "kraken", "value": 1444.2, "alertThreshold": 2.0}]} 09:33:40 INFO - Return code: 0 09:33:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:33:41 INFO - # TBPL SUCCESS # 09:33:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:33:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:33:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:33:41 INFO - 2016-07-05 09:33:41.022 screenresolution[1666:9724] starting screenresolution argv=screenresolution get 09:33:41 INFO - 2016-07-05 09:33:41.024 screenresolution[1666:9724] Display 0: 1600x1200x32@60 09:33:41 INFO - 2016-07-05 09:33:41.030 screenresolution[1667:9727] starting screenresolution argv=screenresolution list 09:33:41 INFO - Available Modes on Display 0 09:33:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:33:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:33:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:33:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:33:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:33:41 INFO - Intel Iris: 09:33:41 INFO - Chipset Model: Intel Iris 09:33:41 INFO - Type: GPU 09:33:41 INFO - Bus: Built-In 09:33:41 INFO - VRAM (Dynamic, Max): 1536 MB 09:33:41 INFO - Vendor: Intel (0x8086) 09:33:41 INFO - Device ID: 0x0a2e 09:33:41 INFO - Revision ID: 0x0009 09:33:41 INFO - Displays: 09:33:41 INFO - Display: 09:33:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:33:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:33:41 INFO - Display Serial Number: 1600x1200 60 09:33:41 INFO - Main Display: Yes 09:33:41 INFO - Mirror: Off 09:33:41 INFO - Online: Yes 09:33:41 INFO - Rotation: Supported 09:33:41 INFO - Return code: 0 09:33:41 INFO - Running post-action listener: _resource_record_post_action 09:33:41 INFO - ##### 09:33:41 INFO - ##### Finished run-tests step (success) 09:33:41 INFO - ##### 09:33:41 INFO - Running post-run listener: _resource_record_post_run 09:33:41 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 38176256; Write bytes: 709965312; Read time: 396; Write time: 2027 09:33:41 INFO - TinderboxPrint: CPU usage
53.4% 09:33:41 INFO - TinderboxPrint: I/O read bytes / time
38,176,256 / 396 09:33:41 INFO - TinderboxPrint: I/O write bytes / time
709,965,312 / 2,027 09:33:41 INFO - TinderboxPrint: CPU idle
2,258.0 (46.6%) 09:33:41 INFO - TinderboxPrint: CPU system
968.1 (20.0%) 09:33:41 INFO - TinderboxPrint: CPU user
1,623.5 (33.5%) 09:33:41 INFO - TinderboxPrint: Swap in / out
459,100,160 / 0 09:33:41 INFO - install - Wall time: 36s; CPU: 55.0%; Read bytes: 403923456; Write bytes: 397635072; Read time: 31104; Write time: 778 09:33:41 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 30830080; Write bytes: 294549504; Read time: 302; Write time: 1210 09:33:41 INFO - Running post-run listener: _upload_blobber_files 09:33:41 INFO - Blob upload gear active. 09:33:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:33:41 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 09:33:41 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:33:41 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:33:42 INFO - (blobuploader) - INFO - Open directory for files ... 09:33:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:33:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:33:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:33:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:33:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:33:42 INFO - (blobuploader) - INFO - Done attempting. 09:33:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:33:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:33:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:33:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:33:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:33:43 INFO - (blobuploader) - INFO - Done attempting. 09:33:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:33:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:33:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:33:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:33:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:33:46 INFO - (blobuploader) - INFO - Done attempting. 09:33:46 INFO - (blobuploader) - INFO - Iteration through files over. 09:33:46 INFO - Return code: 0 09:33:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:33:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:33:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/986c5a5cbadd955ab6bf78576ca2a68c90f2ac0a476b617ddf9cb8dd815354e0620d85e2ae7e14793f52300680a806fd1878e10a85b903ef58beccc9c5653805", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bc3dfa65d397d87dd2a315c146df96f52be59ef59d79183258fcdeba6bf31ce8f5653c53499ab7f79e1d095aa5efc12513f96b21e8cd779d3f542dd224db9c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6241899851838ce4825a50d411751fead52650a5f4b6a18a20e26f8f5d13958a15a511bd5809d9b087daed139ed6971d4407badcfddaab1023bd855013a104ec"} 09:33:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:33:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:33:46 INFO - Contents: 09:33:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/986c5a5cbadd955ab6bf78576ca2a68c90f2ac0a476b617ddf9cb8dd815354e0620d85e2ae7e14793f52300680a806fd1878e10a85b903ef58beccc9c5653805", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bc3dfa65d397d87dd2a315c146df96f52be59ef59d79183258fcdeba6bf31ce8f5653c53499ab7f79e1d095aa5efc12513f96b21e8cd779d3f542dd224db9c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6241899851838ce4825a50d411751fead52650a5f4b6a18a20e26f8f5d13958a15a511bd5809d9b087daed139ed6971d4407badcfddaab1023bd855013a104ec"} 09:33:46 INFO - Running post-run listener: copy_logs_to_upload_dir 09:33:46 INFO - Copying logs to upload dir... 09:33:46 INFO - mkdir: /builds/slave/test/build/upload/logs 09:33:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.863775 ========= master_lag: 1.59 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-07-05 09:33:47.881976) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 09:33:47.886508) ========= 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.Y1qSsKYrxN/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.IstenzZUWC/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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/Firefox/sha512/986c5a5cbadd955ab6bf78576ca2a68c90f2ac0a476b617ddf9cb8dd815354e0620d85e2ae7e14793f52300680a806fd1878e10a85b903ef58beccc9c5653805", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bc3dfa65d397d87dd2a315c146df96f52be59ef59d79183258fcdeba6bf31ce8f5653c53499ab7f79e1d095aa5efc12513f96b21e8cd779d3f542dd224db9c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6241899851838ce4825a50d411751fead52650a5f4b6a18a20e26f8f5d13958a15a511bd5809d9b087daed139ed6971d4407badcfddaab1023bd855013a104ec"} build_url:https://queue.taskcluster.net/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011266 build_url: 'https://queue.taskcluster.net/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/986c5a5cbadd955ab6bf78576ca2a68c90f2ac0a476b617ddf9cb8dd815354e0620d85e2ae7e14793f52300680a806fd1878e10a85b903ef58beccc9c5653805", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bc3dfa65d397d87dd2a315c146df96f52be59ef59d79183258fcdeba6bf31ce8f5653c53499ab7f79e1d095aa5efc12513f96b21e8cd779d3f542dd224db9c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6241899851838ce4825a50d411751fead52650a5f4b6a18a20e26f8f5d13958a15a511bd5809d9b087daed139ed6971d4407badcfddaab1023bd855013a104ec"}' ========= master_lag: 0.38 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 09:33:48.275666) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:33:48.276038) ========= 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.Y1qSsKYrxN/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.IstenzZUWC/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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.005257 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:33:48.304436) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 09:33:48.304797) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 09:33:48.325850) ========= ========= Total master_lag: 2.05 =========