builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0106 starttime: 1487111909.81 results: success (0) buildid: 20170214131245 builduid: 08554464d5a446e793e297102f7155c6 revision: 1060668405a9399774c205430de4a7001d3f27ac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-14 14:38:29.808190) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-14 14:38:29.808646) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-14 14:38:29.808925) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-14 14:38:29.835146) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 14:38:29.836367) ========= 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.F0ma1153va/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.4VsfdygmGb/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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-02-14 14:38:29-- 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% 15.2M=0.001s 2017-02-14 14:38:30 (15.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.181139 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 14:38:30.041273) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 14:38:30.042256) ========= 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.F0ma1153va/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.4VsfdygmGb/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.028473 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 14:38:30.091975) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 14:38:30.092299) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1060668405a9399774c205430de4a7001d3f27ac --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 1060668405a9399774c205430de4a7001d3f27ac --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.F0ma1153va/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.4VsfdygmGb/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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-02-14 14:38:30,192 truncating revision to first 12 chars 2017-02-14 14:38:30,192 Setting DEBUG logging. 2017-02-14 14:38:30,192 attempt 1/10 2017-02-14 14:38:30,192 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1060668405a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-14 14:38:30,492 unpacking tar archive at: mozilla-central-1060668405a9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.593060 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 14:38:30.709274) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-14 14:38:30.709628) ========= script_repo_revision: 1060668405a9399774c205430de4a7001d3f27ac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-14 14:38:30.710072) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-14 14:38:30.710343) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-14 14:38:30.729997) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-02-14 14:38:30.730403) ========= /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.F0ma1153va/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.4VsfdygmGb/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 14:38:30 INFO - MultiFileLogger online at 20170214 14:38:30 in /builds/slave/test 14:38:30 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 14:38:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:38:30 INFO - {'append_to_log': False, 14:38:30 INFO - 'base_work_dir': '/builds/slave/test', 14:38:30 INFO - 'blob_upload_branch': 'Firefox', 14:38:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:38:30 INFO - 'branch': 'Firefox', 14:38:30 INFO - 'buildbot_json_path': 'buildprops.json', 14:38:30 INFO - 'config_files': ('talos/mac_config.py',), 14:38:30 INFO - 'default_actions': ('clobber', 14:38:30 INFO - 'read-buildbot-config', 14:38:30 INFO - 'download-and-extract', 14:38:30 INFO - 'populate-webroot', 14:38:30 INFO - 'create-virtualenv', 14:38:30 INFO - 'install', 14:38:30 INFO - 'run-tests'), 14:38:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:38:30 INFO - 'download_minidump_stackwalk': True, 14:38:30 INFO - 'download_symbols': 'ondemand', 14:38:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:38:30 INFO - 'tooltool.py': '/tools/tooltool.py', 14:38:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:38:30 INFO - '/tools/misc-python/virtualenv.py')}, 14:38:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:38:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:38:30 INFO - 'installer_path': 'installer.exe', 14:38:30 INFO - 'log_level': 'info', 14:38:30 INFO - 'log_name': 'talos', 14:38:30 INFO - 'log_to_console': True, 14:38:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:38:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:38:30 INFO - 'opt_config_files': (), 14:38:30 INFO - 'pip_index': False, 14:38:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:38:30 INFO - 'cmd': ('bash', 14:38:30 INFO - '-c', 14:38:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:38:30 INFO - 'enabled': True, 14:38:30 INFO - 'halt_on_failure': False, 14:38:30 INFO - 'name': 'check_screen_resolution'},), 14:38:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:38:30 INFO - 'cmd': ('bash', 14:38:30 INFO - '-c', 14:38:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:38:30 INFO - 'enabled': True, 14:38:30 INFO - 'halt_on_failure': False, 14:38:30 INFO - 'name': 'check_screen_resolution'},), 14:38:30 INFO - 'run_cmd_checks_enabled': True, 14:38:30 INFO - 'sps_profile': False, 14:38:30 INFO - 'sps_profile_interval': 0, 14:38:30 INFO - 'suite': 'dromaeojs', 14:38:30 INFO - 'system_bits': '32', 14:38:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:38:30 INFO - 'title': 't-yosemite-r7-0106', 14:38:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:38:30 INFO - 'use_talos_json': True, 14:38:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:38:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:38:30 INFO - 'work_dir': 'build'} 14:38:30 INFO - [mozharness: 2017-02-14 22:38:30.948862Z] Running clobber step. 14:38:30 INFO - Running pre-action listener: _resource_record_pre_action 14:38:30 INFO - Running main action method: clobber 14:38:30 INFO - rmtree: /builds/slave/test/build 14:38:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:38:33 INFO - Running post-action listener: _resource_record_post_action 14:38:33 INFO - [mozharness: 2017-02-14 22:38:33.377022Z] Finished clobber step (success) 14:38:33 INFO - [mozharness: 2017-02-14 22:38:33.377225Z] Running read-buildbot-config step. 14:38:33 INFO - Running pre-action listener: _resource_record_pre_action 14:38:33 INFO - Running main action method: read_buildbot_config 14:38:33 INFO - Using buildbot properties: 14:38:33 INFO - { 14:38:33 INFO - "project": "", 14:38:33 INFO - "product": "firefox", 14:38:33 INFO - "script_repo_revision": "production", 14:38:33 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 14:38:33 INFO - "repository": "", 14:38:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 14:38:33 INFO - "buildid": "20170214131245", 14:38:33 INFO - "pgo_build": "False", 14:38:33 INFO - "basedir": "/builds/slave/test", 14:38:33 INFO - "buildnumber": 3, 14:38:33 INFO - "slavename": "t-yosemite-r7-0106", 14:38:33 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 14:38:33 INFO - "platform": "yosemite_r7", 14:38:33 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 14:38:33 INFO - "branch": "mozilla-central", 14:38:33 INFO - "repo_path": "mozilla-central", 14:38:33 INFO - "revision": "1060668405a9399774c205430de4a7001d3f27ac", 14:38:33 INFO - "stage_platform": "macosx64", 14:38:33 INFO - "builduid": "08554464d5a446e793e297102f7155c6", 14:38:33 INFO - "slavebuilddir": "test" 14:38:33 INFO - } 14:38:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/IHK3zIGPRqGH1_X-CS9fPQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 14:38:33 INFO - Running post-action listener: _resource_record_post_action 14:38:33 INFO - [mozharness: 2017-02-14 22:38:33.382785Z] Finished read-buildbot-config step (success) 14:38:33 INFO - [mozharness: 2017-02-14 22:38:33.382973Z] Running download-and-extract step. 14:38:33 INFO - Running pre-action listener: _resource_record_pre_action 14:38:33 INFO - Running main action method: download_and_extract 14:38:33 INFO - mkdir: /builds/slave/test/build/tests 14:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:33 INFO - trying https://queue.taskcluster.net/v1/task/IHK3zIGPRqGH1_X-CS9fPQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 14:38:33 INFO - Downloading https://queue.taskcluster.net/v1/task/IHK3zIGPRqGH1_X-CS9fPQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 14:38:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IHK3zIGPRqGH1_X-CS9fPQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 14:38:34 INFO - Downloaded 1199 bytes. 14:38:34 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 14:38:34 INFO - Using the following test package requirements: 14:38:34 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 14:38:34 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 14:38:34 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 14:38:34 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 14:38:34 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 14:38:34 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 14:38:34 INFO - u'jsshell-mac.zip'], 14:38:34 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 14:38:34 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 14:38:34 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 14:38:34 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 14:38:34 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 14:38:34 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 14:38:34 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 14:38:34 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 14:38:34 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 14:38:34 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 14:38:34 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 14:38:34 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:38:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IHK3zIGPRqGH1_X-CS9fPQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 14:38:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IHK3zIGPRqGH1_X-CS9fPQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:38:34 INFO - Fetch https://queue.taskcluster.net/v1/task/IHK3zIGPRqGH1_X-CS9fPQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 14:38:36 INFO - Expected file size: 51505361 14:38:36 INFO - Obtained file size: 51505361 14:38:52 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:38:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IHK3zIGPRqGH1_X-CS9fPQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 14:38:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IHK3zIGPRqGH1_X-CS9fPQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:38:52 INFO - Fetch https://queue.taskcluster.net/v1/task/IHK3zIGPRqGH1_X-CS9fPQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 14:38:53 INFO - Expected file size: 51505361 14:38:53 INFO - Obtained file size: 51505361 14:39:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IHK3zIGPRqGH1_X-CS9fPQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 14:39:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IHK3zIGPRqGH1_X-CS9fPQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:39:09 INFO - Fetch https://queue.taskcluster.net/v1/task/IHK3zIGPRqGH1_X-CS9fPQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 14:39:10 INFO - Expected file size: 14403647 14:39:10 INFO - Obtained file size: 14403647 14:39:10 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')]} 14:39:10 INFO - trying https://queue.taskcluster.net/v1/task/IHK3zIGPRqGH1_X-CS9fPQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 14:39:10 INFO - Downloading https://queue.taskcluster.net/v1/task/IHK3zIGPRqGH1_X-CS9fPQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 14:39:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IHK3zIGPRqGH1_X-CS9fPQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 14:39:12 INFO - Downloaded 70568426 bytes. 14:39:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IHK3zIGPRqGH1_X-CS9fPQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 14:39:12 INFO - mkdir: /builds/slave/test/properties 14:39:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:39:12 INFO - Writing to file /builds/slave/test/properties/build_url 14:39:12 INFO - Contents: 14:39:12 INFO - build_url:https://queue.taskcluster.net/v1/task/IHK3zIGPRqGH1_X-CS9fPQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 14:39:13 INFO - Running post-action listener: _resource_record_post_action 14:39:13 INFO - Running post-action listener: set_extra_try_arguments 14:39:13 INFO - [mozharness: 2017-02-14 22:39:13.229717Z] Finished download-and-extract step (success) 14:39:13 INFO - [mozharness: 2017-02-14 22:39:13.229839Z] Running populate-webroot step. 14:39:13 INFO - Running pre-action listener: _resource_record_pre_action 14:39:13 INFO - Running main action method: populate_webroot 14:39:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:39:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:39:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:39:13 INFO - '--tppagecycles', 14:39:13 INFO - '7'], 14:39:13 INFO - 'tests': ['tsvgm']}}, 14:39:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:39:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:39:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:39:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:39:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:39:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:39:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:39:13 INFO - 'talos_options': ['--disable-e10s'], 14:39:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:39:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:39:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:39:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:39:13 INFO - 'talos_options': ['--disable-e10s'], 14:39:13 INFO - 'tests': ['damp', 'tps']}, 14:39:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:39:13 INFO - 'tests': ['damp', 'tps']}, 14:39:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:39:13 INFO - 'tests': ['dromaeo_dom']}, 14:39:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:39:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:39:13 INFO - 'tests': ['basic_compositor_video']}, 14:39:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:39:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:39:13 INFO - 'tests': ['a11yr', 14:39:13 INFO - 'ts_paint', 14:39:13 INFO - 'tpaint', 14:39:13 INFO - 'sessionrestore', 14:39:13 INFO - 'sessionrestore_no_auto_restore', 14:39:13 INFO - 'tabpaint']}, 14:39:13 INFO - 'other-e10s': {'tests': ['a11yr', 14:39:13 INFO - 'ts_paint', 14:39:13 INFO - 'tpaint', 14:39:13 INFO - 'sessionrestore', 14:39:13 INFO - 'sessionrestore_no_auto_restore', 14:39:13 INFO - 'tabpaint']}, 14:39:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:39:13 INFO - 'ts_paint', 14:39:13 INFO - 'tpaint', 14:39:13 INFO - 'sessionrestore', 14:39:13 INFO - 'sessionrestore_no_auto_restore', 14:39:13 INFO - 'tabpaint']}, 14:39:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:39:13 INFO - 'ts_paint', 14:39:13 INFO - 'tpaint', 14:39:13 INFO - 'sessionrestore', 14:39:13 INFO - 'sessionrestore_no_auto_restore', 14:39:13 INFO - 'tabpaint']}, 14:39:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:39:13 INFO - 'tests': ['a11yr', 14:39:13 INFO - 'ts_paint', 14:39:13 INFO - 'tpaint', 14:39:13 INFO - 'sessionrestore', 14:39:13 INFO - 'sessionrestore_no_auto_restore', 14:39:13 INFO - 'tabpaint']}, 14:39:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:39:13 INFO - 'tests': ['a11yr', 14:39:13 INFO - 'ts_paint', 14:39:13 INFO - 'tpaint', 14:39:13 INFO - 'sessionrestore', 14:39:13 INFO - 'sessionrestore_no_auto_restore', 14:39:13 INFO - 'tabpaint']}, 14:39:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:39:13 INFO - 'tests': ['tsvgx', 14:39:13 INFO - 'tsvgr_opacity', 14:39:13 INFO - 'tart', 14:39:13 INFO - 'tscrollx', 14:39:13 INFO - 'cart', 14:39:13 INFO - 'tsvg_static']}, 14:39:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:39:13 INFO - 'tsvgr_opacity', 14:39:13 INFO - 'tart', 14:39:13 INFO - 'tscrollx', 14:39:13 INFO - 'cart', 14:39:13 INFO - 'tsvg_static']}, 14:39:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:39:13 INFO - 'talos_options': ['--disable-e10s'], 14:39:13 INFO - 'tests': ['tp5o']}, 14:39:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:39:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:39:13 INFO - 'talos_options': ['--disable-e10s', 14:39:13 INFO - '--xperf_path', 14:39:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:39:13 INFO - 'tests': ['tp5n']}, 14:39:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:39:13 INFO - 'talos_options': ['--xperf_path', 14:39:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:39:13 INFO - 'tests': ['tp5n']}}, 14:39:13 INFO - 'talos.zip': {'path': '', 14:39:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:39:13 INFO - Running post-action listener: _resource_record_post_action 14:39:13 INFO - [mozharness: 2017-02-14 22:39:13.248044Z] Finished populate-webroot step (success) 14:39:13 INFO - [mozharness: 2017-02-14 22:39:13.248155Z] Running create-virtualenv step. 14:39:13 INFO - Running pre-action listener: _resource_record_pre_action 14:39:13 INFO - Running main action method: create_virtualenv 14:39:13 INFO - Creating virtualenv /builds/slave/test/build/venv 14:39:13 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 14:39:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:39:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:39:13 INFO - Using real prefix '/tools/python27' 14:39:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:39:14 INFO - Installing distribute.............................................................................................................................................................................................done. 14:39:16 INFO - Installing pip.................done. 14:39:16 INFO - Return code: 0 14:39:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:39:17 INFO - Reading from file tmpfile_stdout 14:39:17 INFO - Output received: 14:39:17 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) 14:39:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107021b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107024768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89304e6870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dffd30>, '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 0x106d26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106df4be8>, '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.F0ma1153va/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.4VsfdygmGb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 14:39:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:39:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F0ma1153va/Render', 14:39:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:39:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:39:17 INFO - 'HOME': '/Users/cltbld', 14:39:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:39:17 INFO - 'LOGNAME': 'cltbld', 14:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:17 INFO - 'MOZ_NO_REMOTE': '1', 14:39:17 INFO - 'NO_EM_RESTART': '1', 14:39:17 INFO - 'PAGER': '/bin/cat', 14:39:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:17 INFO - 'PWD': '/builds/slave/test', 14:39:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:39:17 INFO - 'SHELL': '/bin/bash', 14:39:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4VsfdygmGb/Listeners', 14:39:17 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 14:39:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:39:17 INFO - 'USER': 'cltbld', 14:39:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:39:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:17 INFO - 'XPC_FLAGS': '0x0', 14:39:17 INFO - 'XPC_SERVICE_NAME': '0', 14:39:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:39:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:17 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 14:39:17 INFO - Cleaning up... 14:39:17 INFO - Return code: 0 14:39:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107021b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107024768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89304e6870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dffd30>, '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 0x106d26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106df4be8>, '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.F0ma1153va/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.4VsfdygmGb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 14:39:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:39:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F0ma1153va/Render', 14:39:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:39:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:39:17 INFO - 'HOME': '/Users/cltbld', 14:39:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:39:17 INFO - 'LOGNAME': 'cltbld', 14:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:17 INFO - 'MOZ_NO_REMOTE': '1', 14:39:17 INFO - 'NO_EM_RESTART': '1', 14:39:17 INFO - 'PAGER': '/bin/cat', 14:39:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:17 INFO - 'PWD': '/builds/slave/test', 14:39:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:39:17 INFO - 'SHELL': '/bin/bash', 14:39:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4VsfdygmGb/Listeners', 14:39:17 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 14:39:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:39:17 INFO - 'USER': 'cltbld', 14:39:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:39:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:17 INFO - 'XPC_FLAGS': '0x0', 14:39:17 INFO - 'XPC_SERVICE_NAME': '0', 14:39:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:39:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:17 INFO - Downloading/unpacking psutil>=3.1.1 14:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:39:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:39:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:39:21 INFO - Installing collected packages: psutil 14:39:21 INFO - Running setup.py install for psutil 14:39:21 INFO - building 'psutil._psutil_osx' extension 14:39:21 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 14:39:21 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 14:39:22 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 14:39:22 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 14:39:22 INFO - building 'psutil._psutil_posix' extension 14:39:22 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 14:39:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:39:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:39:22 INFO - ^ 14:39:22 INFO - 1 warning generated. 14:39:22 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 14:39:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:39:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:39:22 INFO - Successfully installed psutil 14:39:22 INFO - Cleaning up... 14:39:22 INFO - Return code: 0 14:39:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:39:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:22 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 0x107021b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107024768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89304e6870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dffd30>, '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 0x106d26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106df4be8>, '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.F0ma1153va/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.4VsfdygmGb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 14:39:22 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 14:39:22 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 14:39:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F0ma1153va/Render', 14:39:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:39:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:39:22 INFO - 'HOME': '/Users/cltbld', 14:39:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:39:22 INFO - 'LOGNAME': 'cltbld', 14:39:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:22 INFO - 'MOZ_NO_REMOTE': '1', 14:39:22 INFO - 'NO_EM_RESTART': '1', 14:39:22 INFO - 'PAGER': '/bin/cat', 14:39:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:39:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:22 INFO - 'PWD': '/builds/slave/test', 14:39:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:39:22 INFO - 'SHELL': '/bin/bash', 14:39:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4VsfdygmGb/Listeners', 14:39:22 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 14:39:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:39:22 INFO - 'USER': 'cltbld', 14:39:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:39:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:39:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:22 INFO - 'XPC_FLAGS': '0x0', 14:39:22 INFO - 'XPC_SERVICE_NAME': '0', 14:39:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:39:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:39:22 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 14:39:22 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 14:39:22 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 14:39:22 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 14:39:22 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 14:39:22 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 14:39:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:39:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:39:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:39:25 INFO - Installing collected packages: mozsystemmonitor 14:39:25 INFO - Running setup.py install for mozsystemmonitor 14:39:25 INFO - Successfully installed mozsystemmonitor 14:39:25 INFO - Cleaning up... 14:39:25 INFO - Return code: 0 14:39:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:26 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')]} 14:39:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:26 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 0x107021b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107024768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89304e6870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dffd30>, '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 0x106d26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106df4be8>, '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.F0ma1153va/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.4VsfdygmGb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 14:39:26 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 14:39:26 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 14:39:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F0ma1153va/Render', 14:39:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:39:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:39:26 INFO - 'HOME': '/Users/cltbld', 14:39:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:39:26 INFO - 'LOGNAME': 'cltbld', 14:39:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:26 INFO - 'MOZ_NO_REMOTE': '1', 14:39:26 INFO - 'NO_EM_RESTART': '1', 14:39:26 INFO - 'PAGER': '/bin/cat', 14:39:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:39:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:26 INFO - 'PWD': '/builds/slave/test', 14:39:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:39:26 INFO - 'SHELL': '/bin/bash', 14:39:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4VsfdygmGb/Listeners', 14:39:26 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 14:39:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:39:26 INFO - 'USER': 'cltbld', 14:39:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:39:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:39:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:26 INFO - 'XPC_FLAGS': '0x0', 14:39:26 INFO - 'XPC_SERVICE_NAME': '0', 14:39:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:39:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:26 INFO - Downloading/unpacking jsonschema==2.5.1 14:39:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:39:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:39:29 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 14:39:29 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 14:39:29 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 14:39:29 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 14:39:29 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 14:39:29 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 14:39:30 INFO - Downloading functools32-3.2.3-2.tar.gz 14:39:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:39:30 INFO - warning: no files found matching '*.txt' 14:39:30 INFO - no previously-included directories found matching 'build' 14:39:30 INFO - no previously-included directories found matching 'dist' 14:39:30 INFO - no previously-included directories found matching '.git*' 14:39:30 INFO - Installing collected packages: jsonschema, functools32 14:39:30 INFO - Running setup.py install for functools32 14:39:30 INFO - warning: no files found matching '*.txt' 14:39:30 INFO - no previously-included directories found matching 'build' 14:39:30 INFO - no previously-included directories found matching 'dist' 14:39:30 INFO - no previously-included directories found matching '.git*' 14:39:30 INFO - Successfully installed jsonschema functools32 14:39:30 INFO - Cleaning up... 14:39:30 INFO - Return code: 0 14:39:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:30 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 0x107021b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107024768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89304e6870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dffd30>, '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 0x106d26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106df4be8>, '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.F0ma1153va/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.4VsfdygmGb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 14:39:30 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 14:39:30 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 14:39:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F0ma1153va/Render', 14:39:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:39:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:39:30 INFO - 'HOME': '/Users/cltbld', 14:39:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:39:30 INFO - 'LOGNAME': 'cltbld', 14:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:30 INFO - 'MOZ_NO_REMOTE': '1', 14:39:30 INFO - 'NO_EM_RESTART': '1', 14:39:30 INFO - 'PAGER': '/bin/cat', 14:39:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:30 INFO - 'PWD': '/builds/slave/test', 14:39:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:39:30 INFO - 'SHELL': '/bin/bash', 14:39:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4VsfdygmGb/Listeners', 14:39:30 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 14:39:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:39:30 INFO - 'USER': 'cltbld', 14:39:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:39:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:30 INFO - 'XPC_FLAGS': '0x0', 14:39:30 INFO - 'XPC_SERVICE_NAME': '0', 14:39:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:39:30 INFO - Cleaning up... 14:39:30 INFO - Return code: 0 14:39:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:30 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 0x107021b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107024768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89304e6870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dffd30>, '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 0x106d26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106df4be8>, '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.F0ma1153va/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.4VsfdygmGb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 14:39:30 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 14:39:30 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 14:39:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F0ma1153va/Render', 14:39:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:39:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:39:30 INFO - 'HOME': '/Users/cltbld', 14:39:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:39:30 INFO - 'LOGNAME': 'cltbld', 14:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:30 INFO - 'MOZ_NO_REMOTE': '1', 14:39:30 INFO - 'NO_EM_RESTART': '1', 14:39:30 INFO - 'PAGER': '/bin/cat', 14:39:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:30 INFO - 'PWD': '/builds/slave/test', 14:39:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:39:30 INFO - 'SHELL': '/bin/bash', 14:39:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4VsfdygmGb/Listeners', 14:39:30 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 14:39:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:39:30 INFO - 'USER': 'cltbld', 14:39:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:39:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:30 INFO - 'XPC_FLAGS': '0x0', 14:39:30 INFO - 'XPC_SERVICE_NAME': '0', 14:39:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:39:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:31 INFO - Downloading/unpacking blobuploader==1.2.4 14:39:31 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 14:39:31 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 14:39:31 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 14:39:31 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 14:39:31 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 14:39:31 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 14:39:33 INFO - Downloading blobuploader-1.2.4.tar.gz 14:39:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:39:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:39:33 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 14:39:33 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 14:39:33 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 14:39:33 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 14:39:33 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 14:39:33 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 14:39:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:39:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:34 INFO - Downloading docopt-0.6.1.tar.gz 14:39:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:39:35 INFO - Installing collected packages: blobuploader, requests, docopt 14:39:35 INFO - Running setup.py install for blobuploader 14:39:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:39:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:39:35 INFO - Running setup.py install for requests 14:39:35 INFO - Running setup.py install for docopt 14:39:35 INFO - Successfully installed blobuploader requests docopt 14:39:35 INFO - Cleaning up... 14:39:35 INFO - Return code: 0 14:39:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:35 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 0x107021b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107024768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89304e6870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dffd30>, '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 0x106d26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106df4be8>, '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.F0ma1153va/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.4VsfdygmGb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 14:39:35 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 14:39:35 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 14:39:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F0ma1153va/Render', 14:39:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:39:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:39:35 INFO - 'HOME': '/Users/cltbld', 14:39:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:39:35 INFO - 'LOGNAME': 'cltbld', 14:39:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:35 INFO - 'MOZ_NO_REMOTE': '1', 14:39:35 INFO - 'NO_EM_RESTART': '1', 14:39:35 INFO - 'PAGER': '/bin/cat', 14:39:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:39:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:35 INFO - 'PWD': '/builds/slave/test', 14:39:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:39:35 INFO - 'SHELL': '/bin/bash', 14:39:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4VsfdygmGb/Listeners', 14:39:35 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 14:39:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:39:35 INFO - 'USER': 'cltbld', 14:39:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:39:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:39:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:35 INFO - 'XPC_FLAGS': '0x0', 14:39:35 INFO - 'XPC_SERVICE_NAME': '0', 14:39:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:39:36 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Fndnq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:39:36 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-MeXTJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:39:36 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-kcecRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:39:36 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-872tqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:39:36 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-lmL0Et-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:39:36 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-61vdav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:39:36 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-iFPiPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:39:36 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-IeElI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:39:37 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-6Zt1ES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:39:37 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-QW0uNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:39:37 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-PfuxhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:39:37 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-CyToOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:39:37 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-RVLgHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:39:37 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-6gwvIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:37 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-4ATetE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:39:37 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-RHZJ3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:39:37 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Dp0vBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:39:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:39:37 INFO - Running setup.py install for manifestparser 14:39:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:39:38 INFO - Running setup.py install for mozcrash 14:39:38 INFO - Running setup.py install for mozdebug 14:39:38 INFO - Running setup.py install for mozdevice 14:39:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:39:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:39:38 INFO - Running setup.py install for mozfile 14:39:38 INFO - Running setup.py install for mozhttpd 14:39:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:39:38 INFO - Running setup.py install for mozinfo 14:39:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:39:38 INFO - Running setup.py install for mozInstall 14:39:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:39:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:39:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:39:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:39:39 INFO - Running setup.py install for mozleak 14:39:39 INFO - Running setup.py install for mozlog 14:39:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:39:39 INFO - Running setup.py install for moznetwork 14:39:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:39:39 INFO - Running setup.py install for mozprocess 14:39:39 INFO - Running setup.py install for mozprofile 14:39:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:39:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:39:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:39:39 INFO - Running setup.py install for mozrunner 14:39:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:39:40 INFO - Running setup.py install for mozscreenshot 14:39:40 INFO - Running setup.py install for moztest 14:39:40 INFO - Running setup.py install for mozversion 14:39:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:39:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:39:40 INFO - Cleaning up... 14:39:40 INFO - Return code: 0 14:39:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:39: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')]} 14:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39: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')]} 14:39:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:40 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 0x107021b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107024768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89304e6870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dffd30>, '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 0x106d26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106df4be8>, '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.F0ma1153va/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.4VsfdygmGb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 14:39:40 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 14:39:40 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 14:39:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F0ma1153va/Render', 14:39:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:39:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:39:40 INFO - 'HOME': '/Users/cltbld', 14:39:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:39:40 INFO - 'LOGNAME': 'cltbld', 14:39:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:40 INFO - 'MOZ_NO_REMOTE': '1', 14:39:40 INFO - 'NO_EM_RESTART': '1', 14:39:40 INFO - 'PAGER': '/bin/cat', 14:39:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:39:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:40 INFO - 'PWD': '/builds/slave/test', 14:39:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:39:40 INFO - 'SHELL': '/bin/bash', 14:39:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4VsfdygmGb/Listeners', 14:39:40 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 14:39:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:39:40 INFO - 'USER': 'cltbld', 14:39:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:39:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:39:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:40 INFO - 'XPC_FLAGS': '0x0', 14:39:40 INFO - 'XPC_SERVICE_NAME': '0', 14:39:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:39:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:39:40 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Izrm_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:39:40 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)) 14:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:39:40 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-eQ0lZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:39:40 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)) 14:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:39:40 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-QKH8Pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:39:41 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)) 14:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:39:41 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-kbqSvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:39:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 14:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:39:41 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-TrysG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:39:41 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)) 14:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:39:41 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-y8V3bi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:39:41 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)) 14:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:39:41 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-cKqdBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:39:41 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)) 14:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:39:41 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-owZqNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:39:41 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)) 14:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:39:41 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-9kUSmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:39:41 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)) 14:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:39:41 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-E3frFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:39:41 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)) 14:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:39:41 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-kmAaEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:39:41 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)) 14:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:39:41 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-uIPqsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 14:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:39:42 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-o_TMHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:39:42 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)) 14:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:39:42 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Yk7Hh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:39:42 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)) 14:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:42 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-ia5ayb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:42 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)) 14:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:39:42 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-LjVTOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:39:42 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)) 14:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:39:42 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-OY34qV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:39:42 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)) 14:39:42 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)) 14:39:42 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)) 14:39:42 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)) 14:39:42 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:39:42 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:39:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:39:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:45 INFO - Downloading blessings-1.6.tar.gz 14:39:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:39:45 INFO - Installing collected packages: blessings 14:39:45 INFO - Running setup.py install for blessings 14:39:45 INFO - Successfully installed blessings 14:39:45 INFO - Cleaning up... 14:39:45 INFO - Return code: 0 14:39:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:39:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:39:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:39:45 INFO - Reading from file tmpfile_stdout 14:39:45 INFO - Current package versions: 14:39:45 INFO - blessings == 1.6 14:39:45 INFO - blobuploader == 1.2.4 14:39:45 INFO - docopt == 0.6.1 14:39:45 INFO - functools32 == 3.2.3-2 14:39:45 INFO - jsonschema == 2.5.1 14:39:45 INFO - manifestparser == 1.1 14:39:45 INFO - mozInstall == 1.12 14:39:45 INFO - mozcrash == 1.0 14:39:45 INFO - mozdebug == 0.1 14:39:45 INFO - mozdevice == 0.49 14:39:45 INFO - mozfile == 1.2 14:39:45 INFO - mozhttpd == 0.7 14:39:45 INFO - mozinfo == 0.9 14:39:45 INFO - mozleak == 0.1 14:39:45 INFO - mozlog == 3.4 14:39:45 INFO - moznetwork == 0.27 14:39:45 INFO - mozprocess == 0.24 14:39:45 INFO - mozprofile == 0.28 14:39:45 INFO - mozrunner == 6.13 14:39:45 INFO - mozscreenshot == 0.1 14:39:45 INFO - mozsystemmonitor == 0.3 14:39:45 INFO - moztest == 0.8 14:39:45 INFO - mozversion == 1.4 14:39:45 INFO - psutil == 3.1.1 14:39:45 INFO - requests == 1.2.3 14:39:45 INFO - wsgiref == 0.1.2 14:39:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:39:45 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')]} 14:39:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:45 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')]} 14:39:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:45 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 0x107021b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107024768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89304e6870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dffd30>, '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 0x106d26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106df4be8>, '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.F0ma1153va/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.4VsfdygmGb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 14:39:45 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 14:39:45 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 14:39:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F0ma1153va/Render', 14:39:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:39:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:39:45 INFO - 'HOME': '/Users/cltbld', 14:39:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:39:45 INFO - 'LOGNAME': 'cltbld', 14:39:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:45 INFO - 'MOZ_NO_REMOTE': '1', 14:39:45 INFO - 'NO_EM_RESTART': '1', 14:39:45 INFO - 'PAGER': '/bin/cat', 14:39:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:39:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:45 INFO - 'PWD': '/builds/slave/test', 14:39:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:39:45 INFO - 'SHELL': '/bin/bash', 14:39:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4VsfdygmGb/Listeners', 14:39:45 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 14:39:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:39:45 INFO - 'USER': 'cltbld', 14:39:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:39:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:39:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:45 INFO - 'XPC_FLAGS': '0x0', 14:39:45 INFO - 'XPC_SERVICE_NAME': '0', 14:39:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:39:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:46 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)) 14:39:46 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)) 14:39:46 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)) 14:39:46 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)) 14:39:46 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)) 14:39:46 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)) 14:39:46 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)) 14:39:46 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)) 14:39:46 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)) 14:39:46 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)) 14:39:46 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)) 14:39:46 INFO - Cleaning up... 14:39:46 INFO - Return code: 0 14:39:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107021b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107024768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89304e6870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dffd30>, '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 0x106d26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106df4be8>, '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.F0ma1153va/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.4VsfdygmGb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 14:39:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:39:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F0ma1153va/Render', 14:39:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:39:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:39:46 INFO - 'HOME': '/Users/cltbld', 14:39:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:39:46 INFO - 'LOGNAME': 'cltbld', 14:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:46 INFO - 'MOZ_NO_REMOTE': '1', 14:39:46 INFO - 'NO_EM_RESTART': '1', 14:39:46 INFO - 'PAGER': '/bin/cat', 14:39:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:46 INFO - 'PWD': '/builds/slave/test', 14:39:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:39:46 INFO - 'SHELL': '/bin/bash', 14:39:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4VsfdygmGb/Listeners', 14:39:46 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 14:39:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:39:46 INFO - 'USER': 'cltbld', 14:39:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:39:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:46 INFO - 'XPC_FLAGS': '0x0', 14:39:46 INFO - 'XPC_SERVICE_NAME': '0', 14:39:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:39:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:39:46 INFO - Cleaning up... 14:39:46 INFO - Return code: 0 14:39:46 INFO - Running post-action listener: _resource_record_post_action 14:39:46 INFO - Running post-action listener: _start_resource_monitoring 14:39:46 INFO - Starting resource monitoring. 14:39:46 INFO - [mozharness: 2017-02-14 22:39:46.400791Z] Finished create-virtualenv step (success) 14:39:46 INFO - [mozharness: 2017-02-14 22:39:46.401760Z] Running install step. 14:39:46 INFO - Running pre-action listener: _resource_record_pre_action 14:39:46 INFO - Running main action method: install 14:39:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:39:46 INFO - Reading from file tmpfile_stdout 14:39:46 INFO - Detecting whether we're running mozinstall >=1.0... 14:39:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:39:46 INFO - Reading from file tmpfile_stdout 14:39:46 INFO - Output received: 14:39:46 INFO - Usage: mozinstall [options] installer 14:39:46 INFO - Options: 14:39:46 INFO - -h, --help show this help message and exit 14:39:46 INFO - -d DEST, --destination=DEST 14:39:46 INFO - Directory to install application into. [default: 14:39:46 INFO - "/builds/slave/test"] 14:39:46 INFO - --app=APP Application being installed. [default: firefox] 14:39:46 INFO - mkdir: /builds/slave/test/build/application 14:39:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:40:08 INFO - Reading from file tmpfile_stdout 14:40:08 INFO - Output received: 14:40:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:40:08 INFO - Running post-action listener: _resource_record_post_action 14:40:08 INFO - [mozharness: 2017-02-14 22:40:08.526524Z] Finished install step (success) 14:40:08 INFO - [mozharness: 2017-02-14 22:40:08.526678Z] Running run-tests step. 14:40:08 INFO - Running pre-action listener: _resource_record_pre_action 14:40:08 INFO - Running main action method: run_tests 14:40:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:40:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:40:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:40:08 INFO - 2017-02-14 14:40:08.541 screenresolution[1627:7428] starting screenresolution argv=screenresolution get 14:40:08 INFO - 2017-02-14 14:40:08.544 screenresolution[1627:7428] Display 0: 1600x1200x32@60 14:40:08 INFO - 2017-02-14 14:40:08.549 screenresolution[1628:7430] starting screenresolution argv=screenresolution list 14:40:08 INFO - Available Modes on Display 0 14:40:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:40:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:40:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:40:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:40:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:40:08 INFO - Intel Iris: 14:40:08 INFO - Chipset Model: Intel Iris 14:40:08 INFO - Type: GPU 14:40:08 INFO - Bus: Built-In 14:40:08 INFO - VRAM (Dynamic, Max): 1536 MB 14:40:08 INFO - Vendor: Intel (0x8086) 14:40:08 INFO - Device ID: 0x0a2e 14:40:08 INFO - Revision ID: 0x0009 14:40:08 INFO - Displays: 14:40:08 INFO - Display: 14:40:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:40:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:40:08 INFO - Display Serial Number: 1600x1200 60 14:40:08 INFO - Main Display: Yes 14:40:08 INFO - Mirror: Off 14:40:08 INFO - Online: Yes 14:40:08 INFO - Rotation: Supported 14:40:08 INFO - Return code: 0 14:40:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:40:08 INFO - Python 2.7.3 14:40:08 INFO - Return code: 0 14:40:08 INFO - grabbing minidump binary from tooltool 14:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:40:08 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 0x106dffd30>, '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 0x106d26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106df4be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:40:08 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 14:40:08 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 14:40:08 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 14:40:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:40:08 INFO - Return code: 0 14:40:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:40:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:40:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:40:08 INFO - ENV: RUST_BACKTRACE is now 1 14:40:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:40:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:40:08 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/IHK3zIGPRqGH1_X-CS9fPQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--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 14:40:08 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/IHK3zIGPRqGH1_X-CS9fPQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0106 --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 14:40:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F0ma1153va/Render', 14:40:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:40:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:40:08 INFO - 'HOME': '/Users/cltbld', 14:40:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:40:08 INFO - 'LOGNAME': 'cltbld', 14:40:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:40:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:08 INFO - 'MOZ_NO_REMOTE': '1', 14:40:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:40:08 INFO - 'NO_EM_RESTART': '1', 14:40:08 INFO - 'PAGER': '/bin/cat', 14:40:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:08 INFO - 'PWD': '/builds/slave/test', 14:40:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:40:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:40:08 INFO - 'RUST_BACKTRACE': '1', 14:40:08 INFO - 'SHELL': '/bin/bash', 14:40:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4VsfdygmGb/Listeners', 14:40:08 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 14:40:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:40:08 INFO - 'USER': 'cltbld', 14:40:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:40:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:08 INFO - 'XPC_FLAGS': '0x0', 14:40:08 INFO - 'XPC_SERVICE_NAME': '0', 14:40:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:40:08 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/IHK3zIGPRqGH1_X-CS9fPQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--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 14:40:09 INFO - mozversion application_buildid: 20170214131245 14:40:09 INFO - mozversion application_changeset: 1060668405a9399774c205430de4a7001d3f27ac 14:40:09 INFO - mozversion application_display_name: Nightly 14:40:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:40:09 INFO - mozversion application_name: Firefox 14:40:09 INFO - mozversion application_remotingname: firefox 14:40:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:40:09 INFO - mozversion application_vendor: Mozilla 14:40:09 INFO - mozversion application_version: 54.0a1 14:40:09 INFO - mozversion platform_buildid: 20170214131245 14:40:09 INFO - mozversion platform_changeset: 1060668405a9399774c205430de4a7001d3f27ac 14:40:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:40:09 INFO - mozversion platform_version: 54.0a1 14:40:09 INFO - using testdate: 1487112009 14:40:09 INFO - actual date: 1487112009 14:40:09 INFO - starting webserver on 'localhost:49240' 14:40:09 INFO - SUITE-START | Running 2 tests 14:40:09 INFO - TEST-START | dromaeo_css 14:40:09 INFO - operating with platform_type : mac_ 14:40:09 INFO - Initialising browser for dromaeo_css test... 14:40:09 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpRbvoQh/profile http://localhost:49240/getInfo.html) 14:40:11 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 14:40:11 INFO - PROCESS | 1638 | colorDepth:24 14:40:11 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 14:40:11 INFO - PROCESS | 1638 | __metrics 14:40:11 INFO - PROCESS | 1638 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:40:11 INFO - PROCESS | 1638 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:40:12 INFO - TEST-INFO | 1638: exit 0 14:40:12 INFO - Browser initialized. 14:40:12 INFO - Running cycle 1/1 for dromaeo_css test... 14:40:12 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpRbvoQh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:40:24 INFO - PROCESS | 1640 | RSS: Main: 228958208 14:40:24 INFO - PROCESS | 1640 | 14:43:29 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 14:43:30 INFO - PROCESS | 1640 | RSS: Main: 389996544 14:43:30 INFO - PROCESS | 1640 | 14:45:13 INFO - PROCESS | 1640 | ************************* 14:45:13 INFO - PROCESS | 1640 | A coding exception was thrown and uncaught in a Task. 14:45:13 INFO - PROCESS | 1640 | 14:45:13 ERROR - PROCESS | 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:45:13 INFO - PROCESS | 1640 | Full stack: 14:45:13 INFO - PROCESS | 1640 | ************************* 14:46:33 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 14:46:34 INFO - PROCESS | 1640 | RSS: Main: 378667008 14:46:34 INFO - PROCESS | 1640 | 14:49:37 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 14:49:37 INFO - PROCESS | 1640 | RSS: Main: 355262464 14:49:37 INFO - PROCESS | 1640 | 14:52:40 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 14:52:40 INFO - PROCESS | 1640 | RSS: Main: 342016000 14:52:40 INFO - PROCESS | 1640 | 14:55:44 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 14:55:45 INFO - PROCESS | 1640 | RSS: Main: 343138304 14:55:45 INFO - PROCESS | 1640 | 14:58:48 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 14:58:48 INFO - PROCESS | 1640 | RSS: Main: 461901824 14:58:48 INFO - PROCESS | 1640 | 14:58:48 INFO - PROCESS | 1640 | __start_tp_report 14:58:48 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 14:58:48 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 14:58:48 INFO - PROCESS | 1640 | |i|pagename|runs| 14:58:48 INFO - PROCESS | 1640 | |0;dojo.html;2745.560710286354;3249.463838466653;3345.3978283908887;3374.865005399784;3394.032700680307;5517.310336207974;5603.355614104379;5610.663360198391;5672.347680016799;5701.144828275756;4648.53514648535;5533.418991005947;5610.354809196943;5610.933922554712;5617.241672374228;4208.494980602332;5083.5933125349975;5119.974400127994;5174.948250517503;5208.817691380802;5151.459096794839;5251.369835619731;5260.368755749316;5260.605454590902;5267.631265811395;5235.816746413876;5238.214267859814;5242.7378631068295;5243.187305967581;5243.632945693803;5216.452272511369;5227.50338717825;5235.528802407764;5237.554807841338;5246.344206974129;4995.075910956485;5113.821016264413;5176.197689358156;5185.818496352647;5203.1414816555225;5718.828435146952;5731.856703582402;5752.654840709571;5756.309242890838;5770.971145144247;5992.730327135289;6206.224221972254;6217.316095229521;6257;6268.780592679234;6140.2106357041575;6153;6179.81460556184;6197.473214776749;6210.037444196157;5172.146595811687;5678.148277758328;5773.393793651648;5793.594448388657;5799.88400231993;6248.75004999804;6268.561200715997;6274.121622972787;6275.341089185661;6305.180326557518;5088.796448142033;6140.355262697352;6142;6160.8767824643255;6166.7224974876235;6022.18700475439;6089.725962331706;6108.380260339294;6113.052476866093;6262.718177682015;5923.200367950271;6096.116063170815;6097.481714054266;6105.389461053859;6107.206063211843;6104.145419641254;6104.664243466563;6107.328193898667;6108.297545782203;6119.938800611937;4775.95224047762;4882.0724062428735;4916.2625606158645;4923.532264434873;4929.186684197068;4228.534861165331;4401.581849724271;4414.028913638995;4432.268675668479;4438.289873620205;5733.799317023884;5737.51231145349;5740.282464691913;5749.626274292157;5756.683382414008;5497.47773961473;6260.906086408708;6305.117283580303;6312.589681670676;6318.71565779541;5542.695151766611;5594.0769772987815;5595.384507704231;5644.8306550803545;5659.462351076723;5377.704226267593;5378.11261141915;5379.946200538023;5393.164059570773;5394.946050539523;5202.271681964604;6204.751809927552;6271.874562508724;6272.372762723782;6291.276503202099;6291.307956124731;6309.400606942333;6311.179546658905;6312.863684536644;6324.2410910691015;6245.375462453719;6251.624902505864;6254.343293954069;6271.717772700148;6291.496680265476;5931.525477961666;6062.393760623902;6066.4540191382985;6234.594751341148;6245.18812554365;5088.338515993045;6129.695011270001;6167.6916154193;6170.259568851767;6172.537059720449;6004.5796794225735;6103.246756470893;6119.112728654409;6123.4351415035735;6136.048912418582;5893.086571581412;6091.390860914051;6108.938910610837;6111.449969502588;6125.9693701531205;5736.799212027559;5806.187133801355;5931.851703707442;5964.284285885721;5967.880642387041;6132.988056970728;6140.938590614037;6152.261728592597;6153.353897840662;6163.3836616338;5906.763729450946;5935.9109613356695;5982.88034239304;6001.459868611846;6010.7295171716505 14:58:48 INFO - PROCESS | 1640 | |1;ext.html;431.5059257150563;440.80604534005016;466.25864874848986;510.20917577754517;538.701020933382;27726.86136569317;28907.27731806706;28910.277243068933;28912.999999999975;28939.85530072352;29358.706412935866;40626;42348.729538113905;42465.93835154123;43824;9141.451512909214;9318.440893546374;9342.112499312554;9346.859797103049;9349.158575728183;8993;9133.588988495534;9137.314701397388;9141.040190779971;9153.176214140725;7451.143118541383;7645.732399366023;11245.60640377587;11491.655250342503;11540.192186546945;9674.274429417752;11442.256253343548;11484.483198256015;11516.16321145121;11516.424178791069;11094;11177.608783692613;11186.440677966151;11192.328460292409;11201.159913006475;27141.592876106875;27565.724342756515;27617.447651047067;38634.61365386338;39278.66131378836;3749.906252343686;3762.191128907271;3763.6989040876665;3767.2465506898457;3788.6400791924725;29008;29008.709912900813;29567.26081847971;29706.25734356637;30117.69882301171;3082.3635758596206;3095.2261934516373;3110.8133511989354;3193.6327322357993;3216.8713251469912;311085;311433;311829;312439.99999999773;312647;55779.16331255034;55927;56048.07062622749;56051.719741401845;56099.439005610235;47746.28380574294;58922.11616825751;59134.40865591289;59318.70340648355;59324.40675593189;12682.302473364054;13036.41336139876;14357.282135893163;14680.706385872223;14695.191764452844;11135.944320278346;11410.714732131597;11446.427678616035;11488.253263537843;11508.36703981289;14810.33413985493;14864.547349687396;14872.256387180598;15076.512375458145;15122.39510419593;6066.75732970685;6501.284858665543;6677.732890684415;6745.763898263635;6802;826.6486743134144;835.6907944060737;838.3544670603601;839.9916000840036;862.3403096631082;28446.431071378458;28470.430591388056;28788.42423151525;29164.562531562042;29288.26779330534;934.8691183234353;972.2707969023232;973.3332667123043;1022.1311884897926;1165.5745652836822;13959;14562.271886405637;14725.263736813116;15094.320755566026;15109.47116850927;532675;534300.2559795207;535339;537864;539962;56448.717756411774;56470.87058258812;56533.434665652814;56573.71713141408;56618.63957685557;1300.8959283257316;1343.2544937559749;1345.8115863779078;1353.573624308379;1358.9660258493418;26749;27692.723072769015;28333.858330709038;28365.290867728472;28488;46863.828404290165;47323.52676473191;47349;47420.2886956689;47584.7620761894;464134;465003;466628;466901.29579267156;467734;27674;33212;35386;36504.40597993688;36555.451668224465;44270;44711.329330060726;45523.31715024211;45652.8586785333;45753.33973282196;32202.516962246053;33125.33749324952;34754.82622586871;36089.458658120675;36145;33295.83352083224;35397;36668.44997324989;36770.42607017483;36825;35290.47064294089;35759;35893.82053089822;36334.27331453409;36411.635883640825;29946.401071978875;30999.84500077485;31146.844265778527;31272.530912036793;31887.68112318847;21644.45888852791;23073.538529229656;23686.815659217315;24032.279031629078;24099 14:58:48 INFO - PROCESS | 1640 | |2;jquery.html;359.20615439877866;392.29974495525494;397.0946242566947;402.4064504855338;424.68361071002107;13455.46178152874;15813.762793558106;19367.515812104688;20019.799802002013;20903.68644470334;18609.7208541872;20756;21387.144514219413;21405.250816221436;21523.24668636598;5668.631538949976;5979.312379076397;5992.910106348409;6001;6002.249718785152;5604.271444712182;5852.67810270435;5858.414158584129;5898.203742494751;5899;5695.629784064044;5823.272090988627;5860.062390017598;5865.941340586583;5868.501177399926;5686.061799803048;5769.7115144242825;5829.912551311733;5839.503642190419;5853;5019.121653710623;5076.492350764931;5100.107481190814;5107.978404319114;5131.102057140023;25533.489330213477;25734.227973160836;25745.613815792778;26147.60778588323;26149.32474984268;2625.2780485366675;2629.6187052877226;2640.7095219525836;2641.511320405731;2644.537205988944;15221.391144354213;15223.923880380638;15250.618734531614;15643.139627320494;15821;1692.5260926940477;1727.1450631937146;1733.6879361714887;1748.1434097292363;1757.4639734880857;113045;117994;118892;119114;119444;7483.363914067365;10052.497375131214;10132.78406591199;10628.681139565826;11060.778784424427;13092.672683182996;13966.930165349107;13975.37110830015;13992.930035349962;14013;5837.357890632027;6902.686710379046;7466.738664146729;8181.754547363588;8248.092709801916;7919.881201781978;8155.877661835078;8165.183481651788;8241.79395515117;8249.711260105867;5920.763169473173;6828.639517978363;6832.350926661959;6842.247352791189;6860.348266914635;1819.736138259945;1842.9170687318835;1846.9168887400099;1847.3072597775833;1847.9260829566936;862.9827403451895;870.629982257538;873.7073080518097;873.8727042115727;904.6833608237196;21981.560368792536;22149.778502215093;22163.44591385196;22179.556408871733;22202;873.7378786364065;889.2974550105345;894.1773568317163;903.2864037410372;911.7766147293822;10142.543585538668;11548.76902461946;11623;11636.88363116375;11721.35532545701;597219;602987.4473222467;603680;619794;623515;121781.39109304397;124849.7515024838;125581;126075;126678.36660816637;867.3538214030588;988.3921388346115;994.9006347985517;1011.8785745710562;1011.9089281964658;9293;10764.085052770602;17687.38094166698;17745.29018839232;18720.625587488445;45733.13673056337;48575.75712121558;52365.95268094693;54154.187687183934;56999.58377103456;61602.69198653978;78277.60861195657;78558;78691.60654196692;79371;9623.085806848338;11770.82343764827;12325.055982086005;12697.55558555446;12708.809367859305;13177.011724120921;13326.267055312052;13376.799348009594;13754.93122534421;13778.448862045407;11480.712982175512;11484.733586110424;11685.240459370454;11764.352960586908;11832.940835295769;11357.37534435614;11521.078313735048;11588.710282243012;11767.176297659082;11768;10581.89418105809;11091.833622495507;11122.054625356936;11286.887131128584;11579.594714184963;11150.609728659458;11254.437278136224;12087.637370878887;12440;12584.685382865502;10448.373097614167;10776.946115269373;10838.349699018085;10927.617533386294;10976.670699879016 14:58:48 INFO - PROCESS | 1640 | |3;mootools.html;1241.1994263699914;1401.8528054554272;1430.1204759073166;1434.4262295081967;1436.4038923846604;8072.475289106212;8467.703630372938;8478;8489.023762267349;8511.914880851189;8133.593320333989;8453.450525715823;8475.957620211906;8536.14638536146;8536.402451828375;2241.0923575951765;2271.0234599122373;2273.8408311418207;2278.3506700590333;2278.612635851901;1941.107090738262;2243.1251811793413;2297.5519773644146;2307.8846057697133;2311.971172828092;1961.3331467301114;1987.0263570850252;1988.2047181127593;1989.1347263940231;1990.4327266728985;1619.3846338391395;2173.9456513587206;2242.3497185816095;2250.7749225077523;2258.8305877059124;2272;2278.863268203913;2279.088364654135;2280.920167794136;2286.119843860109;8458.365622578269;8519.872201916914;8519.872201916976;8523.232909038215;8542.316614670812;4126;4521.954780452219;4722.716637001791;5197;5220.582353411756;3188.1870123118456;3412.1640198151613;3477.530533378012;3481.2863363010524;3498.1604414940484;1160.5589875847209;1179.1804695736466;1233.9321337326444;1264.5982307592637;1273.7388835288743;10872.67381978542;10932.07077398422;10997.285176463503;11004.119670426348;11012.39431831257;4168.312228482267;4350.608445239944;4408.426904502394;4438.356438316426;4443.355713421601;8729.388942773945;8735.34484913634;8737.213650771333;8747.08155643661;8781.20969112783;5072.873178170502;5086.821961231339;5091.032703786269;5092.210707340369;5095.97452012745;4627.421572303462;4634.21218392874;4718.41019872516;4737.3841400618385;4762.476127625959;2658.853763043051;3474.7741396809633;3512.0683624006692;3563.6436356364156;3574.1064733816547;1082.2640604388935;1092.448313601626;1102.5534658463334;1119.8936101070385;1120.7310245541012;831.4138532334689;861.6165806216173;866.5190819095336;921.2123634292717;922.3866129024258;5510.972445137829;5667.773289068474;5768.74040668171;5977.551683623746;6033.095324699936;914.679862048291;921.9492927888896;923.9236289722533;928.8560273157672;969.2246203037682;3554.87557935471;3643.3988391915036;3687.6681098701247;3732.925341493155;3810.7523011004196;9653.082957119062;10012.799744005079;10022.148117410103;10030.297879148535;10047.899521004843;9969.900300996896;9970;9971.750706232257;9975.902650708416;9992.200623950212;7550.509216900884;7672.5012874163;7688.462307538514;7689.730859420005;7702.807429814299;5170.97414512925;5385.596080294072;5478.698671572943;5504.697241651747;5569.275994120739;8772.912270877465;8791.912080879109;9141.862872056792;9268.582913768762;9272.258219342302;9071.319651026068;9180.816383672156;9302.302327325613;9352.953235233781;9366.906330936603;7033.824154396181;7047.295270473117;7186.1376634804155;7197.820054498679;7200.1719802223415;7799.6100194988885;7809.180036096355;7899.763007109566;7906.16985216567;7911.208879112273;7047.894281585678;7085.751998680022;7097.432205423451;7151.42788576923;7284.635768211674;7034.366906978396;7046.1192350956135;7048.3304086113785;7109.182444019004;7130.607816570138;5714.742836572281;6052.364501727256;6294.653794041372;6339.714712837841;6394.616323020634;3925.803709814441;4681.672282940298;4716.646251531218;4745.145873742759;4871.098846713369;4846.273059041172;4927.841957140141;4971.502849715;4994.525520075587;5086.9745651271505 14:58:48 INFO - PROCESS | 1640 | |4;prototype.html;357.9015770663068;360.62855259083136;364.88870894377203;366.87526241078035;370.47947633574836;4514.52597477265;4962.602991760659;5017.347744793176;5226.189940559219;5362.946370536293;4940.530649588283;5237.397699264586;5258.475931552857;5272.393674727407;5304.230886521452;3738.6261373862667;3877.6428250112517;3886.7862267575274;3929.3713005919058;3985.681145508367;3209.181658677034;3669.6880765134997;3946.980265098685;3948.302230041081;3967.5437324707596;3426.417509023472;3670.8069877289854;3783.489228954097;3955.228730397559;3979.9204015919663;3483.6168021517615;3587.7488575799703;3786.848526058954;3905.0627849316243;3965.306071437487;3342.8328583570724;3417.2652879631;3433.9141521461916;3439.6904278614793;3456.2569047654624;4244.745315281062;4255.85079534836;5120.718360490171;5130.1791713326065;5160.870978225536;3781.357169281201;3804.733668643196;3812.8284227209842;4498.460184777848;4561.2245918193985;4573.370312070573;5055.393352797688;5072.670276432057;5477.75350109246;5528.585356098269;3728.50859656137;3738.906527336811;3750.4374343848367;3757.8684746034032;3794.7343685941996;5470.835874923759;5647.576431767634;5690.723710515744;5768.173594938492;5782.913256301159;3229.9677003230136;3618.3667858124722;3663.4504824276037;3685.8894233173046;3755.0424641716186;3255.9975614996606;3416.590009198912;3826.7129965252716;3831.3295173344554;3849.7690138591774;3602.0814692253307;4340.392345071693;4395.494518130392;4492.820287188541;4510;4694.577488026094;4941.901161976741;4944.406671199407;5541.889162216814;5648.915266271009;1131.5134492168447;1192.2905871006737;1248.5193200617646;1260.3257257367266;1268.7969924811987;771.7221800151941;807.3420162567488;844.995775021121;852.4672079950032;856.9914300857037;4417.8232870684815;4431.734095954189;4889.777555611097;4891.951080489221;4913.31213630092;5243.449437809051;5405.270288511079;5428.348598168245;5433;5473.863153421116;4775.832845850448;4894.877628059327;4920.8769780755765;4936.67911585753;5019.7490125494305;2339.239747082205;2556.4661203277883;2633.8674370021076;2849.5725641153995;2863.914082577526;4848.636352273594;5165.590710131295;5225.294585231021;5638.757714314203;5764.250647415809;4900.607951363882;5150.922736158961;5467.425920278393;5657.462541058593;5663.122216056518;4974.955259395495;4978.6017118630425;5612.410696876851;5652.241259562427;5782;5139.659221506051;5574.609777315549;5684.971575142098;5714.714264286852;5740.68426236561;4586.88532786683;4955.529224723646;5313.52178303939;5664.943350566442;5669.971650141723;4988.45127036033;5175.353080864892;5871.150587564904;5888.646681199141;5915.852103697442;3532.6114127446476;3582;3769.2838360712476;3796.5064541609413;3801.904952376213;5002.649284693185;5301.602379821606;5321.467853214647;5696.202531645656;5708.971455142864;4564.931526027179;4779.378680771478;4913.680610760289;5281.167731525611;5608.690872385312;4708.7039072648595;4758.762061896822;5391.379991301051;5596.748146333343;5615.803446879339;5272.578193744568;5299.788008479772;5457.945420545744;5460.972695136657;5489;4882.340883980617;5497.945020549743;5515.669059856422;5522.2544956431975;5544.615815199341;4784.277660042312;5128.7179205144075;5141.714571357161;5398.704310965419;5427.83716488506 14:58:48 INFO - PROCESS | 1640 | |5;yui.html;681.8125015620706;694.1011390249627;697.7174244431004;766.5400759544274;782.8825676148579;13747.587572372833;14175.291235438239;14219.146851188923;14243.71512569748;14262;9853.7536561586;13049.021323400735;13265.734685306288;13342.93328533356;13347.132436391652;728.5373787644844;913.5204017890627;915.6245939164944;916.2395211974045;917.3074328881685;889.8620713789373;908.3868388837541;910.5947853205327;912.0924679943465;920.2913756407562;969.1568335548083;972.0376826941313;972.2853702528636;973.2749101919045;973.8733964584594;972.2125078686216;972.4019727867382;972.4602845420789;973.4889183178817;981.9787421082066;722.9674664640104;723.4863247094569;723.9601821899794;725.0610459455019;728.1589763822793;12360.876391236063;14480.420783168765;15315.693686126326;15331.540053798293;15342.156181410019;13506.459741610324;13711.040227184101;13857.722845543032;13889.930550347284;13936.303184840717;11214.271072380268;11271.43642817864;11384.260023098472;11698.415079246004;11992.70018249542;3613.1328481164596;3658.396364599838;3661.9267614647824;3678.411454167347;3691.2248427830186;84848.15151848464;90856;91921.54039229828;92277.53861230718;92717;10579.259451838298;10599.258051936291;10710.946445267724;10969.177311701655;11222.943885280685;21729.348119556438;21741.67387489189;22045.33863984083;22806.771932280797;22894;6836.38472537474;6914;7039.507234493639;7048.436125109979;7311.707531698672;3948.1314110896133;3997.380406037069;4040.515138183378;4060.6954478414236;4060.939085913714;3508.2281897982402;3536.398812201932;3593.389123848952;3605.729570282187;3612.674859262679;670.1857243449135;670.8222321084917;676.922153952292;689.6138162628944;690.2510775808304;565.5080080330057;578.9044807606782;608.405976341978;612.9325774164838;626.7023163997156;7685.693432116554;8974.878140232471;9111.088891110969;9145.268378529701;9461.52692365379;574.3136951343105;589.3870374810235;644.6196743921109;652.846581053452;657.8980258060009;4022.9195416091516;4035.627886518539;4299.333603291495;4600.446906244257;4717.292406139107;69938.65030674814;70562;75245;93008.37395325584;97853;69966;76041;76533.85199222017;79079;79170;59902.10146847888;62713.68643156755;63534.682326589;66554.33445665482;69248.6537567309;10184.796304074025;10270.794584108426;10343.863293617214;10524;10543.726482742755;42808.57191428046;43139.352909707006;43672.56327436685;45273.77363113163;46173.076538469715;57163.42836571581;61807;61926;61986.69006654938;62579;12354.444050017592;12444.688882778002;12666.936665316614;12682.175658582162;12892.38845144357;13771;14040;14070.577882663536;14084.718305634035;14162.575122746333;12683.746325073262;13001.674958126123;13072.346382680638;13186.340682965621;13695.726085478434;11682.357470339213;12303;12928.547500837425;13076.673083172996;13141.868581314448;10431;11203.71990700239;12550.623481295575;12614.684632884251;12961.675958100746;10438.947805260925;10566.947165264124;10622.177471612753;10745.677629671123;11334.546618135182;8674.826503469769;8911.955440222757;9769.85345219808;10748.677539673823;11082.778344432905 14:58:48 INFO - PROCESS | 1640 | __end_tp_report 14:58:48 INFO - PROCESS | 1640 | __start_cc_report 14:58:48 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,1502 14:58:48 INFO - PROCESS | 1640 | __end_cc_report 14:58:48 INFO - PROCESS | 1640 | __startTimestamp1487113128409__endTimestamp 14:58:48 INFO - PROCESS | 1640 | 14:58:48 INFO - PROCESS | 1640 | ------- Summary: start ------- 14:58:48 INFO - PROCESS | 1640 | Number of tests: 6 14:58:48 INFO - PROCESS | 1640 | 14:58:48 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5675.57 Median:5906.76 stddev:665.53 (11.3%) stddev-sans-first:626.63 14:58:48 INFO - PROCESS | 1640 | Values: 2745.6 3249.5 3345.4 3374.9 3394.0 5517.3 5603.4 5610.7 5672.3 5701.1 4648.5 5533.4 5610.4 5610.9 5617.2 4208.5 5083.6 5120.0 5174.9 5208.8 5151.5 5251.4 5260.4 5260.6 5267.6 5235.8 5238.2 5242.7 5243.2 5243.6 5216.5 5227.5 5235.5 5237.6 5246.3 4995.1 5113.8 5176.2 5185.8 5203.1 5718.8 5731.9 5752.7 5756.3 5771.0 5992.7 6206.2 6217.3 6257.0 6268.8 6140.2 6153.0 6179.8 6197.5 6210.0 5172.1 5678.1 5773.4 5793.6 5799.9 6248.8 6268.6 6274.1 6275.3 6305.2 5088.8 6140.4 6142.0 6160.9 6166.7 6022.2 6089.7 6108.4 6113.1 6262.7 5923.2 6096.1 6097.5 6105.4 6107.2 6104.1 6104.7 6107.3 6108.3 6119.9 4776.0 4882.1 4916.3 4923.5 4929.2 4228.5 4401.6 4414.0 4432.3 4438.3 5733.8 5737.5 5740.3 5749.6 5756.7 5497.5 6260.9 6305.1 6312.6 6318.7 5542.7 5594.1 5595.4 5644.8 5659.5 5377.7 5378.1 5379.9 5393.2 5394.9 5202.3 6204.8 6271.9 6272.4 6291.3 6291.3 6309.4 6311.2 6312.9 6324.2 6245.4 6251.6 6254.3 6271.7 6291.5 5931.5 6062.4 6066.5 6234.6 6245.2 5088.3 6129.7 6167.7 6170.3 6172.5 6004.6 6103.2 6119.1 6123.4 6136.0 5893.1 6091.4 6108.9 6111.4 6126.0 5736.8 5806.2 5931.9 5964.3 5967.9 6133.0 6140.9 6152.3 6153.4 6163.4 5906.8 5935.9 5982.9 6001.5 6010.7 14:58:48 INFO - PROCESS | 1640 | 14:58:48 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:57767.78 Median:35391.50 stddev:119276.57 (337.0%) stddev-sans-first:119533.49 14:58:48 INFO - PROCESS | 1640 | Values: 431.5 440.8 466.3 510.2 538.7 27726.9 28907.3 28910.3 28913.0 28939.9 29358.7 40626.0 42348.7 42465.9 43824.0 9141.5 9318.4 9342.1 9346.9 9349.2 8993.0 9133.6 9137.3 9141.0 9153.2 7451.1 7645.7 11245.6 11491.7 11540.2 9674.3 11442.3 11484.5 11516.2 11516.4 11094.0 11177.6 11186.4 11192.3 11201.2 27141.6 27565.7 27617.4 38634.6 39278.7 3749.9 3762.2 3763.7 3767.2 3788.6 29008.0 29008.7 29567.3 29706.3 30117.7 3082.4 3095.2 3110.8 3193.6 3216.9 311085.0 311433.0 311829.0 312440.0 312647.0 55779.2 55927.0 56048.1 56051.7 56099.4 47746.3 58922.1 59134.4 59318.7 59324.4 12682.3 13036.4 14357.3 14680.7 14695.2 11135.9 11410.7 11446.4 11488.3 11508.4 14810.3 14864.5 14872.3 15076.5 15122.4 6066.8 6501.3 6677.7 6745.8 6802.0 826.6 835.7 838.4 840.0 862.3 28446.4 28470.4 28788.4 29164.6 29288.3 934.9 972.3 973.3 1022.1 1165.6 13959.0 14562.3 14725.3 15094.3 15109.5 532675.0 534300.3 535339.0 537864.0 539962.0 56448.7 56470.9 56533.4 56573.7 56618.6 1300.9 1343.3 1345.8 1353.6 1359.0 26749.0 27692.7 28333.9 28365.3 28488.0 46863.8 47323.5 47349.0 47420.3 47584.8 464134.0 465003.0 466628.0 466901.3 467734.0 27674.0 33212.0 35386.0 36504.4 36555.5 44270.0 44711.3 45523.3 45652.9 45753.3 32202.5 33125.3 34754.8 36089.5 36145.0 33295.8 35397.0 36668.4 36770.4 36825.0 35290.5 35759.0 35893.8 36334.3 36411.6 29946.4 30999.8 31146.8 31272.5 31887.7 21644.5 23073.5 23686.8 24032.3 24099.0 14:58:48 INFO - PROCESS | 1640 | 14:58:48 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:35368.20 Median:22156.61 stddev:101455.53 (457.9%) stddev-sans-first:101706.09 14:58:48 INFO - PROCESS | 1640 | Values: 359.2 392.3 397.1 402.4 424.7 13455.5 15813.8 19367.5 20019.8 20903.7 18609.7 20756.0 21387.1 21405.3 21523.2 5668.6 5979.3 5992.9 6001.0 6002.2 5604.3 5852.7 5858.4 5898.2 5899.0 5695.6 5823.3 5860.1 5865.9 5868.5 5686.1 5769.7 5829.9 5839.5 5853.0 5019.1 5076.5 5100.1 5108.0 5131.1 25533.5 25734.2 25745.6 26147.6 26149.3 2625.3 2629.6 2640.7 2641.5 2644.5 15221.4 15223.9 15250.6 15643.1 15821.0 1692.5 1727.1 1733.7 1748.1 1757.5 113045.0 117994.0 118892.0 119114.0 119444.0 7483.4 10052.5 10132.8 10628.7 11060.8 13092.7 13966.9 13975.4 13992.9 14013.0 5837.4 6902.7 7466.7 8181.8 8248.1 7919.9 8155.9 8165.2 8241.8 8249.7 5920.8 6828.6 6832.4 6842.2 6860.3 1819.7 1842.9 1846.9 1847.3 1847.9 863.0 870.6 873.7 873.9 904.7 21981.6 22149.8 22163.4 22179.6 22202.0 873.7 889.3 894.2 903.3 911.8 10142.5 11548.8 11623.0 11636.9 11721.4 597219.0 602987.4 603680.0 619794.0 623515.0 121781.4 124849.8 125581.0 126075.0 126678.4 867.4 988.4 994.9 1011.9 1011.9 9293.0 10764.1 17687.4 17745.3 18720.6 45733.1 48575.8 52366.0 54154.2 56999.6 61602.7 78277.6 78558.0 78691.6 79371.0 9623.1 11770.8 12325.1 12697.6 12708.8 13177.0 13326.3 13376.8 13754.9 13778.4 11480.7 11484.7 11685.2 11764.4 11832.9 11357.4 11521.1 11588.7 11767.2 11768.0 10581.9 11091.8 11122.1 11286.9 11579.6 11150.6 11254.4 12087.6 12440.0 12584.7 10448.4 10776.9 10838.3 10927.6 10976.7 14:58:48 INFO - PROCESS | 1640 | 14:58:48 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:5356.23 Median:5094.09 stddev:2989.30 (58.7%) stddev-sans-first:2981.68 14:58:48 INFO - PROCESS | 1640 | Values: 1241.2 1401.9 1430.1 1434.4 1436.4 8072.5 8467.7 8478.0 8489.0 8511.9 8133.6 8453.5 8476.0 8536.1 8536.4 2241.1 2271.0 2273.8 2278.4 2278.6 1941.1 2243.1 2297.6 2307.9 2312.0 1961.3 1987.0 1988.2 1989.1 1990.4 1619.4 2173.9 2242.3 2250.8 2258.8 2272.0 2278.9 2279.1 2280.9 2286.1 8458.4 8519.9 8519.9 8523.2 8542.3 4126.0 4522.0 4722.7 5197.0 5220.6 3188.2 3412.2 3477.5 3481.3 3498.2 1160.6 1179.2 1233.9 1264.6 1273.7 10872.7 10932.1 10997.3 11004.1 11012.4 4168.3 4350.6 4408.4 4438.4 4443.4 8729.4 8735.3 8737.2 8747.1 8781.2 5072.9 5086.8 5091.0 5092.2 5096.0 4627.4 4634.2 4718.4 4737.4 4762.5 2658.9 3474.8 3512.1 3563.6 3574.1 1082.3 1092.4 1102.6 1119.9 1120.7 831.4 861.6 866.5 921.2 922.4 5511.0 5667.8 5768.7 5977.6 6033.1 914.7 921.9 923.9 928.9 969.2 3554.9 3643.4 3687.7 3732.9 3810.8 9653.1 10012.8 10022.1 10030.3 10047.9 9969.9 9970.0 9971.8 9975.9 9992.2 7550.5 7672.5 7688.5 7689.7 7702.8 5171.0 5385.6 5478.7 5504.7 5569.3 8772.9 8791.9 9141.9 9268.6 9272.3 9071.3 9180.8 9302.3 9353.0 9366.9 7033.8 7047.3 7186.1 7197.8 7200.2 7799.6 7809.2 7899.8 7906.2 7911.2 7047.9 7085.8 7097.4 7151.4 7284.6 7034.4 7046.1 7048.3 7109.2 7130.6 5714.7 6052.4 6294.7 6339.7 6394.6 3925.8 4681.7 4716.6 4745.1 4871.1 4846.3 4927.8 4971.5 4994.5 5087.0 14:58:48 INFO - PROCESS | 1640 | 14:58:48 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4353.58 Median:4913.50 stddev:1352.15 (27.5%) stddev-sans-first:1322.26 14:58:48 INFO - PROCESS | 1640 | Values: 357.9 360.6 364.9 366.9 370.5 4514.5 4962.6 5017.3 5226.2 5362.9 4940.5 5237.4 5258.5 5272.4 5304.2 3738.6 3877.6 3886.8 3929.4 3985.7 3209.2 3669.7 3947.0 3948.3 3967.5 3426.4 3670.8 3783.5 3955.2 3979.9 3483.6 3587.7 3786.8 3905.1 3965.3 3342.8 3417.3 3433.9 3439.7 3456.3 4244.7 4255.9 5120.7 5130.2 5160.9 3781.4 3804.7 3812.8 4498.5 4561.2 4573.4 5055.4 5072.7 5477.8 5528.6 3728.5 3738.9 3750.4 3757.9 3794.7 5470.8 5647.6 5690.7 5768.2 5782.9 3230.0 3618.4 3663.5 3685.9 3755.0 3256.0 3416.6 3826.7 3831.3 3849.8 3602.1 4340.4 4395.5 4492.8 4510.0 4694.6 4941.9 4944.4 5541.9 5648.9 1131.5 1192.3 1248.5 1260.3 1268.8 771.7 807.3 845.0 852.5 857.0 4417.8 4431.7 4889.8 4892.0 4913.3 5243.4 5405.3 5428.3 5433.0 5473.9 4775.8 4894.9 4920.9 4936.7 5019.7 2339.2 2556.5 2633.9 2849.6 2863.9 4848.6 5165.6 5225.3 5638.8 5764.3 4900.6 5150.9 5467.4 5657.5 5663.1 4975.0 4978.6 5612.4 5652.2 5782.0 5139.7 5574.6 5685.0 5714.7 5740.7 4586.9 4955.5 5313.5 5664.9 5670.0 4988.5 5175.4 5871.2 5888.6 5915.9 3532.6 3582.0 3769.3 3796.5 3801.9 5002.6 5301.6 5321.5 5696.2 5709.0 4564.9 4779.4 4913.7 5281.2 5608.7 4708.7 4758.8 5391.4 5596.7 5615.8 5272.6 5299.8 5457.9 5461.0 5489.0 4882.3 5497.9 5515.7 5522.3 5544.6 4784.3 5128.7 5141.7 5398.7 5427.8 14:58:48 INFO - PROCESS | 1640 | 14:58:48 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:18088.66 Median:43405.96 stddev:24615.36 (56.7%) stddev-sans-first:24649.71 14:58:48 INFO - PROCESS | 1640 | Values: 681.8 694.1 697.7 766.5 782.9 13747.6 14175.3 14219.1 14243.7 14262.0 9853.8 13049.0 13265.7 13342.9 13347.1 728.5 913.5 915.6 916.2 917.3 889.9 908.4 910.6 912.1 920.3 969.2 972.0 972.3 973.3 973.9 972.2 972.4 972.5 973.5 982.0 723.0 723.5 724.0 725.1 728.2 12360.9 14480.4 15315.7 15331.5 15342.2 13506.5 13711.0 13857.7 13889.9 13936.3 11214.3 11271.4 11384.3 11698.4 11992.7 3613.1 3658.4 3661.9 3678.4 3691.2 84848.2 90856.0 91921.5 92277.5 92717.0 10579.3 10599.3 10710.9 10969.2 11222.9 21729.3 21741.7 22045.3 22806.8 22894.0 6836.4 6914.0 7039.5 7048.4 7311.7 3948.1 3997.4 4040.5 4060.7 4060.9 3508.2 3536.4 3593.4 3605.7 3612.7 670.2 670.8 676.9 689.6 690.3 565.5 578.9 608.4 612.9 626.7 7685.7 8974.9 9111.1 9145.3 9461.5 574.3 589.4 644.6 652.8 657.9 4022.9 4035.6 4299.3 4600.4 4717.3 69938.7 70562.0 75245.0 93008.4 97853.0 69966.0 76041.0 76533.9 79079.0 79170.0 59902.1 62713.7 63534.7 66554.3 69248.7 10184.8 10270.8 10343.9 10524.0 10543.7 42808.6 43139.4 43672.6 45273.8 46173.1 57163.4 61807.0 61926.0 61986.7 62579.0 12354.4 12444.7 12666.9 12682.2 12892.4 13771.0 14040.0 14070.6 14084.7 14162.6 12683.7 13001.7 13072.3 13186.3 13695.7 11682.4 12303.0 12928.5 13076.7 13141.9 10431.0 11203.7 12550.6 12614.7 12961.7 10438.9 10566.9 10622.2 10745.7 11334.5 8674.8 8912.0 9769.9 10748.7 11082.8 14:58:48 INFO - PROCESS | 1640 | -------- Summary: end -------- 14:58:48 INFO - PROCESS | 1640 | 14:58:49 INFO - TEST-INFO | 1640: exit 0 14:58:49 INFO - TEST-OK | dromaeo_css | took 1120005ms 14:58:49 INFO - TEST-START | kraken 14:58:49 INFO - operating with platform_type : mac_ 14:58:49 INFO - Initialising browser for kraken test... 14:58:49 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmp1SAXoT/profile http://localhost:49240/getInfo.html) 14:58:51 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 14:58:51 INFO - PROCESS | 1650 | colorDepth:24 14:58:51 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 14:58:51 INFO - PROCESS | 1650 | __metrics 14:58:51 INFO - PROCESS | 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:58:51 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:58:52 INFO - TEST-INFO | 1650: exit 0 14:58:52 INFO - Browser initialized. 14:58:52 INFO - Running cycle 1/1 for kraken test... 14:58:52 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmp1SAXoT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:59:04 INFO - PROCESS | 1651 | RSS: Main: 236625920 14:59:04 INFO - PROCESS | 1651 | 14:59:07 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 14:59:08 INFO - PROCESS | 1651 | RSS: Main: 289665024 14:59:08 INFO - PROCESS | 1651 | 14:59:10 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 14:59:11 INFO - PROCESS | 1651 | RSS: Main: 291557376 14:59:11 INFO - PROCESS | 1651 | 14:59:14 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 14:59:15 INFO - PROCESS | 1651 | RSS: Main: 380997632 14:59:15 INFO - PROCESS | 1651 | 14:59:17 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 14:59:18 INFO - PROCESS | 1651 | RSS: Main: 286998528 14:59:18 INFO - PROCESS | 1651 | 14:59:20 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:59:20 INFO - PROCESS | 1651 | RSS: Main: 288694272 14:59:20 INFO - PROCESS | 1651 | 14:59:23 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 14:59:24 INFO - PROCESS | 1651 | RSS: Main: 331223040 14:59:24 INFO - PROCESS | 1651 | 14:59:27 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 14:59:27 INFO - PROCESS | 1651 | RSS: Main: 334663680 14:59:27 INFO - PROCESS | 1651 | 14:59:30 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 14:59:31 INFO - PROCESS | 1651 | RSS: Main: 329388032 14:59:31 INFO - PROCESS | 1651 | 14:59:33 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:59:33 INFO - PROCESS | 1651 | RSS: Main: 306909184 14:59:33 INFO - PROCESS | 1651 | 14:59:35 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:59:36 INFO - PROCESS | 1651 | RSS: Main: 312012800 14:59:36 INFO - PROCESS | 1651 | 14:59:38 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:59:39 INFO - PROCESS | 1651 | RSS: Main: 312934400 14:59:39 INFO - PROCESS | 1651 | 14:59:42 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:59:42 INFO - PROCESS | 1651 | RSS: Main: 329580544 14:59:42 INFO - PROCESS | 1651 | 14:59:45 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:59:46 INFO - PROCESS | 1651 | RSS: Main: 324018176 14:59:46 INFO - PROCESS | 1651 | 14:59:48 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 14:59:48 INFO - PROCESS | 1651 | RSS: Main: 369885184 14:59:48 INFO - PROCESS | 1651 | 14:59:48 INFO - PROCESS | 1651 | __start_tp_report 14:59:48 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 14:59:48 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 14:59:48 INFO - PROCESS | 1651 | |i|pagename|runs| 14:59:48 INFO - PROCESS | 1651 | |0;ai-astar;114;113;113;112;112;113;112;113;111;114 14:59:48 INFO - PROCESS | 1651 | |1;audio-beat-detection;145;110;110;150;112;112;108;112;136;111 14:59:48 INFO - PROCESS | 1651 | |2;audio-dft;186;184;185;185;184;184;191;243;263;200 14:59:48 INFO - PROCESS | 1651 | |3;audio-fft;80;62;74;106;53;74;79;84;100;82 14:59:48 INFO - PROCESS | 1651 | |4;audio-oscillator;91;70;89;70;70;69;87;68;67;85 14:59:48 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;87;87;87;88;87;88;87;87;87;87 14:59:48 INFO - PROCESS | 1651 | |6;imaging-darkroom;95;98;95;94;93;94;95;94;94;94 14:59:48 INFO - PROCESS | 1651 | |7;imaging-desaturate;90;85;86;86;86;86;85;86;83;87 14:59:48 INFO - PROCESS | 1651 | |8;json-parse-financial;61;60;60;60;59;58;59;58;57;59 14:59:48 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;64;73;76;79;72;67;69;69;68;70 14:59:48 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;94;93;93;92;92;93;90;91;94;93 14:59:48 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;146;145;150;154;155;154;151;153;218;147 14:59:48 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;180;181;181;182;180;177;180;182;181;181 14:59:48 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;70;70;69;71;85;89;89;86;67;67 14:59:48 INFO - PROCESS | 1651 | __end_tp_report 14:59:48 INFO - PROCESS | 1651 | __start_cc_report 14:59:48 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,2067 14:59:48 INFO - PROCESS | 1651 | __end_cc_report 14:59:48 INFO - PROCESS | 1651 | __startTimestamp1487113188771__endTimestamp 14:59:48 INFO - PROCESS | 1651 | 14:59:48 INFO - PROCESS | 1651 | ------- Summary: start ------- 14:59:48 INFO - PROCESS | 1651 | Number of tests: 14 14:59:48 INFO - PROCESS | 1651 | 14:59:48 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:0.95 (0.8%) stddev-sans-first:0.88 14:59:48 INFO - PROCESS | 1651 | Values: 114.0 113.0 113.0 112.0 112.0 113.0 112.0 113.0 111.0 114.0 14:59:48 INFO - PROCESS | 1651 | 14:59:48 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:120.60 Median:112.00 stddev:16.31 (14.6%) stddev-sans-first:14.72 14:59:48 INFO - PROCESS | 1651 | Values: 145.0 110.0 110.0 150.0 112.0 112.0 108.0 112.0 136.0 111.0 14:59:48 INFO - PROCESS | 1651 | 14:59:48 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:200.50 Median:188.50 stddev:28.50 (15.1%) stddev-sans-first:29.74 14:59:48 INFO - PROCESS | 1651 | Values: 186.0 184.0 185.0 185.0 184.0 184.0 191.0 243.0 263.0 200.0 14:59:48 INFO - PROCESS | 1651 | 14:59:48 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:79.40 Median:76.50 stddev:15.70 (20.5%) stddev-sans-first:16.65 14:59:48 INFO - PROCESS | 1651 | Values: 80.0 62.0 74.0 106.0 53.0 74.0 79.0 84.0 100.0 82.0 14:59:48 INFO - PROCESS | 1651 | 14:59:48 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:77.50 stddev:9.97 (12.9%) stddev-sans-first:9.11 14:59:48 INFO - PROCESS | 1651 | Values: 91.0 70.0 89.0 70.0 70.0 69.0 87.0 68.0 67.0 85.0 14:59:48 INFO - PROCESS | 1651 | 14:59:48 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:87.20 Median:87.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 14:59:48 INFO - PROCESS | 1651 | Values: 87.0 87.0 87.0 88.0 87.0 88.0 87.0 87.0 87.0 87.0 14:59:48 INFO - PROCESS | 1651 | 14:59:48 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:94.50 stddev:1.35 (1.4%) stddev-sans-first:1.42 14:59:48 INFO - PROCESS | 1651 | Values: 95.0 98.0 95.0 94.0 93.0 94.0 95.0 94.0 94.0 94.0 14:59:48 INFO - PROCESS | 1651 | 14:59:48 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:86.00 stddev:1.76 (2.1%) stddev-sans-first:1.13 14:59:48 INFO - PROCESS | 1651 | Values: 90.0 85.0 86.0 86.0 86.0 86.0 85.0 86.0 83.0 87.0 14:59:48 INFO - PROCESS | 1651 | 14:59:48 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:59.50 stddev:1.20 (2.0%) stddev-sans-first:1.05 14:59:48 INFO - PROCESS | 1651 | Values: 61.0 60.0 60.0 60.0 59.0 58.0 59.0 58.0 57.0 59.0 14:59:48 INFO - PROCESS | 1651 | 14:59:48 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:71.00 stddev:4.42 (6.2%) stddev-sans-first:3.97 14:59:48 INFO - PROCESS | 1651 | Values: 64.0 73.0 76.0 79.0 72.0 67.0 69.0 69.0 68.0 70.0 14:59:48 INFO - PROCESS | 1651 | 14:59:48 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:92.50 Median:93.00 stddev:1.27 (1.4%) stddev-sans-first:1.22 14:59:48 INFO - PROCESS | 1651 | Values: 94.0 93.0 93.0 92.0 92.0 93.0 90.0 91.0 94.0 93.0 14:59:48 INFO - PROCESS | 1651 | 14:59:48 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:157.30 Median:153.50 stddev:21.62 (14.1%) stddev-sans-first:22.55 14:59:48 INFO - PROCESS | 1651 | Values: 146.0 145.0 150.0 154.0 155.0 154.0 151.0 153.0 218.0 147.0 14:59:48 INFO - PROCESS | 1651 | 14:59:48 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.50 Median:181.00 stddev:1.43 (0.8%) stddev-sans-first:1.51 14:59:48 INFO - PROCESS | 1651 | Values: 180.0 181.0 181.0 182.0 180.0 177.0 180.0 182.0 181.0 181.0 14:59:48 INFO - PROCESS | 1651 | 14:59:48 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.30 Median:78.00 stddev:9.58 (12.3%) stddev-sans-first:9.89 14:59:48 INFO - PROCESS | 1651 | Values: 70.0 70.0 69.0 71.0 85.0 89.0 89.0 86.0 67.0 67.0 14:59:48 INFO - PROCESS | 1651 | -------- Summary: end -------- 14:59:48 INFO - PROCESS | 1651 | 14:59:49 INFO - TEST-INFO | 1651: exit 0 14:59:49 INFO - TEST-OK | kraken | took 60557ms 14:59:49 INFO - SUITE-END | took 1180s 14:59:49 INFO - Completed test suite (00:19:40) 14:59:49 INFO - javascript benchmark 14:59:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7061.720674722015, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2745.560710286354, 3249.463838466653, 3345.3978283908887, 3374.865005399784, 3394.032700680307, 5517.310336207974, 5603.355614104379, 5610.663360198391, 5672.347680016799, 5701.144828275756, 4648.53514648535, 5533.418991005947, 5610.354809196943, 5610.933922554712, 5617.241672374228, 4208.494980602332, 5083.5933125349975, 5119.974400127994, 5174.948250517503, 5208.817691380802, 5151.459096794839, 5251.369835619731, 5260.368755749316, 5260.605454590902, 5267.631265811395, 5235.816746413876, 5238.214267859814, 5242.7378631068295, 5243.187305967581, 5243.632945693803, 5216.452272511369, 5227.50338717825, 5235.528802407764, 5237.554807841338, 5246.344206974129, 4995.075910956485, 5113.821016264413, 5176.197689358156, 5185.818496352647, 5203.1414816555225, 5718.828435146952, 5731.856703582402, 5752.654840709571, 5756.309242890838, 5770.971145144247, 5992.730327135289, 6206.224221972254, 6217.316095229521, 6257.0, 6268.780592679234, 6140.2106357041575, 6153.0, 6179.81460556184, 6197.473214776749, 6210.037444196157, 5172.146595811687, 5678.148277758328, 5773.393793651648, 5793.594448388657, 5799.88400231993, 6248.75004999804, 6268.561200715997, 6274.121622972787, 6275.341089185661, 6305.180326557518, 5088.796448142033, 6140.355262697352, 6142.0, 6160.8767824643255, 6166.7224974876235, 6022.18700475439, 6089.725962331706, 6108.380260339294, 6113.052476866093, 6262.718177682015, 5923.200367950271, 6096.116063170815, 6097.481714054266, 6105.389461053859, 6107.206063211843, 6104.145419641254, 6104.664243466563, 6107.328193898667, 6108.297545782203, 6119.938800611937, 4775.95224047762, 4882.0724062428735, 4916.2625606158645, 4923.532264434873, 4929.186684197068, 4228.534861165331, 4401.581849724271, 4414.028913638995, 4432.268675668479, 4438.289873620205, 5733.799317023884, 5737.51231145349, 5740.282464691913, 5749.626274292157, 5756.683382414008, 5497.47773961473, 6260.906086408708, 6305.117283580303, 6312.589681670676, 6318.71565779541, 5542.695151766611, 5594.0769772987815, 5595.384507704231, 5644.8306550803545, 5659.462351076723, 5377.704226267593, 5378.11261141915, 5379.946200538023, 5393.164059570773, 5394.946050539523, 5202.271681964604, 6204.751809927552, 6271.874562508724, 6272.372762723782, 6291.276503202099, 6291.307956124731, 6309.400606942333, 6311.179546658905, 6312.863684536644, 6324.2410910691015, 6245.375462453719, 6251.624902505864, 6254.343293954069, 6271.717772700148, 6291.496680265476, 5931.525477961666, 6062.393760623902, 6066.4540191382985, 6234.594751341148, 6245.18812554365, 5088.338515993045, 6129.695011270001, 6167.6916154193, 6170.259568851767, 6172.537059720449, 6004.5796794225735, 6103.246756470893, 6119.112728654409, 6123.4351415035735, 6136.048912418582, 5893.086571581412, 6091.390860914051, 6108.938910610837, 6111.449969502588, 6125.9693701531205, 5736.799212027559, 5806.187133801355, 5931.851703707442, 5964.284285885721, 5967.880642387041, 6132.988056970728, 6140.938590614037, 6152.261728592597, 6153.353897840662, 6163.3836616338, 5906.763729450946, 5935.9109613356695, 5982.88034239304, 6001.459868611846, 6010.7295171716505], "value": 5632.255199305812, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.5059257150563, 440.80604534005016, 466.25864874848986, 510.20917577754517, 538.701020933382, 27726.86136569317, 28907.27731806706, 28910.277243068933, 28912.999999999975, 28939.85530072352, 29358.706412935866, 40626.0, 42348.729538113905, 42465.93835154123, 43824.0, 9141.451512909214, 9318.440893546374, 9342.112499312554, 9346.859797103049, 9349.158575728183, 8993.0, 9133.588988495534, 9137.314701397388, 9141.040190779971, 9153.176214140725, 7451.143118541383, 7645.732399366023, 11245.60640377587, 11491.655250342503, 11540.192186546945, 9674.274429417752, 11442.256253343548, 11484.483198256015, 11516.16321145121, 11516.424178791069, 11094.0, 11177.608783692613, 11186.440677966151, 11192.328460292409, 11201.159913006475, 27141.592876106875, 27565.724342756515, 27617.447651047067, 38634.61365386338, 39278.66131378836, 3749.906252343686, 3762.191128907271, 3763.6989040876665, 3767.2465506898457, 3788.6400791924725, 29008.0, 29008.709912900813, 29567.26081847971, 29706.25734356637, 30117.69882301171, 3082.3635758596206, 3095.2261934516373, 3110.8133511989354, 3193.6327322357993, 3216.8713251469912, 311085.0, 311433.0, 311829.0, 312439.99999999773, 312647.0, 55779.16331255034, 55927.0, 56048.07062622749, 56051.719741401845, 56099.439005610235, 47746.28380574294, 58922.11616825751, 59134.40865591289, 59318.70340648355, 59324.40675593189, 12682.302473364054, 13036.41336139876, 14357.282135893163, 14680.706385872223, 14695.191764452844, 11135.944320278346, 11410.714732131597, 11446.427678616035, 11488.253263537843, 11508.36703981289, 14810.33413985493, 14864.547349687396, 14872.256387180598, 15076.512375458145, 15122.39510419593, 6066.75732970685, 6501.284858665543, 6677.732890684415, 6745.763898263635, 6802.0, 826.6486743134144, 835.6907944060737, 838.3544670603601, 839.9916000840036, 862.3403096631082, 28446.431071378458, 28470.430591388056, 28788.42423151525, 29164.562531562042, 29288.26779330534, 934.8691183234353, 972.2707969023232, 973.3332667123043, 1022.1311884897926, 1165.5745652836822, 13959.0, 14562.271886405637, 14725.263736813116, 15094.320755566026, 15109.47116850927, 532675.0, 534300.2559795207, 535339.0, 537864.0, 539962.0, 56448.717756411774, 56470.87058258812, 56533.434665652814, 56573.71713141408, 56618.63957685557, 1300.8959283257316, 1343.2544937559749, 1345.8115863779078, 1353.573624308379, 1358.9660258493418, 26749.0, 27692.723072769015, 28333.858330709038, 28365.290867728472, 28488.0, 46863.828404290165, 47323.52676473191, 47349.0, 47420.2886956689, 47584.7620761894, 464134.0, 465003.0, 466628.0, 466901.29579267156, 467734.0, 27674.0, 33212.0, 35386.0, 36504.40597993688, 36555.451668224465, 44270.0, 44711.329330060726, 45523.31715024211, 45652.8586785333, 45753.33973282196, 32202.516962246053, 33125.33749324952, 34754.82622586871, 36089.458658120675, 36145.0, 33295.83352083224, 35397.0, 36668.44997324989, 36770.42607017483, 36825.0, 35290.47064294089, 35759.0, 35893.82053089822, 36334.27331453409, 36411.635883640825, 29946.401071978875, 30999.84500077485, 31146.844265778527, 31272.530912036793, 31887.68112318847, 21644.45888852791, 23073.538529229656, 23686.815659217315, 24032.279031629078, 24099.0], "value": 18522.90269829158, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.20615439877866, 392.29974495525494, 397.0946242566947, 402.4064504855338, 424.68361071002107, 13455.46178152874, 15813.762793558106, 19367.515812104688, 20019.799802002013, 20903.68644470334, 18609.7208541872, 20756.0, 21387.144514219413, 21405.250816221436, 21523.24668636598, 5668.631538949976, 5979.312379076397, 5992.910106348409, 6001.0, 6002.249718785152, 5604.271444712182, 5852.67810270435, 5858.414158584129, 5898.203742494751, 5899.0, 5695.629784064044, 5823.272090988627, 5860.062390017598, 5865.941340586583, 5868.501177399926, 5686.061799803048, 5769.7115144242825, 5829.912551311733, 5839.503642190419, 5853.0, 5019.121653710623, 5076.492350764931, 5100.107481190814, 5107.978404319114, 5131.102057140023, 25533.489330213477, 25734.227973160836, 25745.613815792778, 26147.60778588323, 26149.32474984268, 2625.2780485366675, 2629.6187052877226, 2640.7095219525836, 2641.511320405731, 2644.537205988944, 15221.391144354213, 15223.923880380638, 15250.618734531614, 15643.139627320494, 15821.0, 1692.5260926940477, 1727.1450631937146, 1733.6879361714887, 1748.1434097292363, 1757.4639734880857, 113045.0, 117994.0, 118892.0, 119114.0, 119444.0, 7483.363914067365, 10052.497375131214, 10132.78406591199, 10628.681139565826, 11060.778784424427, 13092.672683182996, 13966.930165349107, 13975.37110830015, 13992.930035349962, 14013.0, 5837.357890632027, 6902.686710379046, 7466.738664146729, 8181.754547363588, 8248.092709801916, 7919.881201781978, 8155.877661835078, 8165.183481651788, 8241.79395515117, 8249.711260105867, 5920.763169473173, 6828.639517978363, 6832.350926661959, 6842.247352791189, 6860.348266914635, 1819.736138259945, 1842.9170687318835, 1846.9168887400099, 1847.3072597775833, 1847.9260829566936, 862.9827403451895, 870.629982257538, 873.7073080518097, 873.8727042115727, 904.6833608237196, 21981.560368792536, 22149.778502215093, 22163.44591385196, 22179.556408871733, 22202.0, 873.7378786364065, 889.2974550105345, 894.1773568317163, 903.2864037410372, 911.7766147293822, 10142.543585538668, 11548.76902461946, 11623.0, 11636.88363116375, 11721.35532545701, 597219.0, 602987.4473222467, 603680.0, 619794.0, 623515.0, 121781.39109304397, 124849.7515024838, 125581.0, 126075.0, 126678.36660816637, 867.3538214030588, 988.3921388346115, 994.9006347985517, 1011.8785745710562, 1011.9089281964658, 9293.0, 10764.085052770602, 17687.38094166698, 17745.29018839232, 18720.625587488445, 45733.13673056337, 48575.75712121558, 52365.95268094693, 54154.187687183934, 56999.58377103456, 61602.69198653978, 78277.60861195657, 78558.0, 78691.60654196692, 79371.0, 9623.085806848338, 11770.82343764827, 12325.055982086005, 12697.55558555446, 12708.809367859305, 13177.011724120921, 13326.267055312052, 13376.799348009594, 13754.93122534421, 13778.448862045407, 11480.712982175512, 11484.733586110424, 11685.240459370454, 11764.352960586908, 11832.940835295769, 11357.37534435614, 11521.078313735048, 11588.710282243012, 11767.176297659082, 11768.0, 10581.89418105809, 11091.833622495507, 11122.054625356936, 11286.887131128584, 11579.594714184963, 11150.609728659458, 11254.437278136224, 12087.637370878887, 12440.0, 12584.685382865502, 10448.373097614167, 10776.946115269373, 10838.349699018085, 10927.617533386294, 10976.670699879016], "value": 9801.491265482942, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1241.1994263699914, 1401.8528054554272, 1430.1204759073166, 1434.4262295081967, 1436.4038923846604, 8072.475289106212, 8467.703630372938, 8478.0, 8489.023762267349, 8511.914880851189, 8133.593320333989, 8453.450525715823, 8475.957620211906, 8536.14638536146, 8536.402451828375, 2241.0923575951765, 2271.0234599122373, 2273.8408311418207, 2278.3506700590333, 2278.612635851901, 1941.107090738262, 2243.1251811793413, 2297.5519773644146, 2307.8846057697133, 2311.971172828092, 1961.3331467301114, 1987.0263570850252, 1988.2047181127593, 1989.1347263940231, 1990.4327266728985, 1619.3846338391395, 2173.9456513587206, 2242.3497185816095, 2250.7749225077523, 2258.8305877059124, 2272.0, 2278.863268203913, 2279.088364654135, 2280.920167794136, 2286.119843860109, 8458.365622578269, 8519.872201916914, 8519.872201916976, 8523.232909038215, 8542.316614670812, 4126.0, 4521.954780452219, 4722.716637001791, 5197.0, 5220.582353411756, 3188.1870123118456, 3412.1640198151613, 3477.530533378012, 3481.2863363010524, 3498.1604414940484, 1160.5589875847209, 1179.1804695736466, 1233.9321337326444, 1264.5982307592637, 1273.7388835288743, 10872.67381978542, 10932.07077398422, 10997.285176463503, 11004.119670426348, 11012.39431831257, 4168.312228482267, 4350.608445239944, 4408.426904502394, 4438.356438316426, 4443.355713421601, 8729.388942773945, 8735.34484913634, 8737.213650771333, 8747.08155643661, 8781.20969112783, 5072.873178170502, 5086.821961231339, 5091.032703786269, 5092.210707340369, 5095.97452012745, 4627.421572303462, 4634.21218392874, 4718.41019872516, 4737.3841400618385, 4762.476127625959, 2658.853763043051, 3474.7741396809633, 3512.0683624006692, 3563.6436356364156, 3574.1064733816547, 1082.2640604388935, 1092.448313601626, 1102.5534658463334, 1119.8936101070385, 1120.7310245541012, 831.4138532334689, 861.6165806216173, 866.5190819095336, 921.2123634292717, 922.3866129024258, 5510.972445137829, 5667.773289068474, 5768.74040668171, 5977.551683623746, 6033.095324699936, 914.679862048291, 921.9492927888896, 923.9236289722533, 928.8560273157672, 969.2246203037682, 3554.87557935471, 3643.3988391915036, 3687.6681098701247, 3732.925341493155, 3810.7523011004196, 9653.082957119062, 10012.799744005079, 10022.148117410103, 10030.297879148535, 10047.899521004843, 9969.900300996896, 9970.0, 9971.750706232257, 9975.902650708416, 9992.200623950212, 7550.509216900884, 7672.5012874163, 7688.462307538514, 7689.730859420005, 7702.807429814299, 5170.97414512925, 5385.596080294072, 5478.698671572943, 5504.697241651747, 5569.275994120739, 8772.912270877465, 8791.912080879109, 9141.862872056792, 9268.582913768762, 9272.258219342302, 9071.319651026068, 9180.816383672156, 9302.302327325613, 9352.953235233781, 9366.906330936603, 7033.824154396181, 7047.295270473117, 7186.1376634804155, 7197.820054498679, 7200.1719802223415, 7799.6100194988885, 7809.180036096355, 7899.763007109566, 7906.16985216567, 7911.208879112273, 7047.894281585678, 7085.751998680022, 7097.432205423451, 7151.42788576923, 7284.635768211674, 7034.366906978396, 7046.1192350956135, 7048.3304086113785, 7109.182444019004, 7130.607816570138, 5714.742836572281, 6052.364501727256, 6294.653794041372, 6339.714712837841, 6394.616323020634, 3925.803709814441, 4681.672282940298, 4716.646251531218, 4745.145873742759, 4871.098846713369, 4846.273059041172, 4927.841957140141, 4971.502849715, 4994.525520075587, 5086.9745651271505], "value": 4313.0787757045755, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.9015770663068, 360.62855259083136, 364.88870894377203, 366.87526241078035, 370.47947633574836, 4514.52597477265, 4962.602991760659, 5017.347744793176, 5226.189940559219, 5362.946370536293, 4940.530649588283, 5237.397699264586, 5258.475931552857, 5272.393674727407, 5304.230886521452, 3738.6261373862667, 3877.6428250112517, 3886.7862267575274, 3929.3713005919058, 3985.681145508367, 3209.181658677034, 3669.6880765134997, 3946.980265098685, 3948.302230041081, 3967.5437324707596, 3426.417509023472, 3670.8069877289854, 3783.489228954097, 3955.228730397559, 3979.9204015919663, 3483.6168021517615, 3587.7488575799703, 3786.848526058954, 3905.0627849316243, 3965.306071437487, 3342.8328583570724, 3417.2652879631, 3433.9141521461916, 3439.6904278614793, 3456.2569047654624, 4244.745315281062, 4255.85079534836, 5120.718360490171, 5130.1791713326065, 5160.870978225536, 3781.357169281201, 3804.733668643196, 3812.8284227209842, 4498.460184777848, 4561.2245918193985, 4573.370312070573, 5055.393352797688, 5072.670276432057, 5477.75350109246, 5528.585356098269, 3728.50859656137, 3738.906527336811, 3750.4374343848367, 3757.8684746034032, 3794.7343685941996, 5470.835874923759, 5647.576431767634, 5690.723710515744, 5768.173594938492, 5782.913256301159, 3229.9677003230136, 3618.3667858124722, 3663.4504824276037, 3685.8894233173046, 3755.0424641716186, 3255.9975614996606, 3416.590009198912, 3826.7129965252716, 3831.3295173344554, 3849.7690138591774, 3602.0814692253307, 4340.392345071693, 4395.494518130392, 4492.820287188541, 4510.0, 4694.577488026094, 4941.901161976741, 4944.406671199407, 5541.889162216814, 5648.915266271009, 1131.5134492168447, 1192.2905871006737, 1248.5193200617646, 1260.3257257367266, 1268.7969924811987, 771.7221800151941, 807.3420162567488, 844.995775021121, 852.4672079950032, 856.9914300857037, 4417.8232870684815, 4431.734095954189, 4889.777555611097, 4891.951080489221, 4913.31213630092, 5243.449437809051, 5405.270288511079, 5428.348598168245, 5433.0, 5473.863153421116, 4775.832845850448, 4894.877628059327, 4920.8769780755765, 4936.67911585753, 5019.7490125494305, 2339.239747082205, 2556.4661203277883, 2633.8674370021076, 2849.5725641153995, 2863.914082577526, 4848.636352273594, 5165.590710131295, 5225.294585231021, 5638.757714314203, 5764.250647415809, 4900.607951363882, 5150.922736158961, 5467.425920278393, 5657.462541058593, 5663.122216056518, 4974.955259395495, 4978.6017118630425, 5612.410696876851, 5652.241259562427, 5782.0, 5139.659221506051, 5574.609777315549, 5684.971575142098, 5714.714264286852, 5740.68426236561, 4586.88532786683, 4955.529224723646, 5313.52178303939, 5664.943350566442, 5669.971650141723, 4988.45127036033, 5175.353080864892, 5871.150587564904, 5888.646681199141, 5915.852103697442, 3532.6114127446476, 3582.0, 3769.2838360712476, 3796.5064541609413, 3801.904952376213, 5002.649284693185, 5301.602379821606, 5321.467853214647, 5696.202531645656, 5708.971455142864, 4564.931526027179, 4779.378680771478, 4913.680610760289, 5281.167731525611, 5608.690872385312, 4708.7039072648595, 4758.762061896822, 5391.379991301051, 5596.748146333343, 5615.803446879339, 5272.578193744568, 5299.788008479772, 5457.945420545744, 5460.972695136657, 5489.0, 4882.340883980617, 5497.945020549743, 5515.669059856422, 5522.2544956431975, 5544.615815199341, 4784.277660042312, 5128.7179205144075, 5141.714571357161, 5398.704310965419, 5427.83716488506], "value": 3939.0449266668975, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.8125015620706, 694.1011390249627, 697.7174244431004, 766.5400759544274, 782.8825676148579, 13747.587572372833, 14175.291235438239, 14219.146851188923, 14243.71512569748, 14262.0, 9853.7536561586, 13049.021323400735, 13265.734685306288, 13342.93328533356, 13347.132436391652, 728.5373787644844, 913.5204017890627, 915.6245939164944, 916.2395211974045, 917.3074328881685, 889.8620713789373, 908.3868388837541, 910.5947853205327, 912.0924679943465, 920.2913756407562, 969.1568335548083, 972.0376826941313, 972.2853702528636, 973.2749101919045, 973.8733964584594, 972.2125078686216, 972.4019727867382, 972.4602845420789, 973.4889183178817, 981.9787421082066, 722.9674664640104, 723.4863247094569, 723.9601821899794, 725.0610459455019, 728.1589763822793, 12360.876391236063, 14480.420783168765, 15315.693686126326, 15331.540053798293, 15342.156181410019, 13506.459741610324, 13711.040227184101, 13857.722845543032, 13889.930550347284, 13936.303184840717, 11214.271072380268, 11271.43642817864, 11384.260023098472, 11698.415079246004, 11992.70018249542, 3613.1328481164596, 3658.396364599838, 3661.9267614647824, 3678.411454167347, 3691.2248427830186, 84848.15151848464, 90856.0, 91921.54039229828, 92277.53861230718, 92717.0, 10579.259451838298, 10599.258051936291, 10710.946445267724, 10969.177311701655, 11222.943885280685, 21729.348119556438, 21741.67387489189, 22045.33863984083, 22806.771932280797, 22894.0, 6836.38472537474, 6914.0, 7039.507234493639, 7048.436125109979, 7311.707531698672, 3948.1314110896133, 3997.380406037069, 4040.515138183378, 4060.6954478414236, 4060.939085913714, 3508.2281897982402, 3536.398812201932, 3593.389123848952, 3605.729570282187, 3612.674859262679, 670.1857243449135, 670.8222321084917, 676.922153952292, 689.6138162628944, 690.2510775808304, 565.5080080330057, 578.9044807606782, 608.405976341978, 612.9325774164838, 626.7023163997156, 7685.693432116554, 8974.878140232471, 9111.088891110969, 9145.268378529701, 9461.52692365379, 574.3136951343105, 589.3870374810235, 644.6196743921109, 652.846581053452, 657.8980258060009, 4022.9195416091516, 4035.627886518539, 4299.333603291495, 4600.446906244257, 4717.292406139107, 69938.65030674814, 70562.0, 75245.0, 93008.37395325584, 97853.0, 69966.0, 76041.0, 76533.85199222017, 79079.0, 79170.0, 59902.10146847888, 62713.68643156755, 63534.682326589, 66554.33445665482, 69248.6537567309, 10184.796304074025, 10270.794584108426, 10343.863293617214, 10524.0, 10543.726482742755, 42808.57191428046, 43139.352909707006, 43672.56327436685, 45273.77363113163, 46173.076538469715, 57163.42836571581, 61807.0, 61926.0, 61986.69006654938, 62579.0, 12354.444050017592, 12444.688882778002, 12666.936665316614, 12682.175658582162, 12892.38845144357, 13771.0, 14040.0, 14070.577882663536, 14084.718305634035, 14162.575122746333, 12683.746325073262, 13001.674958126123, 13072.346382680638, 13186.340682965621, 13695.726085478434, 11682.357470339213, 12303.0, 12928.547500837425, 13076.673083172996, 13141.868581314448, 10431.0, 11203.71990700239, 12550.623481295575, 12614.684632884251, 12961.675958100746, 10438.947805260925, 10566.947165264124, 10622.177471612753, 10745.677629671123, 11334.546618135182, 8674.826503469769, 8911.955440222757, 9769.85345219808, 10748.677539673823, 11082.778344432905], "value": 7137.624811182609, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1494.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 112.0, 112.0, 113.0, 112.0, 113.0, 111.0, 114.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 110.0, 110.0, 150.0, 112.0, 112.0, 108.0, 112.0, 136.0, 111.0], "value": 120.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 185.0, 185.0, 184.0, 184.0, 191.0, 243.0, 263.0, 200.0], "value": 200.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 62.0, 74.0, 106.0, 53.0, 74.0, 79.0, 84.0, 100.0, 82.0], "value": 79.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 89.0, 70.0, 70.0, 69.0, 87.0, 68.0, 67.0, 85.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 88.0, 87.0, 88.0, 87.0, 87.0, 87.0, 87.0], "value": 87.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 95.0, 94.0, 93.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 85.0, 86.0, 86.0, 86.0, 86.0, 85.0, 86.0, 83.0, 87.0], "value": 86.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 60.0, 59.0, 58.0, 59.0, 58.0, 57.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 73.0, 76.0, 79.0, 72.0, 67.0, 69.0, 69.0, 68.0, 70.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 92.0, 92.0, 93.0, 90.0, 91.0, 94.0, 93.0], "value": 92.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 150.0, 154.0, 155.0, 154.0, 151.0, 153.0, 218.0, 147.0], "value": 157.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 181.0, 181.0, 182.0, 180.0, 177.0, 180.0, 182.0, 181.0, 181.0], "value": 180.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 69.0, 71.0, 85.0, 89.0, 89.0, 86.0, 67.0, 67.0], "value": 76.3, "unit": "score"}]}]} 14:59:49 INFO - Return code: 0 14:59:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:59:50 ERROR - # TBPL SUCCESS # 14:59:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:59:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:59:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:59:50 INFO - 2017-02-14 14:59:50.089 screenresolution[1655:10039] starting screenresolution argv=screenresolution get 14:59:50 INFO - 2017-02-14 14:59:50.092 screenresolution[1655:10039] Display 0: 1600x1200x32@60 14:59:50 INFO - 2017-02-14 14:59:50.098 screenresolution[1656:10042] starting screenresolution argv=screenresolution list 14:59:50 INFO - Available Modes on Display 0 14:59:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:59:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:59:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:59:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:59:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:59:50 INFO - Intel Iris: 14:59:50 INFO - Chipset Model: Intel Iris 14:59:50 INFO - Type: GPU 14:59:50 INFO - Bus: Built-In 14:59:50 INFO - VRAM (Dynamic, Max): 1536 MB 14:59:50 INFO - Vendor: Intel (0x8086) 14:59:50 INFO - Device ID: 0x0a2e 14:59:50 INFO - Revision ID: 0x0009 14:59:50 INFO - Displays: 14:59:50 INFO - Display: 14:59:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:59:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:59:50 INFO - Display Serial Number: 1600x1200 60 14:59:50 INFO - Main Display: Yes 14:59:50 INFO - Mirror: Off 14:59:50 INFO - Online: Yes 14:59:50 INFO - Rotation: Supported 14:59:50 INFO - Return code: 0 14:59:50 INFO - Running post-action listener: _resource_record_post_action 14:59:50 INFO - [mozharness: 2017-02-14 22:59:50.341060Z] Finished run-tests step (success) 14:59:50 INFO - Running post-run listener: _resource_record_post_run 14:59:50 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 38876160; Write bytes: 555316736; Read time: 378; Write time: 1892 14:59:50 INFO - TinderboxPrint: CPU usage
53.9% 14:59:50 INFO - TinderboxPrint: I/O read bytes / time
38,876,160 / 378 14:59:50 INFO - TinderboxPrint: I/O write bytes / time
555,316,736 / 1,892 14:59:50 INFO - TinderboxPrint: CPU idle
2,218.8 (46.1%) 14:59:50 INFO - TinderboxPrint: CPU system
963.4 (20.0%) 14:59:50 INFO - TinderboxPrint: CPU user
1,631.4 (33.9%) 14:59:50 INFO - TinderboxPrint: Swap in / out
291,860,480 / 0 14:59:50 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 254095872; Write bytes: 256366592; Read time: 18215; Write time: 625 14:59:50 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 34305024; Write bytes: 297442816; Read time: 344; Write time: 1261 14:59:50 INFO - Running post-run listener: _upload_blobber_files 14:59:50 INFO - Blob upload gear active. 14:59:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:59:50 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 14:59:50 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'] 14:59:50 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 14:59:51 INFO - (blobuploader) - INFO - Open directory for files ... 14:59:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:59:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:59:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:59:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:59:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:59:52 INFO - (blobuploader) - INFO - Done attempting. 14:59:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:59:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:59:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:59:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:59:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:59:53 INFO - (blobuploader) - INFO - Done attempting. 14:59:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:59:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:59:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:59:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:59:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:59:55 INFO - (blobuploader) - INFO - Done attempting. 14:59:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:59:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:59:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:59:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:59:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:59:57 INFO - (blobuploader) - INFO - Done attempting. 14:59:57 INFO - (blobuploader) - INFO - Iteration through files over. 14:59:57 INFO - Return code: 0 14:59:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:59:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:59:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe0760aa7fe9931aa8f1c7927805daf38155063335ed7cd93dfec5525aaba820d31be3659ec6a603830fd244ed28fa354db86790bbbc795efa956b5cb54b3371", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb282aa968a3e6bc4ea25218bea61b6d9ff855c04d104f4b7b9ef192c8912f7bcbaa7f0300c6e557736867fa61c1048607ce1419778bc1b20aa7df85f10c0d24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bb3aec8321b47e5e944f789fb5915c478ab0ac82f56f5c251d0a3707a07ac41225d787db58de1fd532335026892897ba0d15be89d5d434e76aa5e8e0cdc924b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/375b76398dc9b45bbf269d870f88f5e80bc6664cab3ee42e74563df6f80980c135ab1e5e5d2082ec317fb64c5d298bdbe71e24b4929c2ac4528844262381dedc"} 14:59:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:59:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:59:57 INFO - Contents: 14:59:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe0760aa7fe9931aa8f1c7927805daf38155063335ed7cd93dfec5525aaba820d31be3659ec6a603830fd244ed28fa354db86790bbbc795efa956b5cb54b3371", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb282aa968a3e6bc4ea25218bea61b6d9ff855c04d104f4b7b9ef192c8912f7bcbaa7f0300c6e557736867fa61c1048607ce1419778bc1b20aa7df85f10c0d24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bb3aec8321b47e5e944f789fb5915c478ab0ac82f56f5c251d0a3707a07ac41225d787db58de1fd532335026892897ba0d15be89d5d434e76aa5e8e0cdc924b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/375b76398dc9b45bbf269d870f88f5e80bc6664cab3ee42e74563df6f80980c135ab1e5e5d2082ec317fb64c5d298bdbe71e24b4929c2ac4528844262381dedc"} 14:59:57 INFO - Running post-run listener: copy_logs_to_upload_dir 14:59:57 INFO - Copying logs to upload dir... 14:59:57 INFO - mkdir: /builds/slave/test/build/upload/logs 14:59:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.741671 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-02-14 14:59:57.518012) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-14 14:59:57.521812) ========= 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.F0ma1153va/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.4VsfdygmGb/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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/fe0760aa7fe9931aa8f1c7927805daf38155063335ed7cd93dfec5525aaba820d31be3659ec6a603830fd244ed28fa354db86790bbbc795efa956b5cb54b3371", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb282aa968a3e6bc4ea25218bea61b6d9ff855c04d104f4b7b9ef192c8912f7bcbaa7f0300c6e557736867fa61c1048607ce1419778bc1b20aa7df85f10c0d24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bb3aec8321b47e5e944f789fb5915c478ab0ac82f56f5c251d0a3707a07ac41225d787db58de1fd532335026892897ba0d15be89d5d434e76aa5e8e0cdc924b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/375b76398dc9b45bbf269d870f88f5e80bc6664cab3ee42e74563df6f80980c135ab1e5e5d2082ec317fb64c5d298bdbe71e24b4929c2ac4528844262381dedc"} build_url:https://queue.taskcluster.net/v1/task/IHK3zIGPRqGH1_X-CS9fPQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010373 build_url: 'https://queue.taskcluster.net/v1/task/IHK3zIGPRqGH1_X-CS9fPQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe0760aa7fe9931aa8f1c7927805daf38155063335ed7cd93dfec5525aaba820d31be3659ec6a603830fd244ed28fa354db86790bbbc795efa956b5cb54b3371", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb282aa968a3e6bc4ea25218bea61b6d9ff855c04d104f4b7b9ef192c8912f7bcbaa7f0300c6e557736867fa61c1048607ce1419778bc1b20aa7df85f10c0d24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bb3aec8321b47e5e944f789fb5915c478ab0ac82f56f5c251d0a3707a07ac41225d787db58de1fd532335026892897ba0d15be89d5d434e76aa5e8e0cdc924b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/375b76398dc9b45bbf269d870f88f5e80bc6664cab3ee42e74563df6f80980c135ab1e5e5d2082ec317fb64c5d298bdbe71e24b4929c2ac4528844262381dedc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-14 14:59:57.554519) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 14:59:57.554830) ========= 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.F0ma1153va/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.4VsfdygmGb/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.005255 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 14:59:57.603139) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-14 14:59:57.603483) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-14 14:59:57.603796) ========= ========= Total master_lag: 0.18 =========