builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0294 starttime: 1482150994.67 results: success (0) buildid: 20161219030207 builduid: c30bb37e85bb4dfcb67f74a5e58d3911 revision: 863c2b61bd27bb6099104933134d3be7c052551a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-19 04:36:34.674130) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-19 04:36:34.674495) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-19 04:36:34.674763) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-19 04:36:34.703371) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 04:36:34.703717) ========= 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.AI7frqGEOa/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.SYAe9rmV9C/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-19 04:36:34-- 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% 18.8M=0.001s 2016-12-19 04:36:34 (18.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131369 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 04:36:34.860057) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 04:36:34.860384) ========= 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.AI7frqGEOa/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.SYAe9rmV9C/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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.039415 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 04:36:34.925012) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-19 04:36:34.925351) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 863c2b61bd27bb6099104933134d3be7c052551a --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 863c2b61bd27bb6099104933134d3be7c052551a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AI7frqGEOa/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.SYAe9rmV9C/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-19 04:36:35,026 truncating revision to first 12 chars 2016-12-19 04:36:35,026 Setting DEBUG logging. 2016-12-19 04:36:35,026 attempt 1/10 2016-12-19 04:36:35,027 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/863c2b61bd27?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-19 04:36:36,246 unpacking tar archive at: mozilla-central-863c2b61bd27/testing/mozharness/ program finished with exit code 0 elapsedTime=1.522086 ========= master_lag: 1.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-19 04:36:37.459458) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-19 04:36:37.459795) ========= script_repo_revision: 863c2b61bd27bb6099104933134d3be7c052551a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-19 04:36:37.460242) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-19 04:36:37.460508) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-19 04:36:37.497786) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-12-19 04:36:37.498165) ========= /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.AI7frqGEOa/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.SYAe9rmV9C/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 04:36:37 INFO - MultiFileLogger online at 20161219 04:36:37 in /builds/slave/test 04:36:37 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 04:36:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:36:37 INFO - {'append_to_log': False, 04:36:37 INFO - 'base_work_dir': '/builds/slave/test', 04:36:37 INFO - 'blob_upload_branch': 'Firefox', 04:36:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:36:37 INFO - 'branch': 'Firefox', 04:36:37 INFO - 'buildbot_json_path': 'buildprops.json', 04:36:37 INFO - 'config_files': ('talos/mac_config.py',), 04:36:37 INFO - 'default_actions': ('clobber', 04:36:37 INFO - 'read-buildbot-config', 04:36:37 INFO - 'download-and-extract', 04:36:37 INFO - 'populate-webroot', 04:36:37 INFO - 'create-virtualenv', 04:36:37 INFO - 'install', 04:36:37 INFO - 'run-tests'), 04:36:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:36:37 INFO - 'download_minidump_stackwalk': True, 04:36:37 INFO - 'download_symbols': 'ondemand', 04:36:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:36:37 INFO - 'tooltool.py': '/tools/tooltool.py', 04:36:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:36:37 INFO - '/tools/misc-python/virtualenv.py')}, 04:36:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:36:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:36:37 INFO - 'installer_path': 'installer.exe', 04:36:37 INFO - 'log_level': 'info', 04:36:37 INFO - 'log_name': 'talos', 04:36:37 INFO - 'log_to_console': True, 04:36:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:36:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:36:37 INFO - 'opt_config_files': (), 04:36:37 INFO - 'pip_index': False, 04:36:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:36:37 INFO - 'cmd': ('bash', 04:36:37 INFO - '-c', 04:36:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:36:37 INFO - 'enabled': True, 04:36:37 INFO - 'halt_on_failure': False, 04:36:37 INFO - 'name': 'check_screen_resolution'},), 04:36:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:36:37 INFO - 'cmd': ('bash', 04:36:37 INFO - '-c', 04:36:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:36:37 INFO - 'enabled': True, 04:36:37 INFO - 'halt_on_failure': False, 04:36:37 INFO - 'name': 'check_screen_resolution'},), 04:36:37 INFO - 'run_cmd_checks_enabled': True, 04:36:37 INFO - 'sps_profile': False, 04:36:37 INFO - 'sps_profile_interval': 0, 04:36:37 INFO - 'suite': 'dromaeojs', 04:36:37 INFO - 'system_bits': '32', 04:36:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:36:37 INFO - 'title': 't-yosemite-r7-0294', 04:36:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:36:37 INFO - 'use_talos_json': True, 04:36:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:36:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:36:37 INFO - 'work_dir': 'build'} 04:36:37 INFO - [mozharness: 2016-12-19 12:36:37.706830Z] Running clobber step. 04:36:37 INFO - Running pre-action listener: _resource_record_pre_action 04:36:37 INFO - Running main action method: clobber 04:36:37 INFO - rmtree: /builds/slave/test/build 04:36:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:36:40 INFO - Running post-action listener: _resource_record_post_action 04:36:40 INFO - [mozharness: 2016-12-19 12:36:40.156639Z] Finished clobber step (success) 04:36:40 INFO - [mozharness: 2016-12-19 12:36:40.156803Z] Running read-buildbot-config step. 04:36:40 INFO - Running pre-action listener: _resource_record_pre_action 04:36:40 INFO - Running main action method: read_buildbot_config 04:36:40 INFO - Using buildbot properties: 04:36:40 INFO - { 04:36:40 INFO - "project": "", 04:36:40 INFO - "product": "firefox", 04:36:40 INFO - "script_repo_revision": "production", 04:36:40 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:36:40 INFO - "repository": "", 04:36:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:36:40 INFO - "buildid": "20161219030207", 04:36:40 INFO - "stage_platform": "macosx64", 04:36:40 INFO - "basedir": "/builds/slave/test", 04:36:40 INFO - "nightly_build": "True", 04:36:40 INFO - "buildnumber": 156, 04:36:40 INFO - "slavename": "t-yosemite-r7-0294", 04:36:40 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 04:36:40 INFO - "platform": "yosemite_r7", 04:36:40 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:36:40 INFO - "branch": "mozilla-central", 04:36:40 INFO - "repo_path": "mozilla-central", 04:36:40 INFO - "revision": "863c2b61bd27bb6099104933134d3be7c052551a", 04:36:40 INFO - "pgo_build": "False", 04:36:40 INFO - "builduid": "c30bb37e85bb4dfcb67f74a5e58d3911", 04:36:40 INFO - "slavebuilddir": "test" 04:36:40 INFO - } 04:36:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/S4xJ5v3pT7Sdn9Z-RA8TiA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 04:36:40 INFO - Running post-action listener: _resource_record_post_action 04:36:40 INFO - [mozharness: 2016-12-19 12:36:40.160311Z] Finished read-buildbot-config step (success) 04:36:40 INFO - [mozharness: 2016-12-19 12:36:40.160443Z] Running download-and-extract step. 04:36:40 INFO - Running pre-action listener: _resource_record_pre_action 04:36:40 INFO - Running main action method: download_and_extract 04:36:40 INFO - mkdir: /builds/slave/test/build/tests 04:36: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')]} 04:36:40 INFO - trying https://queue.taskcluster.net/v1/task/S4xJ5v3pT7Sdn9Z-RA8TiA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 04:36:40 INFO - Downloading https://queue.taskcluster.net/v1/task/S4xJ5v3pT7Sdn9Z-RA8TiA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:36:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S4xJ5v3pT7Sdn9Z-RA8TiA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 04:36:41 INFO - Downloaded 1199 bytes. 04:36:41 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:36:41 INFO - Using the following test package requirements: 04:36:41 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:36:41 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:36:41 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 04:36:41 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:36:41 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 04:36:41 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:36:41 INFO - u'jsshell-mac.zip'], 04:36:41 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:36:41 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 04:36:41 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:36:41 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:36:41 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 04:36:41 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:36:41 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 04:36:41 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:36:41 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 04:36:41 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:36:41 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 04:36:41 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:36:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S4xJ5v3pT7Sdn9Z-RA8TiA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:36:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S4xJ5v3pT7Sdn9Z-RA8TiA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:36:41 INFO - Fetch https://queue.taskcluster.net/v1/task/S4xJ5v3pT7Sdn9Z-RA8TiA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:36:42 INFO - Expected file size: 16276165 04:36:42 INFO - Obtained file size: 16276165 04:36:48 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:36:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S4xJ5v3pT7Sdn9Z-RA8TiA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:36:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S4xJ5v3pT7Sdn9Z-RA8TiA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:36:48 INFO - Fetch https://queue.taskcluster.net/v1/task/S4xJ5v3pT7Sdn9Z-RA8TiA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:36:49 INFO - Expected file size: 16276165 04:36:49 INFO - Obtained file size: 16276165 04:36:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S4xJ5v3pT7Sdn9Z-RA8TiA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 04:36:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S4xJ5v3pT7Sdn9Z-RA8TiA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:36:56 INFO - Fetch https://queue.taskcluster.net/v1/task/S4xJ5v3pT7Sdn9Z-RA8TiA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 04:36:56 INFO - Expected file size: 14409734 04:36:56 INFO - Obtained file size: 14409734 04:36:57 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')]} 04:36:57 INFO - trying https://queue.taskcluster.net/v1/task/S4xJ5v3pT7Sdn9Z-RA8TiA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:36:57 INFO - Downloading https://queue.taskcluster.net/v1/task/S4xJ5v3pT7Sdn9Z-RA8TiA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 04:36:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S4xJ5v3pT7Sdn9Z-RA8TiA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 04:37:00 INFO - Downloaded 69622939 bytes. 04:37:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S4xJ5v3pT7Sdn9Z-RA8TiA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:37:00 INFO - mkdir: /builds/slave/test/properties 04:37:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:37:00 INFO - Writing to file /builds/slave/test/properties/build_url 04:37:00 INFO - Contents: 04:37:00 INFO - build_url:https://queue.taskcluster.net/v1/task/S4xJ5v3pT7Sdn9Z-RA8TiA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:37:01 INFO - Running post-action listener: _resource_record_post_action 04:37:01 INFO - Running post-action listener: set_extra_try_arguments 04:37:01 INFO - [mozharness: 2016-12-19 12:37:01.326134Z] Finished download-and-extract step (success) 04:37:01 INFO - [mozharness: 2016-12-19 12:37:01.326268Z] Running populate-webroot step. 04:37:01 INFO - Running pre-action listener: _resource_record_pre_action 04:37:01 INFO - Running main action method: populate_webroot 04:37:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:37:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:37:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:37:01 INFO - '--tppagecycles', 04:37:01 INFO - '7'], 04:37:01 INFO - 'tests': ['tsvgm']}}, 04:37:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:37:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:37:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:37:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:37:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:37:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:37:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:37:01 INFO - 'talos_options': ['--disable-e10s'], 04:37:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:37:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:37:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:37:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:37:01 INFO - 'talos_options': ['--disable-e10s'], 04:37:01 INFO - 'tests': ['damp', 'tps']}, 04:37:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:37:01 INFO - 'tests': ['damp', 'tps']}, 04:37:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:37:01 INFO - 'tests': ['dromaeo_dom']}, 04:37:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:37:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:37:01 INFO - 'tests': ['basic_compositor_video']}, 04:37:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:37:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:37:01 INFO - 'tests': ['a11yr', 04:37:01 INFO - 'ts_paint', 04:37:01 INFO - 'tpaint', 04:37:01 INFO - 'sessionrestore', 04:37:01 INFO - 'sessionrestore_no_auto_restore', 04:37:01 INFO - 'tabpaint']}, 04:37:01 INFO - 'other-e10s': {'tests': ['a11yr', 04:37:01 INFO - 'ts_paint', 04:37:01 INFO - 'tpaint', 04:37:01 INFO - 'sessionrestore', 04:37:01 INFO - 'sessionrestore_no_auto_restore', 04:37:01 INFO - 'tabpaint']}, 04:37:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:37:01 INFO - 'ts_paint', 04:37:01 INFO - 'tpaint', 04:37:01 INFO - 'sessionrestore', 04:37:01 INFO - 'sessionrestore_no_auto_restore', 04:37:01 INFO - 'tabpaint']}, 04:37:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:37:01 INFO - 'ts_paint', 04:37:01 INFO - 'tpaint', 04:37:01 INFO - 'sessionrestore', 04:37:01 INFO - 'sessionrestore_no_auto_restore', 04:37:01 INFO - 'tabpaint']}, 04:37:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:37:01 INFO - 'tests': ['a11yr', 04:37:01 INFO - 'ts_paint', 04:37:01 INFO - 'tpaint', 04:37:01 INFO - 'sessionrestore', 04:37:01 INFO - 'sessionrestore_no_auto_restore', 04:37:01 INFO - 'tabpaint']}, 04:37:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:37:01 INFO - 'tests': ['a11yr', 04:37:01 INFO - 'ts_paint', 04:37:01 INFO - 'tpaint', 04:37:01 INFO - 'sessionrestore', 04:37:01 INFO - 'sessionrestore_no_auto_restore', 04:37:01 INFO - 'tabpaint']}, 04:37:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:37:01 INFO - 'tests': ['tsvgx', 04:37:01 INFO - 'tsvgr_opacity', 04:37:01 INFO - 'tart', 04:37:01 INFO - 'tscrollx', 04:37:01 INFO - 'cart', 04:37:01 INFO - 'tsvg_static']}, 04:37:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:37:01 INFO - 'tsvgr_opacity', 04:37:01 INFO - 'tart', 04:37:01 INFO - 'tscrollx', 04:37:01 INFO - 'cart', 04:37:01 INFO - 'tsvg_static']}, 04:37:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:37:01 INFO - 'talos_options': ['--disable-e10s'], 04:37:01 INFO - 'tests': ['tp5o']}, 04:37:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:37:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:37:01 INFO - 'talos_options': ['--disable-e10s', 04:37:01 INFO - '--xperf_path', 04:37:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:37:01 INFO - 'tests': ['tp5n']}, 04:37:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:37:01 INFO - 'talos_options': ['--xperf_path', 04:37:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:37:01 INFO - 'tests': ['tp5n']}}, 04:37:01 INFO - 'talos.zip': {'path': '', 04:37:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:37:01 INFO - Running post-action listener: _resource_record_post_action 04:37:01 INFO - [mozharness: 2016-12-19 12:37:01.345135Z] Finished populate-webroot step (success) 04:37:01 INFO - [mozharness: 2016-12-19 12:37:01.345270Z] Running create-virtualenv step. 04:37:01 INFO - Running pre-action listener: _resource_record_pre_action 04:37:01 INFO - Running main action method: create_virtualenv 04:37:01 INFO - Creating virtualenv /builds/slave/test/build/venv 04:37:01 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 04:37:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:37:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:37:01 INFO - Using real prefix '/tools/python27' 04:37:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:37:02 INFO - Installing distribute.............................................................................................................................................................................................done. 04:37:05 INFO - Installing pip.................done. 04:37:05 INFO - Return code: 0 04:37:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:37:05 INFO - Reading from file tmpfile_stdout 04:37:05 INFO - Output received: 04:37:05 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) 04:37:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:05 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 0x108997b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10899a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7b8c72600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108775d30>, '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 0x10869cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10876abe8>, '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.AI7frqGEOa/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.SYAe9rmV9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 04:37:05 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 04:37:05 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 04:37:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AI7frqGEOa/Render', 04:37:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:05 INFO - 'HOME': '/Users/cltbld', 04:37:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:05 INFO - 'LOGNAME': 'cltbld', 04:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:05 INFO - 'MOZ_NO_REMOTE': '1', 04:37:05 INFO - 'NO_EM_RESTART': '1', 04:37:05 INFO - 'PAGER': '/bin/cat', 04:37:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:05 INFO - 'PWD': '/builds/slave/test', 04:37:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:05 INFO - 'SHELL': '/bin/bash', 04:37:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SYAe9rmV9C/Listeners', 04:37:05 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 04:37:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:05 INFO - 'USER': 'cltbld', 04:37:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:05 INFO - 'XPC_FLAGS': '0x0', 04:37:05 INFO - 'XPC_SERVICE_NAME': '0', 04:37:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:05 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 04:37:05 INFO - Cleaning up... 04:37:05 INFO - Return code: 0 04:37:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:05 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 0x108997b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10899a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7b8c72600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108775d30>, '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 0x10869cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10876abe8>, '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.AI7frqGEOa/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.SYAe9rmV9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 04:37:05 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 04:37:05 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 04:37:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AI7frqGEOa/Render', 04:37:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:05 INFO - 'HOME': '/Users/cltbld', 04:37:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:05 INFO - 'LOGNAME': 'cltbld', 04:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:05 INFO - 'MOZ_NO_REMOTE': '1', 04:37:05 INFO - 'NO_EM_RESTART': '1', 04:37:05 INFO - 'PAGER': '/bin/cat', 04:37:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:05 INFO - 'PWD': '/builds/slave/test', 04:37:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:05 INFO - 'SHELL': '/bin/bash', 04:37:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SYAe9rmV9C/Listeners', 04:37:05 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 04:37:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:05 INFO - 'USER': 'cltbld', 04:37:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:05 INFO - 'XPC_FLAGS': '0x0', 04:37:05 INFO - 'XPC_SERVICE_NAME': '0', 04:37:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:05 INFO - Downloading/unpacking psutil>=3.1.1 04:37:05 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 04:37:05 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 04:37:05 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 04:37:05 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 04:37:05 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 04:37:05 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 04:37:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:37:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:37:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:37:09 INFO - Installing collected packages: psutil 04:37:09 INFO - Running setup.py install for psutil 04:37:09 INFO - building 'psutil._psutil_osx' extension 04:37:09 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 04:37:10 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 04:37:10 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 04:37:10 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 04:37:10 INFO - building 'psutil._psutil_posix' extension 04:37:10 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 04:37:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:37:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:37:10 INFO - ^ 04:37:10 INFO - 1 warning generated. 04:37:10 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 04:37:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:37:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:37:10 INFO - Successfully installed psutil 04:37:10 INFO - Cleaning up... 04:37:10 INFO - Return code: 0 04:37:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:37: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')]} 04:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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')]} 04:37:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:10 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 0x108997b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10899a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7b8c72600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108775d30>, '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 0x10869cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10876abe8>, '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.AI7frqGEOa/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.SYAe9rmV9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 04:37:10 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 04:37:10 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 04:37:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AI7frqGEOa/Render', 04:37:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:10 INFO - 'HOME': '/Users/cltbld', 04:37:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:10 INFO - 'LOGNAME': 'cltbld', 04:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:10 INFO - 'MOZ_NO_REMOTE': '1', 04:37:10 INFO - 'NO_EM_RESTART': '1', 04:37:10 INFO - 'PAGER': '/bin/cat', 04:37:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:10 INFO - 'PWD': '/builds/slave/test', 04:37:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:10 INFO - 'SHELL': '/bin/bash', 04:37:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SYAe9rmV9C/Listeners', 04:37:10 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 04:37:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:10 INFO - 'USER': 'cltbld', 04:37:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:10 INFO - 'XPC_FLAGS': '0x0', 04:37:10 INFO - 'XPC_SERVICE_NAME': '0', 04:37:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:37:11 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 04:37:11 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 04:37:11 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 04:37:11 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 04:37:11 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 04:37:11 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 04:37:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:37:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:37:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:37:13 INFO - Installing collected packages: mozsystemmonitor 04:37:13 INFO - Running setup.py install for mozsystemmonitor 04:37:14 INFO - Successfully installed mozsystemmonitor 04:37:14 INFO - Cleaning up... 04:37:14 INFO - Return code: 0 04:37:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:14 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 0x108997b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10899a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7b8c72600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108775d30>, '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 0x10869cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10876abe8>, '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.AI7frqGEOa/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.SYAe9rmV9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 04:37:14 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 04:37:14 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 04:37:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AI7frqGEOa/Render', 04:37:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:14 INFO - 'HOME': '/Users/cltbld', 04:37:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:14 INFO - 'LOGNAME': 'cltbld', 04:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:14 INFO - 'MOZ_NO_REMOTE': '1', 04:37:14 INFO - 'NO_EM_RESTART': '1', 04:37:14 INFO - 'PAGER': '/bin/cat', 04:37:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:14 INFO - 'PWD': '/builds/slave/test', 04:37:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:14 INFO - 'SHELL': '/bin/bash', 04:37:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SYAe9rmV9C/Listeners', 04:37:14 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 04:37:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:14 INFO - 'USER': 'cltbld', 04:37:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:14 INFO - 'XPC_FLAGS': '0x0', 04:37:14 INFO - 'XPC_SERVICE_NAME': '0', 04:37:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:14 INFO - Downloading/unpacking jsonschema==2.5.1 04:37:14 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 04:37:14 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 04:37:14 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 04:37:14 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 04:37:14 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 04:37:14 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 04:37:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:37:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37:17 INFO - Downloading functools32-3.2.3-2.tar.gz 04:37:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:37:17 INFO - warning: no files found matching '*.txt' 04:37:17 INFO - no previously-included directories found matching 'build' 04:37:17 INFO - no previously-included directories found matching 'dist' 04:37:17 INFO - no previously-included directories found matching '.git*' 04:37:17 INFO - Installing collected packages: jsonschema, functools32 04:37:17 INFO - Running setup.py install for functools32 04:37:17 INFO - warning: no files found matching '*.txt' 04:37:17 INFO - no previously-included directories found matching 'build' 04:37:17 INFO - no previously-included directories found matching 'dist' 04:37:17 INFO - no previously-included directories found matching '.git*' 04:37:17 INFO - Successfully installed jsonschema functools32 04:37:17 INFO - Cleaning up... 04:37:18 INFO - Return code: 0 04:37:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:18 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 0x108997b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10899a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7b8c72600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108775d30>, '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 0x10869cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10876abe8>, '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.AI7frqGEOa/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.SYAe9rmV9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 04:37:18 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 04:37:18 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 04:37:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AI7frqGEOa/Render', 04:37:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:18 INFO - 'HOME': '/Users/cltbld', 04:37:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:18 INFO - 'LOGNAME': 'cltbld', 04:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:18 INFO - 'MOZ_NO_REMOTE': '1', 04:37:18 INFO - 'NO_EM_RESTART': '1', 04:37:18 INFO - 'PAGER': '/bin/cat', 04:37:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:18 INFO - 'PWD': '/builds/slave/test', 04:37:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:18 INFO - 'SHELL': '/bin/bash', 04:37:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SYAe9rmV9C/Listeners', 04:37:18 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 04:37:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:18 INFO - 'USER': 'cltbld', 04:37:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:18 INFO - 'XPC_FLAGS': '0x0', 04:37:18 INFO - 'XPC_SERVICE_NAME': '0', 04:37:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:37:18 INFO - Cleaning up... 04:37:18 INFO - Return code: 0 04:37:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:18 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 0x108997b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10899a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7b8c72600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108775d30>, '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 0x10869cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10876abe8>, '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.AI7frqGEOa/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.SYAe9rmV9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 04:37:18 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 04:37:18 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 04:37:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AI7frqGEOa/Render', 04:37:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:18 INFO - 'HOME': '/Users/cltbld', 04:37:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:18 INFO - 'LOGNAME': 'cltbld', 04:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:18 INFO - 'MOZ_NO_REMOTE': '1', 04:37:18 INFO - 'NO_EM_RESTART': '1', 04:37:18 INFO - 'PAGER': '/bin/cat', 04:37:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:18 INFO - 'PWD': '/builds/slave/test', 04:37:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:18 INFO - 'SHELL': '/bin/bash', 04:37:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SYAe9rmV9C/Listeners', 04:37:18 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 04:37:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:18 INFO - 'USER': 'cltbld', 04:37:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:18 INFO - 'XPC_FLAGS': '0x0', 04:37:18 INFO - 'XPC_SERVICE_NAME': '0', 04:37:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:18 INFO - Downloading/unpacking blobuploader==1.2.4 04:37:18 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 04:37:18 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 04:37:18 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 04:37:18 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 04:37:18 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 04:37:18 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 04:37:21 INFO - Downloading blobuploader-1.2.4.tar.gz 04:37:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:37:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:37:21 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 04:37:21 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 04:37:21 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 04:37:21 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 04:37:21 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 04:37:21 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 04:37:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:37:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37:22 INFO - Downloading docopt-0.6.1.tar.gz 04:37:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:37:22 INFO - Installing collected packages: blobuploader, requests, docopt 04:37:22 INFO - Running setup.py install for blobuploader 04:37:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:37:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:37:22 INFO - Running setup.py install for requests 04:37:23 INFO - Running setup.py install for docopt 04:37:23 INFO - Successfully installed blobuploader requests docopt 04:37:23 INFO - Cleaning up... 04:37:23 INFO - Return code: 0 04:37:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37:23 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')]} 04:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:23 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')]} 04:37:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:23 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 0x108997b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10899a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7b8c72600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108775d30>, '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 0x10869cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10876abe8>, '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.AI7frqGEOa/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.SYAe9rmV9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 04:37:23 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 04:37:23 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 04:37:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AI7frqGEOa/Render', 04:37:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:23 INFO - 'HOME': '/Users/cltbld', 04:37:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:23 INFO - 'LOGNAME': 'cltbld', 04:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:23 INFO - 'MOZ_NO_REMOTE': '1', 04:37:23 INFO - 'NO_EM_RESTART': '1', 04:37:23 INFO - 'PAGER': '/bin/cat', 04:37:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:23 INFO - 'PWD': '/builds/slave/test', 04:37:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:23 INFO - 'SHELL': '/bin/bash', 04:37:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SYAe9rmV9C/Listeners', 04:37:23 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 04:37:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:23 INFO - 'USER': 'cltbld', 04:37:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:23 INFO - 'XPC_FLAGS': '0x0', 04:37:23 INFO - 'XPC_SERVICE_NAME': '0', 04:37:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:37:23 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-2PmbwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:37:23 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-2oq6p5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:37:24 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-RwOFQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:37:24 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-ljQ14G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:37:24 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-UvRItI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:37:24 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-ORPe16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:37:24 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-nMQTH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:37:24 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-yt8U3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:37:24 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-i3cYQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:37:24 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-zKAfy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:37:24 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-NSEMH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:37:24 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-NNunpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:37:25 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-1dyHik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:37:25 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-_SDaYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:25 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-fTQ1Gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:37:25 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-MuHjEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:37:25 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-yaUMwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:37:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:37:25 INFO - Running setup.py install for manifestparser 04:37:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:37:25 INFO - Running setup.py install for mozcrash 04:37:25 INFO - Running setup.py install for mozdebug 04:37:26 INFO - Running setup.py install for mozdevice 04:37:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:37:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:37:26 INFO - Running setup.py install for mozfile 04:37:26 INFO - Running setup.py install for mozhttpd 04:37:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:37:26 INFO - Running setup.py install for mozinfo 04:37:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:37:26 INFO - Running setup.py install for mozInstall 04:37:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:37:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:37:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:37:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:37:26 INFO - Running setup.py install for mozleak 04:37:26 INFO - Running setup.py install for mozlog 04:37:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:37:27 INFO - Running setup.py install for moznetwork 04:37:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:37:27 INFO - Running setup.py install for mozprocess 04:37:27 INFO - Running setup.py install for mozprofile 04:37:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:37:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:37:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:37:27 INFO - Running setup.py install for mozrunner 04:37:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:37:27 INFO - Running setup.py install for mozscreenshot 04:37:27 INFO - Running setup.py install for moztest 04:37:28 INFO - Running setup.py install for mozversion 04:37:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:37:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:37:28 INFO - Cleaning up... 04:37:28 INFO - Return code: 0 04:37:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:28 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 0x108997b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10899a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7b8c72600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108775d30>, '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 0x10869cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10876abe8>, '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.AI7frqGEOa/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.SYAe9rmV9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 04:37:28 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 04:37:28 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 04:37:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AI7frqGEOa/Render', 04:37:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:28 INFO - 'HOME': '/Users/cltbld', 04:37:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:28 INFO - 'LOGNAME': 'cltbld', 04:37:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:28 INFO - 'MOZ_NO_REMOTE': '1', 04:37:28 INFO - 'NO_EM_RESTART': '1', 04:37:28 INFO - 'PAGER': '/bin/cat', 04:37:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:28 INFO - 'PWD': '/builds/slave/test', 04:37:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:28 INFO - 'SHELL': '/bin/bash', 04:37:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SYAe9rmV9C/Listeners', 04:37:28 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 04:37:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:28 INFO - 'USER': 'cltbld', 04:37:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:28 INFO - 'XPC_FLAGS': '0x0', 04:37:28 INFO - 'XPC_SERVICE_NAME': '0', 04:37:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:37:28 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-Kqo51m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:37:28 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)) 04:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:37:28 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-dBfgNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:37:28 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)) 04:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:37:28 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-R3Bf2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:37:28 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)) 04:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:37:28 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-BgE7QD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:37:28 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)) 04:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:37:28 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-taPWRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:37:28 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)) 04:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:37:28 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-ZtblUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:37:29 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)) 04:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:37:29 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-X8yy4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:37:29 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)) 04:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:37:29 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-zq3XXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:37:29 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)) 04:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:37:29 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-tj0QFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:37:29 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)) 04:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:37:29 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-jbJpu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:37:29 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)) 04:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:37:29 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-4e0bCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:37:29 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)) 04:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:37:29 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-YJ3WC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:37:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:37:29 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-AkJarE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:37:29 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)) 04:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:37:29 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-CtFPMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:37:29 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)) 04:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:29 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-UWHhpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:30 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)) 04:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:37:30 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-DVABgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:37:30 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-UBQoWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:37:30 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)) 04:37:30 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)) 04:37:30 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)) 04:37:30 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)) 04:37:30 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)) 04:37:30 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)) 04:37:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:37:30 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 04:37:30 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 04:37:30 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 04:37:30 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 04:37:30 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 04:37:30 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 04:37:32 INFO - Downloading blessings-1.6.tar.gz 04:37:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:37:32 INFO - Installing collected packages: blessings 04:37:32 INFO - Running setup.py install for blessings 04:37:33 INFO - Successfully installed blessings 04:37:33 INFO - Cleaning up... 04:37:33 INFO - Return code: 0 04:37:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:37:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:37:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:37:33 INFO - Reading from file tmpfile_stdout 04:37:33 INFO - Current package versions: 04:37:33 INFO - blessings == 1.6 04:37:33 INFO - blobuploader == 1.2.4 04:37:33 INFO - docopt == 0.6.1 04:37:33 INFO - functools32 == 3.2.3-2 04:37:33 INFO - jsonschema == 2.5.1 04:37:33 INFO - manifestparser == 1.1 04:37:33 INFO - mozInstall == 1.12 04:37:33 INFO - mozcrash == 1.0 04:37:33 INFO - mozdebug == 0.1 04:37:33 INFO - mozdevice == 0.49 04:37:33 INFO - mozfile == 1.2 04:37:33 INFO - mozhttpd == 0.7 04:37:33 INFO - mozinfo == 0.9 04:37:33 INFO - mozleak == 0.1 04:37:33 INFO - mozlog == 3.4 04:37:33 INFO - moznetwork == 0.27 04:37:33 INFO - mozprocess == 0.23 04:37:33 INFO - mozprofile == 0.28 04:37:33 INFO - mozrunner == 6.13 04:37:33 INFO - mozscreenshot == 0.1 04:37:33 INFO - mozsystemmonitor == 0.3 04:37:33 INFO - moztest == 0.7 04:37:33 INFO - mozversion == 1.4 04:37:33 INFO - psutil == 3.1.1 04:37:33 INFO - requests == 1.2.3 04:37:33 INFO - wsgiref == 0.1.2 04:37:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37: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')]} 04:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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')]} 04:37:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:33 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 0x108997b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10899a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7b8c72600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108775d30>, '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 0x10869cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10876abe8>, '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.AI7frqGEOa/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.SYAe9rmV9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 04:37:33 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 04:37:33 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 04:37:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AI7frqGEOa/Render', 04:37:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:33 INFO - 'HOME': '/Users/cltbld', 04:37:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:33 INFO - 'LOGNAME': 'cltbld', 04:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:33 INFO - 'MOZ_NO_REMOTE': '1', 04:37:33 INFO - 'NO_EM_RESTART': '1', 04:37:33 INFO - 'PAGER': '/bin/cat', 04:37:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:33 INFO - 'PWD': '/builds/slave/test', 04:37:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:33 INFO - 'SHELL': '/bin/bash', 04:37:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SYAe9rmV9C/Listeners', 04:37:33 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 04:37:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:33 INFO - 'USER': 'cltbld', 04:37:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:33 INFO - 'XPC_FLAGS': '0x0', 04:37:33 INFO - 'XPC_SERVICE_NAME': '0', 04:37:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:33 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)) 04:37:33 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)) 04:37:33 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)) 04:37:33 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)) 04:37:33 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)) 04:37:33 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)) 04:37:33 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)) 04:37:33 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)) 04:37:33 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)) 04:37:33 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)) 04:37:33 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)) 04:37:33 INFO - Cleaning up... 04:37:33 INFO - Return code: 0 04:37:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:37: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')]} 04:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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')]} 04:37:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:33 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 0x108997b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10899a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7b8c72600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108775d30>, '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 0x10869cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10876abe8>, '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.AI7frqGEOa/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.SYAe9rmV9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 04:37:33 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 04:37:33 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 04:37:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AI7frqGEOa/Render', 04:37:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:33 INFO - 'HOME': '/Users/cltbld', 04:37:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:33 INFO - 'LOGNAME': 'cltbld', 04:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:33 INFO - 'MOZ_NO_REMOTE': '1', 04:37:33 INFO - 'NO_EM_RESTART': '1', 04:37:33 INFO - 'PAGER': '/bin/cat', 04:37:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:33 INFO - 'PWD': '/builds/slave/test', 04:37:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:33 INFO - 'SHELL': '/bin/bash', 04:37:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SYAe9rmV9C/Listeners', 04:37:33 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 04:37:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:33 INFO - 'USER': 'cltbld', 04:37:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:33 INFO - 'XPC_FLAGS': '0x0', 04:37:33 INFO - 'XPC_SERVICE_NAME': '0', 04:37:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:37:33 INFO - Cleaning up... 04:37:33 INFO - Return code: 0 04:37:33 INFO - Running post-action listener: _resource_record_post_action 04:37:33 INFO - Running post-action listener: _start_resource_monitoring 04:37:33 INFO - Starting resource monitoring. 04:37:33 INFO - [mozharness: 2016-12-19 12:37:33.981434Z] Finished create-virtualenv step (success) 04:37:33 INFO - [mozharness: 2016-12-19 12:37:33.982398Z] Running install step. 04:37:33 INFO - Running pre-action listener: _resource_record_pre_action 04:37:33 INFO - Running main action method: install 04:37:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:37:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:37:34 INFO - Reading from file tmpfile_stdout 04:37:34 INFO - Detecting whether we're running mozinstall >=1.0... 04:37:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:37:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:37:34 INFO - Reading from file tmpfile_stdout 04:37:34 INFO - Output received: 04:37:34 INFO - Usage: mozinstall [options] installer 04:37:34 INFO - Options: 04:37:34 INFO - -h, --help show this help message and exit 04:37:34 INFO - -d DEST, --destination=DEST 04:37:34 INFO - Directory to install application into. [default: 04:37:34 INFO - "/builds/slave/test"] 04:37:34 INFO - --app=APP Application being installed. [default: firefox] 04:37:34 INFO - mkdir: /builds/slave/test/build/application 04:37:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:37:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:37:55 INFO - Reading from file tmpfile_stdout 04:37:55 INFO - Output received: 04:37:55 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:37:55 INFO - Running post-action listener: _resource_record_post_action 04:37:55 INFO - [mozharness: 2016-12-19 12:37:55.921844Z] Finished install step (success) 04:37:55 INFO - [mozharness: 2016-12-19 12:37:55.921954Z] Running run-tests step. 04:37:55 INFO - Running pre-action listener: _resource_record_pre_action 04:37:55 INFO - Running main action method: run_tests 04:37:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:37:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:37:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:37:55 INFO - 2016-12-19 04:37:55.934 screenresolution[1636:8074] starting screenresolution argv=screenresolution get 04:37:55 INFO - 2016-12-19 04:37:55.937 screenresolution[1636:8074] Display 0: 1600x1200x32@60 04:37:55 INFO - 2016-12-19 04:37:55.942 screenresolution[1637:8077] starting screenresolution argv=screenresolution list 04:37:55 INFO - Available Modes on Display 0 04:37:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:37:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:37:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:37:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:37:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:37:56 INFO - Intel Iris: 04:37:56 INFO - Chipset Model: Intel Iris 04:37:56 INFO - Type: GPU 04:37:56 INFO - Bus: Built-In 04:37:56 INFO - VRAM (Dynamic, Max): 1536 MB 04:37:56 INFO - Vendor: Intel (0x8086) 04:37:56 INFO - Device ID: 0x0a2e 04:37:56 INFO - Revision ID: 0x0009 04:37:56 INFO - Displays: 04:37:56 INFO - Display: 04:37:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:37:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:37:56 INFO - Display Serial Number: 1600x1200 60 04:37:56 INFO - Main Display: Yes 04:37:56 INFO - Mirror: Off 04:37:56 INFO - Online: Yes 04:37:56 INFO - Rotation: Supported 04:37:56 INFO - Return code: 0 04:37:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:37:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:37:56 INFO - Python 2.7.3 04:37:56 INFO - Return code: 0 04:37:56 INFO - grabbing minidump binary from tooltool 04:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:56 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 0x108775d30>, '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 0x10869cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10876abe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:37:56 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 04:37:56 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 04:37:56 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 04:37:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:37:56 INFO - Return code: 0 04:37:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:37:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:37:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:37:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:37:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:37:56 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S4xJ5v3pT7Sdn9Z-RA8TiA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0294', '--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 04:37:56 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S4xJ5v3pT7Sdn9Z-RA8TiA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0294 --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 04:37:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AI7frqGEOa/Render', 04:37:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:56 INFO - 'HOME': '/Users/cltbld', 04:37:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:56 INFO - 'LOGNAME': 'cltbld', 04:37:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:37:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:56 INFO - 'MOZ_NO_REMOTE': '1', 04:37:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:37:56 INFO - 'NO_EM_RESTART': '1', 04:37:56 INFO - 'PAGER': '/bin/cat', 04:37:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:56 INFO - 'PWD': '/builds/slave/test', 04:37:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:37:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:56 INFO - 'SHELL': '/bin/bash', 04:37:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SYAe9rmV9C/Listeners', 04:37:56 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 04:37:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:56 INFO - 'USER': 'cltbld', 04:37:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:56 INFO - 'XPC_FLAGS': '0x0', 04:37:56 INFO - 'XPC_SERVICE_NAME': '0', 04:37:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:56 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S4xJ5v3pT7Sdn9Z-RA8TiA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0294', '--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 04:37:56 INFO - mozversion application_buildid: 20161219030207 04:37:56 INFO - mozversion application_changeset: 863c2b61bd27bb6099104933134d3be7c052551a 04:37:56 INFO - mozversion application_display_name: Nightly 04:37:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:37:56 INFO - mozversion application_name: Firefox 04:37:56 INFO - mozversion application_remotingname: firefox 04:37:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:37:56 INFO - mozversion application_vendor: Mozilla 04:37:56 INFO - mozversion application_version: 53.0a1 04:37:56 INFO - mozversion platform_buildid: 20161219030207 04:37:56 INFO - mozversion platform_changeset: 863c2b61bd27bb6099104933134d3be7c052551a 04:37:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:37:56 INFO - mozversion platform_version: 53.0a1 04:37:56 INFO - using testdate: 1482151076 04:37:56 INFO - actual date: 1482151076 04:37:56 INFO - starting webserver on 'localhost:49244' 04:37:56 INFO - SUITE-START | Running 2 tests 04:37:56 INFO - TEST-START | dromaeo_css 04:37:56 INFO - operating with platform_type : mac_ 04:37:56 INFO - Initialising browser for dromaeo_css test... 04:37:56 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/tmp8CNuR3/profile http://localhost:49244/getInfo.html) 04:37:59 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 04:37:59 INFO - PROCESS | 1647 | colorDepth:24 04:37:59 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 04:37:59 INFO - PROCESS | 1647 | __metrics 04:37:59 INFO - PROCESS | 1647 | 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" 04:37:59 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:38:00 INFO - TEST-INFO | 1647: exit 0 04:38:00 INFO - Browser initialized. 04:38:00 INFO - Running cycle 1/1 for dromaeo_css test... 04:38:00 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/tmp8CNuR3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:38:11 INFO - PROCESS | 1652 | RSS: Main: 236883968 04:38:11 INFO - PROCESS | 1652 | 04:39:02 INFO - PROCESS | 1652 | 1482151142897 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:41:14 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 04:41:17 INFO - PROCESS | 1652 | RSS: Main: 468365312 04:41:17 INFO - PROCESS | 1652 | 04:44:20 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 04:44:21 INFO - PROCESS | 1652 | RSS: Main: 374296576 04:44:21 INFO - PROCESS | 1652 | 04:47:23 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 04:47:24 INFO - PROCESS | 1652 | RSS: Main: 367288320 04:47:24 INFO - PROCESS | 1652 | 04:50:26 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 04:50:27 INFO - PROCESS | 1652 | RSS: Main: 356360192 04:50:27 INFO - PROCESS | 1652 | 04:53:31 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 04:53:31 INFO - PROCESS | 1652 | RSS: Main: 337043456 04:53:31 INFO - PROCESS | 1652 | 04:56:35 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 04:56:35 INFO - PROCESS | 1652 | RSS: Main: 473300992 04:56:35 INFO - PROCESS | 1652 | 04:56:35 INFO - PROCESS | 1652 | __start_tp_report 04:56:35 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 04:56:35 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 04:56:35 INFO - PROCESS | 1652 | |i|pagename|runs| 04:56:35 INFO - PROCESS | 1652 | |0;dojo.html;3074.9077527674162;3286.819224942627;3289.0790578637984;3300.4224260754363;3332.5501057357264;5372.247885296052;5473.23374727538;5479.397266300709;5502;5535.667859928397;5483.917741233875;5484.012877682016;5521.668699878;5532.114861622142;5562.193481945115;4192.727472714279;4890.877728056791;4962.354893863792;5054.797808087681;5119.976004799037;4907.803687852482;4997.15048441764;5011.047900898836;5013.849584512453;5040.319556859832;4156.480439945007;4849.490803465621;5032.993401319733;5035.068512325213;5037.4458809530925;4975.552200301954;5005.924911126336;5102.489751024905;5105.617078719111;5152.098382783035;5010.574101201402;5018.7992480300745;5033.521815427529;5047.369078865142;5099.949000509984;5472.480114389126;5483.424240454775;5484.232207490954;5511.5039646432015;5511.889762204733;5884.411558844125;5980.910286345708;5986.760529578812;5997.8800423991715;6013.488853447462;5863.179154918314;5917.8816423671715;5932.11018347247;5991.011483105326;6099.146119543268;5579.6652200868075;5593.049181639131;5604.103343465026;5634.267545219136;5646.632968857011;6199.659018753921;6221.564490485623;6224.470919971763;6224.9377506224355;6237.96881015592;5711.628744131618;5764.884702306014;5788.305403351541;5861.736221870026;5863.882722345615;5890.440408161217;5945.464908158287;5963.612365196335;5964.552658550626;5975.014122669798;5498.1752737089755;5602.4957753802355;5870.471657550841;5933.614315069507;5933.6736479493175;5923.585349025527;5973.940260597338;5992.13114098462;5998.130271110665;6002.54980876436;4684.859454216379;4780.760961951889;4783.808647654125;4793.712377257376;4820.204666230103;4237.237297286518;4256.59562341577;4262.232798096373;4273.722208056529;4288.335308027261;5655.915161272585;5679.148127780783;5684.63049901755;5708.628939119027;5720.885582288414;6050.183225264533;6096.664683442454;6101.633901965896;6104.725287362079;6131;5542.806001789918;5597.832065038056;5603.691796951207;5604.775808967595;5645.9717701412055;5210;5220.947790522122;5222.4255331913455;5261.94761047792;5273.1035723927025;6305.747770089145;6315.842103947438;6317.210348706411;6317.4630156437215;6317.810465686037;5805.970970145122;5808.273965754281;6073.817785466443;6090.817275481742;6091.5126789857595;6197.907031394623;6202.4417802398;6227.813165605039;6233.189685340877;6237.313895471404;5804.73878675469;5806;5808.5353171747;5813.563982701399;5818.912716309174;5872.588918775645;5883.352831188651;5895.882082358243;5898.675572843535;5901.940980590139;5600.943990560205;5766.279215098113;5811.476967072984;5835.620684655484;5905.675187864536;5813.709314534171;5817.854553636193;5829.09649004388;5833.329167145833;5900.557458190567;5581.386047534849;5699.116636921284;5701.344345400332;5712;5717.685527296038;5721.342045664802;5744.310682718101;5781.768729250783;5788.363280039108;5813.79651712188;5672.801451949162;5677.829665110054;5694.601377903507;5723.656580605177;5729.828105156852 04:56:35 INFO - PROCESS | 1652 | |1;ext.html;429.39026582253206;479.5875547029555;484.65105124310486;515.6777014366019;516.8733660253239;36801.44797828035;38731.806340968295;38976.610233897656;38985.220295594074;39140.41289380661;39518;39913.20173596526;39965;39974.60025399745;40019.19961600766;8359.874601880976;9240.584173712166;9404.435733855991;9415.764605884839;9421.764455888624;8417.368697347723;10985.143862595743;11267.492962816652;11274.774504509905;11417.143714221467;11230.943845280763;11285.435728213597;11304.208705390625;11323.547058117665;11326.830097548544;8433.40966132371;8647.956760216222;11170.609028683997;11259.380734059583;11259.662210133627;10812.837807432894;11082.833757493645;11103.888961110448;11253.718657033558;11307.943460282646;38416.42375364372;38707.612923870685;38750.224995499935;38855.41716874249;38878.63924762648;3262.9347413051605;3473.062273186251;3492.8253587320532;3546.804925729084;4034.293998550271;26145.869270653715;27644.894204231805;27687.584686229722;27711.584326235123;27858.024969126185;3080.630324361091;3209.646938836726;3220.565223694818;3296.489044198153;3298.4062868683627;438905;492735;493519;495234.23828808416;496413;52496.475035249925;52800.73599632054;52812.94374112496;52891;53026.20460693093;54462.638434039465;54688;54770.90458190814;54893.451065488836;55029.89940201174;14737.557873263604;14974.550763477113;14977.326020329112;14978.850211497964;14994.70010599782;10534.20993425496;10819.404932728617;10860.728481788019;11628.069754419626;11673.124515661359;15745.543145248696;19840.107195176253;19891.403257901995;20470.692939605917;20480.69278960817;8142.389320800964;8243.299319557906;8297.792555186048;8336.749897503085;8388.748337549883;851;893.5353616119711;1005.7586179317058;1032.0402026115785;1064.2709743825503;28914.42171156565;28978;29281.56077658837;29600;29865.701342986293;1045.9790804184026;1142.8400023996646;1145.7536629624672;1154.4112502623723;1171.3030746705697;14389.928050359891;14884.255787210595;14901.180435075958;15301.234938253043;15421.383144674088;559973.6010559532;671111;672452;674743;684535;56516;57001.71499142478;57043;57192.428075719545;57325.713371432874;1232.89520390766;1288.9033322500663;1355.4171706166444;1383.1700979412474;1401.6846209602759;27591.31021724473;28872.566911496764;28970.13089607315;29399.412011760072;29465.85267073651;47184.7640761794;47657.04685906193;47674.5232547684;47716.7614161927;47777;483731;561441;563753;569007;569812;24633.384165396008;25791.871040644677;26057.739422605533;39479.01302467461;39964.60035399609;40366.59633403629;40748.79625601853;41341.37987930123;41461.79269103635;41820.372694409;34606.665268497345;35119.648803511634;35285.823570881985;35468;35551.288974220886;33567.49648755222;33824.66175338215;34113.82943085368;34932.82533587316;34937.65062349445;33302;34085.488717668755;34264.31471370609;34315.97052088441;34414.82792586021;29717;30734.692653073183;30741.692583073884;30934.226644333172;31206.375872482877;20602.793972060088;22141.265129481402;22915;23229.883850580638;23488 04:56:35 INFO - PROCESS | 1652 | |2;jquery.html;349.7429389398793;351.7748640869845;372.86576832340353;380.9580946095929;401.29973196771635;14458.638534036654;14791.704165916675;15558.45545405911;19270.51823704408;19817.10823012964;18502;18948.526286842836;19230.519237019045;19607.117679704414;19758.60482790347;5453.127499600065;5761.654300741948;5770.82687519373;5775.104858746901;5780.335261444925;4824.807007719687;5578.665280083208;5677.630953987978;5728.14077888318;5735.139729040636;5691.08942569189;5695.8576035599235;5698.886022279552;5699.943000570003;5704.65772053676;5404.189371594272;5617.101263797793;5685.914711279334;5692.886142277172;5693.516051135658;4749.667523273372;4974.42794078682;4979.0788704089855;4984.675996060245;4986.551210391082;20591.485212869797;20914.163433462643;21063.946802659804;22686.54626907469;23825.379208287075;2153.956920861574;2260.886955652211;2285.3829466044076;2325.953480930372;2885.6248687670677;12780.936095319557;14174.220417877013;14946.40214391434;15230.93383463158;15707.057576545443;1812.5559237986645;1833.8899666020081;1852.6016906365196;1853.1475521260236;1882.632886587116;77517.22482775156;87064;97720;108495.235428811;109017;8632.179942905414;10492.632757853438;10517.316374435637;10561.313514621525;10736;13287.269200194081;13313.267770272729;13320.333983300796;13320.934325253957;13321.600351989262;8040.718574849852;8331.791705207419;8346.66613335472;8484.769708392372;8509.61706723199;8339.666413343399;8357.8328433431;8369.665213391396;8520.318374530023;8529.530875801767;6333.746650134035;6478.578892371981;6487.3836985486305;6500;6574.901376479356;1785.9464216073538;1826.9177886995117;1832.4502649205185;1832.4960635825255;1835.4768890866305;869.9173578510031;872.1975782280317;909.2862103248918;979.363413781048;989.8960609135937;20184.19263229484;20593.794062059187;20821.709611942675;20921.163153473994;20977.68533471999;918.8024574716468;941.6374695742188;954.6181527388961;1008.5627980128288;1017.0693815159046;8651.351148663749;10725;11158.721031974103;11253.268537545033;11282.774344513064;415268;499038;514800;520200;523369;89448.658270126;97869;100484.48788780192;103020;103335.4833225829;884.4118661090303;940.351157701184;997.2719914462338;1020.5407566595062;1026.779242462874;18150.636987260445;18387.264509419474;18644.813551864307;18683.972381519146;19054.42836714901;49751.75620609514;50508.49491505038;50600.74699626478;50601.74699126481;50815;55286;69189.65405172942;70615;70738.64630676813;71191;7620.618969051415;7669.118051424158;7888.84222315539;8017.318527925192;8243.958780206061;10653.627123050655;11634.709132271422;12578.496860125493;12735.426905789447;13103.344832758134;9077.639813648368;10881.238313317992;10891.836622450512;11032.06227470674;11388.316700997966;10881.891181088087;10988.230823842574;11146.275492092987;11324.263922845319;11400.144989126014;9618.759531011501;11225.831612525655;11267.887321126684;11620;11840.467178976794;7935.40484463656;7978.601069946596;7997.960010199912;8147.307478864126;8197.385196110436;8128.918710812816;9975.900240997496;10889.183311251529;11236.381998990135;11377.943110284727 04:56:35 INFO - PROCESS | 1652 | |3;mootools.html;1336.5698702388436;1470.514730139054;1498.2209251189379;1677.2200926569144;1859.7489338939247;5720.456556627124;7869.881951770728;7883.526988380701;7897.012873390826;7898.486598371109;8005.1994800519915;8264.256216940474;8316.584170791451;8422.19989101036;8439.32485401168;2293.6444851048072;2346.120204923154;2348.941276468085;2349.9765002350014;2356.6582845487396;2049.6720524716047;2301.309607117866;2357.7406485286606;2375.3467796356053;2382.5711371953043;2108.4728817795553;2148.677698345245;2149.4304009437433;2150.849440539163;2160.157538559963;1928.7299778031088;2231.6094683430415;2317.0384290519414;2323.6863023491783;2327.5577640248466;2315.490592069742;2344.1912540173785;2350.8824558771994;2350.9882450587806;2352.1061996441244;8317.792055198668;8545.786355341104;8551.230389264934;8554.35842311829;8559.572021398904;5072.365954255718;5236;5247.39654939683;5251.317328747276;5254.553362964152;3353.161709572607;3532.1346270163717;3614.1868079681863;3616.4756110364115;3624.3657359961903;1025.4770067265674;1050.669039252633;1079.1528650009784;1085.375908852405;1098.4617537406614;8884.200421962054;10758.193135514868;10922.29005114665;10979.451027448675;11038.337699738042;4290.163418133434;4595.37962375075;4619.884502887455;4679.602233810164;4682.555157260055;9422.152006319327;9441;9445.90554094464;9464;9473.952630236805;5219.921701174486;5228.92156617651;5233.345831771028;5237.711925844039;5245.423003469616;4508.346289788028;4726.125666751662;4739.597134243559;4791.9936813269605;4828.179209534387;3775.452559378875;3814.3598252751585;3829.6553310202216;3865.38153895381;3876.302265592164;1092.257265059767;1148.586508856811;1167.8030019230357;1261.5773715805308;1276.2852802430668;664.4617560917346;794.6543253684665;806.9515829050275;810.4205493072482;878.7363790862844;4957.405111386656;5414.187871819258;5581.134924086773;5811.883762324815;5839.0949402842625;846.0862268749736;897.1387468030764;909.8544232922701;910.8770316007386;935.9017303183203;3608.657177568127;3693.024232035848;3700.3339398908456;3865.980670096688;3890.3775395936514;9721.173700235558;10295.639652612123;10296.970302969643;10300.690979270634;10314.02016808402;10235.48822558884;10254.948725256327;10255.58977640901;10266.897331026594;10269.229807764448;7432.2567743225245;7866.252705992922;7876.645550950221;7960.442769006114;7971.481853679492;5169.405518365436;5654.491095801398;5687.236956543485;5798.246227990334;5806.477417032487;8897.377183597346;9241.630334786532;9325.533723313943;9476.478793666414;9481.573329200064;9075.319351048565;9107.863382049407;9336.719898403058;9383.343165978316;9453.669121580711;7625.6568454418575;7940.0471943367165;7950.7217247396065;7961.800954976172;7968.362530997622;7808.375329973702;7848.60756962161;7859.331956783737;7868.291853733192;7926.326262267772;6977.3720365165345;6995.895061573979;7133.5719856808755;7192.640367981685;7279.636018199175;6949.270326615632;7008.123984501937;7023.122109736283;7042;7251.274872512707;6656.800295991128;6658;6671.66641667905;6742.595444273359;6743.966280168568;4714.104320179155;4846.442659094249;4853.878653033702;4889.853304400874;5015.570562389701;4810.230363141881;4900.705957642553;4916.729579873141;4969.801207951786;5027.2207807789855 04:56:35 INFO - PROCESS | 1652 | |4;prototype.html;350.147391102665;353.6145601294588;358.56971634039144;369.4218547972425;372.2313422781953;4907.877303067425;5065;5095.6687815292025;5127.0002349541855;5177.352830896138;4941.0611983723065;5003.973390776732;5038.521340472649;5051.444341122483;5068.797248110081;3482.8432720527635;3781.560893223869;3801.220749746309;3975.9204815903663;3990.281749285135;3005.9849700751574;3355.456490014596;3959.6436320731273;4004.279229738646;4015.4741198344586;3831.218483405216;3833.750806197588;3865.6520913117815;3872.7869967151796;3901.239258344624;3411.4712219606;3755.117547376378;3833.29084119436;3840.289546433905;3861.7876016819064;3358.4458564336855;3366.4108780963234;3368.473644766425;3369.326134773031;3373.308471763283;3902.609739026103;4145.7927103645;4434.711743736647;4959.355283813117;4995.577145084631;4345.3699213613845;4359.520452750195;4380.846670366522;4381.9123617527475;4402.779861006937;4630.259158534652;5244.980682437251;5257.7108259045735;5258.842234732964;5291.603129765283;3100.3489267253904;3198.9207015439915;3479;3682.502862113607;3686.5391826021746;5200.6619569727845;5515.255440515519;5560.916586251209;5574.498295153456;5613.4386561343945;3483.494893240466;3694.8891533254045;3699.2231631357176;3721.325403568351;3739.8504059837846;3679.8344074516713;3752.1932784451474;3769.5476542815036;3774.5467994822193;3774.9433758493647;3404.863805447754;3726.2174943262216;4352.847650332224;4364.018095928391;4403.92103934538;4603.539646035437;5056.508330042646;5356.276902618097;5375.784968601212;5415.620906536505;1167.3754541320352;1180.5808937827119;1188.9346085965183;1198.5804968261039;1223.3883058470765;827.7475370012204;844.079952851395;845.2561745663777;847.2332539052168;851.3997631669658;4030.8109107813266;4144.8134833932545;4279.015826359955;4670.963873482264;4812.542808433193;4716.924553196651;4812.783424745895;5081.078379931554;5232.92150617741;5264.289320941701;4351.564843515686;4404.427424434803;4505.549445055468;4780.737059461693;4807.903841923142;2708.349996000946;2713.3487962889158;2724.8365098094177;2726.445925822302;2732.808703390783;5201.765920533585;5240.240165176028;5329.280547126088;5440.6735595864375;5489.2589500417735;4619.422572178478;5136.178211486219;5245.868853278698;5275.393329767049;5278.208268759717;4821.614270858323;5453.536449401766;5472.5621950243885;5500.3949565547755;5518.806841760519;4669.766511674471;4925.399245245381;5016.974915125547;5128.1794912813775;5214.9478505214465;4782.832600858953;5507.366652834975;5509.586780991522;5525.171224316385;5556.638818476786;5228.738563071755;5884.6469211847425;5891.524000839525;5900.4597241654665;5926.762929482945;3592.3892938201093;3697;3714.331420344364;3745.7451753662826;3751.83116759741;4483.686141970031;4740.691855029412;5064.924026139537;5522.641028333145;5561.776409189972;4503.256962601135;5377.8117765878005;5405.270288511158;5431.8098866539485;5487.506124448819;4142.2543942090715;5117.260131555289;5158.45836187195;5337.171299211269;5409.83770486886;4419.756913369795;5045.31888195089;5150.197430899156;5194.922076168785;5296.629235953446;4000.7799571023875;4552.904025262853;4903.16131450706;5243.95120975814;5407.269673704377;4391.692581519263;4770.689905156154;5211.9478805211465;5237.292965449616;5270.947290527199 04:56:35 INFO - PROCESS | 1652 | |5;yui.html;637.9234491860977;723.3670538279005;767.5049593012507;781.656071328615;796.3310818912113;15263.847361526381;15498.845011549882;15875.36498540057;15885.84114158858;15923.52229433119;14283.642908927257;14432.5670229893;14474.782878256809;14474.782878256834;14478.855211447883;680.0750978669006;699.8670252652005;705.4673721340381;705.7953193573883;848.6181218451705;699.199416667915;838.3837879158843;866.744310428422;873.3057219510505;876.5660997806095;927.5315965437445;937.3953799799159;938.2822141062093;938.9342746007782;939.6805086270666;918.9494577798218;919.2140719684674;919.2783664823082;920.5305294299889;920.5305294299889;521.5931573372775;541.5478075806706;666.3935818405228;687.8039758668806;690.3096903096903;14722.337494812758;14788.778168327484;14791.112533248039;14796.70406591873;14809;13390.933045334808;13472.730545389135;13513.594592162252;13524.459021639123;13542.45830166792;12282.877171228263;12358.25850448967;12387.75224495514;12496.875031249661;12666.303353315563;4391.187630288407;4547.477040140393;4565.977170114162;4574.359589657451;4580.106879158566;99983.50008249911;101680;102195;102861.4856925718;110361.89638103677;9096.272298216127;10542.525586348633;10632.521536530874;10633.202509811796;10671.146308295318;20199;20563;20609.381718548466;20833.479163021046;20870;7617.314441700273;7632.80917977055;7643.541387516656;7738.767836964787;7876.330511906437;4177.373393990865;4204.1171354016;4251.957480425156;4260.211860805761;4386.429764130707;3350.363430948112;3423.5207071010077;3426.1605906553054;3440.6215316315183;3478.217401084786;614.3917521653531;623.1618473153601;623.6258245053023;634.0236036503825;638.9936100639027;495.83320887720174;550.8292429346915;623.1836294454189;626.2891618013497;631.5011141198402;8552.529610871461;8649.870251946226;8731.170538798804;8818.319269863881;8895.154960278764;542.6337222374881;568.6758547627812;623.1805176193292;640.4204195203348;644.0532417346493;4146.979265103655;4232.640225580799;4254.3831144483875;4300.225959327351;4434.982083152223;109214;113006;113986.72026559588;115726.26410603848;120355;98668;100267.49866250622;102533.48733256436;103073.96926030643;104340;83607.16392835994;86174.56912715397;86653.5667321672;87007.69488457804;88577.55711221532;8048.718294859652;8348.165183481604;8356.33149348063;8522.957385213034;8672.956635216784;40589;56402.43597563972;57198.14202786878;58011.709941450026;60183;64375;76706.08234794174;78776.60611696905;80909;81883;10815.242932994615;11191.425228548109;11200.43997800123;11306.152038596974;11550.768984620428;11831.645050648494;11918.761624767283;11961.162718609614;12479.750404991668;12652.936735316265;11733.434214717941;11801.527938882691;11925.4037298133;12096.516139354328;12114.757704845677;11777.941110294394;11932.880671193525;12077.57728479499;12419.93790031044;12533.310667913353;11802;13102.737945240851;13267.867321326663;13588.184708917497;13933.790993135313;10417.0302737151;10591.417472039111;11116.49975751077;11611;11892.048636108917;10712.571497140027;11380.203385762918;11464.82802757976;11609.419529023346;11706.648800535997 04:56:35 INFO - PROCESS | 1652 | __end_tp_report 04:56:35 INFO - PROCESS | 1652 | __start_cc_report 04:56:35 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,2790 04:56:35 INFO - PROCESS | 1652 | __end_cc_report 04:56:35 INFO - PROCESS | 1652 | __startTimestamp1482152195528__endTimestamp 04:56:35 INFO - PROCESS | 1652 | 04:56:35 INFO - PROCESS | 1652 | ------- Summary: start ------- 04:56:35 INFO - PROCESS | 1652 | Number of tests: 6 04:56:35 INFO - PROCESS | 1652 | 04:56:35 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5527.63 Median:5708.63 stddev:628.82 (11.0%) stddev-sans-first:600.59 04:56:35 INFO - PROCESS | 1652 | Values: 3074.9 3286.8 3289.1 3300.4 3332.6 5372.2 5473.2 5479.4 5502.0 5535.7 5483.9 5484.0 5521.7 5532.1 5562.2 4192.7 4890.9 4962.4 5054.8 5120.0 4907.8 4997.2 5011.0 5013.8 5040.3 4156.5 4849.5 5033.0 5035.1 5037.4 4975.6 5005.9 5102.5 5105.6 5152.1 5010.6 5018.8 5033.5 5047.4 5099.9 5472.5 5483.4 5484.2 5511.5 5511.9 5884.4 5980.9 5986.8 5997.9 6013.5 5863.2 5917.9 5932.1 5991.0 6099.1 5579.7 5593.0 5604.1 5634.3 5646.6 6199.7 6221.6 6224.5 6224.9 6238.0 5711.6 5764.9 5788.3 5861.7 5863.9 5890.4 5945.5 5963.6 5964.6 5975.0 5498.2 5602.5 5870.5 5933.6 5933.7 5923.6 5973.9 5992.1 5998.1 6002.5 4684.9 4780.8 4783.8 4793.7 4820.2 4237.2 4256.6 4262.2 4273.7 4288.3 5655.9 5679.1 5684.6 5708.6 5720.9 6050.2 6096.7 6101.6 6104.7 6131.0 5542.8 5597.8 5603.7 5604.8 5646.0 5210.0 5220.9 5222.4 5261.9 5273.1 6305.7 6315.8 6317.2 6317.5 6317.8 5806.0 5808.3 6073.8 6090.8 6091.5 6197.9 6202.4 6227.8 6233.2 6237.3 5804.7 5806.0 5808.5 5813.6 5818.9 5872.6 5883.4 5895.9 5898.7 5901.9 5600.9 5766.3 5811.5 5835.6 5905.7 5813.7 5817.9 5829.1 5833.3 5900.6 5581.4 5699.1 5701.3 5712.0 5717.7 5721.3 5744.3 5781.8 5788.4 5813.8 5672.8 5677.8 5694.6 5723.7 5729.8 04:56:35 INFO - PROCESS | 1652 | 04:56:35 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:68364.14 Median:34365.40 stddev:151771.93 (441.6%) stddev-sans-first:152111.99 04:56:35 INFO - PROCESS | 1652 | Values: 429.4 479.6 484.7 515.7 516.9 36801.4 38731.8 38976.6 38985.2 39140.4 39518.0 39913.2 39965.0 39974.6 40019.2 8359.9 9240.6 9404.4 9415.8 9421.8 8417.4 10985.1 11267.5 11274.8 11417.1 11230.9 11285.4 11304.2 11323.5 11326.8 8433.4 8648.0 11170.6 11259.4 11259.7 10812.8 11082.8 11103.9 11253.7 11307.9 38416.4 38707.6 38750.2 38855.4 38878.6 3262.9 3473.1 3492.8 3546.8 4034.3 26145.9 27644.9 27687.6 27711.6 27858.0 3080.6 3209.6 3220.6 3296.5 3298.4 438905.0 492735.0 493519.0 495234.2 496413.0 52496.5 52800.7 52812.9 52891.0 53026.2 54462.6 54688.0 54770.9 54893.5 55029.9 14737.6 14974.6 14977.3 14978.9 14994.7 10534.2 10819.4 10860.7 11628.1 11673.1 15745.5 19840.1 19891.4 20470.7 20480.7 8142.4 8243.3 8297.8 8336.7 8388.7 851.0 893.5 1005.8 1032.0 1064.3 28914.4 28978.0 29281.6 29600.0 29865.7 1046.0 1142.8 1145.8 1154.4 1171.3 14389.9 14884.3 14901.2 15301.2 15421.4 559973.6 671111.0 672452.0 674743.0 684535.0 56516.0 57001.7 57043.0 57192.4 57325.7 1232.9 1288.9 1355.4 1383.2 1401.7 27591.3 28872.6 28970.1 29399.4 29465.9 47184.8 47657.0 47674.5 47716.8 47777.0 483731.0 561441.0 563753.0 569007.0 569812.0 24633.4 25791.9 26057.7 39479.0 39964.6 40366.6 40748.8 41341.4 41461.8 41820.4 34606.7 35119.6 35285.8 35468.0 35551.3 33567.5 33824.7 34113.8 34932.8 34937.7 33302.0 34085.5 34264.3 34316.0 34414.8 29717.0 30734.7 30741.7 30934.2 31206.4 20602.8 22141.3 22915.0 23229.9 23488.0 04:56:35 INFO - PROCESS | 1652 | 04:56:35 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:30118.85 Median:376.91 stddev:82461.88 (21878.3%) stddev-sans-first:82662.91 04:56:35 INFO - PROCESS | 1652 | Values: 349.7 351.8 372.9 381.0 401.3 14458.6 14791.7 15558.5 19270.5 19817.1 18502.0 18948.5 19230.5 19607.1 19758.6 5453.1 5761.7 5770.8 5775.1 5780.3 4824.8 5578.7 5677.6 5728.1 5735.1 5691.1 5695.9 5698.9 5699.9 5704.7 5404.2 5617.1 5685.9 5692.9 5693.5 4749.7 4974.4 4979.1 4984.7 4986.6 20591.5 20914.2 21063.9 22686.5 23825.4 2154.0 2260.9 2285.4 2326.0 2885.6 12780.9 14174.2 14946.4 15230.9 15707.1 1812.6 1833.9 1852.6 1853.1 1882.6 77517.2 87064.0 97720.0 108495.2 109017.0 8632.2 10492.6 10517.3 10561.3 10736.0 13287.3 13313.3 13320.3 13320.9 13321.6 8040.7 8331.8 8346.7 8484.8 8509.6 8339.7 8357.8 8369.7 8520.3 8529.5 6333.7 6478.6 6487.4 6500.0 6574.9 1785.9 1826.9 1832.5 1832.5 1835.5 869.9 872.2 909.3 979.4 989.9 20184.2 20593.8 20821.7 20921.2 20977.7 918.8 941.6 954.6 1008.6 1017.1 8651.4 10725.0 11158.7 11253.3 11282.8 415268.0 499038.0 514800.0 520200.0 523369.0 89448.7 97869.0 100484.5 103020.0 103335.5 884.4 940.4 997.3 1020.5 1026.8 18150.6 18387.3 18644.8 18684.0 19054.4 49751.8 50508.5 50600.7 50601.7 50815.0 55286.0 69189.7 70615.0 70738.6 71191.0 7620.6 7669.1 7888.8 8017.3 8244.0 10653.6 11634.7 12578.5 12735.4 13103.3 9077.6 10881.2 10891.8 11032.1 11388.3 10881.9 10988.2 11146.3 11324.3 11400.1 9618.8 11225.8 11267.9 11620.0 11840.5 7935.4 7978.6 7998.0 8147.3 8197.4 8128.9 9975.9 10889.2 11236.4 11377.9 04:56:35 INFO - PROCESS | 1652 | 04:56:35 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5453.19 Median:5194.66 stddev:2993.62 (57.6%) stddev-sans-first:2986.03 04:56:35 INFO - PROCESS | 1652 | Values: 1336.6 1470.5 1498.2 1677.2 1859.7 5720.5 7869.9 7883.5 7897.0 7898.5 8005.2 8264.3 8316.6 8422.2 8439.3 2293.6 2346.1 2348.9 2350.0 2356.7 2049.7 2301.3 2357.7 2375.3 2382.6 2108.5 2148.7 2149.4 2150.8 2160.2 1928.7 2231.6 2317.0 2323.7 2327.6 2315.5 2344.2 2350.9 2351.0 2352.1 8317.8 8545.8 8551.2 8554.4 8559.6 5072.4 5236.0 5247.4 5251.3 5254.6 3353.2 3532.1 3614.2 3616.5 3624.4 1025.5 1050.7 1079.2 1085.4 1098.5 8884.2 10758.2 10922.3 10979.5 11038.3 4290.2 4595.4 4619.9 4679.6 4682.6 9422.2 9441.0 9445.9 9464.0 9474.0 5219.9 5228.9 5233.3 5237.7 5245.4 4508.3 4726.1 4739.6 4792.0 4828.2 3775.5 3814.4 3829.7 3865.4 3876.3 1092.3 1148.6 1167.8 1261.6 1276.3 664.5 794.7 807.0 810.4 878.7 4957.4 5414.2 5581.1 5811.9 5839.1 846.1 897.1 909.9 910.9 935.9 3608.7 3693.0 3700.3 3866.0 3890.4 9721.2 10295.6 10297.0 10300.7 10314.0 10235.5 10254.9 10255.6 10266.9 10269.2 7432.3 7866.3 7876.6 7960.4 7971.5 5169.4 5654.5 5687.2 5798.2 5806.5 8897.4 9241.6 9325.5 9476.5 9481.6 9075.3 9107.9 9336.7 9383.3 9453.7 7625.7 7940.0 7950.7 7961.8 7968.4 7808.4 7848.6 7859.3 7868.3 7926.3 6977.4 6995.9 7133.6 7192.6 7279.6 6949.3 7008.1 7023.1 7042.0 7251.3 6656.8 6658.0 6671.7 6742.6 6744.0 4714.1 4846.4 4853.9 4889.9 5015.6 4810.2 4900.7 4916.7 4969.8 5027.2 04:56:35 INFO - PROCESS | 1652 | 04:56:35 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4249.79 Median:4693.94 stddev:1298.24 (27.7%) stddev-sans-first:1268.46 04:56:35 INFO - PROCESS | 1652 | Values: 350.1 353.6 358.6 369.4 372.2 4907.9 5065.0 5095.7 5127.0 5177.4 4941.1 5004.0 5038.5 5051.4 5068.8 3482.8 3781.6 3801.2 3975.9 3990.3 3006.0 3355.5 3959.6 4004.3 4015.5 3831.2 3833.8 3865.7 3872.8 3901.2 3411.5 3755.1 3833.3 3840.3 3861.8 3358.4 3366.4 3368.5 3369.3 3373.3 3902.6 4145.8 4434.7 4959.4 4995.6 4345.4 4359.5 4380.8 4381.9 4402.8 4630.3 5245.0 5257.7 5258.8 5291.6 3100.3 3198.9 3479.0 3682.5 3686.5 5200.7 5515.3 5560.9 5574.5 5613.4 3483.5 3694.9 3699.2 3721.3 3739.9 3679.8 3752.2 3769.5 3774.5 3774.9 3404.9 3726.2 4352.8 4364.0 4403.9 4603.5 5056.5 5356.3 5375.8 5415.6 1167.4 1180.6 1188.9 1198.6 1223.4 827.7 844.1 845.3 847.2 851.4 4030.8 4144.8 4279.0 4671.0 4812.5 4716.9 4812.8 5081.1 5232.9 5264.3 4351.6 4404.4 4505.5 4780.7 4807.9 2708.3 2713.3 2724.8 2726.4 2732.8 5201.8 5240.2 5329.3 5440.7 5489.3 4619.4 5136.2 5245.9 5275.4 5278.2 4821.6 5453.5 5472.6 5500.4 5518.8 4669.8 4925.4 5017.0 5128.2 5214.9 4782.8 5507.4 5509.6 5525.2 5556.6 5228.7 5884.6 5891.5 5900.5 5926.8 3592.4 3697.0 3714.3 3745.7 3751.8 4483.7 4740.7 5064.9 5522.6 5561.8 4503.3 5377.8 5405.3 5431.8 5487.5 4142.3 5117.3 5158.5 5337.2 5409.8 4419.8 5045.3 5150.2 5194.9 5296.6 4000.8 4552.9 4903.2 5244.0 5407.3 4391.7 4770.7 5211.9 5237.3 5270.9 04:56:35 INFO - PROCESS | 1652 | 04:56:35 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:21383.97 Median:4218.38 stddev:32112.39 (761.2%) stddev-sans-first:32164.69 04:56:35 INFO - PROCESS | 1652 | Values: 637.9 723.4 767.5 781.7 796.3 15263.8 15498.8 15875.4 15885.8 15923.5 14283.6 14432.6 14474.8 14474.8 14478.9 680.1 699.9 705.5 705.8 848.6 699.2 838.4 866.7 873.3 876.6 927.5 937.4 938.3 938.9 939.7 918.9 919.2 919.3 920.5 920.5 521.6 541.5 666.4 687.8 690.3 14722.3 14788.8 14791.1 14796.7 14809.0 13390.9 13472.7 13513.6 13524.5 13542.5 12282.9 12358.3 12387.8 12496.9 12666.3 4391.2 4547.5 4566.0 4574.4 4580.1 99983.5 101680.0 102195.0 102861.5 110361.9 9096.3 10542.5 10632.5 10633.2 10671.1 20199.0 20563.0 20609.4 20833.5 20870.0 7617.3 7632.8 7643.5 7738.8 7876.3 4177.4 4204.1 4252.0 4260.2 4386.4 3350.4 3423.5 3426.2 3440.6 3478.2 614.4 623.2 623.6 634.0 639.0 495.8 550.8 623.2 626.3 631.5 8552.5 8649.9 8731.2 8818.3 8895.2 542.6 568.7 623.2 640.4 644.1 4147.0 4232.6 4254.4 4300.2 4435.0 109214.0 113006.0 113986.7 115726.3 120355.0 98668.0 100267.5 102533.5 103074.0 104340.0 83607.2 86174.6 86653.6 87007.7 88577.6 8048.7 8348.2 8356.3 8523.0 8673.0 40589.0 56402.4 57198.1 58011.7 60183.0 64375.0 76706.1 78776.6 80909.0 81883.0 10815.2 11191.4 11200.4 11306.2 11550.8 11831.6 11918.8 11961.2 12479.8 12652.9 11733.4 11801.5 11925.4 12096.5 12114.8 11777.9 11932.9 12077.6 12419.9 12533.3 11802.0 13102.7 13267.9 13588.2 13933.8 10417.0 10591.4 11116.5 11611.0 11892.0 10712.6 11380.2 11464.8 11609.4 11706.6 04:56:35 INFO - PROCESS | 1652 | -------- Summary: end -------- 04:56:35 INFO - PROCESS | 1652 | 04:56:36 INFO - TEST-INFO | 1652: exit 0 04:56:36 INFO - TEST-OK | dromaeo_css | took 1119701ms 04:56:36 INFO - TEST-START | kraken 04:56:36 INFO - operating with platform_type : mac_ 04:56:36 INFO - Initialising browser for kraken test... 04:56:36 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/tmpfV2kuT/profile http://localhost:49244/getInfo.html) 04:56:38 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 04:56:38 INFO - PROCESS | 1657 | colorDepth:24 04:56:38 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 04:56:38 INFO - PROCESS | 1657 | __metrics 04:56:38 INFO - PROCESS | 1657 | 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" 04:56:38 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:56:39 INFO - TEST-INFO | 1657: exit 0 04:56:39 INFO - Browser initialized. 04:56:39 INFO - Running cycle 1/1 for kraken test... 04:56:39 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/tmpfV2kuT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:56:51 INFO - PROCESS | 1659 | RSS: Main: 237256704 04:56:51 INFO - PROCESS | 1659 | 04:56:53 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 04:56:54 INFO - PROCESS | 1659 | RSS: Main: 290054144 04:56:54 INFO - PROCESS | 1659 | 04:56:57 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 04:56:58 INFO - PROCESS | 1659 | RSS: Main: 291241984 04:56:58 INFO - PROCESS | 1659 | 04:57:01 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 04:57:02 INFO - PROCESS | 1659 | RSS: Main: 382296064 04:57:02 INFO - PROCESS | 1659 | 04:57:04 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 04:57:04 INFO - PROCESS | 1659 | RSS: Main: 286392320 04:57:04 INFO - PROCESS | 1659 | 04:57:06 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:57:07 INFO - PROCESS | 1659 | RSS: Main: 290152448 04:57:07 INFO - PROCESS | 1659 | 04:57:10 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 04:57:11 INFO - PROCESS | 1659 | RSS: Main: 333381632 04:57:11 INFO - PROCESS | 1659 | 04:57:13 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 04:57:14 INFO - PROCESS | 1659 | RSS: Main: 334032896 04:57:14 INFO - PROCESS | 1659 | 04:57:17 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 04:57:18 INFO - PROCESS | 1659 | RSS: Main: 330735616 04:57:18 INFO - PROCESS | 1659 | 04:57:19 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:57:20 INFO - PROCESS | 1659 | RSS: Main: 306253824 04:57:20 INFO - PROCESS | 1659 | 04:57:22 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:57:22 INFO - PROCESS | 1659 | RSS: Main: 310489088 04:57:22 INFO - PROCESS | 1659 | 04:57:24 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:57:25 INFO - PROCESS | 1659 | RSS: Main: 310763520 04:57:25 INFO - PROCESS | 1659 | 04:57:28 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:57:29 INFO - PROCESS | 1659 | RSS: Main: 327225344 04:57:29 INFO - PROCESS | 1659 | 04:57:32 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:57:32 INFO - PROCESS | 1659 | RSS: Main: 321712128 04:57:32 INFO - PROCESS | 1659 | 04:57:34 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 04:57:34 INFO - PROCESS | 1659 | RSS: Main: 365662208 04:57:34 INFO - PROCESS | 1659 | 04:57:34 INFO - PROCESS | 1659 | __start_tp_report 04:57:34 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 04:57:34 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 04:57:34 INFO - PROCESS | 1659 | |i|pagename|runs| 04:57:34 INFO - PROCESS | 1659 | |0;ai-astar;112;113;113;112;113;114;112;113;114;113 04:57:34 INFO - PROCESS | 1659 | |1;audio-beat-detection;143;111;111;147;109;105;121;113;130;112 04:57:34 INFO - PROCESS | 1659 | |2;audio-dft;176;182;183;186;186;181;180;181;182;183 04:57:34 INFO - PROCESS | 1659 | |3;audio-fft;78;58;58;87;60;60;67;84;98;80 04:57:34 INFO - PROCESS | 1659 | |4;audio-oscillator;88;68;85;70;69;68;84;70;69;84 04:57:34 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;153;107;106;108;107;108;109;109;106;107 04:57:34 INFO - PROCESS | 1659 | |6;imaging-darkroom;145;93;93;94;93;92;93;94;92;92 04:57:34 INFO - PROCESS | 1659 | |7;imaging-desaturate;122;128;85;87;87;85;86;86;88;87 04:57:34 INFO - PROCESS | 1659 | |8;json-parse-financial;55;53;54;54;55;58;57;58;57;57 04:57:34 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;64;76;75;72;73;73;70;70;71;72 04:57:34 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;87;87;86;86;87;86;87;87;88;90 04:57:34 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;140;141;141;131;141;151;144;152;182;152 04:57:34 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;173;170;196;170;171;170;202;169;172;174 04:57:34 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;67;67;68;67;66;67;68;66;67;65 04:57:34 INFO - PROCESS | 1659 | __end_tp_report 04:57:34 INFO - PROCESS | 1659 | __start_cc_report 04:57:34 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1972 04:57:34 INFO - PROCESS | 1659 | __end_cc_report 04:57:34 INFO - PROCESS | 1659 | __startTimestamp1482152254831__endTimestamp 04:57:34 INFO - PROCESS | 1659 | 04:57:34 INFO - PROCESS | 1659 | ------- Summary: start ------- 04:57:34 INFO - PROCESS | 1659 | Number of tests: 14 04:57:34 INFO - PROCESS | 1659 | 04:57:34 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:0.74 (0.7%) stddev-sans-first:0.71 04:57:34 INFO - PROCESS | 1659 | Values: 112.0 113.0 113.0 112.0 113.0 114.0 112.0 113.0 114.0 113.0 04:57:34 INFO - PROCESS | 1659 | 04:57:34 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:120.20 Median:117.00 stddev:14.83 (12.7%) stddev-sans-first:13.24 04:57:34 INFO - PROCESS | 1659 | Values: 143.0 111.0 111.0 147.0 109.0 105.0 121.0 113.0 130.0 112.0 04:57:34 INFO - PROCESS | 1659 | 04:57:34 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:182.00 Median:182.50 stddev:2.91 (1.6%) stddev-sans-first:2.12 04:57:34 INFO - PROCESS | 1659 | Values: 176.0 182.0 183.0 186.0 186.0 181.0 180.0 181.0 182.0 183.0 04:57:34 INFO - PROCESS | 1659 | 04:57:34 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:73.00 Median:79.00 stddev:14.30 (18.1%) stddev-sans-first:15.05 04:57:34 INFO - PROCESS | 1659 | Values: 78.0 58.0 58.0 87.0 60.0 60.0 67.0 84.0 98.0 80.0 04:57:34 INFO - PROCESS | 1659 | 04:57:34 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:75.50 Median:77.00 stddev:8.49 (11.0%) stddev-sans-first:7.70 04:57:34 INFO - PROCESS | 1659 | Values: 88.0 68.0 85.0 70.0 69.0 68.0 84.0 70.0 69.0 84.0 04:57:34 INFO - PROCESS | 1659 | 04:57:34 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:112.00 Median:108.00 stddev:14.45 (13.4%) stddev-sans-first:1.13 04:57:34 INFO - PROCESS | 1659 | Values: 153.0 107.0 106.0 108.0 107.0 108.0 109.0 109.0 106.0 107.0 04:57:34 INFO - PROCESS | 1659 | 04:57:34 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:98.10 Median:93.00 stddev:16.50 (17.7%) stddev-sans-first:0.78 04:57:34 INFO - PROCESS | 1659 | Values: 145.0 93.0 93.0 94.0 93.0 92.0 93.0 94.0 92.0 92.0 04:57:34 INFO - PROCESS | 1659 | 04:57:34 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:86.50 stddev:16.37 (18.9%) stddev-sans-first:13.91 04:57:34 INFO - PROCESS | 1659 | Values: 122.0 128.0 85.0 87.0 87.0 85.0 86.0 86.0 88.0 87.0 04:57:34 INFO - PROCESS | 1659 | 04:57:34 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:57.00 stddev:1.81 (3.2%) stddev-sans-first:1.90 04:57:34 INFO - PROCESS | 1659 | Values: 55.0 53.0 54.0 54.0 55.0 58.0 57.0 58.0 57.0 57.0 04:57:34 INFO - PROCESS | 1659 | 04:57:34 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:72.50 stddev:3.31 (4.6%) stddev-sans-first:2.07 04:57:34 INFO - PROCESS | 1659 | Values: 64.0 76.0 75.0 72.0 73.0 73.0 70.0 70.0 71.0 72.0 04:57:34 INFO - PROCESS | 1659 | 04:57:34 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:87.00 stddev:1.20 (1.4%) stddev-sans-first:1.27 04:57:34 INFO - PROCESS | 1659 | Values: 87.0 87.0 86.0 86.0 87.0 86.0 87.0 87.0 88.0 90.0 04:57:34 INFO - PROCESS | 1659 | 04:57:34 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:147.50 Median:147.50 stddev:13.79 (9.3%) stddev-sans-first:14.35 04:57:34 INFO - PROCESS | 1659 | Values: 140.0 141.0 141.0 131.0 141.0 151.0 144.0 152.0 182.0 152.0 04:57:34 INFO - PROCESS | 1659 | 04:57:34 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.70 Median:172.50 stddev:11.94 (6.9%) stddev-sans-first:12.58 04:57:34 INFO - PROCESS | 1659 | Values: 173.0 170.0 196.0 170.0 171.0 170.0 202.0 169.0 172.0 174.0 04:57:34 INFO - PROCESS | 1659 | 04:57:34 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 04:57:34 INFO - PROCESS | 1659 | Values: 67.0 67.0 68.0 67.0 66.0 67.0 68.0 66.0 67.0 65.0 04:57:34 INFO - PROCESS | 1659 | -------- Summary: end -------- 04:57:34 INFO - PROCESS | 1659 | 04:57:35 INFO - TEST-INFO | 1659: exit 0 04:57:35 INFO - TEST-OK | kraken | took 59490ms 04:57:35 INFO - SUITE-END | took 1179s 04:57:35 INFO - Completed test suite (00:19:39) 04:57:35 INFO - javascript benchmark 04:57:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3074.9077527674162, 3286.819224942627, 3289.0790578637984, 3300.4224260754363, 3332.5501057357264, 5372.247885296052, 5473.23374727538, 5479.397266300709, 5502.0, 5535.667859928397, 5483.917741233875, 5484.012877682016, 5521.668699878, 5532.114861622142, 5562.193481945115, 4192.727472714279, 4890.877728056791, 4962.354893863792, 5054.797808087681, 5119.976004799037, 4907.803687852482, 4997.15048441764, 5011.047900898836, 5013.849584512453, 5040.319556859832, 4156.480439945007, 4849.490803465621, 5032.993401319733, 5035.068512325213, 5037.4458809530925, 4975.552200301954, 5005.924911126336, 5102.489751024905, 5105.617078719111, 5152.098382783035, 5010.574101201402, 5018.7992480300745, 5033.521815427529, 5047.369078865142, 5099.949000509984, 5472.480114389126, 5483.424240454775, 5484.232207490954, 5511.5039646432015, 5511.889762204733, 5884.411558844125, 5980.910286345708, 5986.760529578812, 5997.8800423991715, 6013.488853447462, 5863.179154918314, 5917.8816423671715, 5932.11018347247, 5991.011483105326, 6099.146119543268, 5579.6652200868075, 5593.049181639131, 5604.103343465026, 5634.267545219136, 5646.632968857011, 6199.659018753921, 6221.564490485623, 6224.470919971763, 6224.9377506224355, 6237.96881015592, 5711.628744131618, 5764.884702306014, 5788.305403351541, 5861.736221870026, 5863.882722345615, 5890.440408161217, 5945.464908158287, 5963.612365196335, 5964.552658550626, 5975.014122669798, 5498.1752737089755, 5602.4957753802355, 5870.471657550841, 5933.614315069507, 5933.6736479493175, 5923.585349025527, 5973.940260597338, 5992.13114098462, 5998.130271110665, 6002.54980876436, 4684.859454216379, 4780.760961951889, 4783.808647654125, 4793.712377257376, 4820.204666230103, 4237.237297286518, 4256.59562341577, 4262.232798096373, 4273.722208056529, 4288.335308027261, 5655.915161272585, 5679.148127780783, 5684.63049901755, 5708.628939119027, 5720.885582288414, 6050.183225264533, 6096.664683442454, 6101.633901965896, 6104.725287362079, 6131.0, 5542.806001789918, 5597.832065038056, 5603.691796951207, 5604.775808967595, 5645.9717701412055, 5210.0, 5220.947790522122, 5222.4255331913455, 5261.94761047792, 5273.1035723927025, 6305.747770089145, 6315.842103947438, 6317.210348706411, 6317.4630156437215, 6317.810465686037, 5805.970970145122, 5808.273965754281, 6073.817785466443, 6090.817275481742, 6091.5126789857595, 6197.907031394623, 6202.4417802398, 6227.813165605039, 6233.189685340877, 6237.313895471404, 5804.73878675469, 5806.0, 5808.5353171747, 5813.563982701399, 5818.912716309174, 5872.588918775645, 5883.352831188651, 5895.882082358243, 5898.675572843535, 5901.940980590139, 5600.943990560205, 5766.279215098113, 5811.476967072984, 5835.620684655484, 5905.675187864536, 5813.709314534171, 5817.854553636193, 5829.09649004388, 5833.329167145833, 5900.557458190567, 5581.386047534849, 5699.116636921284, 5701.344345400332, 5712.0, 5717.685527296038, 5721.342045664802, 5744.310682718101, 5781.768729250783, 5788.363280039108, 5813.79651712188, 5672.801451949162, 5677.829665110054, 5694.601377903507, 5723.656580605177, 5729.828105156852], "value": 5486.744812091957, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.39026582253206, 479.5875547029555, 484.65105124310486, 515.6777014366019, 516.8733660253239, 36801.44797828035, 38731.806340968295, 38976.610233897656, 38985.220295594074, 39140.41289380661, 39518.0, 39913.20173596526, 39965.0, 39974.60025399745, 40019.19961600766, 8359.874601880976, 9240.584173712166, 9404.435733855991, 9415.764605884839, 9421.764455888624, 8417.368697347723, 10985.143862595743, 11267.492962816652, 11274.774504509905, 11417.143714221467, 11230.943845280763, 11285.435728213597, 11304.208705390625, 11323.547058117665, 11326.830097548544, 8433.40966132371, 8647.956760216222, 11170.609028683997, 11259.380734059583, 11259.662210133627, 10812.837807432894, 11082.833757493645, 11103.888961110448, 11253.718657033558, 11307.943460282646, 38416.42375364372, 38707.612923870685, 38750.224995499935, 38855.41716874249, 38878.63924762648, 3262.9347413051605, 3473.062273186251, 3492.8253587320532, 3546.804925729084, 4034.293998550271, 26145.869270653715, 27644.894204231805, 27687.584686229722, 27711.584326235123, 27858.024969126185, 3080.630324361091, 3209.646938836726, 3220.565223694818, 3296.489044198153, 3298.4062868683627, 438905.0, 492735.0, 493519.0, 495234.23828808416, 496413.0, 52496.475035249925, 52800.73599632054, 52812.94374112496, 52891.0, 53026.20460693093, 54462.638434039465, 54688.0, 54770.90458190814, 54893.451065488836, 55029.89940201174, 14737.557873263604, 14974.550763477113, 14977.326020329112, 14978.850211497964, 14994.70010599782, 10534.20993425496, 10819.404932728617, 10860.728481788019, 11628.069754419626, 11673.124515661359, 15745.543145248696, 19840.107195176253, 19891.403257901995, 20470.692939605917, 20480.69278960817, 8142.389320800964, 8243.299319557906, 8297.792555186048, 8336.749897503085, 8388.748337549883, 851.0, 893.5353616119711, 1005.7586179317058, 1032.0402026115785, 1064.2709743825503, 28914.42171156565, 28978.0, 29281.56077658837, 29600.0, 29865.701342986293, 1045.9790804184026, 1142.8400023996646, 1145.7536629624672, 1154.4112502623723, 1171.3030746705697, 14389.928050359891, 14884.255787210595, 14901.180435075958, 15301.234938253043, 15421.383144674088, 559973.6010559532, 671111.0, 672452.0, 674743.0, 684535.0, 56516.0, 57001.71499142478, 57043.0, 57192.428075719545, 57325.713371432874, 1232.89520390766, 1288.9033322500663, 1355.4171706166444, 1383.1700979412474, 1401.6846209602759, 27591.31021724473, 28872.566911496764, 28970.13089607315, 29399.412011760072, 29465.85267073651, 47184.7640761794, 47657.04685906193, 47674.5232547684, 47716.7614161927, 47777.0, 483731.0, 561441.0, 563753.0, 569007.0, 569812.0, 24633.384165396008, 25791.871040644677, 26057.739422605533, 39479.01302467461, 39964.60035399609, 40366.59633403629, 40748.79625601853, 41341.37987930123, 41461.79269103635, 41820.372694409, 34606.665268497345, 35119.648803511634, 35285.823570881985, 35468.0, 35551.288974220886, 33567.49648755222, 33824.66175338215, 34113.82943085368, 34932.82533587316, 34937.65062349445, 33302.0, 34085.488717668755, 34264.31471370609, 34315.97052088441, 34414.82792586021, 29717.0, 30734.692653073183, 30741.692583073884, 30934.226644333172, 31206.375872482877, 20602.793972060088, 22141.265129481402, 22915.0, 23229.883850580638, 23488.0], "value": 19500.22262656338, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.7429389398793, 351.7748640869845, 372.86576832340353, 380.9580946095929, 401.29973196771635, 14458.638534036654, 14791.704165916675, 15558.45545405911, 19270.51823704408, 19817.10823012964, 18502.0, 18948.526286842836, 19230.519237019045, 19607.117679704414, 19758.60482790347, 5453.127499600065, 5761.654300741948, 5770.82687519373, 5775.104858746901, 5780.335261444925, 4824.807007719687, 5578.665280083208, 5677.630953987978, 5728.14077888318, 5735.139729040636, 5691.08942569189, 5695.8576035599235, 5698.886022279552, 5699.943000570003, 5704.65772053676, 5404.189371594272, 5617.101263797793, 5685.914711279334, 5692.886142277172, 5693.516051135658, 4749.667523273372, 4974.42794078682, 4979.0788704089855, 4984.675996060245, 4986.551210391082, 20591.485212869797, 20914.163433462643, 21063.946802659804, 22686.54626907469, 23825.379208287075, 2153.956920861574, 2260.886955652211, 2285.3829466044076, 2325.953480930372, 2885.6248687670677, 12780.936095319557, 14174.220417877013, 14946.40214391434, 15230.93383463158, 15707.057576545443, 1812.5559237986645, 1833.8899666020081, 1852.6016906365196, 1853.1475521260236, 1882.632886587116, 77517.22482775156, 87064.0, 97720.0, 108495.235428811, 109017.0, 8632.179942905414, 10492.632757853438, 10517.316374435637, 10561.313514621525, 10736.0, 13287.269200194081, 13313.267770272729, 13320.333983300796, 13320.934325253957, 13321.600351989262, 8040.718574849852, 8331.791705207419, 8346.66613335472, 8484.769708392372, 8509.61706723199, 8339.666413343399, 8357.8328433431, 8369.665213391396, 8520.318374530023, 8529.530875801767, 6333.746650134035, 6478.578892371981, 6487.3836985486305, 6500.0, 6574.901376479356, 1785.9464216073538, 1826.9177886995117, 1832.4502649205185, 1832.4960635825255, 1835.4768890866305, 869.9173578510031, 872.1975782280317, 909.2862103248918, 979.363413781048, 989.8960609135937, 20184.19263229484, 20593.794062059187, 20821.709611942675, 20921.163153473994, 20977.68533471999, 918.8024574716468, 941.6374695742188, 954.6181527388961, 1008.5627980128288, 1017.0693815159046, 8651.351148663749, 10725.0, 11158.721031974103, 11253.268537545033, 11282.774344513064, 415268.0, 499038.0, 514800.0, 520200.0, 523369.0, 89448.658270126, 97869.0, 100484.48788780192, 103020.0, 103335.4833225829, 884.4118661090303, 940.351157701184, 997.2719914462338, 1020.5407566595062, 1026.779242462874, 18150.636987260445, 18387.264509419474, 18644.813551864307, 18683.972381519146, 19054.42836714901, 49751.75620609514, 50508.49491505038, 50600.74699626478, 50601.74699126481, 50815.0, 55286.0, 69189.65405172942, 70615.0, 70738.64630676813, 71191.0, 7620.618969051415, 7669.118051424158, 7888.84222315539, 8017.318527925192, 8243.958780206061, 10653.627123050655, 11634.709132271422, 12578.496860125493, 12735.426905789447, 13103.344832758134, 9077.639813648368, 10881.238313317992, 10891.836622450512, 11032.06227470674, 11388.316700997966, 10881.891181088087, 10988.230823842574, 11146.275492092987, 11324.263922845319, 11400.144989126014, 9618.759531011501, 11225.831612525655, 11267.887321126684, 11620.0, 11840.467178976794, 7935.40484463656, 7978.601069946596, 7997.960010199912, 8147.307478864126, 8197.385196110436, 8128.918710812816, 9975.900240997496, 10889.183311251529, 11236.381998990135, 11377.943110284727], "value": 9231.055378871939, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.5698702388436, 1470.514730139054, 1498.2209251189379, 1677.2200926569144, 1859.7489338939247, 5720.456556627124, 7869.881951770728, 7883.526988380701, 7897.012873390826, 7898.486598371109, 8005.1994800519915, 8264.256216940474, 8316.584170791451, 8422.19989101036, 8439.32485401168, 2293.6444851048072, 2346.120204923154, 2348.941276468085, 2349.9765002350014, 2356.6582845487396, 2049.6720524716047, 2301.309607117866, 2357.7406485286606, 2375.3467796356053, 2382.5711371953043, 2108.4728817795553, 2148.677698345245, 2149.4304009437433, 2150.849440539163, 2160.157538559963, 1928.7299778031088, 2231.6094683430415, 2317.0384290519414, 2323.6863023491783, 2327.5577640248466, 2315.490592069742, 2344.1912540173785, 2350.8824558771994, 2350.9882450587806, 2352.1061996441244, 8317.792055198668, 8545.786355341104, 8551.230389264934, 8554.35842311829, 8559.572021398904, 5072.365954255718, 5236.0, 5247.39654939683, 5251.317328747276, 5254.553362964152, 3353.161709572607, 3532.1346270163717, 3614.1868079681863, 3616.4756110364115, 3624.3657359961903, 1025.4770067265674, 1050.669039252633, 1079.1528650009784, 1085.375908852405, 1098.4617537406614, 8884.200421962054, 10758.193135514868, 10922.29005114665, 10979.451027448675, 11038.337699738042, 4290.163418133434, 4595.37962375075, 4619.884502887455, 4679.602233810164, 4682.555157260055, 9422.152006319327, 9441.0, 9445.90554094464, 9464.0, 9473.952630236805, 5219.921701174486, 5228.92156617651, 5233.345831771028, 5237.711925844039, 5245.423003469616, 4508.346289788028, 4726.125666751662, 4739.597134243559, 4791.9936813269605, 4828.179209534387, 3775.452559378875, 3814.3598252751585, 3829.6553310202216, 3865.38153895381, 3876.302265592164, 1092.257265059767, 1148.586508856811, 1167.8030019230357, 1261.5773715805308, 1276.2852802430668, 664.4617560917346, 794.6543253684665, 806.9515829050275, 810.4205493072482, 878.7363790862844, 4957.405111386656, 5414.187871819258, 5581.134924086773, 5811.883762324815, 5839.0949402842625, 846.0862268749736, 897.1387468030764, 909.8544232922701, 910.8770316007386, 935.9017303183203, 3608.657177568127, 3693.024232035848, 3700.3339398908456, 3865.980670096688, 3890.3775395936514, 9721.173700235558, 10295.639652612123, 10296.970302969643, 10300.690979270634, 10314.02016808402, 10235.48822558884, 10254.948725256327, 10255.58977640901, 10266.897331026594, 10269.229807764448, 7432.2567743225245, 7866.252705992922, 7876.645550950221, 7960.442769006114, 7971.481853679492, 5169.405518365436, 5654.491095801398, 5687.236956543485, 5798.246227990334, 5806.477417032487, 8897.377183597346, 9241.630334786532, 9325.533723313943, 9476.478793666414, 9481.573329200064, 9075.319351048565, 9107.863382049407, 9336.719898403058, 9383.343165978316, 9453.669121580711, 7625.6568454418575, 7940.0471943367165, 7950.7217247396065, 7961.800954976172, 7968.362530997622, 7808.375329973702, 7848.60756962161, 7859.331956783737, 7868.291853733192, 7926.326262267772, 6977.3720365165345, 6995.895061573979, 7133.5719856808755, 7192.640367981685, 7279.636018199175, 6949.270326615632, 7008.123984501937, 7023.122109736283, 7042.0, 7251.274872512707, 6656.800295991128, 6658.0, 6671.66641667905, 6742.595444273359, 6743.966280168568, 4714.104320179155, 4846.442659094249, 4853.878653033702, 4889.853304400874, 5015.570562389701, 4810.230363141881, 4900.705957642553, 4916.729579873141, 4969.801207951786, 5027.2207807789855], "value": 4399.8691199628665, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.147391102665, 353.6145601294588, 358.56971634039144, 369.4218547972425, 372.2313422781953, 4907.877303067425, 5065.0, 5095.6687815292025, 5127.0002349541855, 5177.352830896138, 4941.0611983723065, 5003.973390776732, 5038.521340472649, 5051.444341122483, 5068.797248110081, 3482.8432720527635, 3781.560893223869, 3801.220749746309, 3975.9204815903663, 3990.281749285135, 3005.9849700751574, 3355.456490014596, 3959.6436320731273, 4004.279229738646, 4015.4741198344586, 3831.218483405216, 3833.750806197588, 3865.6520913117815, 3872.7869967151796, 3901.239258344624, 3411.4712219606, 3755.117547376378, 3833.29084119436, 3840.289546433905, 3861.7876016819064, 3358.4458564336855, 3366.4108780963234, 3368.473644766425, 3369.326134773031, 3373.308471763283, 3902.609739026103, 4145.7927103645, 4434.711743736647, 4959.355283813117, 4995.577145084631, 4345.3699213613845, 4359.520452750195, 4380.846670366522, 4381.9123617527475, 4402.779861006937, 4630.259158534652, 5244.980682437251, 5257.7108259045735, 5258.842234732964, 5291.603129765283, 3100.3489267253904, 3198.9207015439915, 3479.0, 3682.502862113607, 3686.5391826021746, 5200.6619569727845, 5515.255440515519, 5560.916586251209, 5574.498295153456, 5613.4386561343945, 3483.494893240466, 3694.8891533254045, 3699.2231631357176, 3721.325403568351, 3739.8504059837846, 3679.8344074516713, 3752.1932784451474, 3769.5476542815036, 3774.5467994822193, 3774.9433758493647, 3404.863805447754, 3726.2174943262216, 4352.847650332224, 4364.018095928391, 4403.92103934538, 4603.539646035437, 5056.508330042646, 5356.276902618097, 5375.784968601212, 5415.620906536505, 1167.3754541320352, 1180.5808937827119, 1188.9346085965183, 1198.5804968261039, 1223.3883058470765, 827.7475370012204, 844.079952851395, 845.2561745663777, 847.2332539052168, 851.3997631669658, 4030.8109107813266, 4144.8134833932545, 4279.015826359955, 4670.963873482264, 4812.542808433193, 4716.924553196651, 4812.783424745895, 5081.078379931554, 5232.92150617741, 5264.289320941701, 4351.564843515686, 4404.427424434803, 4505.549445055468, 4780.737059461693, 4807.903841923142, 2708.349996000946, 2713.3487962889158, 2724.8365098094177, 2726.445925822302, 2732.808703390783, 5201.765920533585, 5240.240165176028, 5329.280547126088, 5440.6735595864375, 5489.2589500417735, 4619.422572178478, 5136.178211486219, 5245.868853278698, 5275.393329767049, 5278.208268759717, 4821.614270858323, 5453.536449401766, 5472.5621950243885, 5500.3949565547755, 5518.806841760519, 4669.766511674471, 4925.399245245381, 5016.974915125547, 5128.1794912813775, 5214.9478505214465, 4782.832600858953, 5507.366652834975, 5509.586780991522, 5525.171224316385, 5556.638818476786, 5228.738563071755, 5884.6469211847425, 5891.524000839525, 5900.4597241654665, 5926.762929482945, 3592.3892938201093, 3697.0, 3714.331420344364, 3745.7451753662826, 3751.83116759741, 4483.686141970031, 4740.691855029412, 5064.924026139537, 5522.641028333145, 5561.776409189972, 4503.256962601135, 5377.8117765878005, 5405.270288511158, 5431.8098866539485, 5487.506124448819, 4142.2543942090715, 5117.260131555289, 5158.45836187195, 5337.171299211269, 5409.83770486886, 4419.756913369795, 5045.31888195089, 5150.197430899156, 5194.922076168785, 5296.629235953446, 4000.7799571023875, 4552.904025262853, 4903.16131450706, 5243.95120975814, 5407.269673704377, 4391.692581519263, 4770.689905156154, 5211.9478805211465, 5237.292965449616, 5270.947290527199], "value": 3856.7177809042714, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.9234491860977, 723.3670538279005, 767.5049593012507, 781.656071328615, 796.3310818912113, 15263.847361526381, 15498.845011549882, 15875.36498540057, 15885.84114158858, 15923.52229433119, 14283.642908927257, 14432.5670229893, 14474.782878256809, 14474.782878256834, 14478.855211447883, 680.0750978669006, 699.8670252652005, 705.4673721340381, 705.7953193573883, 848.6181218451705, 699.199416667915, 838.3837879158843, 866.744310428422, 873.3057219510505, 876.5660997806095, 927.5315965437445, 937.3953799799159, 938.2822141062093, 938.9342746007782, 939.6805086270666, 918.9494577798218, 919.2140719684674, 919.2783664823082, 920.5305294299889, 920.5305294299889, 521.5931573372775, 541.5478075806706, 666.3935818405228, 687.8039758668806, 690.3096903096903, 14722.337494812758, 14788.778168327484, 14791.112533248039, 14796.70406591873, 14809.0, 13390.933045334808, 13472.730545389135, 13513.594592162252, 13524.459021639123, 13542.45830166792, 12282.877171228263, 12358.25850448967, 12387.75224495514, 12496.875031249661, 12666.303353315563, 4391.187630288407, 4547.477040140393, 4565.977170114162, 4574.359589657451, 4580.106879158566, 99983.50008249911, 101680.0, 102195.0, 102861.4856925718, 110361.89638103677, 9096.272298216127, 10542.525586348633, 10632.521536530874, 10633.202509811796, 10671.146308295318, 20199.0, 20563.0, 20609.381718548466, 20833.479163021046, 20870.0, 7617.314441700273, 7632.80917977055, 7643.541387516656, 7738.767836964787, 7876.330511906437, 4177.373393990865, 4204.1171354016, 4251.957480425156, 4260.211860805761, 4386.429764130707, 3350.363430948112, 3423.5207071010077, 3426.1605906553054, 3440.6215316315183, 3478.217401084786, 614.3917521653531, 623.1618473153601, 623.6258245053023, 634.0236036503825, 638.9936100639027, 495.83320887720174, 550.8292429346915, 623.1836294454189, 626.2891618013497, 631.5011141198402, 8552.529610871461, 8649.870251946226, 8731.170538798804, 8818.319269863881, 8895.154960278764, 542.6337222374881, 568.6758547627812, 623.1805176193292, 640.4204195203348, 644.0532417346493, 4146.979265103655, 4232.640225580799, 4254.3831144483875, 4300.225959327351, 4434.982083152223, 109214.0, 113006.0, 113986.72026559588, 115726.26410603848, 120355.0, 98668.0, 100267.49866250622, 102533.48733256436, 103073.96926030643, 104340.0, 83607.16392835994, 86174.56912715397, 86653.5667321672, 87007.69488457804, 88577.55711221532, 8048.718294859652, 8348.165183481604, 8356.33149348063, 8522.957385213034, 8672.956635216784, 40589.0, 56402.43597563972, 57198.14202786878, 58011.709941450026, 60183.0, 64375.0, 76706.08234794174, 78776.60611696905, 80909.0, 81883.0, 10815.242932994615, 11191.425228548109, 11200.43997800123, 11306.152038596974, 11550.768984620428, 11831.645050648494, 11918.761624767283, 11961.162718609614, 12479.750404991668, 12652.936735316265, 11733.434214717941, 11801.527938882691, 11925.4037298133, 12096.516139354328, 12114.757704845677, 11777.941110294394, 11932.880671193525, 12077.57728479499, 12419.93790031044, 12533.310667913353, 11802.0, 13102.737945240851, 13267.867321326663, 13588.184708917497, 13933.790993135313, 10417.0302737151, 10591.417472039111, 11116.49975751077, 11611.0, 11892.048636108917, 10712.571497140027, 11380.203385762918, 11464.82802757976, 11609.419529023346, 11706.648800535997], "value": 7339.361909646839, "unit": "score"}], "name": "dromaeo_css", "value": 7052.263161972421, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 113.0, 112.0, 113.0, 114.0, 112.0, 113.0, 114.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 111.0, 111.0, 147.0, 109.0, 105.0, 121.0, 113.0, 130.0, 112.0], "value": 120.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 182.0, 183.0, 186.0, 186.0, 181.0, 180.0, 181.0, 182.0, 183.0], "value": 182.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 58.0, 58.0, 87.0, 60.0, 60.0, 67.0, 84.0, 98.0, 80.0], "value": 73.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 68.0, 85.0, 70.0, 69.0, 68.0, 84.0, 70.0, 69.0, 84.0], "value": 75.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 107.0, 106.0, 108.0, 107.0, 108.0, 109.0, 109.0, 106.0, 107.0], "value": 112.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 93.0, 93.0, 94.0, 93.0, 92.0, 93.0, 94.0, 92.0, 92.0], "value": 98.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 128.0, 85.0, 87.0, 87.0, 85.0, 86.0, 86.0, 88.0, 87.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 54.0, 55.0, 58.0, 57.0, 58.0, 57.0, 57.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 76.0, 75.0, 72.0, 73.0, 73.0, 70.0, 70.0, 71.0, 72.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 86.0, 86.0, 87.0, 86.0, 87.0, 87.0, 88.0, 90.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 141.0, 141.0, 131.0, 141.0, 151.0, 144.0, 152.0, 182.0, 152.0], "value": 147.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 196.0, 170.0, 171.0, 170.0, 202.0, 169.0, 172.0, 174.0], "value": 176.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 67.0, 66.0, 67.0, 68.0, 66.0, 67.0, 65.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1473.3, "alertThreshold": 2.0}]} 04:57:36 INFO - Return code: 0 04:57:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:57:36 INFO - # TBPL SUCCESS # 04:57:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:57:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:57:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:57:36 INFO - 2016-12-19 04:57:36.181 screenresolution[1664:10478] starting screenresolution argv=screenresolution get 04:57:36 INFO - 2016-12-19 04:57:36.184 screenresolution[1664:10478] Display 0: 1600x1200x32@60 04:57:36 INFO - 2016-12-19 04:57:36.190 screenresolution[1665:10481] starting screenresolution argv=screenresolution list 04:57:36 INFO - Available Modes on Display 0 04:57:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:57:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:57:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:57:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:57:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:57:36 INFO - Intel Iris: 04:57:36 INFO - Chipset Model: Intel Iris 04:57:36 INFO - Type: GPU 04:57:36 INFO - Bus: Built-In 04:57:36 INFO - VRAM (Dynamic, Max): 1536 MB 04:57:36 INFO - Vendor: Intel (0x8086) 04:57:36 INFO - Device ID: 0x0a2e 04:57:36 INFO - Revision ID: 0x0009 04:57:36 INFO - Displays: 04:57:36 INFO - Display: 04:57:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:57:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:57:36 INFO - Display Serial Number: 1600x1200 60 04:57:36 INFO - Main Display: Yes 04:57:36 INFO - Mirror: Off 04:57:36 INFO - Online: Yes 04:57:36 INFO - Rotation: Supported 04:57:36 INFO - Return code: 0 04:57:36 INFO - Running post-action listener: _resource_record_post_action 04:57:36 INFO - [mozharness: 2016-12-19 12:57:36.425736Z] Finished run-tests step (success) 04:57:36 INFO - Running post-run listener: _resource_record_post_run 04:57:36 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 32476160; Write bytes: 551988224; Read time: 201; Write time: 1680 04:57:36 INFO - TinderboxPrint: CPU usage
53.8% 04:57:36 INFO - TinderboxPrint: I/O read bytes / time
32,476,160 / 201 04:57:36 INFO - TinderboxPrint: I/O write bytes / time
551,988,224 / 1,680 04:57:36 INFO - TinderboxPrint: CPU idle
2,219.7 (46.2%) 04:57:36 INFO - TinderboxPrint: CPU system
961.8 (20.0%) 04:57:36 INFO - TinderboxPrint: CPU user
1,624.2 (33.8%) 04:57:36 INFO - TinderboxPrint: Swap in / out
278,405,120 / 0 04:57:36 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 228782592; Write bytes: 221093888; Read time: 16428; Write time: 476 04:57:36 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 31542272; Write bytes: 301689856; Read time: 188; Write time: 1138 04:57:36 INFO - Running post-run listener: _upload_blobber_files 04:57:36 INFO - Blob upload gear active. 04:57:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:57:36 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 04:57:36 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'] 04:57:36 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 04:57:37 INFO - (blobuploader) - INFO - Open directory for files ... 04:57:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:57:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:57:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:38 INFO - (blobuploader) - INFO - Done attempting. 04:57:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:57:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:57:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:39 INFO - (blobuploader) - INFO - Done attempting. 04:57:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:57:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:57:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:40 INFO - (blobuploader) - INFO - Done attempting. 04:57:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:57:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:57:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:43 INFO - (blobuploader) - INFO - Done attempting. 04:57:43 INFO - (blobuploader) - INFO - Iteration through files over. 04:57:43 INFO - Return code: 0 04:57:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:57:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:57:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35b353b8a5372c6c273186388529d495ae190ab3a8bc50a270a3c8f9f9bfc94d27a05bd744fb6e7c56b2bc3400e8af296dd130b7d96678697faca4ee243db90d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccc79015eac4dcf3ec7f12325945d5cf99a8ae410dc4ab49fc83737e91cbff19c692572055c7d44ff929317eea496ceae9e237f033ce3110772d886ed3fe5fd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8379cee3e39412dc631676a6048dad73c8b59a2dda47e606a9347d23b2b3d9f4fac7fe3017c0ed6a07b3e2e6025645b8009eebc41d4e490c323b0bbbbd98d14c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11ed411a9b9af470bed71be9e36103c82d44b3d71d06212fff167a17e104449fa47c962d76dccf99524c406b6394ac0615de743df666b7bd4bed4c9cad2dcaf6"} 04:57:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:57:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:57:43 INFO - Contents: 04:57:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35b353b8a5372c6c273186388529d495ae190ab3a8bc50a270a3c8f9f9bfc94d27a05bd744fb6e7c56b2bc3400e8af296dd130b7d96678697faca4ee243db90d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccc79015eac4dcf3ec7f12325945d5cf99a8ae410dc4ab49fc83737e91cbff19c692572055c7d44ff929317eea496ceae9e237f033ce3110772d886ed3fe5fd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8379cee3e39412dc631676a6048dad73c8b59a2dda47e606a9347d23b2b3d9f4fac7fe3017c0ed6a07b3e2e6025645b8009eebc41d4e490c323b0bbbbd98d14c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11ed411a9b9af470bed71be9e36103c82d44b3d71d06212fff167a17e104449fa47c962d76dccf99524c406b6394ac0615de743df666b7bd4bed4c9cad2dcaf6"} 04:57:43 INFO - Running post-run listener: copy_logs_to_upload_dir 04:57:43 INFO - Copying logs to upload dir... 04:57:43 INFO - mkdir: /builds/slave/test/build/upload/logs 04:57:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.761587 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-12-19 04:57:43.300298) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-19 04:57:43.303599) ========= 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.AI7frqGEOa/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.SYAe9rmV9C/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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/35b353b8a5372c6c273186388529d495ae190ab3a8bc50a270a3c8f9f9bfc94d27a05bd744fb6e7c56b2bc3400e8af296dd130b7d96678697faca4ee243db90d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccc79015eac4dcf3ec7f12325945d5cf99a8ae410dc4ab49fc83737e91cbff19c692572055c7d44ff929317eea496ceae9e237f033ce3110772d886ed3fe5fd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8379cee3e39412dc631676a6048dad73c8b59a2dda47e606a9347d23b2b3d9f4fac7fe3017c0ed6a07b3e2e6025645b8009eebc41d4e490c323b0bbbbd98d14c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11ed411a9b9af470bed71be9e36103c82d44b3d71d06212fff167a17e104449fa47c962d76dccf99524c406b6394ac0615de743df666b7bd4bed4c9cad2dcaf6"} build_url:https://queue.taskcluster.net/v1/task/S4xJ5v3pT7Sdn9Z-RA8TiA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011195 build_url: 'https://queue.taskcluster.net/v1/task/S4xJ5v3pT7Sdn9Z-RA8TiA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35b353b8a5372c6c273186388529d495ae190ab3a8bc50a270a3c8f9f9bfc94d27a05bd744fb6e7c56b2bc3400e8af296dd130b7d96678697faca4ee243db90d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccc79015eac4dcf3ec7f12325945d5cf99a8ae410dc4ab49fc83737e91cbff19c692572055c7d44ff929317eea496ceae9e237f033ce3110772d886ed3fe5fd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8379cee3e39412dc631676a6048dad73c8b59a2dda47e606a9347d23b2b3d9f4fac7fe3017c0ed6a07b3e2e6025645b8009eebc41d4e490c323b0bbbbd98d14c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11ed411a9b9af470bed71be9e36103c82d44b3d71d06212fff167a17e104449fa47c962d76dccf99524c406b6394ac0615de743df666b7bd4bed4c9cad2dcaf6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-19 04:57:43.337704) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 04:57:43.338076) ========= 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.AI7frqGEOa/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.SYAe9rmV9C/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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.004875 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 04:57:43.387288) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-19 04:57:43.387632) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-19 04:57:43.388057) ========= ========= Total master_lag: 1.17 =========