builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0075 starttime: 1493159522.36 results: success (0) buildid: 20170425135825 builduid: 1070cf3b4c5b4063b9f08eef5f6a72c1 revision: 3f0c8da53c5cb015933b10b52ded3f30432b378a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 15:32:02.363750) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 15:32:02.364204) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-25 15:32:02.364480) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-25 15:32:02.392955) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 15:32:02.393344) ========= 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.yEIry0qI8c/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.azVhkPc7lZ/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 --2017-04-25 15:32:02-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 22.9M=0.001s 2017-04-25 15:32:02 (22.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092532 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 15:32:02.513144) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 15:32:02.513466) ========= 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.yEIry0qI8c/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.azVhkPc7lZ/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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.028848 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 15:32:02.566226) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-25 15:32:02.566590) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3f0c8da53c5cb015933b10b52ded3f30432b378a --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 3f0c8da53c5cb015933b10b52ded3f30432b378a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yEIry0qI8c/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.azVhkPc7lZ/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 2017-04-25 15:32:02,684 truncating revision to first 12 chars 2017-04-25 15:32:02,684 Setting DEBUG logging. 2017-04-25 15:32:02,684 attempt 1/10 2017-04-25 15:32:02,684 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3f0c8da53c5c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-25 15:32:03,658 unpacking tar archive at: mozilla-central-3f0c8da53c5c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.245370 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-25 15:32:03.836551) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 15:32:03.836898) ========= script_repo_revision: 3f0c8da53c5cb015933b10b52ded3f30432b378a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 15:32:03.837367) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 15:32:03.837649) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 15:32:03.858021) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-25 15:32:03.858306) ========= /tools/buildbot/bin/python -u 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', '-u', '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.yEIry0qI8c/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.azVhkPc7lZ/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 15:32:04 INFO - MultiFileLogger online at 20170425 15:32:04 in /builds/slave/test 15:32:04 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 15:32:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:32:04 INFO - {'append_to_log': False, 15:32:04 INFO - 'base_work_dir': '/builds/slave/test', 15:32:04 INFO - 'blob_upload_branch': 'Firefox', 15:32:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:32:04 INFO - 'branch': 'Firefox', 15:32:04 INFO - 'buildbot_json_path': 'buildprops.json', 15:32:04 INFO - 'config_files': ('talos/mac_config.py',), 15:32:04 INFO - 'default_actions': ('clobber', 15:32:04 INFO - 'read-buildbot-config', 15:32:04 INFO - 'download-and-extract', 15:32:04 INFO - 'populate-webroot', 15:32:04 INFO - 'create-virtualenv', 15:32:04 INFO - 'install', 15:32:04 INFO - 'run-tests'), 15:32:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:32:04 INFO - 'download_minidump_stackwalk': True, 15:32:04 INFO - 'download_symbols': 'ondemand', 15:32:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:32:04 INFO - 'tooltool.py': '/tools/tooltool.py', 15:32:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:32:04 INFO - '/tools/misc-python/virtualenv.py')}, 15:32:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:32:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:32:04 INFO - 'gecko_profile': False, 15:32:04 INFO - 'gecko_profile_interval': 0, 15:32:04 INFO - 'installer_path': 'installer.exe', 15:32:04 INFO - 'log_level': 'info', 15:32:04 INFO - 'log_name': 'talos', 15:32:04 INFO - 'log_to_console': True, 15:32:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:32:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:32:04 INFO - 'opt_config_files': (), 15:32:04 INFO - 'pip_index': False, 15:32:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:32:04 INFO - 'cmd': ('bash', 15:32:04 INFO - '-c', 15:32:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:32:04 INFO - 'enabled': True, 15:32:04 INFO - 'halt_on_failure': False, 15:32:04 INFO - 'name': 'check_screen_resolution'},), 15:32:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:32:04 INFO - 'cmd': ('bash', 15:32:04 INFO - '-c', 15:32:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:32:04 INFO - 'enabled': True, 15:32:04 INFO - 'halt_on_failure': False, 15:32:04 INFO - 'name': 'check_screen_resolution'},), 15:32:04 INFO - 'run_cmd_checks_enabled': True, 15:32:04 INFO - 'suite': 'dromaeojs', 15:32:04 INFO - 'system_bits': '32', 15:32:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:32:04 INFO - 'title': 't-yosemite-r7-0075', 15:32:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:32:04 INFO - 'use_talos_json': True, 15:32:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:32:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:32:04 INFO - 'work_dir': 'build'} 15:32:04 INFO - [mozharness: 2017-04-25 22:32:04.090151Z] Running clobber step. 15:32:04 INFO - Running pre-action listener: _resource_record_pre_action 15:32:04 INFO - Running main action method: clobber 15:32:04 INFO - rmtree: /builds/slave/test/build 15:32:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:32:06 INFO - Running post-action listener: _resource_record_post_action 15:32:06 INFO - [mozharness: 2017-04-25 22:32:06.586846Z] Finished clobber step (success) 15:32:06 INFO - [mozharness: 2017-04-25 22:32:06.586990Z] Running read-buildbot-config step. 15:32:06 INFO - Running pre-action listener: _resource_record_pre_action 15:32:06 INFO - Running main action method: read_buildbot_config 15:32:06 INFO - Using buildbot properties: 15:32:06 INFO - { 15:32:06 INFO - "project": "", 15:32:06 INFO - "product": "firefox", 15:32:06 INFO - "script_repo_revision": "production", 15:32:06 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 15:32:06 INFO - "repository": "", 15:32:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 15:32:06 INFO - "buildid": "20170425135825", 15:32:06 INFO - "pgo_build": "False", 15:32:06 INFO - "basedir": "/builds/slave/test", 15:32:06 INFO - "buildnumber": 42, 15:32:06 INFO - "slavename": "t-yosemite-r7-0075", 15:32:06 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:32:06 INFO - "platform": "yosemite_r7", 15:32:06 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:32:06 INFO - "branch": "mozilla-central", 15:32:06 INFO - "repo_path": "mozilla-central", 15:32:06 INFO - "revision": "3f0c8da53c5cb015933b10b52ded3f30432b378a", 15:32:06 INFO - "stage_platform": "macosx64", 15:32:06 INFO - "builduid": "1070cf3b4c5b4063b9f08eef5f6a72c1", 15:32:06 INFO - "slavebuilddir": "test" 15:32:06 INFO - } 15:32:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 15:32:06 INFO - Running post-action listener: _resource_record_post_action 15:32:06 INFO - [mozharness: 2017-04-25 22:32:06.590416Z] Finished read-buildbot-config step (success) 15:32:06 INFO - [mozharness: 2017-04-25 22:32:06.590539Z] Running download-and-extract step. 15:32:06 INFO - Running pre-action listener: _resource_record_pre_action 15:32:06 INFO - Running main action method: download_and_extract 15:32:06 INFO - mkdir: /builds/slave/test/build/tests 15:32: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:06 INFO - trying https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 15:32:06 INFO - Downloading https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 15:32:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 15:32:07 INFO - Downloaded 1325 bytes. 15:32:07 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 15:32:07 INFO - Using the following test package requirements: 15:32:07 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:32:07 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 15:32:07 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:32:07 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:32:07 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 15:32:07 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:32:07 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 15:32:07 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:32:07 INFO - u'jsshell-mac.zip'], 15:32:07 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:32:07 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 15:32:07 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:32:07 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:32:07 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 15:32:07 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:32:07 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 15:32:07 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:32:07 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 15:32:07 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:32:07 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 15:32:07 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:32:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:32:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:32:07 INFO - Fetch https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:32:09 INFO - Content-Length response header: 52527408 15:32:09 INFO - Bytes received: 52527408 15:32:25 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:32:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:32:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:32:25 INFO - Fetch https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:32:27 INFO - Content-Length response header: 52527408 15:32:27 INFO - Bytes received: 52527408 15:32:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 15:32:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:32:42 INFO - Fetch https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 15:32:44 INFO - Content-Length response header: 14408809 15:32:44 INFO - Bytes received: 14408809 15:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:44 INFO - trying https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:32:44 INFO - Downloading https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 15:32:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 15:32:46 INFO - Downloaded 71272160 bytes. 15:32:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:32:46 INFO - mkdir: /builds/slave/test/properties 15:32:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:32:46 INFO - Writing to file /builds/slave/test/properties/build_url 15:32:46 INFO - Contents: 15:32:46 INFO - build_url:https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:32:47 INFO - Running post-action listener: _resource_record_post_action 15:32:47 INFO - Running post-action listener: set_extra_try_arguments 15:32:47 INFO - [mozharness: 2017-04-25 22:32:47.208476Z] Finished download-and-extract step (success) 15:32:47 INFO - [mozharness: 2017-04-25 22:32:47.208613Z] Running populate-webroot step. 15:32:47 INFO - Running pre-action listener: _resource_record_pre_action 15:32:47 INFO - Running main action method: populate_webroot 15:32:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:32:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:32:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:32:47 INFO - '--tppagecycles', 15:32:47 INFO - '7'], 15:32:47 INFO - 'tests': ['tsvgm']}}, 15:32:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:32:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:32:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:32:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:32:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:32:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:32:47 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:32:47 INFO - 'talos_options': ['--disable-e10s'], 15:32:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:32:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:32:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:32:47 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:32:47 INFO - 'talos_options': ['--disable-e10s'], 15:32:47 INFO - 'tests': ['damp', 'tps']}, 15:32:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:32:47 INFO - 'tests': ['damp', 'tps']}, 15:32:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:32:47 INFO - 'tests': ['dromaeo_dom']}, 15:32:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:32:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:32:47 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 15:32:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:32:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:32:47 INFO - 'tests': ['a11yr', 15:32:47 INFO - 'ts_paint', 15:32:47 INFO - 'tpaint', 15:32:47 INFO - 'sessionrestore', 15:32:47 INFO - 'sessionrestore_no_auto_restore', 15:32:47 INFO - 'tabpaint']}, 15:32:47 INFO - 'other-e10s': {'tests': ['a11yr', 15:32:47 INFO - 'ts_paint', 15:32:47 INFO - 'tpaint', 15:32:47 INFO - 'sessionrestore', 15:32:47 INFO - 'sessionrestore_no_auto_restore', 15:32:47 INFO - 'tabpaint']}, 15:32:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:32:47 INFO - 'ts_paint', 15:32:47 INFO - 'tpaint', 15:32:47 INFO - 'sessionrestore', 15:32:47 INFO - 'sessionrestore_no_auto_restore', 15:32:47 INFO - 'tabpaint']}, 15:32:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:32:47 INFO - 'ts_paint', 15:32:47 INFO - 'tpaint', 15:32:47 INFO - 'sessionrestore', 15:32:47 INFO - 'sessionrestore_no_auto_restore', 15:32:47 INFO - 'tabpaint']}, 15:32:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:32:47 INFO - 'tests': ['a11yr', 15:32:47 INFO - 'ts_paint', 15:32:47 INFO - 'tpaint', 15:32:47 INFO - 'sessionrestore', 15:32:47 INFO - 'sessionrestore_no_auto_restore', 15:32:47 INFO - 'tabpaint']}, 15:32:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:32:47 INFO - 'tests': ['a11yr', 15:32:47 INFO - 'ts_paint', 15:32:47 INFO - 'tpaint', 15:32:47 INFO - 'sessionrestore', 15:32:47 INFO - 'sessionrestore_no_auto_restore', 15:32:47 INFO - 'tabpaint']}, 15:32:47 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 15:32:47 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 15:32:47 INFO - 'bloom_basic_ref']}, 15:32:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:32:47 INFO - 'tests': ['tsvgx', 15:32:47 INFO - 'tsvgr_opacity', 15:32:47 INFO - 'tart', 15:32:47 INFO - 'tscrollx', 15:32:47 INFO - 'cart', 15:32:47 INFO - 'tsvg_static']}, 15:32:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:32:47 INFO - 'tsvgr_opacity', 15:32:47 INFO - 'tart', 15:32:47 INFO - 'tscrollx', 15:32:47 INFO - 'cart', 15:32:47 INFO - 'tsvg_static']}, 15:32:47 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:32:47 INFO - 'talos_options': ['--disable-e10s'], 15:32:47 INFO - 'tests': ['tp5o']}, 15:32:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:32:47 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:32:47 INFO - 'talos_options': ['--disable-e10s', 15:32:47 INFO - '--xperf_path', 15:32:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:32:47 INFO - 'tests': ['tp5n']}, 15:32:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:32:47 INFO - 'talos_options': ['--xperf_path', 15:32:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:32:47 INFO - 'tests': ['tp5n']}}, 15:32:47 INFO - 'talos.zip': {'path': '', 15:32:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:32:47 INFO - Running post-action listener: _resource_record_post_action 15:32:47 INFO - [mozharness: 2017-04-25 22:32:47.227967Z] Finished populate-webroot step (success) 15:32:47 INFO - [mozharness: 2017-04-25 22:32:47.228083Z] Running create-virtualenv step. 15:32:47 INFO - Running pre-action listener: _resource_record_pre_action 15:32:47 INFO - Running main action method: create_virtualenv 15:32:47 INFO - Creating virtualenv /builds/slave/test/build/venv 15:32:47 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 15:32:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:32:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:32:47 INFO - Using real prefix '/tools/python27' 15:32:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:32:48 INFO - Installing distribute.............................................................................................................................................................................................done. 15:32:50 INFO - Installing pip.................done. 15:32:50 INFO - Return code: 0 15:32:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:32:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:32:51 INFO - Reading from file tmpfile_stdout 15:32:51 INFO - Output received: 15:32:51 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:32:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:51 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 0x10db36b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db39768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe289d6b090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d914d30>, '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 0x10d83adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d909be8>, '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.yEIry0qI8c/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.azVhkPc7lZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 15:32:51 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 15:32:51 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 15:32:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yEIry0qI8c/Render', 15:32:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:51 INFO - 'HOME': '/Users/cltbld', 15:32:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:51 INFO - 'LOGNAME': 'cltbld', 15:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:51 INFO - 'MOZ_NO_REMOTE': '1', 15:32:51 INFO - 'NO_EM_RESTART': '1', 15:32:51 INFO - 'PAGER': '/bin/cat', 15:32:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:51 INFO - 'PWD': '/builds/slave/test', 15:32:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:51 INFO - 'SHELL': '/bin/bash', 15:32:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.azVhkPc7lZ/Listeners', 15:32:51 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 15:32:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:51 INFO - 'USER': 'cltbld', 15:32:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:51 INFO - 'XPC_FLAGS': '0x0', 15:32:51 INFO - 'XPC_SERVICE_NAME': '0', 15:32:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:51 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 15:32:51 INFO - Cleaning up... 15:32:51 INFO - Return code: 0 15:32:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:51 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 0x10db36b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db39768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe289d6b090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d914d30>, '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 0x10d83adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d909be8>, '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.yEIry0qI8c/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.azVhkPc7lZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 15:32:51 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 15:32:51 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 15:32:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yEIry0qI8c/Render', 15:32:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:51 INFO - 'HOME': '/Users/cltbld', 15:32:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:51 INFO - 'LOGNAME': 'cltbld', 15:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:51 INFO - 'MOZ_NO_REMOTE': '1', 15:32:51 INFO - 'NO_EM_RESTART': '1', 15:32:51 INFO - 'PAGER': '/bin/cat', 15:32:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:51 INFO - 'PWD': '/builds/slave/test', 15:32:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:51 INFO - 'SHELL': '/bin/bash', 15:32:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.azVhkPc7lZ/Listeners', 15:32:51 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 15:32:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:51 INFO - 'USER': 'cltbld', 15:32:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:51 INFO - 'XPC_FLAGS': '0x0', 15:32:51 INFO - 'XPC_SERVICE_NAME': '0', 15:32:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:51 INFO - Downloading/unpacking psutil>=3.1.1 15:32:51 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 15:32:51 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 15:32:51 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 15:32:51 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 15:32:51 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 15:32:51 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 15:32:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:32:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:32:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:32:55 INFO - Installing collected packages: psutil 15:32:55 INFO - Running setup.py install for psutil 15:32:55 INFO - building 'psutil._psutil_osx' extension 15:32:55 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 15:32:55 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 15:32:55 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 15:32:56 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 15:32:56 INFO - building 'psutil._psutil_posix' extension 15:32:56 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 15:32:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:32:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:32:56 INFO - ^ 15:32:56 INFO - 1 warning generated. 15:32:56 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 15:32:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:32:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:32:56 INFO - Successfully installed psutil 15:32:56 INFO - Cleaning up... 15:32:56 INFO - Return code: 0 15:32:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:56 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 0x10db36b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db39768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe289d6b090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d914d30>, '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 0x10d83adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d909be8>, '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.yEIry0qI8c/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.azVhkPc7lZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 15:32:56 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 15:32:56 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 15:32:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yEIry0qI8c/Render', 15:32:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:56 INFO - 'HOME': '/Users/cltbld', 15:32:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:56 INFO - 'LOGNAME': 'cltbld', 15:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:56 INFO - 'MOZ_NO_REMOTE': '1', 15:32:56 INFO - 'NO_EM_RESTART': '1', 15:32:56 INFO - 'PAGER': '/bin/cat', 15:32:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:56 INFO - 'PWD': '/builds/slave/test', 15:32:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:56 INFO - 'SHELL': '/bin/bash', 15:32:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.azVhkPc7lZ/Listeners', 15:32:56 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 15:32:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:56 INFO - 'USER': 'cltbld', 15:32:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:56 INFO - 'XPC_FLAGS': '0x0', 15:32:56 INFO - 'XPC_SERVICE_NAME': '0', 15:32:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:32:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:32:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:32:59 INFO - Installing collected packages: mozsystemmonitor 15:32:59 INFO - Running setup.py install for mozsystemmonitor 15:32:59 INFO - Successfully installed mozsystemmonitor 15:32:59 INFO - Cleaning up... 15:32:59 INFO - Return code: 0 15:32:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:00 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:00 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 0x10db36b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db39768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe289d6b090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d914d30>, '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 0x10d83adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d909be8>, '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.yEIry0qI8c/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.azVhkPc7lZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 15:33:00 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 15:33:00 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 15:33:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yEIry0qI8c/Render', 15:33:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:00 INFO - 'HOME': '/Users/cltbld', 15:33:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:00 INFO - 'LOGNAME': 'cltbld', 15:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:00 INFO - 'MOZ_NO_REMOTE': '1', 15:33:00 INFO - 'NO_EM_RESTART': '1', 15:33:00 INFO - 'PAGER': '/bin/cat', 15:33:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:00 INFO - 'PWD': '/builds/slave/test', 15:33:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:00 INFO - 'SHELL': '/bin/bash', 15:33:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.azVhkPc7lZ/Listeners', 15:33:00 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 15:33:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:00 INFO - 'USER': 'cltbld', 15:33:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:00 INFO - 'XPC_FLAGS': '0x0', 15:33:00 INFO - 'XPC_SERVICE_NAME': '0', 15:33:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:00 INFO - Downloading/unpacking jsonschema==2.5.1 15:33:00 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 15:33:00 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 15:33:00 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 15:33:00 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 15:33:00 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 15:33:00 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 15:33:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:33:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:33:03 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 15:33:03 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 15:33:03 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 15:33:03 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 15:33:03 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 15:33:03 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 15:33:04 INFO - Downloading functools32-3.2.3-2.tar.gz 15:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:33:04 INFO - warning: no files found matching '*.txt' 15:33:04 INFO - no previously-included directories found matching 'build' 15:33:04 INFO - no previously-included directories found matching 'dist' 15:33:04 INFO - no previously-included directories found matching '.git*' 15:33:04 INFO - Installing collected packages: jsonschema, functools32 15:33:04 INFO - Running setup.py install for functools32 15:33:04 INFO - warning: no files found matching '*.txt' 15:33:04 INFO - no previously-included directories found matching 'build' 15:33:04 INFO - no previously-included directories found matching 'dist' 15:33:04 INFO - no previously-included directories found matching '.git*' 15:33:04 INFO - Successfully installed jsonschema functools32 15:33:04 INFO - Cleaning up... 15:33:04 INFO - Return code: 0 15:33:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:04 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db36b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db39768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe289d6b090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d914d30>, '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 0x10d83adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d909be8>, '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.yEIry0qI8c/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.azVhkPc7lZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 15:33:04 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:33:04 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 functools32==3.2.3-2 15:33:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yEIry0qI8c/Render', 15:33:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:04 INFO - 'HOME': '/Users/cltbld', 15:33:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:04 INFO - 'LOGNAME': 'cltbld', 15:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:04 INFO - 'MOZ_NO_REMOTE': '1', 15:33:04 INFO - 'NO_EM_RESTART': '1', 15:33:04 INFO - 'PAGER': '/bin/cat', 15:33:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:04 INFO - 'PWD': '/builds/slave/test', 15:33:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:04 INFO - 'SHELL': '/bin/bash', 15:33:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.azVhkPc7lZ/Listeners', 15:33:04 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 15:33:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:04 INFO - 'USER': 'cltbld', 15:33:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:04 INFO - 'XPC_FLAGS': '0x0', 15:33:04 INFO - 'XPC_SERVICE_NAME': '0', 15:33:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:33:04 INFO - Cleaning up... 15:33:04 INFO - Return code: 0 15:33:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:04 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 0x10db36b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db39768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe289d6b090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d914d30>, '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 0x10d83adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d909be8>, '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.yEIry0qI8c/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.azVhkPc7lZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 15:33:04 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 15:33:04 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 15:33:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yEIry0qI8c/Render', 15:33:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:04 INFO - 'HOME': '/Users/cltbld', 15:33:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:04 INFO - 'LOGNAME': 'cltbld', 15:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:04 INFO - 'MOZ_NO_REMOTE': '1', 15:33:04 INFO - 'NO_EM_RESTART': '1', 15:33:04 INFO - 'PAGER': '/bin/cat', 15:33:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:04 INFO - 'PWD': '/builds/slave/test', 15:33:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:04 INFO - 'SHELL': '/bin/bash', 15:33:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.azVhkPc7lZ/Listeners', 15:33:04 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 15:33:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:04 INFO - 'USER': 'cltbld', 15:33:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:04 INFO - 'XPC_FLAGS': '0x0', 15:33:04 INFO - 'XPC_SERVICE_NAME': '0', 15:33:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:04 INFO - Downloading/unpacking blobuploader==1.2.4 15:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:07 INFO - Downloading blobuploader-1.2.4.tar.gz 15:33:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:33:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:33:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:33:08 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 15:33:08 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 15:33:08 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 15:33:08 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 15:33:08 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 15:33:08 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 15:33:08 INFO - Downloading docopt-0.6.1.tar.gz 15:33:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:33:08 INFO - Installing collected packages: blobuploader, requests, docopt 15:33:08 INFO - Running setup.py install for blobuploader 15:33:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:33:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:33:09 INFO - Running setup.py install for requests 15:33:09 INFO - Running setup.py install for docopt 15:33:09 INFO - Successfully installed blobuploader requests docopt 15:33:09 INFO - Cleaning up... 15:33:09 INFO - Return code: 0 15:33:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:09 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 0x10db36b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db39768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe289d6b090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d914d30>, '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 0x10d83adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d909be8>, '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.yEIry0qI8c/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.azVhkPc7lZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 15:33:09 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 15:33:09 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 15:33:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yEIry0qI8c/Render', 15:33:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:09 INFO - 'HOME': '/Users/cltbld', 15:33:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:09 INFO - 'LOGNAME': 'cltbld', 15:33:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:09 INFO - 'MOZ_NO_REMOTE': '1', 15:33:09 INFO - 'NO_EM_RESTART': '1', 15:33:09 INFO - 'PAGER': '/bin/cat', 15:33:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:09 INFO - 'PWD': '/builds/slave/test', 15:33:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:09 INFO - 'SHELL': '/bin/bash', 15:33:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.azVhkPc7lZ/Listeners', 15:33:09 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 15:33:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:09 INFO - 'USER': 'cltbld', 15:33:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:09 INFO - 'XPC_FLAGS': '0x0', 15:33:09 INFO - 'XPC_SERVICE_NAME': '0', 15:33:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:33:10 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-RCV0a9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:33:10 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-DZFudr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:33:10 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-_mnvxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:33:10 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-BdMWtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:33:10 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-xzNrOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:33:10 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-gtm7WS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:33:10 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-pyhML4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:33:10 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Ot0uqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:33:10 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-xD6msO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:33:10 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-hnYIHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:33:11 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-7Qqcq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:33:11 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-4lYXRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:33:11 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-_ojavL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:33:11 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-9dBpmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:11 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-VJz76p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:33:11 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-t8q4tQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:33:11 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-nfa2Ap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:33:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:33:11 INFO - Running setup.py install for manifestparser 15:33:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:33:11 INFO - Running setup.py install for mozcrash 15:33:12 INFO - Running setup.py install for mozdebug 15:33:12 INFO - Running setup.py install for mozdevice 15:33:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:33:12 INFO - Running setup.py install for mozfile 15:33:12 INFO - Running setup.py install for mozhttpd 15:33:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:33:12 INFO - Running setup.py install for mozinfo 15:33:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:33:12 INFO - Running setup.py install for mozInstall 15:33:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:33:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:33:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:33:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:33:12 INFO - Running setup.py install for mozleak 15:33:13 INFO - Running setup.py install for mozlog 15:33:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:33:13 INFO - Running setup.py install for moznetwork 15:33:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:33:13 INFO - Running setup.py install for mozprocess 15:33:13 INFO - Running setup.py install for mozprofile 15:33:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:33:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:33:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:33:13 INFO - Running setup.py install for mozrunner 15:33:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:33:13 INFO - Running setup.py install for mozscreenshot 15:33:13 INFO - Running setup.py install for moztest 15:33:14 INFO - Running setup.py install for mozversion 15:33:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:33:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:33:14 INFO - Cleaning up... 15:33:14 INFO - Return code: 0 15:33:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:14 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 0x10db36b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db39768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe289d6b090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d914d30>, '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 0x10d83adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d909be8>, '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.yEIry0qI8c/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.azVhkPc7lZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 15:33:14 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 15:33:14 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 15:33:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yEIry0qI8c/Render', 15:33:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:14 INFO - 'HOME': '/Users/cltbld', 15:33:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:14 INFO - 'LOGNAME': 'cltbld', 15:33:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:14 INFO - 'MOZ_NO_REMOTE': '1', 15:33:14 INFO - 'NO_EM_RESTART': '1', 15:33:14 INFO - 'PAGER': '/bin/cat', 15:33:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:14 INFO - 'PWD': '/builds/slave/test', 15:33:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:14 INFO - 'SHELL': '/bin/bash', 15:33:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.azVhkPc7lZ/Listeners', 15:33:14 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 15:33:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:14 INFO - 'USER': 'cltbld', 15:33:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:14 INFO - 'XPC_FLAGS': '0x0', 15:33:14 INFO - 'XPC_SERVICE_NAME': '0', 15:33:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:33:14 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-bo1I3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:33:14 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)) 15:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:33:14 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-f0J_6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 15:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:33:14 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Kl6ptI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:33:14 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)) 15:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:33:14 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-ZeQzto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 15:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:33:14 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-YQmzA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:33:15 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)) 15:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:33:15 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-aYvqUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:33:15 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)) 15:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:33:15 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Ed3GyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:33:15 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)) 15:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:33:15 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-1FwMIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:33:15 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)) 15:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:33:15 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-I4TiHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:33:15 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)) 15:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:33:15 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-ijqQzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:33:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 15:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:33:15 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-lTQ38V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:33:15 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)) 15:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:33:15 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Y_V1Bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:33:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 15:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:33:15 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-syJ6J_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:33:15 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)) 15:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:33:15 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Lpxfss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 15:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:16 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-tY80nR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:16 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)) 15:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:33:16 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-tjl4XV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 15:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:33:16 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-fm7rpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:33:16 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)) 15:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:33:16 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)) 15:33:16 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:33:16 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:33:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33:18 INFO - Downloading blessings-1.6.tar.gz 15:33:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:33:19 INFO - Installing collected packages: blessings 15:33:19 INFO - Running setup.py install for blessings 15:33:19 INFO - Successfully installed blessings 15:33:19 INFO - Cleaning up... 15:33:19 INFO - Return code: 0 15:33:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:33:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:33:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:33:19 INFO - Reading from file tmpfile_stdout 15:33:19 INFO - Current package versions: 15:33:19 INFO - blessings == 1.6 15:33:19 INFO - blobuploader == 1.2.4 15:33:19 INFO - docopt == 0.6.1 15:33:19 INFO - functools32 == 3.2.3-2 15:33:19 INFO - jsonschema == 2.5.1 15:33:19 INFO - manifestparser == 1.1 15:33:19 INFO - mozInstall == 1.12 15:33:19 INFO - mozcrash == 1.0 15:33:19 INFO - mozdebug == 0.1 15:33:19 INFO - mozdevice == 0.50 15:33:19 INFO - mozfile == 1.2 15:33:19 INFO - mozhttpd == 0.7 15:33:19 INFO - mozinfo == 0.9 15:33:19 INFO - mozleak == 0.1 15:33:19 INFO - mozlog == 3.4 15:33:19 INFO - moznetwork == 0.27 15:33:19 INFO - mozprocess == 0.25 15:33:19 INFO - mozprofile == 0.28 15:33:19 INFO - mozrunner == 6.13 15:33:19 INFO - mozscreenshot == 0.1 15:33:19 INFO - mozsystemmonitor == 0.3 15:33:19 INFO - moztest == 0.8 15:33:19 INFO - mozversion == 1.4 15:33:19 INFO - psutil == 3.1.1 15:33:19 INFO - requests == 1.2.3 15:33:19 INFO - wsgiref == 0.1.2 15:33:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:19 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 0x10db36b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db39768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe289d6b090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d914d30>, '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 0x10d83adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d909be8>, '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.yEIry0qI8c/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.azVhkPc7lZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 15:33:19 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 15:33:19 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 15:33:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yEIry0qI8c/Render', 15:33:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:19 INFO - 'HOME': '/Users/cltbld', 15:33:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:19 INFO - 'LOGNAME': 'cltbld', 15:33:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:19 INFO - 'MOZ_NO_REMOTE': '1', 15:33:19 INFO - 'NO_EM_RESTART': '1', 15:33:19 INFO - 'PAGER': '/bin/cat', 15:33:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:19 INFO - 'PWD': '/builds/slave/test', 15:33:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:19 INFO - 'SHELL': '/bin/bash', 15:33:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.azVhkPc7lZ/Listeners', 15:33:19 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 15:33:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:19 INFO - 'USER': 'cltbld', 15:33:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:19 INFO - 'XPC_FLAGS': '0x0', 15:33:19 INFO - 'XPC_SERVICE_NAME': '0', 15:33:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:19 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)) 15:33:19 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)) 15:33:19 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)) 15:33:19 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)) 15:33:19 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)) 15:33:19 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)) 15:33:19 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)) 15:33:19 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)) 15:33:19 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)) 15:33:19 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)) 15:33:19 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)) 15:33:19 INFO - Cleaning up... 15:33:19 INFO - Return code: 0 15:33:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:19 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 0x10db36b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db39768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe289d6b090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d914d30>, '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 0x10d83adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d909be8>, '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.yEIry0qI8c/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.azVhkPc7lZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 15:33:19 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 15:33:19 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 15:33:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yEIry0qI8c/Render', 15:33:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:19 INFO - 'HOME': '/Users/cltbld', 15:33:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:19 INFO - 'LOGNAME': 'cltbld', 15:33:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:19 INFO - 'MOZ_NO_REMOTE': '1', 15:33:19 INFO - 'NO_EM_RESTART': '1', 15:33:19 INFO - 'PAGER': '/bin/cat', 15:33:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:19 INFO - 'PWD': '/builds/slave/test', 15:33:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:19 INFO - 'SHELL': '/bin/bash', 15:33:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.azVhkPc7lZ/Listeners', 15:33:19 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 15:33:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:19 INFO - 'USER': 'cltbld', 15:33:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:19 INFO - 'XPC_FLAGS': '0x0', 15:33:19 INFO - 'XPC_SERVICE_NAME': '0', 15:33:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:33:20 INFO - Cleaning up... 15:33:20 INFO - Return code: 0 15:33:20 INFO - Running post-action listener: _resource_record_post_action 15:33:20 INFO - Running post-action listener: _start_resource_monitoring 15:33:20 INFO - Starting resource monitoring. 15:33:20 INFO - [mozharness: 2017-04-25 22:33:20.202953Z] Finished create-virtualenv step (success) 15:33:20 INFO - [mozharness: 2017-04-25 22:33:20.203971Z] Running install step. 15:33:20 INFO - Running pre-action listener: _resource_record_pre_action 15:33:20 INFO - Running main action method: install 15:33:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:33:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:33:20 INFO - Reading from file tmpfile_stdout 15:33:20 INFO - Detecting whether we're running mozinstall >=1.0... 15:33:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:33:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:33:20 INFO - Reading from file tmpfile_stdout 15:33:20 INFO - Output received: 15:33:20 INFO - Usage: mozinstall [options] installer 15:33:20 INFO - Options: 15:33:20 INFO - -h, --help show this help message and exit 15:33:20 INFO - -d DEST, --destination=DEST 15:33:20 INFO - Directory to install application into. [default: 15:33:20 INFO - "/builds/slave/test"] 15:33:20 INFO - --app=APP Application being installed. [default: firefox] 15:33:20 INFO - mkdir: /builds/slave/test/build/application 15:33:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:33:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:33:40 INFO - Reading from file tmpfile_stdout 15:33:40 INFO - Output received: 15:33:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:33:40 INFO - Running post-action listener: _resource_record_post_action 15:33:40 INFO - [mozharness: 2017-04-25 22:33:40.728311Z] Finished install step (success) 15:33:40 INFO - [mozharness: 2017-04-25 22:33:40.728426Z] Running run-tests step. 15:33:40 INFO - Running pre-action listener: _resource_record_pre_action 15:33:40 INFO - Running main action method: run_tests 15:33:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:33:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:33:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:33:40 INFO - 2017-04-25 15:33:40.742 screenresolution[1618:7464] starting screenresolution argv=screenresolution get 15:33:40 INFO - 2017-04-25 15:33:40.745 screenresolution[1618:7464] Display 0: 1600x1200x32@60 15:33:40 INFO - 2017-04-25 15:33:40.751 screenresolution[1619:7466] starting screenresolution argv=screenresolution list 15:33:40 INFO - Available Modes on Display 0 15:33:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:33:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:33:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:33:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:33:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:33:40 INFO - Intel Iris: 15:33:40 INFO - Chipset Model: Intel Iris 15:33:40 INFO - Type: GPU 15:33:40 INFO - Bus: Built-In 15:33:40 INFO - VRAM (Dynamic, Max): 1536 MB 15:33:40 INFO - Vendor: Intel (0x8086) 15:33:40 INFO - Device ID: 0x0a2e 15:33:40 INFO - Revision ID: 0x0009 15:33:40 INFO - Displays: 15:33:40 INFO - Display: 15:33:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:33:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:33:40 INFO - Display Serial Number: 1600x1200 60 15:33:40 INFO - Main Display: Yes 15:33:40 INFO - Mirror: Off 15:33:40 INFO - Online: Yes 15:33:40 INFO - Rotation: Supported 15:33:40 INFO - Return code: 0 15:33:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:33:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:33:40 INFO - Python 2.7.3 15:33:40 INFO - Return code: 0 15:33:40 INFO - grabbing minidump binary from tooltool 15:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:40 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 0x10d914d30>, '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 0x10d83adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d909be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:33:40 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 15:33:40 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 15:33:40 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 15:33:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:33:41 INFO - Return code: 0 15:33:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:33:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:33:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:33:41 INFO - ENV: RUST_BACKTRACE is now 1 15:33:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:33:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:33:41 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/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0075', '--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 15:33:41 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/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0075 --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 15:33:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yEIry0qI8c/Render', 15:33:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:41 INFO - 'HOME': '/Users/cltbld', 15:33:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:41 INFO - 'LOGNAME': 'cltbld', 15:33:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:33:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:41 INFO - 'MOZ_NO_REMOTE': '1', 15:33:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:33:41 INFO - 'NO_EM_RESTART': '1', 15:33:41 INFO - 'PAGER': '/bin/cat', 15:33:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:41 INFO - 'PWD': '/builds/slave/test', 15:33:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:33:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:41 INFO - 'RUST_BACKTRACE': '1', 15:33:41 INFO - 'SHELL': '/bin/bash', 15:33:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.azVhkPc7lZ/Listeners', 15:33:41 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 15:33:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:41 INFO - 'USER': 'cltbld', 15:33:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:41 INFO - 'XPC_FLAGS': '0x0', 15:33:41 INFO - 'XPC_SERVICE_NAME': '0', 15:33:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:41 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/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0075', '--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 15:33:41 INFO - mozversion application_buildid: 20170425135825 15:33:41 INFO - mozversion application_changeset: 3f0c8da53c5cb015933b10b52ded3f30432b378a 15:33:41 INFO - mozversion application_display_name: Nightly 15:33:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:33:41 INFO - mozversion application_name: Firefox 15:33:41 INFO - mozversion application_remotingname: firefox 15:33:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:33:41 INFO - mozversion application_vendor: Mozilla 15:33:41 INFO - mozversion application_version: 55.0a1 15:33:41 INFO - mozversion platform_buildid: 20170425135825 15:33:41 INFO - mozversion platform_changeset: 3f0c8da53c5cb015933b10b52ded3f30432b378a 15:33:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:33:41 INFO - mozversion platform_version: 55.0a1 15:33:41 INFO - using testdate: 1493159621 15:33:41 INFO - actual date: 1493159621 15:33:41 INFO - starting webserver on 'localhost:49247' 15:33:41 INFO - SUITE-START | Running 2 tests 15:33:41 INFO - TEST-START | dromaeo_css 15:33:41 INFO - operating with platform_type : mac_ 15:33:41 INFO - Initialising browser for dromaeo_css test... 15:33:41 INFO - TEST-INFO | started process 1629 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpi2XYop/profile http://localhost:49247/getInfo.html) 15:33:44 INFO - PID 1629 | __metrics Screen width/height:1600/1200 15:33:44 INFO - PID 1629 | colorDepth:24 15:33:44 INFO - PID 1629 | Browser inner width/height: 1024/689 15:33:44 INFO - PID 1629 | __metrics 15:33:44 INFO - PID 1629 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:33:44 INFO - PID 1629 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:33:45 INFO - TEST-INFO | 1629: exit 0 15:33:45 INFO - Browser initialized. 15:33:45 INFO - Running cycle 1/1 for dromaeo_css test... 15:33:45 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpi2XYop/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:33:57 INFO - PID 1631 | RSS: Main: 242688000 15:33:57 INFO - PID 1631 | 15:37:02 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49247/tests/dromaeo/cssquery-ext.html) 15:37:04 INFO - PID 1631 | RSS: Main: 444178432 15:37:04 INFO - PID 1631 | 15:38:46 INFO - PID 1631 | ************************* 15:38:46 INFO - PID 1631 | A coding exception was thrown and uncaught in a Task. 15:38:46 INFO - PID 1631 | 15:38:46 ERROR - PID 1631 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:38:46 INFO - PID 1631 | Full stack: 15:38:46 INFO - PID 1631 | ************************* 15:38:46 INFO - PID 1631 | ************************* 15:38:46 INFO - PID 1631 | A coding exception was thrown and uncaught in a Task. 15:38:46 INFO - PID 1631 | 15:38:46 ERROR - PID 1631 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:38:46 INFO - PID 1631 | Full stack: 15:38:46 INFO - PID 1631 | ************************* 15:38:46 INFO - PID 1631 | ************************* 15:38:46 INFO - PID 1631 | A coding exception was thrown and uncaught in a Task. 15:38:46 INFO - PID 1631 | 15:38:46 ERROR - PID 1631 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:38:46 INFO - PID 1631 | Full stack: 15:38:46 INFO - PID 1631 | ************************* 15:38:46 INFO - PID 1631 | ************************* 15:38:46 INFO - PID 1631 | A coding exception was thrown and uncaught in a Task. 15:38:46 INFO - PID 1631 | 15:38:46 ERROR - PID 1631 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:38:46 INFO - PID 1631 | Full stack: 15:38:47 INFO - PID 1631 | ************************* 15:40:06 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-ext.html (next: http://localhost:49247/tests/dromaeo/cssquery-jquery.html) 15:40:07 INFO - PID 1631 | RSS: Main: 365932544 15:40:07 INFO - PID 1631 | 15:43:09 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49247/tests/dromaeo/cssquery-mootools.html) 15:43:10 INFO - PID 1631 | RSS: Main: 338194432 15:43:10 INFO - PID 1631 | 15:46:12 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49247/tests/dromaeo/cssquery-prototype.html) 15:46:13 INFO - PID 1631 | RSS: Main: 332595200 15:46:13 INFO - PID 1631 | 15:49:16 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49247/tests/dromaeo/cssquery-yui.html) 15:49:17 INFO - PID 1631 | RSS: Main: 343031808 15:49:17 INFO - PID 1631 | 15:52:19 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-yui.html (next: http://localhost:49247/tests/dromaeo/cssquery-dojo.html) 15:52:20 INFO - PID 1631 | RSS: Main: 377548800 15:52:20 INFO - PID 1631 | 15:52:20 INFO - PID 1631 | __start_tp_report 15:52:20 INFO - PID 1631 | _x_x_mozilla_page_load 15:52:20 INFO - PID 1631 | _x_x_mozilla_page_load_details 15:52:20 INFO - PID 1631 | |i|pagename|runs| 15:52:20 INFO - PID 1631 | |0;dojo.html;3504.316658251642;3523.6300188480227;3534.770239934404;3539.5398598182223;3584.784912905226;5478.205660179272;5988.9101663475085;6156.138140660306;6161.691915404234;6165.106059621352;6094.592115505712;6130.18412495761;6166.414190651892;6223.626582405059;6230.252369715629;5126.282320475137;5178.637495375326;5282.339707536558;5324.627276090685;5376.892462150755;5384.730763461831;5400.83797486076;5401.70290634015;5414.35027796663;5418.593605479585;4076.2866498362814;5245.134552798783;5283.101872681654;5298.284731561228;5312.601554883399;5278.023565640369;5288.894222115575;5294.364676238876;5302.655327403706;5306.681599104066;5212.061828870802;5229.241759944786;5251.55361794248;5258.1849813279005;5264.6051546134195;5292.550133238679;5991.310999235056;6049.637021778663;6107.4503294703245;6147.661878596676;6483.610983341015;6485.156929599169;6491.578047426902;6501.902471462932;6506.739730410825;6534.640594767286;6571.310012448672;6578;6590.143281373439;6595.175603049619;6087.178230938855;6111.964830093264;6123.537002805184;6165.969170154121;6277.089821975788;6658.500612454085;6679.398854103154;6684.766033188815;6688.765893193715;6693.364130407604;6313.021481670348;6397.584157029778;6400.39196276353;6403.391677790602;6412.551121421549;6458.870822583522;6514.837129071716;6516.706748196342;6521.836954076091;6528.151340325728;6356.4279214870885;6414.583052101599;6422.197225346832;6447.580907241015;6459.870802583922;6300.968495157586;6416.454601358843;6421.775237866652;6506.284308726036;6508.8047358579315;5243.895122097537;5244.056069907453;5245.868853278698;5247.580193584504;5248.9737551312;4617.12274667812;4700.059988002413;4718.716876987323;4720.763961801897;4744.4069491313585;6087.421694938974;6096.0855871619615;6097.024476083805;6102.328743838174;6116.174316467309;6372.617642941438;6445.903311450332;6457.935420645734;6464.806055818333;6470.547061705635;6025.698715064317;6043.184170137063;6067.271927368744;6074.787382441594;6096.603720758137;5650.943490565041;5651.802186923438;5656.981743286248;5657.858553536194;5670.659760414388;5897.64614123154;6575.309592492719;6589.604623722592;6589.86820263592;6602.8349291268105;6573.04690819838;6605.207375115017;6608.933910660832;6610.438112760469;6665.600063996176;6767.661616919233;6777.423918966943;6777.762778302736;6783.287754785676;6783.864322713617;4852.296417019583;6389.9041514376395;6484.70818813164;6491.188601424822;6495.675216239264;6379;6525;6573.5069869759;6574.539782215199;6585.275619681927;6268.435840774352;6342.587731797418;6349.746010159727;6356.809295721136;6358.109864619049;6325.810225693236;6341.651209183539;6344.429001389897;6344.619322840645;6345.079963405373;6145.064304743992;6353.745850165941;6362.427381535684;6374.840628984127;6378.330275321025;6258.687065646791;6354.936450635434;6370.8088757337355;6381.680915954091;6396.648184349905;6131.601445906002;6222.066689996355;6240.375962403723;6320.336364681642;6343 15:52:20 INFO - PID 1631 | |1;ext.html;757.7613051888654;787.7951732549536;803.0323460230421;1120.602186223891;1142.925709828861;26301.868490657544;36413.63586364136;36615.26769464609;36708;36733.44899826505;38886.8055659722;39228.60771392285;39290.821275361785;39325;39382.21235575287;6016.27804663441;6127.877442451148;8391.24478796908;8555.315574754004;8561.700340488083;8381.497110173379;8541.231289183972;8561.657533698644;8569.742907712747;8574.742757717248;8526.31789456842;8602.311815054813;8611.397202195849;8613.310935125175;8641.827163456726;8530.616122274481;8580.485170889704;8587.699430519964;8594.527300998443;8606.354523410706;8494.74515764528;8549.914500854975;8550;8552.144785521461;8556.5293908835;37358;37545.43681844747;37586.81206593977;37599.62400375988;37607.435888461696;3413.76103672743;3533.505309256706;3563.1626567756557;3565.090901820045;3567.233044895334;30401.391972160654;30436;30515.847420762977;30527.847360763277;30570.847145764128;3096.922576935572;3107.425126351632;3134.09111357706;3136.1375621703987;3139.4035133324596;279177.6041119802;285426;286005.5699721509;286048;286406;48215.75892120517;48253.51746482561;48302;48461.5153848464;48482.27276590854;50316.49683503118;50347.49652503428;50377.74811125921;50415;50439.243411348856;13500.054996150175;13587.91296696262;13588.660283492993;13601.523946661819;13606.863931360758;9613.711588652352;9660.275479339078;9673.177779888789;11198.720031999264;11206.887931120747;12028.27830330183;12029.09781766371;12102.394880256128;12118.333491658044;12159.574414895613;5385.569154467712;5409.756560954766;5411.729413529387;5421.783128674888;5427;950.3727539823683;953.6614501851882;971.6502059258661;985.669800616787;1041.3335465302212;18696;22880.542389152455;23810.285691429286;23849.7615023851;23923.521529569312;1094.5512339940585;1101.3612104979093;1142.1833389126814;1144.959926402572;1159.2812456276993;11843.038803689358;12298.631041068782;15699.293531790869;16106.516804495885;16121.27454264561;279071.6046419755;279511;280101;280416;280691;51936;51938.48061519412;52240.73879630578;52253.95492090213;52316.73841630767;1457.5263039512201;1481.7703255995339;1514.440595393781;1515.113658509762;1541.5760665816765;27224.047158349364;27892.721072789012;27993.580096298163;28020;29224;48585.27122093242;48610.27084593663;48654.75672621614;48709;48790;264327;264842.1368397339;265327;265767.67116164294;266170;28977;29127.7087229125;32509.34981300408;32513.83743081364;32535.349293014482;37038;42705.78647106745;42725.1454970905;42731.79511536585;42749;28200.43599127965;28385.574216386358;29889.95385161596;30026.099217023526;30360.392792143593;29362.119136425943;29436.116916491683;30073.097807065824;30152.24619384533;30386.696133038386;35807.64192358043;35909.46135807913;35911.64088359083;36038.4594231092;36058.63941360553;22994.655080173477;25559.105431309814;28432.715672843005;30785.8460707695;30827;22051.22820701268;23722.644160337954;24077.879610601834;24174;24188.51622967566 15:52:20 INFO - PID 1631 | |2;jquery.html;441.0693436848252;441.2608880125791;445.7303331484453;454.37977161175;465.7438408875118;19766.604667906635;21698.457538561524;22461.663075053846;22585.322440326774;22708.432289192777;22138.89305534725;22479;22562.774372256274;22804;23502.707351095683;5704.54363650909;6115.235595550545;6333.240011198663;6341.080543321215;6346.873062538746;5408.783648654049;6248.593841400318;6364.077208804721;6364.299927008025;6379.904301435482;6089.0866370044405;6223.1287619733275;6322.146510221107;6331;6333.809985700436;6259.311475737665;6283.497320214372;6302.779402720906;6304.27500837405;6307.463865571432;5412.810551630713;5557.027520183992;5617.747201375907;5624.775008999676;5633.098704207348;27558.448831023466;27681.446371072667;28424.857875710695;28429.85785071082;28547.57178642322;2194.648856183003;2202.196198387593;2244.147224054865;2245.259064508708;2246.146464343555;17776.28894844205;17783.822161778346;17807.910960445246;18315.908420457945;18370.724439133424;2144.1423430627874;2174.4998650310517;2200.3728937252968;2206.0844749428966;2222.411061068818;137168;149154.2711432212;160407;162374.1881290586;163588;11831.585894493823;12437.75124497505;12490.937545312216;12499.56251531192;12519.561815336601;14551.927240363942;16689.415870444718;16713.247903844356;16715.16424178786;16720.581985450463;7451.627418629156;8607.354448416268;8703.782405439788;8887.00212261206;9001;7098.077249957576;8485.618147183392;8518.275946544489;8699.347548933856;8710.651573936972;7548;7610.142882693123;7703.229677032364;7739.883901741478;7769.223077692185;2118.322136916203;2129.403766945227;2140.1546389176187;2142.892855357226;2328.3247858120953;828.9544075075808;937.3906960475746;942.1614762861059;947.275334369208;950.4290893134056;15906.568408843259;20433.897830510752;21400.250991215235;21724.891375543022;21836.017379217974;941.6562954521551;1007.5818535307911;1017.6438246613626;1017.8421745898742;1031.6183012285503;10412.895871041344;10777.892221077846;10795.568177272979;10800.351978881292;10823.13414926804;559350.406495938;564094;571348;574913;575834;129599;134826.325868372;135981;136364;138390;1159.7854396936593;1184.9585264515702;1197.5928184417166;1205.9336736479402;1208.5226335597565;17436.302547897943;17855.553611159306;18342;18350.541236469195;18477.53806154857;56566.717166415554;57050.57373565694;57366.426335736105;57458.7127064362;57713.71143144257;77401;77915.6104219498;78001.21998780167;78650.6067469659;82413;8694.91305086941;8791.956040219759;8853.468791872509;9162.67930622425;9284.118008789153;13428.664283392993;14362.928185359006;14609.269536523343;14735.852641473448;14744.852551474349;11619.6514104577;11797.233179843282;12158.45286962071;12172.634820955385;12225.510979560719;9695;11375.601853935073;11544.365059921785;11887.881121188677;11923.76152476963;12072.818907716215;12224.449899754354;12275.631731048083;12411.813822792847;12460;8854.645814167361;8977.596008179517;9055.320850936338;9118.589663465027;9127.817443651222;11841.822372664245;11978.940105299418;12252.448639811051;12317;12323.075769317516 15:52:20 INFO - PID 1631 | |3;mootools.html;1200.4357951762668;1409.3094383751961;1462.1811785400178;1480.1785009319824;1484.599158227278;9809.068138526838;10287.948560257197;11573.768524629502;11796.646100616974;11811.291322520654;11405.54377824886;11505.194636375436;11526.827097593543;11536.884631153685;11556.479958401871;2492.7382624824404;2537.8857951392233;2543.249741326304;2547.0575886921865;2549.2352294311727;2085.7705652378227;2121.2681624839406;2216.468047668556;2574.961375579368;2587.6506671599377;1582.9683406331924;1937.2251099560149;1957.7748558915694;1961.5880665060283;1966.5673551818577;2500.3874050857567;2532.556802559554;2538.378097366157;2538.885750141248;2539.911103111382;2130.541933484308;2216.1135545781817;2217.3347995601257;2456;2531.5190113878302;11777.057835373149;11889.227200232044;11895.345755983417;11896.524139034429;11906.047516198683;6508.4142427181305;6755.831104222385;6786.59280443175;6787.762428315034;6796.286389929085;4013.0769922917602;4235.2800023996;4323.156984388045;4325.891852703708;4380.8685739427865;1243.521244320943;1262.236347010055;1281.3208999230424;1293.2369901758009;1293.5795866343383;16900.915495422567;16905.15474226284;16910.239039243264;16910.915445422816;16916.32334706598;4766.451858036301;6006.819795406145;6009.36901625323;6021.7802699316;6183.258009038944;13908.791368129487;13926.651833704036;13928;13934.024618276826;13944.51194208198;6892.379685828299;6893.75871844483;6896.069030680894;6904.206016308189;6916.1700595927805;6186.443220110212;6234.9688251559355;6302.621842689453;6326.145970294044;6327.746890124344;3802.258559580855;4485.304777759453;4575.313702944519;4626.375439315717;4730.574248317599;1394.372532360442;1420.943162273518;1422.7439060968918;1443.3432788081398;1447.41379741205;764.5068930539882;774.5430196184166;788.333857890082;790.7627711686471;798.4011991006745;6465.224173099258;6663.833404164838;6911.447084233249;6913.585184888922;6933.168019837652;867.4274978514151;881.110078820396;897.0760117079419;897.2239013253619;905.8747321739892;4129.648979836687;4150.439690641785;4191.476065491814;4249.851255206115;4285.0358669299785;14427.78358324626;15137.167455789817;15139.772903406458;15156.24218789056;15203.391864325304;14517.637059073397;15078;15083.54749357521;15095.698086038217;15103.4713785017;8325.375596830261;8594.699185528601;8605.053444121142;8608.139186081467;8621.61202745878;6316.905246421399;6624.933750662624;6877;6913.688884000131;7010.158780946319;10616.832148463509;13430.127041742255;13741.519046833313;13780.586582402544;13784.172949623055;13558.661033474242;13572.524961626295;13774.724505510034;14061.789073163705;14095;9148;9435.24518038569;9438.433693978383;9445.480498572644;9452.621895124117;10557.313774604627;10641.467926603793;10776.892231077589;10778;10780.975807298295;8929.776755581162;8935.731928042169;9038;9066.682666106655;9068.319876009458;8703.477791332287;8845.51349675774;8953.462792232487;8993;9060.818783624423;7970.521768693897;8113.5131892086665;8159.224873636995;8170.959145204473;8183.3862460316905;5871.412858714265;5899.882002360015;6008.639481631116;6051.576389652682;6119.2350956130485;4590.403247577793;5174.301469301596;5692.402297758676;6165.352637972948;6316.3683631638305 15:52:20 INFO - PID 1631 | |4;prototype.html;402.30401405568364;410.306098236178;413.9110091330367;414.9087200815819;422.22521672730517;4371.672124590653;4772.856814295568;5250.6587071840395;5803.883922321551;5894.909441753273;4924;5442.482964118402;5553.861153471165;5630.465105814951;5755.856103597413;3641.963580364189;3903.765774053566;4037.6070255761715;4272.978635106821;4471.195184866739;4058.9797051014702;4461.5092339842595;4461.687681862271;4462.3752674625575;4485.775711214443;3824.5849035856772;4369.90752311922;4430.446194225722;4432.445944256968;4468.905118246034;3630.528031355907;3643.25313310772;4362.5855543723455;4405.22908491016;4420.182266280716;3458.844352004166;3465.358908601917;3564.144605294711;3949.9605003949882;3962.5244970603712;4167.291560434703;4993.950060499385;5291.86770330741;5365.195220716884;5669.376368599451;3868.825902834379;4142.689298302639;4888.2178851383605;4956.339626225219;4962.3548938638105;6113.908291375633;6123.846903827395;6134;6138.785142520035;6148.6618235997;3116.426204766601;3891.435741817449;4102.466679331667;4107.650849677781;4139.958600413987;5612.326520817487;6097.542684298695;6300.653464059475;6321.523162260738;6468.644224567647;3557.9681892251474;3875.8837234883;4013.57857424972;4048.8987775305854;4182.703361957802;4194.266003449445;4207.8316867325575;4228.344606585984;4236.364545318227;4244.745315281093;4635.605973492224;4682.344471773954;4889.657723959289;4961.875953101201;4969.925451118236;5788;5995.2805663319805;6132.233470816148;6149.7847575334645;6168.444839964424;1305.092960392537;1417.8723914847508;1437.159261831819;1442.401403417591;1442.9134251944918;789.8459800338994;944.1927152284835;945.0124619772217;950.8383574792302;955.2214944820089;5169.896602067937;5531.3362396512675;5817.621854579439;5818.21454103699;5848.473637372657;4862.440819305754;6351.428371446592;6384.808455746335;6390.968045159744;6409.8718025640155;5581.358143813432;5700.7719691212715;5849.473547380756;5869.559783016291;5877.617954832922;3246.62663793662;3250.593675790526;3325.201951531615;3334.683205095512;3343.8160901150673;4420.662399888128;5469.753861076261;6204.55647115846;6488.480921526267;6553.8361540960905;5741.339745929272;6181.752729890754;6524.151860258136;6540.9672951635885;6616.636085015371;6045.911735887583;6174.536909731788;6394.784990851724;6472.223333200046;6590.901136483052;5245.763940622757;6317.368263173646;6327.683615819283;6361.936380636134;6367.93632063692;4708.882277943078;5743.511801496919;6255.31191568918;6265.997440409513;6284.402981716729;5578.693171875423;6217.378262173746;6286.905696414466;6585.440237579668;6603.20761508622;4638.698484598491;4684.60180884615;4700.670953033255;4707.211259721284;4717.528247175255;6197.690115494297;6339.270983836917;6357.141785859035;6370.55406121567;6384;6067.544934130046;6098.939010609837;6116.602420842631;6120.3267640558615;6174.44430001302;6007.789727359522;6096.725647345968;6114.724837382418;6146.877062458815;6184.474319682878;5006.69959802413;6009.5445119057595;6011.941939191116;6018.682807119203;6026.758929642765;4649.790759415767;5085.5931525477135;6095.908561371672;6194.853952018891;6218.53360997936;4812.374391329105;5225.895482090261;5565.30433695788;5999.820005399845;6023.3073196582955 15:52:20 INFO - PID 1631 | |5;yui.html;621.3413781391724;629.946454551363;630.8170630517151;681.7750142452991;742.9554226746392;12982.09125361225;15286.923565382185;18228.544286392847;18610.34863779768;18853.905730471346;16648;17071.91464042681;17159.399421020265;17287.48137555872;17689.734653980202;954.5513608603962;975.6780262513389;978.2418625565173;979.8383266760976;982.351647912378;685.4516386890492;705.2524324216322;1018.4042335233897;1023.145673362743;1028.665683652812;755.8488302339526;761.3984951888002;764.1899586438366;1030.2273295028729;1069.887661795512;1033.529743966501;1033.8655974723313;1036.4765793274387;1037.190991027;1067.3915867955268;773.8877862709932;774.6785084190111;775.1086250811555;785.7524879662888;805.2189376304975;15686.843131568652;15978.280977356048;16014.279357428828;16078.598035049217;16361.509154725378;15577.844221557865;15644.68710625781;15779.842201577952;15954.44159454425;16229.513114606581;10205.591776328938;13555.934219139595;13679.863201367958;13681.384337704827;13843.515476958359;3338;3365.882194123194;3370.477575975703;3370.5955285365667;3373.1567108222944;104076.47961760219;115370;115488;115530;115599;10730.839037414446;12649.810252846215;12895.355232238351;12900.741985160432;12945.482180712854;16197.190140492929;18692.43922682322;19230;24622.753772462405;24643.260702178963;7367.742129025459;7532.962335188398;7550.207228241065;7568.053993250844;7644.464887457824;3532.7703699259464;3866.0721426857353;3918.686505079587;3929.057026313664;3932.7050471214775;3980.641742243154;4139.668826493873;4202.684798640114;4217.030083080908;4220.409142720022;932.5570354081757;945.2107490245585;954.4654993203828;955.8279509688184;956.8660387545749;625.2840497630278;643.369497892059;644.9548531602743;654.3685343643311;685.1504134872822;10767.3539587625;11326.886731132749;11414.714632134263;11424.828627570592;11541.249818761753;621.1800423441015;645.2192846655505;649.5193556768052;678.575890068707;687.1067612104345;5140.511651393186;5154.768035438415;5161.716105614228;5240.266362709223;5250.028744682246;100292;109503.90496095097;111594;112234.43882780534;114674.426627868;86974.56512717523;87040;87815.68276475857;88410;92509.5374523123;73945.89081163787;74490;82012.58993704994;82802.58598706967;83421.16578834255;10098.990100989842;10981.341119532854;12083.154179207371;12133.514659413524;12263.509459621515;28965.42069158647;40428;40605.59394406018;41152.794236028625;41906.58093419027;34760;48629.05483780609;49198.754006231175;53734;53796.38610841681;13534.59396218115;14901.850981490046;14996.47512337063;14999.025063370846;15182.240887955779;13952.720945580828;14359.92820035893;16915.915420423313;16986.915065424593;17000.914995424944;15264.160471174193;15361.462348817739;15584.610384740472;15661.765073524135;15752.448664296695;15441;15449.459268925533;15457.613559661098;15716.13561254142;15733.056016639039;13127.803082953573;14748.48380306727;15187.924060379628;15242;15364.385424582892;10613.840792387966;10626;10986.340819550853;11041.00630943219;11197.944010279896;11600.88399115998;11672.774358692555;12264.32546209967;12324.383780810744;12359.01127909747 15:52:20 INFO - PID 1631 | __end_tp_report 15:52:20 INFO - PID 1631 | __start_cc_report 15:52:20 INFO - PID 1631 | _x_x_mozilla_cycle_collect,2061 15:52:20 INFO - PID 1631 | __end_cc_report 15:52:20 INFO - PID 1631 | __startTimestamp1493160740231__endTimestamp 15:52:20 INFO - PID 1631 | 15:52:20 INFO - PID 1631 | ------- Summary: start ------- 15:52:20 INFO - PID 1631 | Number of tests: 6 15:52:20 INFO - PID 1631 | 15:52:20 INFO - PID 1631 | [#0] dojo.html Cycles:165 Average:5994.68 Median:6277.09 stddev:706.29 (11.3%) stddev-sans-first:680.90 15:52:20 INFO - PID 1631 | Values: 3504.3 3523.6 3534.8 3539.5 3584.8 5478.2 5988.9 6156.1 6161.7 6165.1 6094.6 6130.2 6166.4 6223.6 6230.3 5126.3 5178.6 5282.3 5324.6 5376.9 5384.7 5400.8 5401.7 5414.4 5418.6 4076.3 5245.1 5283.1 5298.3 5312.6 5278.0 5288.9 5294.4 5302.7 5306.7 5212.1 5229.2 5251.6 5258.2 5264.6 5292.6 5991.3 6049.6 6107.5 6147.7 6483.6 6485.2 6491.6 6501.9 6506.7 6534.6 6571.3 6578.0 6590.1 6595.2 6087.2 6112.0 6123.5 6166.0 6277.1 6658.5 6679.4 6684.8 6688.8 6693.4 6313.0 6397.6 6400.4 6403.4 6412.6 6458.9 6514.8 6516.7 6521.8 6528.2 6356.4 6414.6 6422.2 6447.6 6459.9 6301.0 6416.5 6421.8 6506.3 6508.8 5243.9 5244.1 5245.9 5247.6 5249.0 4617.1 4700.1 4718.7 4720.8 4744.4 6087.4 6096.1 6097.0 6102.3 6116.2 6372.6 6445.9 6457.9 6464.8 6470.5 6025.7 6043.2 6067.3 6074.8 6096.6 5650.9 5651.8 5657.0 5657.9 5670.7 5897.6 6575.3 6589.6 6589.9 6602.8 6573.0 6605.2 6608.9 6610.4 6665.6 6767.7 6777.4 6777.8 6783.3 6783.9 4852.3 6389.9 6484.7 6491.2 6495.7 6379.0 6525.0 6573.5 6574.5 6585.3 6268.4 6342.6 6349.7 6356.8 6358.1 6325.8 6341.7 6344.4 6344.6 6345.1 6145.1 6353.7 6362.4 6374.8 6378.3 6258.7 6354.9 6370.8 6381.7 6396.6 6131.6 6222.1 6240.4 6320.3 6343.0 15:52:20 INFO - PID 1631 | 15:52:20 INFO - PID 1631 | [#1] ext.html Cycles:180 Average:43052.85 Median:17974.56 stddev:72378.39 (402.7%) stddev-sans-first:72511.76 15:52:20 INFO - PID 1631 | Values: 757.8 787.8 803.0 1120.6 1142.9 26301.9 36413.6 36615.3 36708.0 36733.4 38886.8 39228.6 39290.8 39325.0 39382.2 6016.3 6127.9 8391.2 8555.3 8561.7 8381.5 8541.2 8561.7 8569.7 8574.7 8526.3 8602.3 8611.4 8613.3 8641.8 8530.6 8580.5 8587.7 8594.5 8606.4 8494.7 8549.9 8550.0 8552.1 8556.5 37358.0 37545.4 37586.8 37599.6 37607.4 3413.8 3533.5 3563.2 3565.1 3567.2 30401.4 30436.0 30515.8 30527.8 30570.8 3096.9 3107.4 3134.1 3136.1 3139.4 279177.6 285426.0 286005.6 286048.0 286406.0 48215.8 48253.5 48302.0 48461.5 48482.3 50316.5 50347.5 50377.7 50415.0 50439.2 13500.1 13587.9 13588.7 13601.5 13606.9 9613.7 9660.3 9673.2 11198.7 11206.9 12028.3 12029.1 12102.4 12118.3 12159.6 5385.6 5409.8 5411.7 5421.8 5427.0 950.4 953.7 971.7 985.7 1041.3 18696.0 22880.5 23810.3 23849.8 23923.5 1094.6 1101.4 1142.2 1145.0 1159.3 11843.0 12298.6 15699.3 16106.5 16121.3 279071.6 279511.0 280101.0 280416.0 280691.0 51936.0 51938.5 52240.7 52254.0 52316.7 1457.5 1481.8 1514.4 1515.1 1541.6 27224.0 27892.7 27993.6 28020.0 29224.0 48585.3 48610.3 48654.8 48709.0 48790.0 264327.0 264842.1 265327.0 265767.7 266170.0 28977.0 29127.7 32509.3 32513.8 32535.3 37038.0 42705.8 42725.1 42731.8 42749.0 28200.4 28385.6 29890.0 30026.1 30360.4 29362.1 29436.1 30073.1 30152.2 30386.7 35807.6 35909.5 35911.6 36038.5 36058.6 22994.7 25559.1 28432.7 30785.8 30827.0 22051.2 23722.6 24077.9 24174.0 24188.5 15:52:20 INFO - PID 1631 | 15:52:20 INFO - PID 1631 | [#2] jquery.html Cycles:180 Average:36343.03 Median:22470.33 stddev:96420.87 (429.1%) stddev-sans-first:96653.68 15:52:20 INFO - PID 1631 | Values: 441.1 441.3 445.7 454.4 465.7 19766.6 21698.5 22461.7 22585.3 22708.4 22138.9 22479.0 22562.8 22804.0 23502.7 5704.5 6115.2 6333.2 6341.1 6346.9 5408.8 6248.6 6364.1 6364.3 6379.9 6089.1 6223.1 6322.1 6331.0 6333.8 6259.3 6283.5 6302.8 6304.3 6307.5 5412.8 5557.0 5617.7 5624.8 5633.1 27558.4 27681.4 28424.9 28429.9 28547.6 2194.6 2202.2 2244.1 2245.3 2246.1 17776.3 17783.8 17807.9 18315.9 18370.7 2144.1 2174.5 2200.4 2206.1 2222.4 137168.0 149154.3 160407.0 162374.2 163588.0 11831.6 12437.8 12490.9 12499.6 12519.6 14551.9 16689.4 16713.2 16715.2 16720.6 7451.6 8607.4 8703.8 8887.0 9001.0 7098.1 8485.6 8518.3 8699.3 8710.7 7548.0 7610.1 7703.2 7739.9 7769.2 2118.3 2129.4 2140.2 2142.9 2328.3 829.0 937.4 942.2 947.3 950.4 15906.6 20433.9 21400.3 21724.9 21836.0 941.7 1007.6 1017.6 1017.8 1031.6 10412.9 10777.9 10795.6 10800.4 10823.1 559350.4 564094.0 571348.0 574913.0 575834.0 129599.0 134826.3 135981.0 136364.0 138390.0 1159.8 1185.0 1197.6 1205.9 1208.5 17436.3 17855.6 18342.0 18350.5 18477.5 56566.7 57050.6 57366.4 57458.7 57713.7 77401.0 77915.6 78001.2 78650.6 82413.0 8694.9 8792.0 8853.5 9162.7 9284.1 13428.7 14362.9 14609.3 14735.9 14744.9 11619.7 11797.2 12158.5 12172.6 12225.5 9695.0 11375.6 11544.4 11887.9 11923.8 12072.8 12224.4 12275.6 12411.8 12460.0 8854.6 8977.6 9055.3 9118.6 9127.8 11841.8 11978.9 12252.4 12317.0 12323.1 15:52:20 INFO - PID 1631 | 15:52:20 INFO - PID 1631 | [#3] mootools.html Cycles:180 Average:7163.42 Median:4071.36 stddev:4605.48 (113.1%) stddev-sans-first:4596.60 15:52:20 INFO - PID 1631 | Values: 1200.4 1409.3 1462.2 1480.2 1484.6 9809.1 10287.9 11573.8 11796.6 11811.3 11405.5 11505.2 11526.8 11536.9 11556.5 2492.7 2537.9 2543.2 2547.1 2549.2 2085.8 2121.3 2216.5 2575.0 2587.7 1583.0 1937.2 1957.8 1961.6 1966.6 2500.4 2532.6 2538.4 2538.9 2539.9 2130.5 2216.1 2217.3 2456.0 2531.5 11777.1 11889.2 11895.3 11896.5 11906.0 6508.4 6755.8 6786.6 6787.8 6796.3 4013.1 4235.3 4323.2 4325.9 4380.9 1243.5 1262.2 1281.3 1293.2 1293.6 16900.9 16905.2 16910.2 16910.9 16916.3 4766.5 6006.8 6009.4 6021.8 6183.3 13908.8 13926.7 13928.0 13934.0 13944.5 6892.4 6893.8 6896.1 6904.2 6916.2 6186.4 6235.0 6302.6 6326.1 6327.7 3802.3 4485.3 4575.3 4626.4 4730.6 1394.4 1420.9 1422.7 1443.3 1447.4 764.5 774.5 788.3 790.8 798.4 6465.2 6663.8 6911.4 6913.6 6933.2 867.4 881.1 897.1 897.2 905.9 4129.6 4150.4 4191.5 4249.9 4285.0 14427.8 15137.2 15139.8 15156.2 15203.4 14517.6 15078.0 15083.5 15095.7 15103.5 8325.4 8594.7 8605.1 8608.1 8621.6 6316.9 6624.9 6877.0 6913.7 7010.2 10616.8 13430.1 13741.5 13780.6 13784.2 13558.7 13572.5 13774.7 14061.8 14095.0 9148.0 9435.2 9438.4 9445.5 9452.6 10557.3 10641.5 10776.9 10778.0 10781.0 8929.8 8935.7 9038.0 9066.7 9068.3 8703.5 8845.5 8953.5 8993.0 9060.8 7970.5 8113.5 8159.2 8171.0 8183.4 5871.4 5899.9 6008.6 6051.6 6119.2 4590.4 5174.3 5692.4 6165.4 6316.4 15:52:20 INFO - PID 1631 | 15:52:20 INFO - PID 1631 | [#4] prototype.html Cycles:180 Average:4904.09 Median:5542.60 stddev:1538.10 (27.8%) stddev-sans-first:1504.85 15:52:20 INFO - PID 1631 | Values: 402.3 410.3 413.9 414.9 422.2 4371.7 4772.9 5250.7 5803.9 5894.9 4924.0 5442.5 5553.9 5630.5 5755.9 3642.0 3903.8 4037.6 4273.0 4471.2 4059.0 4461.5 4461.7 4462.4 4485.8 3824.6 4369.9 4430.4 4432.4 4468.9 3630.5 3643.3 4362.6 4405.2 4420.2 3458.8 3465.4 3564.1 3950.0 3962.5 4167.3 4994.0 5291.9 5365.2 5669.4 3868.8 4142.7 4888.2 4956.3 4962.4 6113.9 6123.8 6134.0 6138.8 6148.7 3116.4 3891.4 4102.5 4107.7 4140.0 5612.3 6097.5 6300.7 6321.5 6468.6 3558.0 3875.9 4013.6 4048.9 4182.7 4194.3 4207.8 4228.3 4236.4 4244.7 4635.6 4682.3 4889.7 4961.9 4969.9 5788.0 5995.3 6132.2 6149.8 6168.4 1305.1 1417.9 1437.2 1442.4 1442.9 789.8 944.2 945.0 950.8 955.2 5169.9 5531.3 5817.6 5818.2 5848.5 4862.4 6351.4 6384.8 6391.0 6409.9 5581.4 5700.8 5849.5 5869.6 5877.6 3246.6 3250.6 3325.2 3334.7 3343.8 4420.7 5469.8 6204.6 6488.5 6553.8 5741.3 6181.8 6524.2 6541.0 6616.6 6045.9 6174.5 6394.8 6472.2 6590.9 5245.8 6317.4 6327.7 6361.9 6367.9 4708.9 5743.5 6255.3 6266.0 6284.4 5578.7 6217.4 6286.9 6585.4 6603.2 4638.7 4684.6 4700.7 4707.2 4717.5 6197.7 6339.3 6357.1 6370.6 6384.0 6067.5 6098.9 6116.6 6120.3 6174.4 6007.8 6096.7 6114.7 6146.9 6184.5 5006.7 6009.5 6011.9 6018.7 6026.8 4649.8 5085.6 6095.9 6194.9 6218.5 4812.4 5225.9 5565.3 5999.8 6023.3 15:52:20 INFO - PID 1631 | 15:52:20 INFO - PID 1631 | [#5] yui.html Cycles:180 Average:20638.86 Median:17223.44 stddev:29551.39 (171.6%) stddev-sans-first:29596.06 15:52:20 INFO - PID 1631 | Values: 621.3 629.9 630.8 681.8 743.0 12982.1 15286.9 18228.5 18610.3 18853.9 16648.0 17071.9 17159.4 17287.5 17689.7 954.6 975.7 978.2 979.8 982.4 685.5 705.3 1018.4 1023.1 1028.7 755.8 761.4 764.2 1030.2 1069.9 1033.5 1033.9 1036.5 1037.2 1067.4 773.9 774.7 775.1 785.8 805.2 15686.8 15978.3 16014.3 16078.6 16361.5 15577.8 15644.7 15779.8 15954.4 16229.5 10205.6 13555.9 13679.9 13681.4 13843.5 3338.0 3365.9 3370.5 3370.6 3373.2 104076.5 115370.0 115488.0 115530.0 115599.0 10730.8 12649.8 12895.4 12900.7 12945.5 16197.2 18692.4 19230.0 24622.8 24643.3 7367.7 7533.0 7550.2 7568.1 7644.5 3532.8 3866.1 3918.7 3929.1 3932.7 3980.6 4139.7 4202.7 4217.0 4220.4 932.6 945.2 954.5 955.8 956.9 625.3 643.4 645.0 654.4 685.2 10767.4 11326.9 11414.7 11424.8 11541.2 621.2 645.2 649.5 678.6 687.1 5140.5 5154.8 5161.7 5240.3 5250.0 100292.0 109503.9 111594.0 112234.4 114674.4 86974.6 87040.0 87815.7 88410.0 92509.5 73945.9 74490.0 82012.6 82802.6 83421.2 10099.0 10981.3 12083.2 12133.5 12263.5 28965.4 40428.0 40605.6 41152.8 41906.6 34760.0 48629.1 49198.8 53734.0 53796.4 13534.6 14901.9 14996.5 14999.0 15182.2 13952.7 14359.9 16915.9 16986.9 17000.9 15264.2 15361.5 15584.6 15661.8 15752.4 15441.0 15449.5 15457.6 15716.1 15733.1 13127.8 14748.5 15187.9 15242.0 15364.4 10613.8 10626.0 10986.3 11041.0 11197.9 11600.9 11672.8 12264.3 12324.4 12359.0 15:52:20 INFO - PID 1631 | -------- Summary: end -------- 15:52:20 INFO - PID 1631 | 15:52:20 INFO - TEST-INFO | 1631: exit 0 15:52:20 INFO - TEST-OK | dromaeo_css | took 1119629ms 15:52:20 INFO - TEST-START | kraken 15:52:20 INFO - operating with platform_type : mac_ 15:52:20 INFO - Initialising browser for kraken test... 15:52:20 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpN7HCG3/profile http://localhost:49247/getInfo.html) 15:52:23 INFO - PID 1640 | __metrics Screen width/height:1600/1200 15:52:23 INFO - PID 1640 | colorDepth:24 15:52:23 INFO - PID 1640 | Browser inner width/height: 1024/689 15:52:23 INFO - PID 1640 | __metrics 15:52:23 INFO - PID 1640 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:52:23 INFO - PID 1640 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:52:24 INFO - TEST-INFO | 1640: exit 0 15:52:24 INFO - Browser initialized. 15:52:24 INFO - Running cycle 1/1 for kraken test... 15:52:24 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpN7HCG3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:52:36 INFO - PID 1641 | RSS: Main: 242905088 15:52:36 INFO - PID 1641 | 15:52:39 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection) 15:52:40 INFO - PID 1641 | RSS: Main: 312287232 15:52:40 INFO - PID 1641 | 15:52:43 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-dft) 15:52:43 INFO - PID 1641 | RSS: Main: 293502976 15:52:43 INFO - PID 1641 | 15:52:46 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-fft) 15:52:47 INFO - PID 1641 | RSS: Main: 384356352 15:52:47 INFO - PID 1641 | 15:52:49 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator) 15:52:50 INFO - PID 1641 | RSS: Main: 288501760 15:52:50 INFO - PID 1641 | 15:52:52 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:52:52 INFO - PID 1641 | RSS: Main: 292261888 15:52:52 INFO - PID 1641 | 15:52:55 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom) 15:52:56 INFO - PID 1641 | RSS: Main: 354783232 15:52:56 INFO - PID 1641 | 15:52:59 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate) 15:52:59 INFO - PID 1641 | RSS: Main: 369934336 15:52:59 INFO - PID 1641 | 15:53:02 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial) 15:53:03 INFO - PID 1641 | RSS: Main: 373583872 15:53:03 INFO - PID 1641 | 15:53:04 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:53:05 INFO - PID 1641 | RSS: Main: 332808192 15:53:05 INFO - PID 1641 | 15:53:07 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:53:07 INFO - PID 1641 | RSS: Main: 335196160 15:53:07 INFO - PID 1641 | 15:53:09 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:53:10 INFO - PID 1641 | RSS: Main: 338202624 15:53:10 INFO - PID 1641 | 15:53:13 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:53:14 INFO - PID 1641 | RSS: Main: 352960512 15:53:14 INFO - PID 1641 | 15:53:17 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:53:17 INFO - PID 1641 | RSS: Main: 345534464 15:53:17 INFO - PID 1641 | 15:53:19 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49247/tests/kraken/driver.html?testName=ai-astar) 15:53:19 INFO - PID 1641 | RSS: Main: 388276224 15:53:19 INFO - PID 1641 | 15:53:19 INFO - PID 1641 | __start_tp_report 15:53:19 INFO - PID 1641 | _x_x_mozilla_page_load 15:53:19 INFO - PID 1641 | _x_x_mozilla_page_load_details 15:53:19 INFO - PID 1641 | |i|pagename|runs| 15:53:19 INFO - PID 1641 | |0;ai-astar;111;110;109;111;112;110;112;110;110;111 15:53:19 INFO - PID 1641 | |1;audio-beat-detection;144;96;108;169;141;140;136;103;136;107 15:53:19 INFO - PID 1641 | |2;audio-dft;184;186;183;186;185;185;186;185;182;183 15:53:19 INFO - PID 1641 | |3;audio-fft;78;57;63;86;63;60;57;56;83;60 15:53:19 INFO - PID 1641 | |4;audio-oscillator;85;71;86;69;69;67;89;69;69;97 15:53:19 INFO - PID 1641 | |5;imaging-gaussian-blur;86;86;86;87;87;87;86;87;87;86 15:53:19 INFO - PID 1641 | |6;imaging-darkroom;102;147;94;93;94;94;94;94;94;94 15:53:19 INFO - PID 1641 | |7;imaging-desaturate;101;92;84;86;86;83;84;83;84;85 15:53:19 INFO - PID 1641 | |8;json-parse-financial;49;48;49;48;48;50;49;49;49;48 15:53:19 INFO - PID 1641 | |9;json-stringify-tinderbox;52;60;60;66;62;59;57;58;56;58 15:53:19 INFO - PID 1641 | |10;stanford-crypto-aes;84;81;83;83;83;81;82;82;79;71 15:53:19 INFO - PID 1641 | |11;stanford-crypto-ccm;138;137;135;144;136;139;148;128;216;155 15:53:19 INFO - PID 1641 | |12;stanford-crypto-pbkdf2;187;182;186;185;188;184;187;181;183;179 15:53:19 INFO - PID 1641 | |13;stanford-crypto-sha256-iterative;68;66;67;68;67;69;68;67;69;66 15:53:19 INFO - PID 1641 | __end_tp_report 15:53:19 INFO - PID 1641 | __start_cc_report 15:53:19 INFO - PID 1641 | _x_x_mozilla_cycle_collect,2158 15:53:19 INFO - PID 1641 | __end_cc_report 15:53:19 INFO - PID 1641 | __startTimestamp1493160799789__endTimestamp 15:53:19 INFO - PID 1641 | 15:53:19 INFO - PID 1641 | ------- Summary: start ------- 15:53:19 INFO - PID 1641 | Number of tests: 14 15:53:19 INFO - PID 1641 | 15:53:19 INFO - PID 1641 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:0.97 (0.9%) stddev-sans-first:1.01 15:53:19 INFO - PID 1641 | Values: 111.0 110.0 109.0 111.0 112.0 110.0 112.0 110.0 110.0 111.0 15:53:19 INFO - PID 1641 | 15:53:19 INFO - PID 1641 | [#1] audio-beat-detection Cycles:10 Average:128.00 Median:140.50 stddev:23.26 (16.6%) stddev-sans-first:23.94 15:53:19 INFO - PID 1641 | Values: 144.0 96.0 108.0 169.0 141.0 140.0 136.0 103.0 136.0 107.0 15:53:19 INFO - PID 1641 | 15:53:19 INFO - PID 1641 | [#2] audio-dft Cycles:10 Average:184.50 Median:185.00 stddev:1.43 (0.8%) stddev-sans-first:1.51 15:53:19 INFO - PID 1641 | Values: 184.0 186.0 183.0 186.0 185.0 185.0 186.0 185.0 182.0 183.0 15:53:19 INFO - PID 1641 | 15:53:19 INFO - PID 1641 | [#3] audio-fft Cycles:10 Average:66.30 Median:63.00 stddev:11.47 (18.2%) stddev-sans-first:11.36 15:53:19 INFO - PID 1641 | Values: 78.0 57.0 63.0 86.0 63.0 60.0 57.0 56.0 83.0 60.0 15:53:19 INFO - PID 1641 | 15:53:19 INFO - PID 1641 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:78.00 stddev:10.96 (14.1%) stddev-sans-first:11.24 15:53:19 INFO - PID 1641 | Values: 85.0 71.0 86.0 69.0 69.0 67.0 89.0 69.0 69.0 97.0 15:53:19 INFO - PID 1641 | 15:53:19 INFO - PID 1641 | [#5] imaging-gaussian-blur Cycles:10 Average:86.50 Median:87.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 15:53:19 INFO - PID 1641 | Values: 86.0 86.0 86.0 87.0 87.0 87.0 86.0 87.0 87.0 86.0 15:53:19 INFO - PID 1641 | 15:53:19 INFO - PID 1641 | [#6] imaging-darkroom Cycles:10 Average:100.00 Median:94.00 stddev:16.71 (17.8%) stddev-sans-first:17.71 15:53:19 INFO - PID 1641 | Values: 102.0 147.0 94.0 93.0 94.0 94.0 94.0 94.0 94.0 94.0 15:53:19 INFO - PID 1641 | 15:53:19 INFO - PID 1641 | [#7] imaging-desaturate Cycles:10 Average:86.80 Median:84.50 stddev:5.63 (6.7%) stddev-sans-first:2.77 15:53:19 INFO - PID 1641 | Values: 101.0 92.0 84.0 86.0 86.0 83.0 84.0 83.0 84.0 85.0 15:53:19 INFO - PID 1641 | 15:53:19 INFO - PID 1641 | [#8] json-parse-financial Cycles:10 Average:48.70 Median:49.00 stddev:0.67 (1.4%) stddev-sans-first:0.71 15:53:19 INFO - PID 1641 | Values: 49.0 48.0 49.0 48.0 48.0 50.0 49.0 49.0 49.0 48.0 15:53:19 INFO - PID 1641 | 15:53:19 INFO - PID 1641 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.50 stddev:3.71 (6.2%) stddev-sans-first:3.00 15:53:19 INFO - PID 1641 | Values: 52.0 60.0 60.0 66.0 62.0 59.0 57.0 58.0 56.0 58.0 15:53:19 INFO - PID 1641 | 15:53:19 INFO - PID 1641 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:82.50 stddev:3.75 (4.6%) stddev-sans-first:3.81 15:53:19 INFO - PID 1641 | Values: 84.0 81.0 83.0 83.0 83.0 81.0 82.0 82.0 79.0 71.0 15:53:19 INFO - PID 1641 | 15:53:19 INFO - PID 1641 | [#11] stanford-crypto-ccm Cycles:10 Average:147.60 Median:141.50 stddev:25.17 (17.8%) stddev-sans-first:26.46 15:53:19 INFO - PID 1641 | Values: 138.0 137.0 135.0 144.0 136.0 139.0 148.0 128.0 216.0 155.0 15:53:19 INFO - PID 1641 | 15:53:19 INFO - PID 1641 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.20 Median:185.50 stddev:2.94 (1.6%) stddev-sans-first:2.93 15:53:19 INFO - PID 1641 | Values: 187.0 182.0 186.0 185.0 188.0 184.0 187.0 181.0 183.0 179.0 15:53:19 INFO - PID 1641 | 15:53:19 INFO - PID 1641 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.08 (1.6%) stddev-sans-first:1.13 15:53:19 INFO - PID 1641 | Values: 68.0 66.0 67.0 68.0 67.0 69.0 68.0 67.0 69.0 66.0 15:53:19 INFO - PID 1641 | -------- Summary: end -------- 15:53:19 INFO - PID 1641 | 15:53:20 INFO - TEST-INFO | 1641: exit 0 15:53:20 INFO - TEST-OK | kraken | took 59871ms 15:53:20 INFO - SUITE-END | took 1179s 15:53:20 INFO - Completed test suite (00:19:39) 15:53:20 INFO - javascript benchmark 15:53:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7662.709676706711, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3504.316658251642, 3523.6300188480227, 3534.770239934404, 3539.5398598182223, 3584.784912905226, 5478.205660179272, 5988.9101663475085, 6156.138140660306, 6161.691915404234, 6165.106059621352, 6094.592115505712, 6130.18412495761, 6166.414190651892, 6223.626582405059, 6230.252369715629, 5126.282320475137, 5178.637495375326, 5282.339707536558, 5324.627276090685, 5376.892462150755, 5384.730763461831, 5400.83797486076, 5401.70290634015, 5414.35027796663, 5418.593605479585, 4076.2866498362814, 5245.134552798783, 5283.101872681654, 5298.284731561228, 5312.601554883399, 5278.023565640369, 5288.894222115575, 5294.364676238876, 5302.655327403706, 5306.681599104066, 5212.061828870802, 5229.241759944786, 5251.55361794248, 5258.1849813279005, 5264.6051546134195, 5292.550133238679, 5991.310999235056, 6049.637021778663, 6107.4503294703245, 6147.661878596676, 6483.610983341015, 6485.156929599169, 6491.578047426902, 6501.902471462932, 6506.739730410825, 6534.640594767286, 6571.310012448672, 6578.0, 6590.143281373439, 6595.175603049619, 6087.178230938855, 6111.964830093264, 6123.537002805184, 6165.969170154121, 6277.089821975788, 6658.500612454085, 6679.398854103154, 6684.766033188815, 6688.765893193715, 6693.364130407604, 6313.021481670348, 6397.584157029778, 6400.39196276353, 6403.391677790602, 6412.551121421549, 6458.870822583522, 6514.837129071716, 6516.706748196342, 6521.836954076091, 6528.151340325728, 6356.4279214870885, 6414.583052101599, 6422.197225346832, 6447.580907241015, 6459.870802583922, 6300.968495157586, 6416.454601358843, 6421.775237866652, 6506.284308726036, 6508.8047358579315, 5243.895122097537, 5244.056069907453, 5245.868853278698, 5247.580193584504, 5248.9737551312, 4617.12274667812, 4700.059988002413, 4718.716876987323, 4720.763961801897, 4744.4069491313585, 6087.421694938974, 6096.0855871619615, 6097.024476083805, 6102.328743838174, 6116.174316467309, 6372.617642941438, 6445.903311450332, 6457.935420645734, 6464.806055818333, 6470.547061705635, 6025.698715064317, 6043.184170137063, 6067.271927368744, 6074.787382441594, 6096.603720758137, 5650.943490565041, 5651.802186923438, 5656.981743286248, 5657.858553536194, 5670.659760414388, 5897.64614123154, 6575.309592492719, 6589.604623722592, 6589.86820263592, 6602.8349291268105, 6573.04690819838, 6605.207375115017, 6608.933910660832, 6610.438112760469, 6665.600063996176, 6767.661616919233, 6777.423918966943, 6777.762778302736, 6783.287754785676, 6783.864322713617, 4852.296417019583, 6389.9041514376395, 6484.70818813164, 6491.188601424822, 6495.675216239264, 6379.0, 6525.0, 6573.5069869759, 6574.539782215199, 6585.275619681927, 6268.435840774352, 6342.587731797418, 6349.746010159727, 6356.809295721136, 6358.109864619049, 6325.810225693236, 6341.651209183539, 6344.429001389897, 6344.619322840645, 6345.079963405373, 6145.064304743992, 6353.745850165941, 6362.427381535684, 6374.840628984127, 6378.330275321025, 6258.687065646791, 6354.936450635434, 6370.8088757337355, 6381.680915954091, 6396.648184349905, 6131.601445906002, 6222.066689996355, 6240.375962403723, 6320.336364681642, 6343.0], "value": 5948.842504133444, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.7613051888654, 787.7951732549536, 803.0323460230421, 1120.602186223891, 1142.925709828861, 26301.868490657544, 36413.63586364136, 36615.26769464609, 36708.0, 36733.44899826505, 38886.8055659722, 39228.60771392285, 39290.821275361785, 39325.0, 39382.21235575287, 6016.27804663441, 6127.877442451148, 8391.24478796908, 8555.315574754004, 8561.700340488083, 8381.497110173379, 8541.231289183972, 8561.657533698644, 8569.742907712747, 8574.742757717248, 8526.31789456842, 8602.311815054813, 8611.397202195849, 8613.310935125175, 8641.827163456726, 8530.616122274481, 8580.485170889704, 8587.699430519964, 8594.527300998443, 8606.354523410706, 8494.74515764528, 8549.914500854975, 8550.0, 8552.144785521461, 8556.5293908835, 37358.0, 37545.43681844747, 37586.81206593977, 37599.62400375988, 37607.435888461696, 3413.76103672743, 3533.505309256706, 3563.1626567756557, 3565.090901820045, 3567.233044895334, 30401.391972160654, 30436.0, 30515.847420762977, 30527.847360763277, 30570.847145764128, 3096.922576935572, 3107.425126351632, 3134.09111357706, 3136.1375621703987, 3139.4035133324596, 279177.6041119802, 285426.0, 286005.5699721509, 286048.0, 286406.0, 48215.75892120517, 48253.51746482561, 48302.0, 48461.5153848464, 48482.27276590854, 50316.49683503118, 50347.49652503428, 50377.74811125921, 50415.0, 50439.243411348856, 13500.054996150175, 13587.91296696262, 13588.660283492993, 13601.523946661819, 13606.863931360758, 9613.711588652352, 9660.275479339078, 9673.177779888789, 11198.720031999264, 11206.887931120747, 12028.27830330183, 12029.09781766371, 12102.394880256128, 12118.333491658044, 12159.574414895613, 5385.569154467712, 5409.756560954766, 5411.729413529387, 5421.783128674888, 5427.0, 950.3727539823683, 953.6614501851882, 971.6502059258661, 985.669800616787, 1041.3335465302212, 18696.0, 22880.542389152455, 23810.285691429286, 23849.7615023851, 23923.521529569312, 1094.5512339940585, 1101.3612104979093, 1142.1833389126814, 1144.959926402572, 1159.2812456276993, 11843.038803689358, 12298.631041068782, 15699.293531790869, 16106.516804495885, 16121.27454264561, 279071.6046419755, 279511.0, 280101.0, 280416.0, 280691.0, 51936.0, 51938.48061519412, 52240.73879630578, 52253.95492090213, 52316.73841630767, 1457.5263039512201, 1481.7703255995339, 1514.440595393781, 1515.113658509762, 1541.5760665816765, 27224.047158349364, 27892.721072789012, 27993.580096298163, 28020.0, 29224.0, 48585.27122093242, 48610.27084593663, 48654.75672621614, 48709.0, 48790.0, 264327.0, 264842.1368397339, 265327.0, 265767.67116164294, 266170.0, 28977.0, 29127.7087229125, 32509.34981300408, 32513.83743081364, 32535.349293014482, 37038.0, 42705.78647106745, 42725.1454970905, 42731.79511536585, 42749.0, 28200.43599127965, 28385.574216386358, 29889.95385161596, 30026.099217023526, 30360.392792143593, 29362.119136425943, 29436.116916491683, 30073.097807065824, 30152.24619384533, 30386.696133038386, 35807.64192358043, 35909.46135807913, 35911.64088359083, 36038.4594231092, 36058.63941360553, 22994.655080173477, 25559.105431309814, 28432.715672843005, 30785.8460707695, 30827.0, 22051.22820701268, 23722.644160337954, 24077.879610601834, 24174.0, 24188.51622967566], "value": 17214.901506482427, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.0693436848252, 441.2608880125791, 445.7303331484453, 454.37977161175, 465.7438408875118, 19766.604667906635, 21698.457538561524, 22461.663075053846, 22585.322440326774, 22708.432289192777, 22138.89305534725, 22479.0, 22562.774372256274, 22804.0, 23502.707351095683, 5704.54363650909, 6115.235595550545, 6333.240011198663, 6341.080543321215, 6346.873062538746, 5408.783648654049, 6248.593841400318, 6364.077208804721, 6364.299927008025, 6379.904301435482, 6089.0866370044405, 6223.1287619733275, 6322.146510221107, 6331.0, 6333.809985700436, 6259.311475737665, 6283.497320214372, 6302.779402720906, 6304.27500837405, 6307.463865571432, 5412.810551630713, 5557.027520183992, 5617.747201375907, 5624.775008999676, 5633.098704207348, 27558.448831023466, 27681.446371072667, 28424.857875710695, 28429.85785071082, 28547.57178642322, 2194.648856183003, 2202.196198387593, 2244.147224054865, 2245.259064508708, 2246.146464343555, 17776.28894844205, 17783.822161778346, 17807.910960445246, 18315.908420457945, 18370.724439133424, 2144.1423430627874, 2174.4998650310517, 2200.3728937252968, 2206.0844749428966, 2222.411061068818, 137168.0, 149154.2711432212, 160407.0, 162374.1881290586, 163588.0, 11831.585894493823, 12437.75124497505, 12490.937545312216, 12499.56251531192, 12519.561815336601, 14551.927240363942, 16689.415870444718, 16713.247903844356, 16715.16424178786, 16720.581985450463, 7451.627418629156, 8607.354448416268, 8703.782405439788, 8887.00212261206, 9001.0, 7098.077249957576, 8485.618147183392, 8518.275946544489, 8699.347548933856, 8710.651573936972, 7548.0, 7610.142882693123, 7703.229677032364, 7739.883901741478, 7769.223077692185, 2118.322136916203, 2129.403766945227, 2140.1546389176187, 2142.892855357226, 2328.3247858120953, 828.9544075075808, 937.3906960475746, 942.1614762861059, 947.275334369208, 950.4290893134056, 15906.568408843259, 20433.897830510752, 21400.250991215235, 21724.891375543022, 21836.017379217974, 941.6562954521551, 1007.5818535307911, 1017.6438246613626, 1017.8421745898742, 1031.6183012285503, 10412.895871041344, 10777.892221077846, 10795.568177272979, 10800.351978881292, 10823.13414926804, 559350.406495938, 564094.0, 571348.0, 574913.0, 575834.0, 129599.0, 134826.325868372, 135981.0, 136364.0, 138390.0, 1159.7854396936593, 1184.9585264515702, 1197.5928184417166, 1205.9336736479402, 1208.5226335597565, 17436.302547897943, 17855.553611159306, 18342.0, 18350.541236469195, 18477.53806154857, 56566.717166415554, 57050.57373565694, 57366.426335736105, 57458.7127064362, 57713.71143144257, 77401.0, 77915.6104219498, 78001.21998780167, 78650.6067469659, 82413.0, 8694.91305086941, 8791.956040219759, 8853.468791872509, 9162.67930622425, 9284.118008789153, 13428.664283392993, 14362.928185359006, 14609.269536523343, 14735.852641473448, 14744.852551474349, 11619.6514104577, 11797.233179843282, 12158.45286962071, 12172.634820955385, 12225.510979560719, 9695.0, 11375.601853935073, 11544.365059921785, 11887.881121188677, 11923.76152476963, 12072.818907716215, 12224.449899754354, 12275.631731048083, 12411.813822792847, 12460.0, 8854.645814167361, 8977.596008179517, 9055.320850936338, 9118.589663465027, 9127.817443651222, 11841.822372664245, 11978.940105299418, 12252.448639811051, 12317.0, 12323.075769317516], "value": 10508.33994585344, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1200.4357951762668, 1409.3094383751961, 1462.1811785400178, 1480.1785009319824, 1484.599158227278, 9809.068138526838, 10287.948560257197, 11573.768524629502, 11796.646100616974, 11811.291322520654, 11405.54377824886, 11505.194636375436, 11526.827097593543, 11536.884631153685, 11556.479958401871, 2492.7382624824404, 2537.8857951392233, 2543.249741326304, 2547.0575886921865, 2549.2352294311727, 2085.7705652378227, 2121.2681624839406, 2216.468047668556, 2574.961375579368, 2587.6506671599377, 1582.9683406331924, 1937.2251099560149, 1957.7748558915694, 1961.5880665060283, 1966.5673551818577, 2500.3874050857567, 2532.556802559554, 2538.378097366157, 2538.885750141248, 2539.911103111382, 2130.541933484308, 2216.1135545781817, 2217.3347995601257, 2456.0, 2531.5190113878302, 11777.057835373149, 11889.227200232044, 11895.345755983417, 11896.524139034429, 11906.047516198683, 6508.4142427181305, 6755.831104222385, 6786.59280443175, 6787.762428315034, 6796.286389929085, 4013.0769922917602, 4235.2800023996, 4323.156984388045, 4325.891852703708, 4380.8685739427865, 1243.521244320943, 1262.236347010055, 1281.3208999230424, 1293.2369901758009, 1293.5795866343383, 16900.915495422567, 16905.15474226284, 16910.239039243264, 16910.915445422816, 16916.32334706598, 4766.451858036301, 6006.819795406145, 6009.36901625323, 6021.7802699316, 6183.258009038944, 13908.791368129487, 13926.651833704036, 13928.0, 13934.024618276826, 13944.51194208198, 6892.379685828299, 6893.75871844483, 6896.069030680894, 6904.206016308189, 6916.1700595927805, 6186.443220110212, 6234.9688251559355, 6302.621842689453, 6326.145970294044, 6327.746890124344, 3802.258559580855, 4485.304777759453, 4575.313702944519, 4626.375439315717, 4730.574248317599, 1394.372532360442, 1420.943162273518, 1422.7439060968918, 1443.3432788081398, 1447.41379741205, 764.5068930539882, 774.5430196184166, 788.333857890082, 790.7627711686471, 798.4011991006745, 6465.224173099258, 6663.833404164838, 6911.447084233249, 6913.585184888922, 6933.168019837652, 867.4274978514151, 881.110078820396, 897.0760117079419, 897.2239013253619, 905.8747321739892, 4129.648979836687, 4150.439690641785, 4191.476065491814, 4249.851255206115, 4285.0358669299785, 14427.78358324626, 15137.167455789817, 15139.772903406458, 15156.24218789056, 15203.391864325304, 14517.637059073397, 15078.0, 15083.54749357521, 15095.698086038217, 15103.4713785017, 8325.375596830261, 8594.699185528601, 8605.053444121142, 8608.139186081467, 8621.61202745878, 6316.905246421399, 6624.933750662624, 6877.0, 6913.688884000131, 7010.158780946319, 10616.832148463509, 13430.127041742255, 13741.519046833313, 13780.586582402544, 13784.172949623055, 13558.661033474242, 13572.524961626295, 13774.724505510034, 14061.789073163705, 14095.0, 9148.0, 9435.24518038569, 9438.433693978383, 9445.480498572644, 9452.621895124117, 10557.313774604627, 10641.467926603793, 10776.892231077589, 10778.0, 10780.975807298295, 8929.776755581162, 8935.731928042169, 9038.0, 9066.682666106655, 9068.319876009458, 8703.477791332287, 8845.51349675774, 8953.462792232487, 8993.0, 9060.818783624423, 7970.521768693897, 8113.5131892086665, 8159.224873636995, 8170.959145204473, 8183.3862460316905, 5871.412858714265, 5899.882002360015, 6008.639481631116, 6051.576389652682, 6119.2350956130485, 4590.403247577793, 5174.301469301596, 5692.402297758676, 6165.352637972948, 6316.3683631638305], "value": 5371.3104942607815, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.30401405568364, 410.306098236178, 413.9110091330367, 414.9087200815819, 422.22521672730517, 4371.672124590653, 4772.856814295568, 5250.6587071840395, 5803.883922321551, 5894.909441753273, 4924.0, 5442.482964118402, 5553.861153471165, 5630.465105814951, 5755.856103597413, 3641.963580364189, 3903.765774053566, 4037.6070255761715, 4272.978635106821, 4471.195184866739, 4058.9797051014702, 4461.5092339842595, 4461.687681862271, 4462.3752674625575, 4485.775711214443, 3824.5849035856772, 4369.90752311922, 4430.446194225722, 4432.445944256968, 4468.905118246034, 3630.528031355907, 3643.25313310772, 4362.5855543723455, 4405.22908491016, 4420.182266280716, 3458.844352004166, 3465.358908601917, 3564.144605294711, 3949.9605003949882, 3962.5244970603712, 4167.291560434703, 4993.950060499385, 5291.86770330741, 5365.195220716884, 5669.376368599451, 3868.825902834379, 4142.689298302639, 4888.2178851383605, 4956.339626225219, 4962.3548938638105, 6113.908291375633, 6123.846903827395, 6134.0, 6138.785142520035, 6148.6618235997, 3116.426204766601, 3891.435741817449, 4102.466679331667, 4107.650849677781, 4139.958600413987, 5612.326520817487, 6097.542684298695, 6300.653464059475, 6321.523162260738, 6468.644224567647, 3557.9681892251474, 3875.8837234883, 4013.57857424972, 4048.8987775305854, 4182.703361957802, 4194.266003449445, 4207.8316867325575, 4228.344606585984, 4236.364545318227, 4244.745315281093, 4635.605973492224, 4682.344471773954, 4889.657723959289, 4961.875953101201, 4969.925451118236, 5788.0, 5995.2805663319805, 6132.233470816148, 6149.7847575334645, 6168.444839964424, 1305.092960392537, 1417.8723914847508, 1437.159261831819, 1442.401403417591, 1442.9134251944918, 789.8459800338994, 944.1927152284835, 945.0124619772217, 950.8383574792302, 955.2214944820089, 5169.896602067937, 5531.3362396512675, 5817.621854579439, 5818.21454103699, 5848.473637372657, 4862.440819305754, 6351.428371446592, 6384.808455746335, 6390.968045159744, 6409.8718025640155, 5581.358143813432, 5700.7719691212715, 5849.473547380756, 5869.559783016291, 5877.617954832922, 3246.62663793662, 3250.593675790526, 3325.201951531615, 3334.683205095512, 3343.8160901150673, 4420.662399888128, 5469.753861076261, 6204.55647115846, 6488.480921526267, 6553.8361540960905, 5741.339745929272, 6181.752729890754, 6524.151860258136, 6540.9672951635885, 6616.636085015371, 6045.911735887583, 6174.536909731788, 6394.784990851724, 6472.223333200046, 6590.901136483052, 5245.763940622757, 6317.368263173646, 6327.683615819283, 6361.936380636134, 6367.93632063692, 4708.882277943078, 5743.511801496919, 6255.31191568918, 6265.997440409513, 6284.402981716729, 5578.693171875423, 6217.378262173746, 6286.905696414466, 6585.440237579668, 6603.20761508622, 4638.698484598491, 4684.60180884615, 4700.670953033255, 4707.211259721284, 4717.528247175255, 6197.690115494297, 6339.270983836917, 6357.141785859035, 6370.55406121567, 6384.0, 6067.544934130046, 6098.939010609837, 6116.602420842631, 6120.3267640558615, 6174.44430001302, 6007.789727359522, 6096.725647345968, 6114.724837382418, 6146.877062458815, 6184.474319682878, 5006.69959802413, 6009.5445119057595, 6011.941939191116, 6018.682807119203, 6026.758929642765, 4649.790759415767, 5085.5931525477135, 6095.908561371672, 6194.853952018891, 6218.53360997936, 4812.374391329105, 5225.895482090261, 5565.30433695788, 5999.820005399845, 6023.3073196582955], "value": 4438.684222623617, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.3413781391724, 629.946454551363, 630.8170630517151, 681.7750142452991, 742.9554226746392, 12982.09125361225, 15286.923565382185, 18228.544286392847, 18610.34863779768, 18853.905730471346, 16648.0, 17071.91464042681, 17159.399421020265, 17287.48137555872, 17689.734653980202, 954.5513608603962, 975.6780262513389, 978.2418625565173, 979.8383266760976, 982.351647912378, 685.4516386890492, 705.2524324216322, 1018.4042335233897, 1023.145673362743, 1028.665683652812, 755.8488302339526, 761.3984951888002, 764.1899586438366, 1030.2273295028729, 1069.887661795512, 1033.529743966501, 1033.8655974723313, 1036.4765793274387, 1037.190991027, 1067.3915867955268, 773.8877862709932, 774.6785084190111, 775.1086250811555, 785.7524879662888, 805.2189376304975, 15686.843131568652, 15978.280977356048, 16014.279357428828, 16078.598035049217, 16361.509154725378, 15577.844221557865, 15644.68710625781, 15779.842201577952, 15954.44159454425, 16229.513114606581, 10205.591776328938, 13555.934219139595, 13679.863201367958, 13681.384337704827, 13843.515476958359, 3338.0, 3365.882194123194, 3370.477575975703, 3370.5955285365667, 3373.1567108222944, 104076.47961760219, 115370.0, 115488.0, 115530.0, 115599.0, 10730.839037414446, 12649.810252846215, 12895.355232238351, 12900.741985160432, 12945.482180712854, 16197.190140492929, 18692.43922682322, 19230.0, 24622.753772462405, 24643.260702178963, 7367.742129025459, 7532.962335188398, 7550.207228241065, 7568.053993250844, 7644.464887457824, 3532.7703699259464, 3866.0721426857353, 3918.686505079587, 3929.057026313664, 3932.7050471214775, 3980.641742243154, 4139.668826493873, 4202.684798640114, 4217.030083080908, 4220.409142720022, 932.5570354081757, 945.2107490245585, 954.4654993203828, 955.8279509688184, 956.8660387545749, 625.2840497630278, 643.369497892059, 644.9548531602743, 654.3685343643311, 685.1504134872822, 10767.3539587625, 11326.886731132749, 11414.714632134263, 11424.828627570592, 11541.249818761753, 621.1800423441015, 645.2192846655505, 649.5193556768052, 678.575890068707, 687.1067612104345, 5140.511651393186, 5154.768035438415, 5161.716105614228, 5240.266362709223, 5250.028744682246, 100292.0, 109503.90496095097, 111594.0, 112234.43882780534, 114674.426627868, 86974.56512717523, 87040.0, 87815.68276475857, 88410.0, 92509.5374523123, 73945.89081163787, 74490.0, 82012.58993704994, 82802.58598706967, 83421.16578834255, 10098.990100989842, 10981.341119532854, 12083.154179207371, 12133.514659413524, 12263.509459621515, 28965.42069158647, 40428.0, 40605.59394406018, 41152.794236028625, 41906.58093419027, 34760.0, 48629.05483780609, 49198.754006231175, 53734.0, 53796.38610841681, 13534.59396218115, 14901.850981490046, 14996.47512337063, 14999.025063370846, 15182.240887955779, 13952.720945580828, 14359.92820035893, 16915.915420423313, 16986.915065424593, 17000.914995424944, 15264.160471174193, 15361.462348817739, 15584.610384740472, 15661.765073524135, 15752.448664296695, 15441.0, 15449.459268925533, 15457.613559661098, 15716.13561254142, 15733.056016639039, 13127.803082953573, 14748.48380306727, 15187.924060379628, 15242.0, 15364.385424582892, 10613.840792387966, 10626.0, 10986.340819550853, 11041.00630943219, 11197.944010279896, 11600.88399115998, 11672.774358692555, 12264.32546209967, 12324.383780810744, 12359.01127909747], "value": 7889.606725577212, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1427.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 109.0, 111.0, 112.0, 110.0, 112.0, 110.0, 110.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 96.0, 108.0, 169.0, 141.0, 140.0, 136.0, 103.0, 136.0, 107.0], "value": 128.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 186.0, 183.0, 186.0, 185.0, 185.0, 186.0, 185.0, 182.0, 183.0], "value": 184.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 57.0, 63.0, 86.0, 63.0, 60.0, 57.0, 56.0, 83.0, 60.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 86.0, 69.0, 69.0, 67.0, 89.0, 69.0, 69.0, 97.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 87.0, 87.0, 87.0, 86.0, 87.0, 87.0, 86.0], "value": 86.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 147.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 100.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 92.0, 84.0, 86.0, 86.0, 83.0, 84.0, 83.0, 84.0, 85.0], "value": 86.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 48.0, 49.0, 48.0, 48.0, 50.0, 49.0, 49.0, 49.0, 48.0], "value": 48.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 60.0, 60.0, 66.0, 62.0, 59.0, 57.0, 58.0, 56.0, 58.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 83.0, 83.0, 83.0, 81.0, 82.0, 82.0, 79.0, 71.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 135.0, 144.0, 136.0, 139.0, 148.0, 128.0, 216.0, 155.0], "value": 147.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 182.0, 186.0, 185.0, 188.0, 184.0, 187.0, 181.0, 183.0, 179.0], "value": 184.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 68.0, 67.0, 69.0, 68.0, 67.0, 69.0, 66.0], "value": 67.5, "unit": "score"}]}]} 15:53:21 INFO - Return code: 0 15:53:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:53:21 ERROR - # TBPL SUCCESS # 15:53:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:53:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:53:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:53:21 INFO - 2017-04-25 15:53:21.111 screenresolution[1645:10012] starting screenresolution argv=screenresolution get 15:53:21 INFO - 2017-04-25 15:53:21.114 screenresolution[1645:10012] Display 0: 1600x1200x32@60 15:53:21 INFO - 2017-04-25 15:53:21.120 screenresolution[1646:10015] starting screenresolution argv=screenresolution list 15:53:21 INFO - Available Modes on Display 0 15:53:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:53:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:53:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:53:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:53:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:53:21 INFO - Intel Iris: 15:53:21 INFO - Chipset Model: Intel Iris 15:53:21 INFO - Type: GPU 15:53:21 INFO - Bus: Built-In 15:53:21 INFO - VRAM (Dynamic, Max): 1536 MB 15:53:21 INFO - Vendor: Intel (0x8086) 15:53:21 INFO - Device ID: 0x0a2e 15:53:21 INFO - Revision ID: 0x0009 15:53:21 INFO - Displays: 15:53:21 INFO - Display: 15:53:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:53:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:53:21 INFO - Display Serial Number: 1600x1200 60 15:53:21 INFO - Main Display: Yes 15:53:21 INFO - Mirror: Off 15:53:21 INFO - Online: Yes 15:53:21 INFO - Rotation: Supported 15:53:21 INFO - Return code: 0 15:53:21 INFO - Running post-action listener: _resource_record_post_action 15:53:21 INFO - [mozharness: 2017-04-25 22:53:21.367254Z] Finished run-tests step (success) 15:53:21 INFO - Running post-run listener: _resource_record_post_run 15:53:21 INFO - Total resource usage - Wall time: 1200s; CPU: 53.0%; Read bytes: 39564288; Write bytes: 507399168; Read time: 390; Write time: 1837 15:53:21 INFO - TinderboxPrint: CPU usage
53.3% 15:53:21 INFO - TinderboxPrint: I/O read bytes / time
39,564,288 / 390 15:53:21 INFO - TinderboxPrint: I/O write bytes / time
507,399,168 / 1,837 15:53:21 INFO - TinderboxPrint: CPU idle
2,240.2 (46.7%) 15:53:21 INFO - TinderboxPrint: CPU system
957.2 (19.9%) 15:53:21 INFO - TinderboxPrint: CPU user
1,604.2 (33.4%) 15:53:21 INFO - TinderboxPrint: Swap in / out
247,521,280 / 0 15:53:21 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 204571136; Write bytes: 206452736; Read time: 16863; Write time: 434 15:53:21 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 37544960; Write bytes: 294155264; Read time: 364; Write time: 1374 15:53:21 INFO - Running post-run listener: _upload_blobber_files 15:53:21 INFO - Blob upload gear active. 15:53:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:53:21 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 15:53:21 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'] 15:53:21 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 15:53:22 INFO - (blobuploader) - INFO - Open directory for files ... 15:53:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:53:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:53:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:53:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:53:23 INFO - (blobuploader) - INFO - Done attempting. 15:53:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:53:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:53:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:53:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:53:24 INFO - (blobuploader) - INFO - Done attempting. 15:53:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:53:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:53:25 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:53:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:53:25 INFO - (blobuploader) - INFO - Done attempting. 15:53:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:53:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:53:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:53:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:53:27 INFO - (blobuploader) - INFO - Done attempting. 15:53:27 INFO - (blobuploader) - INFO - Iteration through files over. 15:53:27 INFO - Return code: 0 15:53:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:53:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:53:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddc62363daa7c866bca311e38d87323ac5e16e59b6025f6bc90521cab0be4c5eebd63ff0baf001b17df7d69a5e3c86c7448a8ea87faca0538934f1f247ecc196", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4eb9f0ce903ed1382bb848303844f4b990c395956e163bf3b735a57ce3f3fa316d647eb09446991be244c2126c9dc558af8360bfa2b3c963416e49a135a76d3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0305d2f5e0df1ab31909b743d3514bed43084e56ba707ebdbc9899e70619ac2d9670eeec951ac003a7b4ae78c1d59ca67b881a0732975a9a81988b81b852f03f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/648bef7794e24c24ffff17174623e57a11f91ddda1b403a4c7d3b446547df90b2c5d0ad0925c8651b099f298586e4ff5a59c18410c93c4bdd8f8e849f3c93cb2"} 15:53:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:53:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:53:27 INFO - Contents: 15:53:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddc62363daa7c866bca311e38d87323ac5e16e59b6025f6bc90521cab0be4c5eebd63ff0baf001b17df7d69a5e3c86c7448a8ea87faca0538934f1f247ecc196", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4eb9f0ce903ed1382bb848303844f4b990c395956e163bf3b735a57ce3f3fa316d647eb09446991be244c2126c9dc558af8360bfa2b3c963416e49a135a76d3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0305d2f5e0df1ab31909b743d3514bed43084e56ba707ebdbc9899e70619ac2d9670eeec951ac003a7b4ae78c1d59ca67b881a0732975a9a81988b81b852f03f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/648bef7794e24c24ffff17174623e57a11f91ddda1b403a4c7d3b446547df90b2c5d0ad0925c8651b099f298586e4ff5a59c18410c93c4bdd8f8e849f3c93cb2"} 15:53:27 INFO - Running post-run listener: copy_logs_to_upload_dir 15:53:27 INFO - Copying logs to upload dir... 15:53:27 INFO - mkdir: /builds/slave/test/build/upload/logs 15:53:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.986692 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-25 15:53:27.885333) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-25 15:53:27.889051) ========= 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.yEIry0qI8c/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.azVhkPc7lZ/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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/ddc62363daa7c866bca311e38d87323ac5e16e59b6025f6bc90521cab0be4c5eebd63ff0baf001b17df7d69a5e3c86c7448a8ea87faca0538934f1f247ecc196", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4eb9f0ce903ed1382bb848303844f4b990c395956e163bf3b735a57ce3f3fa316d647eb09446991be244c2126c9dc558af8360bfa2b3c963416e49a135a76d3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0305d2f5e0df1ab31909b743d3514bed43084e56ba707ebdbc9899e70619ac2d9670eeec951ac003a7b4ae78c1d59ca67b881a0732975a9a81988b81b852f03f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/648bef7794e24c24ffff17174623e57a11f91ddda1b403a4c7d3b446547df90b2c5d0ad0925c8651b099f298586e4ff5a59c18410c93c4bdd8f8e849f3c93cb2"} build_url:https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011621 build_url: 'https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddc62363daa7c866bca311e38d87323ac5e16e59b6025f6bc90521cab0be4c5eebd63ff0baf001b17df7d69a5e3c86c7448a8ea87faca0538934f1f247ecc196", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4eb9f0ce903ed1382bb848303844f4b990c395956e163bf3b735a57ce3f3fa316d647eb09446991be244c2126c9dc558af8360bfa2b3c963416e49a135a76d3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0305d2f5e0df1ab31909b743d3514bed43084e56ba707ebdbc9899e70619ac2d9670eeec951ac003a7b4ae78c1d59ca67b881a0732975a9a81988b81b852f03f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/648bef7794e24c24ffff17174623e57a11f91ddda1b403a4c7d3b446547df90b2c5d0ad0925c8651b099f298586e4ff5a59c18410c93c4bdd8f8e849f3c93cb2"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-25 15:53:27.928786) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 15:53:27.929643) ========= 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.yEIry0qI8c/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.azVhkPc7lZ/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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.005148 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 15:53:27.981753) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 15:53:27.982127) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 15:53:27.982487) ========= ========= Total master_lag: 0.19 =========