builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0022 starttime: 1490908741.11 results: success (0) buildid: 20170330124805 builduid: a631c646a7994c4b848dadef0374536b revision: fe3e3c0ea489cea724da1bd56ce20fe843d96a9e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 14:19:01.109643) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 14:19:01.110096) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 14:19:01.110411) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 14:19:01.138947) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 14:19:01.139560) ========= 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.XHJo4hCk5e/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.OgsOdV7p6b/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-30 14:19:01-- 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% 14.6M=0.001s 2017-03-30 14:19:01 (14.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.162376 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 14:19:01.329097) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 14:19:01.329867) ========= 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.XHJo4hCk5e/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.OgsOdV7p6b/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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.033233 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 14:19:01.386306) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-30 14:19:01.387105) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fe3e3c0ea489cea724da1bd56ce20fe843d96a9e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fe3e3c0ea489cea724da1bd56ce20fe843d96a9e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XHJo4hCk5e/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.OgsOdV7p6b/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-30 14:19:01,502 truncating revision to first 12 chars 2017-03-30 14:19:01,502 Setting DEBUG logging. 2017-03-30 14:19:01,502 attempt 1/10 2017-03-30 14:19:01,502 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/fe3e3c0ea489?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-30 14:19:03,348 unpacking tar archive at: mozilla-beta-fe3e3c0ea489/testing/mozharness/ program finished with exit code 0 elapsedTime=2.126089 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-30 14:19:03.540149) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 14:19:03.540864) ========= script_repo_revision: fe3e3c0ea489cea724da1bd56ce20fe843d96a9e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 14:19:03.541666) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 14:19:03.542206) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 14:19:03.563472) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-03-30 14:19:03.563968) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XHJo4hCk5e/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.OgsOdV7p6b/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 14:19:03 INFO - MultiFileLogger online at 20170330 14:19:03 in /builds/slave/test 14:19:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:19:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:19:03 INFO - {'append_to_log': False, 14:19:03 INFO - 'base_work_dir': '/builds/slave/test', 14:19:03 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:19:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:19:03 INFO - 'branch': 'Mozilla-Beta', 14:19:03 INFO - 'buildbot_json_path': 'buildprops.json', 14:19:03 INFO - 'config_files': ('talos/mac_config.py',), 14:19:03 INFO - 'default_actions': ('clobber', 14:19:03 INFO - 'read-buildbot-config', 14:19:03 INFO - 'download-and-extract', 14:19:03 INFO - 'populate-webroot', 14:19:03 INFO - 'create-virtualenv', 14:19:03 INFO - 'install', 14:19:03 INFO - 'run-tests'), 14:19:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:19:03 INFO - 'download_minidump_stackwalk': True, 14:19:03 INFO - 'download_symbols': 'ondemand', 14:19:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:19:03 INFO - 'tooltool.py': '/tools/tooltool.py', 14:19:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:19:03 INFO - '/tools/misc-python/virtualenv.py')}, 14:19:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:19:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:19:03 INFO - 'installer_path': 'installer.exe', 14:19:03 INFO - 'log_level': 'info', 14:19:03 INFO - 'log_name': 'talos', 14:19:03 INFO - 'log_to_console': True, 14:19:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:19:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:19:03 INFO - 'opt_config_files': (), 14:19:03 INFO - 'pip_index': False, 14:19:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:19:03 INFO - 'cmd': ('bash', 14:19:03 INFO - '-c', 14:19:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:19:03 INFO - 'enabled': True, 14:19:03 INFO - 'halt_on_failure': False, 14:19:03 INFO - 'name': 'check_screen_resolution'},), 14:19:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:19:03 INFO - 'cmd': ('bash', 14:19:03 INFO - '-c', 14:19:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:19:03 INFO - 'enabled': True, 14:19:03 INFO - 'halt_on_failure': False, 14:19:03 INFO - 'name': 'check_screen_resolution'},), 14:19:03 INFO - 'run_cmd_checks_enabled': True, 14:19:03 INFO - 'sps_profile': False, 14:19:03 INFO - 'sps_profile_interval': 0, 14:19:03 INFO - 'suite': 'dromaeojs', 14:19:03 INFO - 'system_bits': '32', 14:19:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:19:03 INFO - 'title': 't-yosemite-r7-0022', 14:19:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:19:03 INFO - 'use_talos_json': True, 14:19:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:19:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:19:03 INFO - 'work_dir': 'build'} 14:19:03 INFO - [mozharness: 2017-03-30 21:19:03.782912Z] Running clobber step. 14:19:03 INFO - Running pre-action listener: _resource_record_pre_action 14:19:03 INFO - Running main action method: clobber 14:19:03 INFO - rmtree: /builds/slave/test/build 14:19:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:19:06 INFO - Running post-action listener: _resource_record_post_action 14:19:06 INFO - [mozharness: 2017-03-30 21:19:06.330095Z] Finished clobber step (success) 14:19:06 INFO - [mozharness: 2017-03-30 21:19:06.330283Z] Running read-buildbot-config step. 14:19:06 INFO - Running pre-action listener: _resource_record_pre_action 14:19:06 INFO - Running main action method: read_buildbot_config 14:19:06 INFO - Using buildbot properties: 14:19:06 INFO - { 14:19:06 INFO - "project": "", 14:19:06 INFO - "product": "firefox", 14:19:06 INFO - "script_repo_revision": "production", 14:19:06 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 14:19:06 INFO - "repository": "", 14:19:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 14:19:06 INFO - "buildid": "20170330124805", 14:19:06 INFO - "pgo_build": "False", 14:19:06 INFO - "basedir": "/builds/slave/test", 14:19:06 INFO - "buildnumber": 7, 14:19:06 INFO - "slavename": "t-yosemite-r7-0022", 14:19:06 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 14:19:06 INFO - "platform": "yosemite_r7", 14:19:06 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:19:06 INFO - "branch": "mozilla-beta", 14:19:06 INFO - "repo_path": "releases/mozilla-beta", 14:19:06 INFO - "revision": "fe3e3c0ea489cea724da1bd56ce20fe843d96a9e", 14:19:06 INFO - "stage_platform": "macosx64", 14:19:06 INFO - "builduid": "a631c646a7994c4b848dadef0374536b", 14:19:06 INFO - "slavebuilddir": "test" 14:19:06 INFO - } 14:19:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/FZnecyPcSui5Yo0HLDNHjg/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 14:19:06 INFO - Running post-action listener: _resource_record_post_action 14:19:06 INFO - [mozharness: 2017-03-30 21:19:06.333580Z] Finished read-buildbot-config step (success) 14:19:06 INFO - [mozharness: 2017-03-30 21:19:06.333694Z] Running download-and-extract step. 14:19:06 INFO - Running pre-action listener: _resource_record_pre_action 14:19:06 INFO - Running main action method: download_and_extract 14:19:06 INFO - mkdir: /builds/slave/test/build/tests 14:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:06 INFO - trying https://queue.taskcluster.net/v1/task/FZnecyPcSui5Yo0HLDNHjg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 14:19:06 INFO - Downloading https://queue.taskcluster.net/v1/task/FZnecyPcSui5Yo0HLDNHjg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 14:19:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FZnecyPcSui5Yo0HLDNHjg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 14:19:07 INFO - Downloaded 1165 bytes. 14:19:07 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 14:19:07 INFO - Using the following test package requirements: 14:19:07 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 14:19:07 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:19:07 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 14:19:07 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:19:07 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 14:19:07 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:19:07 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:19:07 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 14:19:07 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 14:19:07 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:19:07 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 14:19:07 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:19:07 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 14:19:07 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:19:07 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 14:19:07 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:19:07 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 14:19:07 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 14:19:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FZnecyPcSui5Yo0HLDNHjg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 14:19:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FZnecyPcSui5Yo0HLDNHjg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 14:19:07 INFO - Fetch https://queue.taskcluster.net/v1/task/FZnecyPcSui5Yo0HLDNHjg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 14:19:08 INFO - Expected file size: 16108843 14:19:08 INFO - Obtained file size: 16108843 14:19:15 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 14:19:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FZnecyPcSui5Yo0HLDNHjg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 14:19:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FZnecyPcSui5Yo0HLDNHjg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 14:19:15 INFO - Fetch https://queue.taskcluster.net/v1/task/FZnecyPcSui5Yo0HLDNHjg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 14:19:16 INFO - Expected file size: 16108843 14:19:16 INFO - Obtained file size: 16108843 14:19:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FZnecyPcSui5Yo0HLDNHjg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 14:19:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FZnecyPcSui5Yo0HLDNHjg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 14:19:22 INFO - Fetch https://queue.taskcluster.net/v1/task/FZnecyPcSui5Yo0HLDNHjg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 14:19:23 INFO - Expected file size: 14403663 14:19:23 INFO - Obtained file size: 14403663 14:19: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')]} 14:19:23 INFO - trying https://queue.taskcluster.net/v1/task/FZnecyPcSui5Yo0HLDNHjg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 14:19:23 INFO - Downloading https://queue.taskcluster.net/v1/task/FZnecyPcSui5Yo0HLDNHjg/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 14:19:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FZnecyPcSui5Yo0HLDNHjg/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 14:19:25 INFO - Downloaded 58691563 bytes. 14:19:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FZnecyPcSui5Yo0HLDNHjg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 14:19:25 INFO - mkdir: /builds/slave/test/properties 14:19:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:19:25 INFO - Writing to file /builds/slave/test/properties/build_url 14:19:25 INFO - Contents: 14:19:25 INFO - build_url:https://queue.taskcluster.net/v1/task/FZnecyPcSui5Yo0HLDNHjg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 14:19:26 INFO - Running post-action listener: _resource_record_post_action 14:19:26 INFO - Running post-action listener: set_extra_try_arguments 14:19:26 INFO - [mozharness: 2017-03-30 21:19:26.208190Z] Finished download-and-extract step (success) 14:19:26 INFO - [mozharness: 2017-03-30 21:19:26.208352Z] Running populate-webroot step. 14:19:26 INFO - Running pre-action listener: _resource_record_pre_action 14:19:26 INFO - Running main action method: populate_webroot 14:19:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:19:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:19:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:19:26 INFO - '--tppagecycles', 14:19:26 INFO - '7'], 14:19:26 INFO - 'tests': ['tsvgm']}}, 14:19:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:19:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:19:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:19:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:19:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:19:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:19:26 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:19:26 INFO - 'talos_options': ['--disable-e10s'], 14:19:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:19:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:19:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:19:26 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:19:26 INFO - 'talos_options': ['--disable-e10s'], 14:19:26 INFO - 'tests': ['damp', 'tps']}, 14:19:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:19:26 INFO - 'tests': ['damp', 'tps']}, 14:19:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:19:26 INFO - 'tests': ['dromaeo_dom']}, 14:19:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:19:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:19:26 INFO - 'tests': ['basic_compositor_video']}, 14:19:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:19:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:19:26 INFO - 'tests': ['a11yr', 14:19:26 INFO - 'ts_paint', 14:19:26 INFO - 'tpaint', 14:19:26 INFO - 'sessionrestore', 14:19:26 INFO - 'sessionrestore_no_auto_restore', 14:19:26 INFO - 'tabpaint']}, 14:19:26 INFO - 'other-e10s': {'tests': ['a11yr', 14:19:26 INFO - 'ts_paint', 14:19:26 INFO - 'tpaint', 14:19:26 INFO - 'sessionrestore', 14:19:26 INFO - 'sessionrestore_no_auto_restore', 14:19:26 INFO - 'tabpaint']}, 14:19:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:19:26 INFO - 'ts_paint', 14:19:26 INFO - 'tpaint', 14:19:26 INFO - 'sessionrestore', 14:19:26 INFO - 'sessionrestore_no_auto_restore', 14:19:26 INFO - 'tabpaint']}, 14:19:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:19:26 INFO - 'ts_paint', 14:19:26 INFO - 'tpaint', 14:19:26 INFO - 'sessionrestore', 14:19:26 INFO - 'sessionrestore_no_auto_restore', 14:19:26 INFO - 'tabpaint']}, 14:19:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:19:26 INFO - 'tests': ['a11yr', 14:19:26 INFO - 'ts_paint', 14:19:26 INFO - 'tpaint', 14:19:26 INFO - 'sessionrestore', 14:19:26 INFO - 'sessionrestore_no_auto_restore', 14:19:26 INFO - 'tabpaint']}, 14:19:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:19:26 INFO - 'tests': ['a11yr', 14:19:26 INFO - 'ts_paint', 14:19:26 INFO - 'tpaint', 14:19:26 INFO - 'sessionrestore', 14:19:26 INFO - 'sessionrestore_no_auto_restore', 14:19:26 INFO - 'tabpaint']}, 14:19:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:19:26 INFO - 'tests': ['tsvgx', 14:19:26 INFO - 'tsvgr_opacity', 14:19:26 INFO - 'tart', 14:19:26 INFO - 'tscrollx', 14:19:26 INFO - 'cart', 14:19:26 INFO - 'tsvg_static']}, 14:19:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:19:26 INFO - 'tsvgr_opacity', 14:19:26 INFO - 'tart', 14:19:26 INFO - 'tscrollx', 14:19:26 INFO - 'cart', 14:19:26 INFO - 'tsvg_static']}, 14:19:26 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:19:26 INFO - 'talos_options': ['--disable-e10s'], 14:19:26 INFO - 'tests': ['tp5o']}, 14:19:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:19:26 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:19:26 INFO - 'talos_options': ['--disable-e10s', 14:19:26 INFO - '--xperf_path', 14:19:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:19:26 INFO - 'tests': ['tp5n']}, 14:19:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:19:26 INFO - 'talos_options': ['--xperf_path', 14:19:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:19:26 INFO - 'tests': ['tp5n']}}, 14:19:26 INFO - 'talos.zip': {'path': '', 14:19:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:19:26 INFO - Running post-action listener: _resource_record_post_action 14:19:26 INFO - [mozharness: 2017-03-30 21:19:26.228728Z] Finished populate-webroot step (success) 14:19:26 INFO - [mozharness: 2017-03-30 21:19:26.228846Z] Running create-virtualenv step. 14:19:26 INFO - Running pre-action listener: _resource_record_pre_action 14:19:26 INFO - Running main action method: create_virtualenv 14:19:26 INFO - Creating virtualenv /builds/slave/test/build/venv 14:19:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:19:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:19:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:19:26 INFO - Using real prefix '/tools/python27' 14:19:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:19:27 INFO - Installing distribute.............................................................................................................................................................................................done. 14:19:29 INFO - Installing pip.................done. 14:19:29 INFO - Return code: 0 14:19:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:19:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:19:30 INFO - Reading from file tmpfile_stdout 14:19:30 INFO - Output received: 14:19:30 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:19:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e0c92ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e94ad30>, '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 0x10e871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e93fbe8>, '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.XHJo4hCk5e/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.OgsOdV7p6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:19:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:19:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:19:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XHJo4hCk5e/Render', 14:19:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:30 INFO - 'HOME': '/Users/cltbld', 14:19:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:30 INFO - 'LOGNAME': 'cltbld', 14:19:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:30 INFO - 'MOZ_NO_REMOTE': '1', 14:19:30 INFO - 'NO_EM_RESTART': '1', 14:19:30 INFO - 'PAGER': '/bin/cat', 14:19:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:30 INFO - 'PWD': '/builds/slave/test', 14:19:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:30 INFO - 'SHELL': '/bin/bash', 14:19:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OgsOdV7p6b/Listeners', 14:19:30 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 14:19:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:30 INFO - 'USER': 'cltbld', 14:19:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:30 INFO - 'XPC_FLAGS': '0x0', 14:19:30 INFO - 'XPC_SERVICE_NAME': '0', 14:19:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:19:30 INFO - Cleaning up... 14:19:30 INFO - Return code: 0 14:19:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10eb6cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e0c92ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e94ad30>, '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 0x10e871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e93fbe8>, '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.XHJo4hCk5e/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.OgsOdV7p6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:19:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:19:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:19:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XHJo4hCk5e/Render', 14:19:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:30 INFO - 'HOME': '/Users/cltbld', 14:19:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:30 INFO - 'LOGNAME': 'cltbld', 14:19:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:30 INFO - 'MOZ_NO_REMOTE': '1', 14:19:30 INFO - 'NO_EM_RESTART': '1', 14:19:30 INFO - 'PAGER': '/bin/cat', 14:19:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:30 INFO - 'PWD': '/builds/slave/test', 14:19:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:30 INFO - 'SHELL': '/bin/bash', 14:19:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OgsOdV7p6b/Listeners', 14:19:30 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 14:19:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:30 INFO - 'USER': 'cltbld', 14:19:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:30 INFO - 'XPC_FLAGS': '0x0', 14:19:30 INFO - 'XPC_SERVICE_NAME': '0', 14:19:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:30 INFO - Downloading/unpacking psutil>=3.1.1 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:19:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:19:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:19:34 INFO - Installing collected packages: psutil 14:19:34 INFO - Running setup.py install for psutil 14:19:34 INFO - building 'psutil._psutil_osx' extension 14:19:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:19:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:19:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:19:35 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:19:35 INFO - building 'psutil._psutil_posix' extension 14:19:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:19:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:19:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:19:35 INFO - ^ 14:19:35 INFO - 1 warning generated. 14:19:35 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:19:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:19:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:19:35 INFO - Successfully installed psutil 14:19:35 INFO - Cleaning up... 14:19:35 INFO - Return code: 0 14:19:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:19:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:35 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 0x10eb6cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e0c92ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e94ad30>, '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 0x10e871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e93fbe8>, '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.XHJo4hCk5e/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.OgsOdV7p6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:19:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:19:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:19:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XHJo4hCk5e/Render', 14:19:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:35 INFO - 'HOME': '/Users/cltbld', 14:19:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:35 INFO - 'LOGNAME': 'cltbld', 14:19:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:35 INFO - 'MOZ_NO_REMOTE': '1', 14:19:35 INFO - 'NO_EM_RESTART': '1', 14:19:35 INFO - 'PAGER': '/bin/cat', 14:19:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:35 INFO - 'PWD': '/builds/slave/test', 14:19:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:35 INFO - 'SHELL': '/bin/bash', 14:19:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OgsOdV7p6b/Listeners', 14:19:35 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 14:19:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:35 INFO - 'USER': 'cltbld', 14:19:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:35 INFO - 'XPC_FLAGS': '0x0', 14:19:35 INFO - 'XPC_SERVICE_NAME': '0', 14:19:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:19:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:19:38 INFO - Installing collected packages: mozsystemmonitor 14:19:38 INFO - Running setup.py install for mozsystemmonitor 14:19:38 INFO - Successfully installed mozsystemmonitor 14:19:38 INFO - Cleaning up... 14:19:38 INFO - Return code: 0 14:19:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:38 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 0x10eb6cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e0c92ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e94ad30>, '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 0x10e871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e93fbe8>, '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.XHJo4hCk5e/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.OgsOdV7p6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:19:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:19:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XHJo4hCk5e/Render', 14:19:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:38 INFO - 'HOME': '/Users/cltbld', 14:19:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:38 INFO - 'LOGNAME': 'cltbld', 14:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:38 INFO - 'MOZ_NO_REMOTE': '1', 14:19:38 INFO - 'NO_EM_RESTART': '1', 14:19:38 INFO - 'PAGER': '/bin/cat', 14:19:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:38 INFO - 'PWD': '/builds/slave/test', 14:19:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:38 INFO - 'SHELL': '/bin/bash', 14:19:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OgsOdV7p6b/Listeners', 14:19:38 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 14:19:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:38 INFO - 'USER': 'cltbld', 14:19:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:38 INFO - 'XPC_FLAGS': '0x0', 14:19:38 INFO - 'XPC_SERVICE_NAME': '0', 14:19:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:38 INFO - Downloading/unpacking jsonschema==2.5.1 14:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:19:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:42 INFO - Downloading functools32-3.2.3-2.tar.gz 14:19:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:19:42 INFO - warning: no files found matching '*.txt' 14:19:42 INFO - no previously-included directories found matching 'build' 14:19:42 INFO - no previously-included directories found matching 'dist' 14:19:42 INFO - no previously-included directories found matching '.git*' 14:19:42 INFO - Installing collected packages: jsonschema, functools32 14:19:42 INFO - Running setup.py install for functools32 14:19:42 INFO - warning: no files found matching '*.txt' 14:19:42 INFO - no previously-included directories found matching 'build' 14:19:42 INFO - no previously-included directories found matching 'dist' 14:19:42 INFO - no previously-included directories found matching '.git*' 14:19:42 INFO - Successfully installed jsonschema functools32 14:19:42 INFO - Cleaning up... 14:19:42 INFO - Return code: 0 14:19:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10eb6cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e0c92ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e94ad30>, '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 0x10e871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e93fbe8>, '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.XHJo4hCk5e/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.OgsOdV7p6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:19:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:19:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XHJo4hCk5e/Render', 14:19:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:42 INFO - 'HOME': '/Users/cltbld', 14:19:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:42 INFO - 'LOGNAME': 'cltbld', 14:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:42 INFO - 'MOZ_NO_REMOTE': '1', 14:19:42 INFO - 'NO_EM_RESTART': '1', 14:19:42 INFO - 'PAGER': '/bin/cat', 14:19:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:42 INFO - 'PWD': '/builds/slave/test', 14:19:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:42 INFO - 'SHELL': '/bin/bash', 14:19:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OgsOdV7p6b/Listeners', 14:19:42 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 14:19:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:42 INFO - 'USER': 'cltbld', 14:19:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:42 INFO - 'XPC_FLAGS': '0x0', 14:19:42 INFO - 'XPC_SERVICE_NAME': '0', 14:19:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:19:42 INFO - Cleaning up... 14:19:42 INFO - Return code: 0 14:19:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10eb6cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e0c92ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e94ad30>, '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 0x10e871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e93fbe8>, '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.XHJo4hCk5e/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.OgsOdV7p6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:19:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:19:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XHJo4hCk5e/Render', 14:19:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:42 INFO - 'HOME': '/Users/cltbld', 14:19:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:42 INFO - 'LOGNAME': 'cltbld', 14:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:42 INFO - 'MOZ_NO_REMOTE': '1', 14:19:42 INFO - 'NO_EM_RESTART': '1', 14:19:42 INFO - 'PAGER': '/bin/cat', 14:19:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:42 INFO - 'PWD': '/builds/slave/test', 14:19:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:42 INFO - 'SHELL': '/bin/bash', 14:19:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OgsOdV7p6b/Listeners', 14:19:42 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 14:19:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:42 INFO - 'USER': 'cltbld', 14:19:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:42 INFO - 'XPC_FLAGS': '0x0', 14:19:42 INFO - 'XPC_SERVICE_NAME': '0', 14:19:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:42 INFO - Downloading/unpacking blobuploader==1.2.4 14:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:45 INFO - Downloading blobuploader-1.2.4.tar.gz 14:19:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:19:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:19:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:46 INFO - Downloading docopt-0.6.1.tar.gz 14:19:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:19:46 INFO - Installing collected packages: blobuploader, requests, docopt 14:19:46 INFO - Running setup.py install for blobuploader 14:19:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:19:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:19:47 INFO - Running setup.py install for requests 14:19:47 INFO - Running setup.py install for docopt 14:19:47 INFO - Successfully installed blobuploader requests docopt 14:19:47 INFO - Cleaning up... 14:19:47 INFO - Return code: 0 14:19:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:19:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:47 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 0x10eb6cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e0c92ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e94ad30>, '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 0x10e871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e93fbe8>, '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.XHJo4hCk5e/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.OgsOdV7p6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:19:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:19:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:19:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XHJo4hCk5e/Render', 14:19:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:47 INFO - 'HOME': '/Users/cltbld', 14:19:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:47 INFO - 'LOGNAME': 'cltbld', 14:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:47 INFO - 'MOZ_NO_REMOTE': '1', 14:19:47 INFO - 'NO_EM_RESTART': '1', 14:19:47 INFO - 'PAGER': '/bin/cat', 14:19:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:47 INFO - 'PWD': '/builds/slave/test', 14:19:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:47 INFO - 'SHELL': '/bin/bash', 14:19:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OgsOdV7p6b/Listeners', 14:19:47 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 14:19:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:47 INFO - 'USER': 'cltbld', 14:19:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:47 INFO - 'XPC_FLAGS': '0x0', 14:19:47 INFO - 'XPC_SERVICE_NAME': '0', 14:19:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:19:48 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-1VGcmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:19:48 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-8ZjZqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:19:48 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-Gs7H6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:19:48 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-Az9vTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:19:48 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-NZfEK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:19:48 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-mrc6VZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:19:48 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-cnCw9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:19:48 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-67chH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:19:48 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-eRA2LN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:19:49 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-u3zDrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:19:49 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-aXVFnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:19:49 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-UubAF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:19:49 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-kd6R7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:19:49 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-anmJWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:19:49 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-GkaJr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:19:49 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-y4fGn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:19:49 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-gQeyV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:19:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:19:49 INFO - Running setup.py install for manifestparser 14:19:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:19:50 INFO - Running setup.py install for mozcrash 14:19:50 INFO - Running setup.py install for mozdebug 14:19:50 INFO - Running setup.py install for mozdevice 14:19:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:19:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:19:50 INFO - Running setup.py install for mozfile 14:19:50 INFO - Running setup.py install for mozhttpd 14:19:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:19:50 INFO - Running setup.py install for mozinfo 14:19:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:19:50 INFO - Running setup.py install for mozInstall 14:19:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:19:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:19:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:19:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:19:51 INFO - Running setup.py install for mozleak 14:19:51 INFO - Running setup.py install for mozlog 14:19:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:19:51 INFO - Running setup.py install for moznetwork 14:19:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:19:51 INFO - Running setup.py install for mozprocess 14:19:51 INFO - Running setup.py install for mozprofile 14:19:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:19:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:19:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:19:51 INFO - Running setup.py install for mozrunner 14:19:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:19:52 INFO - Running setup.py install for mozscreenshot 14:19:52 INFO - Running setup.py install for moztest 14:19:52 INFO - Running setup.py install for mozversion 14:19:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:19:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:19:52 INFO - Cleaning up... 14:19:52 INFO - Return code: 0 14:19:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:52 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 0x10eb6cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e0c92ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e94ad30>, '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 0x10e871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e93fbe8>, '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.XHJo4hCk5e/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.OgsOdV7p6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:19:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:19:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XHJo4hCk5e/Render', 14:19:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:52 INFO - 'HOME': '/Users/cltbld', 14:19:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:52 INFO - 'LOGNAME': 'cltbld', 14:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:52 INFO - 'MOZ_NO_REMOTE': '1', 14:19:52 INFO - 'NO_EM_RESTART': '1', 14:19:52 INFO - 'PAGER': '/bin/cat', 14:19:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:52 INFO - 'PWD': '/builds/slave/test', 14:19:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:52 INFO - 'SHELL': '/bin/bash', 14:19:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OgsOdV7p6b/Listeners', 14:19:52 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 14:19:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:52 INFO - 'USER': 'cltbld', 14:19:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:52 INFO - 'XPC_FLAGS': '0x0', 14:19:52 INFO - 'XPC_SERVICE_NAME': '0', 14:19:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:19:52 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-H1ovkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:19:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:19:52 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-w8Qmsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:19:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:19:52 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-m3Adi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:19:53 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-u1mcLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:19:53 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-FTHiKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:19:53 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-ud4ciJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:19:53 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-hydnf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:19:53 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-eBtcOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:19:53 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-lXg2Ao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:19:53 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-OfbG1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:19:53 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-KkkiL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:19:53 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-SEPSAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:19:54 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-ArowO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:19:54 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-jyGYiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:19:54 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-27foLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:19:54 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-uCfJjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:19:54 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-gyaH1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:19:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:57 INFO - Downloading blessings-1.6.tar.gz 14:19:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:19:57 INFO - Installing collected packages: blessings 14:19:57 INFO - Running setup.py install for blessings 14:19:57 INFO - Successfully installed blessings 14:19:57 INFO - Cleaning up... 14:19:57 INFO - Return code: 0 14:19:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:19:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:19:57 INFO - Reading from file tmpfile_stdout 14:19:57 INFO - Current package versions: 14:19:57 INFO - blessings == 1.6 14:19:57 INFO - blobuploader == 1.2.4 14:19:57 INFO - docopt == 0.6.1 14:19:57 INFO - functools32 == 3.2.3-2 14:19:57 INFO - jsonschema == 2.5.1 14:19:57 INFO - manifestparser == 1.1 14:19:57 INFO - mozInstall == 1.12 14:19:57 INFO - mozcrash == 1.0 14:19:57 INFO - mozdebug == 0.1 14:19:57 INFO - mozdevice == 0.49 14:19:57 INFO - mozfile == 1.2 14:19:57 INFO - mozhttpd == 0.7 14:19:57 INFO - mozinfo == 0.9 14:19:57 INFO - mozleak == 0.1 14:19:57 INFO - mozlog == 3.4 14:19:57 INFO - moznetwork == 0.27 14:19:57 INFO - mozprocess == 0.24 14:19:57 INFO - mozprofile == 0.28 14:19:57 INFO - mozrunner == 6.13 14:19:57 INFO - mozscreenshot == 0.1 14:19:57 INFO - mozsystemmonitor == 0.3 14:19:57 INFO - moztest == 0.8 14:19:57 INFO - mozversion == 1.4 14:19:57 INFO - psutil == 3.1.1 14:19:57 INFO - requests == 1.2.3 14:19:57 INFO - wsgiref == 0.1.2 14:19:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:19: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')]} 14:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:58 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 0x10eb6cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e0c92ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e94ad30>, '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 0x10e871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e93fbe8>, '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.XHJo4hCk5e/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.OgsOdV7p6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:19:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:19:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:19:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XHJo4hCk5e/Render', 14:19:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:58 INFO - 'HOME': '/Users/cltbld', 14:19:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:58 INFO - 'LOGNAME': 'cltbld', 14:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:58 INFO - 'MOZ_NO_REMOTE': '1', 14:19:58 INFO - 'NO_EM_RESTART': '1', 14:19:58 INFO - 'PAGER': '/bin/cat', 14:19:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:58 INFO - 'PWD': '/builds/slave/test', 14:19:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:58 INFO - 'SHELL': '/bin/bash', 14:19:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OgsOdV7p6b/Listeners', 14:19:58 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 14:19:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:58 INFO - 'USER': 'cltbld', 14:19:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:58 INFO - 'XPC_FLAGS': '0x0', 14:19:58 INFO - 'XPC_SERVICE_NAME': '0', 14:19:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:19:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:19:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:19:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:19:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:19:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:19:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:19:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:19:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:19:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:19:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:19:58 INFO - Cleaning up... 14:19:58 INFO - Return code: 0 14:19:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:19:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:59 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 0x10eb6cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e0c92ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e94ad30>, '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 0x10e871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e93fbe8>, '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.XHJo4hCk5e/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.OgsOdV7p6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:19:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:19:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XHJo4hCk5e/Render', 14:19:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:59 INFO - 'HOME': '/Users/cltbld', 14:19:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:59 INFO - 'LOGNAME': 'cltbld', 14:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:59 INFO - 'MOZ_NO_REMOTE': '1', 14:19:59 INFO - 'NO_EM_RESTART': '1', 14:19:59 INFO - 'PAGER': '/bin/cat', 14:19:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:59 INFO - 'PWD': '/builds/slave/test', 14:19:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:59 INFO - 'SHELL': '/bin/bash', 14:19:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OgsOdV7p6b/Listeners', 14:19:59 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 14:19:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:59 INFO - 'USER': 'cltbld', 14:19:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:59 INFO - 'XPC_FLAGS': '0x0', 14:19:59 INFO - 'XPC_SERVICE_NAME': '0', 14:19:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:19:59 INFO - Cleaning up... 14:19:59 INFO - Return code: 0 14:19:59 INFO - Running post-action listener: _resource_record_post_action 14:19:59 INFO - Running post-action listener: _start_resource_monitoring 14:19:59 INFO - Starting resource monitoring. 14:19:59 INFO - [mozharness: 2017-03-30 21:19:59.500306Z] Finished create-virtualenv step (success) 14:19:59 INFO - [mozharness: 2017-03-30 21:19:59.501256Z] Running install step. 14:19:59 INFO - Running pre-action listener: _resource_record_pre_action 14:19:59 INFO - Running main action method: install 14:19:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:19:59 INFO - Reading from file tmpfile_stdout 14:19:59 INFO - Detecting whether we're running mozinstall >=1.0... 14:19:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:19:59 INFO - Reading from file tmpfile_stdout 14:19:59 INFO - Output received: 14:19:59 INFO - Usage: mozinstall [options] installer 14:19:59 INFO - Options: 14:19:59 INFO - -h, --help show this help message and exit 14:19:59 INFO - -d DEST, --destination=DEST 14:19:59 INFO - Directory to install application into. [default: 14:19:59 INFO - "/builds/slave/test"] 14:19:59 INFO - --app=APP Application being installed. [default: firefox] 14:19:59 INFO - mkdir: /builds/slave/test/build/application 14:19:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 14:20:14 INFO - Reading from file tmpfile_stdout 14:20:14 INFO - Output received: 14:20:14 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:20:14 INFO - Running post-action listener: _resource_record_post_action 14:20:14 INFO - [mozharness: 2017-03-30 21:20:14.354750Z] Finished install step (success) 14:20:14 INFO - [mozharness: 2017-03-30 21:20:14.354888Z] Running run-tests step. 14:20:14 INFO - Running pre-action listener: _resource_record_pre_action 14:20:14 INFO - Running main action method: run_tests 14:20:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:20:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:20:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:20:14 INFO - 2017-03-30 14:20:14.369 screenresolution[1629:7512] starting screenresolution argv=screenresolution get 14:20:14 INFO - 2017-03-30 14:20:14.372 screenresolution[1629:7512] Display 0: 1600x1200x32@60 14:20:14 INFO - 2017-03-30 14:20:14.378 screenresolution[1630:7514] starting screenresolution argv=screenresolution list 14:20:14 INFO - Available Modes on Display 0 14:20:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:20:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:20:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:20:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:20:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:20:14 INFO - Intel Iris: 14:20:14 INFO - Chipset Model: Intel Iris 14:20:14 INFO - Type: GPU 14:20:14 INFO - Bus: Built-In 14:20:14 INFO - VRAM (Dynamic, Max): 1536 MB 14:20:14 INFO - Vendor: Intel (0x8086) 14:20:14 INFO - Device ID: 0x0a2e 14:20:14 INFO - Revision ID: 0x0009 14:20:14 INFO - Displays: 14:20:14 INFO - Display: 14:20:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:20:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:20:14 INFO - Display Serial Number: 1600x1200 60 14:20:14 INFO - Main Display: Yes 14:20:14 INFO - Mirror: Off 14:20:14 INFO - Online: Yes 14:20:14 INFO - Rotation: Supported 14:20:14 INFO - Return code: 0 14:20:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:20:14 INFO - Python 2.7.3 14:20:14 INFO - Return code: 0 14:20:14 INFO - grabbing minidump binary from tooltool 14:20: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')]} 14:20:14 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 0x10e94ad30>, '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 0x10e871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e93fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:20:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:20:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:20:14 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:20:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:20:14 INFO - Return code: 0 14:20:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:20:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:20:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:20:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:20:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:20:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FZnecyPcSui5Yo0HLDNHjg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FZnecyPcSui5Yo0HLDNHjg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:20:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XHJo4hCk5e/Render', 14:20:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:20:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:20:14 INFO - 'HOME': '/Users/cltbld', 14:20:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:20:14 INFO - 'LOGNAME': 'cltbld', 14:20:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:20:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:14 INFO - 'MOZ_NO_REMOTE': '1', 14:20:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:20:14 INFO - 'NO_EM_RESTART': '1', 14:20:14 INFO - 'PAGER': '/bin/cat', 14:20:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:14 INFO - 'PWD': '/builds/slave/test', 14:20:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:20:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:20:14 INFO - 'SHELL': '/bin/bash', 14:20:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OgsOdV7p6b/Listeners', 14:20:14 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 14:20:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:20:14 INFO - 'USER': 'cltbld', 14:20:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:20:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:14 INFO - 'XPC_FLAGS': '0x0', 14:20:14 INFO - 'XPC_SERVICE_NAME': '0', 14:20:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:20:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FZnecyPcSui5Yo0HLDNHjg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:20:14 INFO - mozversion application_buildid: 20170330124805 14:20:14 INFO - mozversion application_changeset: fe3e3c0ea489cea724da1bd56ce20fe843d96a9e 14:20:14 INFO - mozversion application_display_name: Firefox 14:20:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:20:14 INFO - mozversion application_name: Firefox 14:20:14 INFO - mozversion application_remotingname: firefox 14:20:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:20:14 INFO - mozversion application_vendor: Mozilla 14:20:14 INFO - mozversion application_version: 53.0 14:20:14 INFO - mozversion platform_buildid: 20170330124805 14:20:14 INFO - mozversion platform_changeset: fe3e3c0ea489cea724da1bd56ce20fe843d96a9e 14:20:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:20:14 INFO - mozversion platform_version: 53.0 14:20:14 INFO - using testdate: 1490908814 14:20:14 INFO - actual date: 1490908814 14:20:14 INFO - starting webserver on 'localhost:49242' 14:20:14 INFO - SUITE-START | Running 2 tests 14:20:14 INFO - TEST-START | dromaeo_css 14:20:14 INFO - operating with platform_type : mac_ 14:20:14 INFO - Initialising browser for dromaeo_css test... 14:20:15 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmpjhinxl/profile http://localhost:49242/getInfo.html) 14:20:17 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 14:20:17 INFO - PROCESS | 1640 | colorDepth:24 14:20:17 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 14:20:17 INFO - PROCESS | 1640 | __metrics 14:20:17 INFO - PROCESS | 1640 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:20:17 INFO - PROCESS | 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:20:17 INFO - TEST-INFO | 1640: exit 0 14:20:17 INFO - Browser initialized. 14:20:17 INFO - Running cycle 1/1 for dromaeo_css test... 14:20:17 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmpjhinxl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:20:30 INFO - PROCESS | 1643 | RSS: Main: 163131392 14:20:30 INFO - PROCESS | 1643 | 14:23:32 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 14:23:34 INFO - PROCESS | 1643 | RSS: Main: 297144320 14:23:34 INFO - PROCESS | 1643 | 14:26:37 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 14:26:37 INFO - PROCESS | 1643 | RSS: Main: 309551104 14:26:37 INFO - PROCESS | 1643 | 14:29:40 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 14:29:40 INFO - PROCESS | 1643 | RSS: Main: 281952256 14:29:40 INFO - PROCESS | 1643 | 14:32:43 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 14:32:43 INFO - PROCESS | 1643 | RSS: Main: 288735232 14:32:43 INFO - PROCESS | 1643 | 14:35:46 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 14:35:47 INFO - PROCESS | 1643 | RSS: Main: 269611008 14:35:47 INFO - PROCESS | 1643 | 14:38:50 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 14:38:50 INFO - PROCESS | 1643 | RSS: Main: 312782848 14:38:50 INFO - PROCESS | 1643 | 14:38:50 INFO - PROCESS | 1643 | __start_tp_report 14:38:50 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 14:38:50 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 14:38:50 INFO - PROCESS | 1643 | |i|pagename|runs| 14:38:50 INFO - PROCESS | 1643 | |0;dojo.html;3266.9346613067737;3433.742469314802;3455.6889879910805;3472.114610774252;3493.16164120611;4856.927146092807;5848.502877255439;5856.004479238529;5857.209276747638;5869.9999999999945;5800.709964501779;5854.238948936632;5874.206982057421;5875.970620146904;5885.823425297237;5256.3955145158225;5294.973525132369;5297.17893726473;5320.680759154444;5333.040052790496;5239.633225674204;5247.973760131213;5251.2385704072885;5366.356037275533;5368.248445217672;3964.2864284428933;5167.379914410257;5269.841904742864;5328.5470734987375;5333.120035194188;5307.840764777044;5343.305370301855;5345.786168553253;5346.545543628797;5352.304200453955;5218.8695282617855;5259.710715910624;5293.020791153649;5303.681779093266;5335.0663633863915;5678.26182596264;5706;5709.628874123168;5718.942810571883;5858.677772722499;5226.503482169188;6361.173047503795;6375.87248255037;6377.07532407803;6384.52116091295;6302;6360.618362898241;6363.854506188884;6368.936310636927;6372.139761132281;5779.075347944308;5867.735951882176;5910;5951.196588460546;5953.374895635982;6263.655498947511;6367.968160159169;6375.776847810397;6383.680815959184;6428.19647544057;6337.144485494491;6341.714622841983;6347.460465860361;6348.682565871688;6352.587081839758;6238.844028899314;6348.111264422984;6351;6362.331955144736;6362.363763623694;6160.599561028519;6226.750929962751;6268.9969604863;6324;6343.904841427382;6363.7772677956045;6381.8085457436355;6383.521235907326;6392.4246817786625;6403.103565500834;5051.974740126276;5054.545090941833;5054.823081192214;5065.949340506621;5085.593152547787;4434.84478043267;4443.866683999485;4447.977760111244;4466.977665111654;4486.3494793254795;5812.157237200582;5848.210491583667;5862.267216597926;5870.735816888165;5886.587938844325;6322.968385158045;6351.237851457762;6370.362963703593;6374.203224596926;6388.872222555523;5532.1425179097305;5824.650520968756;5831.096180092092;5851.473367396955;5887.970560147258;5483.122700367922;5529.778808847601;5539.362973258047;5550.833474995757;5562.137868630369;5373.516383525502;6318.178636777189;6380.202474690664;6383.968080159662;6397.136386587751;5323.201519772065;6311.621302721851;6331.240251169889;6335.524835637253;6360.745570177141;6379.840503987438;6419.582727122722;6422.678866056772;6437.613743175424;6462.515311351762;6150.569460137926;6216.689165541615;6350.110984462087;6351.745930162741;6376.426121649074;5661.179129026351;6159.692015399301;6304.936950630435;6308.747650093945;6348.269948955744;6251.437370636664;6271.811845644455;6274.874502509833;6280.403361680633;6292.559520833498;6060.606060606046;6292.496600271876;6296.181496405438;6302.9684851577285;6326;5996.310424301261;6052.122442245938;6058.787942421994;6120.60216085953;6127.9837278401355;5265.552428043506;5356.758945847524;5954.583179177416;6288.5283603728985;6336.017917222838;6093.086037094471;6102.0541816018585;6130.856783744145;6132.540059495466;6134.294556126102 14:38:50 INFO - PROCESS | 1643 | |1;ext.html;500.82971789591545;518.5566340778635;538.6148903533972;539.094321539813;544.7902557515356;26252.737472625293;34142.65857341429;42717;42975.92560185997;45077;43981;44470.33294500585;44478.55521444784;44490.7775461123;44566.55433445665;8855.203031727144;9505.904940950588;9725.465099419529;9732.854007189862;9733.270004749636;8968.910310896905;11459.656210313662;11681.357525336103;11708.12189085822;11879.881201188007;11596.942015289911;11712.53149874004;11719.238249513797;11719.472623731952;11723;11581.478833452515;11631.6510504685;11637.47631356591;11656.59201927937;11658.6502404928;11476.540938362456;11573.42132893352;11595.130365222642;11600.361980091091;11604.361760103191;40616.78149655515;40724.796376017934;40800.59199407998;40879;40907.386389204185;3512.5960514540643;4097.97951010243;4098.754074755494;4157.397177409289;4185.811638476276;30274.84862575695;32405.675943240738;32699.509507357172;33005.834970824995;33163.83418082894;3253.5607692961385;3292.209869631295;3380.3070370573973;3406.42090844557;3416.521686963827;498090;501927;502671;504016;505307;67653.66173169202;67930;67961.66019169873;68079.65960170167;68184.6590767043;71197.64401178065;71272.28727712657;71403.28596713966;71637;71659;17039;17682;17715.645687086442;17719.73420398695;17745.556361090818;12628.431720572597;12846.421911014028;13820.447182112805;13879.097858639156;13954.790678139836;18126.456206313833;18303.72544411835;18309.992950387856;18506.907465462587;18543;6588.96705516479;6651.102101216371;6695.263521012685;6712.697928593225;6734.427573656294;828.411827602397;866.6663334616092;881.3918396306528;884.186548375496;915.2677857713802;24867.751322486543;30585.694143058285;30803.383932321227;30972.22569435737;31418.528722069186;986.659602437158;1096.7313008312856;1125.6904351303458;1137.4530638331862;1198.5984695127056;15683.607909802118;16048.679026419406;16085.35658573644;16182.838171618369;16474.75287870683;632561;633030;634462;638145.8092709506;640184;63234;63948;64100;64226.35773642204;64425.67787161034;1194.4445832687843;1344.0860215053663;1391.7912313153108;1494.9701005980037;1495.7532007218688;24865.87567062153;31532.369352613277;32275.838620807684;32293.677063230007;32933.17667058247;53737.46262537324;54304;54474.91050179054;54491.72754136204;54506.72746636241;520934;521387;522028.779712198;522033;774916;33151.66848331486;34275;34351.82824085864;35739;45913;47833.52166478291;48237.276440852715;48780.02439951252;51194.74402627963;51234.74382628063;30415.847920760254;31643.84178079187;34030;34883.82558087193;35154.64845351616;33176.50235246425;33327.83336083304;33380;34520.48219276763;34583.308333832676;37375.06562335963;37986.050348741504;40081.398779017756;40150.59849401469;40267.597324027556;30630.540541892336;30916;31116.22209444782;31739.682603174595;31888.36223275475;19078.61842763165;20278.695819562425;24907.87546062258;25016;25574.616380754676 14:38:50 INFO - PROCESS | 1643 | |2;jquery.html;396.34602905206407;398.2353880549345;402.74828232354776;406.90844559974;427.1350515206708;19933.3023344183;21159.259425920096;21164;21186.788132118676;21882.452938676543;12479.1264611477;12598.685032874182;12619.684507887307;12721;12764.361781910913;5444.972775136119;5478.753456094475;5650.29371328584;5704.828855134353;5736.254286942692;5531.363893152278;5689.6017278790505;5700.743466543995;5705.400932902048;5705.942940570603;4153.439285696438;4358.912821743564;4361.95313124851;5617.691026993513;6283.528735344845;6290.276618188921;6370.0763389308295;6373.298937116913;6391.265004524469;6948.6525673716615;6192.504599632019;6239.968800156015;6279.623222606659;6290.276618188921;6295.5907865988565;14111.223882686449;14260.786088208684;14262.358193881197;14271.78592321116;23076.076956921872;2711.3357227479196;2721.142840005392;2758.1449750577185;2758.2276962450546;2789.27478855497;8863.335249856287;10258.487075646188;10268.973102689746;10602.787944241149;10734.838977415346;1790.7134858422721;1874.9437516874516;1898.2691663709434;1921.4619906426083;1976.2193933396372;130895;145402;146367;149352;152822.23588882096;11893.821592676117;12283.508659653693;12347.38263086842;12451.003919686404;12466.252024878537;15859.127747973742;15891.364345426053;16064.27710753019;16267.430639927547;16302.83697163037;6913.239543650195;7017.754378596725;8843.425177363451;9197.954010229905;9318.30112741547;8971.282297416192;9000.8649870252;9006.729798106067;9160.083991600919;9185.724428267162;4798.976005119952;4865.367502224759;4873.074115917964;4890.266460030953;4942.5304596063315;1769.4868488138552;2040.8163265306193;2087.9895600522204;2089.613421517024;2090.4669309326327;882.6998820401094;930.4835816122118;1032.6643840751785;1061.6708820265587;1064.4305296666246;21646.56706865854;21903;22021.22925697593;22021.22925697625;22072.00675969585;1054.841773733946;1069.550788668761;1091.3342860854873;1100.7523307255963;1107.2360071550604;9833.508324583741;11241.55033798639;11260.380679062566;11293.322400655987;11310.943445282886;758528;760039;768177;781948;786438;150180.24909875382;164104;170375;171397.57204855833;172714;1068.1721665708983;1092.415557676639;1116.9497372618252;1122.9382383968796;1128.8758236593967;19822;20059.39821805348;20545.691814623093;20665.863377514383;20666.070026849127;58891.17207381506;59701.40298596959;59740;59750.402495974486;60050.699746500984;83791;89484.5525772367;92053;93033.60449593126;95696;7457.105147382349;8083.474574152661;8376.455530390505;8512.446690965067;8849.91150088491;11366.261193022427;12806.039547034195;13106.148100373444;13273.66815829612;13364.732705345645;10983.890161098287;11169.385683787144;11399.373034483184;11554.364509952033;11610.767784644091;9005.909940900507;10074.14369778577;10548.578056877639;10629.9468502657;11009.944950275198;11431.59989400367;11615.941920290345;11793.941030294794;11817.82273265919;11935.104867134825;7581.355584775356;7620.961895190489;7659.77020689358;7919.881201782093;7970.4819186752675;10449.84325235107;10921.508532115915;11465.656030319104;11512.906273903965;11519 14:38:50 INFO - PROCESS | 1643 | |3;mootools.html;1389.3192335755482;1483.0582580061657;1488.8660020598147;1510.6147932277272;1511.667433164704;7595.126560445544;8017.398695097869;8216.30161436278;8360;8485.78785530362;8419.410641255115;8520.19058189471;8537.060923298432;8537.10360412157;8542.743717688463;2123.479747461874;2370.5021945391445;2405.4467472481338;2408.301592538162;2413.5293617744546;2204.019211450905;2223.0774228695072;2224.2215224671318;2224.3660556741333;2331.160782118436;2369.5497855407502;2392.868392238426;2395.724491683461;2396.0535588442553;2400.9039638414442;2342.9179978700836;2367.656689779972;2369.763023697634;2377.025419577965;2380.155044959049;2091.215794077221;2399.1602938971396;2414.770596793302;2429.125514814665;2433.1605596069326;8305.584720763998;8477.279431248351;8568.400211985101;8576.785580360478;8593.226609605103;5157.742112894341;5321.813736519242;5321.893562128775;5330.466953304638;5338;3473.322702073097;3576.3204991051875;3604.189057462076;3643.1802844360072;3644.2711457708565;1236.8021116621387;1246.9875301246961;1289.5164313382481;1289.851667058291;1290.7289469211478;10904.50929708165;10960.12319014477;10961.451927403677;10965.671029869038;10966.616168434146;4289.691644048595;4594.494605593382;4645.535446455395;4828.203346447867;4835.44392394872;8703.738887833375;8858.98121715998;8863.290936725047;8871.866921996176;8880.911190888137;5239.214117882349;5242.213667949762;5273.34083239595;5292.047431462373;5292.735363231823;4737.38414006177;4745;4832.782524786393;4953.23224900141;4965.404151501771;3549;3661.6338366163704;3666.926661466756;3758.1356288053903;3863.36254518007;1080.0873262093519;1112.8775834658181;1116.6203490813;1123.528118190362;1124.651358078998;797.2744802229943;801.6192308653459;812.9147587970008;818.2553875972956;827.9793005174919;5188.584913206934;5548.195511650869;5880.176775251468;5898.675572843449;5981.581289309794;967.9032096790264;986.6398764451068;1032.4218437674926;1046.6755305855208;1064.2656566968767;3047.4362242985117;3711.888643340704;3841.3469710148784;3957.703172262092;4003.2393845169327;9907.356021858555;10047.346922450017;10131.594736210469;10158.796824063478;10166.135878450414;9725.6596019139;10004.149647280063;10091.596336146618;10110.646127385506;10113.039261270167;7966.322862556747;8155.632996515171;8163.918360816435;8163.959180204061;8175.182481751896;5539.390667026543;5586.944130558642;5602.13166959122;5754.741036653444;5775.364709881826;9369.109934556207;9436.480993545421;9456.574454149717;9464.858027129461;9507.572159252988;8111.675532978615;9247.491387973727;9396.201322887631;9489.383190092622;9633.614655413705;6834.726610935507;6841.726330946706;6896.344847239504;6940.687669055005;6966.338197871194;7967.083785364757;7979.361651067785;8051.315638170821;8059.073206581318;8061.798455038671;6883.139607549057;7094.758417277059;7101.680424381018;7218.27817218274;7230.855382892418;6866.485013623898;6927.064846245692;6935.89596156048;7116.537425067561;7122.074130363019;6434.195725534309;6579.769708060195;6581.572197807127;6587.934120658732;6591.670416479253;5011.09800235961;5030.723310217973;5046.646734728533;5051.494850514919;5073.797048118182;5021.397432308147;5064.366954130734;5180.870478238075;5225.634205605571;5239.869003274796 14:38:50 INFO - PROCESS | 1643 | |4;prototype.html;336.4012058535806;367.2251549231122;371.715637537284;383.0786957367532;384.54815591679767;5114.411842638097;5306.787728490865;5374.677519348842;5382.004329199096;5478.479544443281;5179.637425380225;5272.314599102121;5350.866228344294;5373.704446255454;5400.1909360364225;3851.2682590307822;4006.939895901564;4232.545123828188;4244.0026593750445;4248.27779277522;3448.8789394522314;3634.200475895299;3740.5698344690436;3969.4045893115976;4295;3836.139472355905;4079.327475734949;4181.205570941526;4198.8320467181275;4237.449131612886;3846.230753849213;4156.233600719682;4164.521080075785;4170.270202714543;4188.769617671027;3732.962670373289;3733.8693145739767;3756.2487502499607;3780.2250538639787;3824.139568597071;5052.867222322184;5177.922331165036;5212.400573934008;5226.536569760473;5306.283651707047;4814.448342378545;4830.468648448667;4847.5394837490385;4857.465678775332;4898.828541001048;5382.515573598395;5655.293088363955;5686.526361032964;5699.779624512179;5716.799912003102;3859.363205071188;3955.703322250814;4094.6896992962265;4126.525449573308;4150.335946248586;5476.698781566973;5928.49607783339;5958.454719441925;5972.044472884318;5972.163897054415;3601.837917293728;4217.8523751668545;4231.640310573574;4259.829606815754;4268.743875367488;4088.8959980805016;4089.8159582818844;4258.041940563348;4264.848490907438;4308.80610372534;4314.576189857339;4563.338315944236;4853.733044682505;4863.367762190964;4891.26631005352;5520.282363292747;5713.74288157034;5721.05484135396;5762.366139724627;5785.797497087582;1255.8744125587368;1316.5655333739842;1353.627752368087;1391.9930400347932;1405.5994041698068;939.9765005874908;942.9528523573794;976.0191008037019;978.0952618827556;983.2527279267808;4223.260929337353;4413.051193993243;4898.779554920037;5062.215356619729;5083.872903177376;4994.450610432849;5189.325387699575;5466.590005749585;5511.255980442589;5524.58565607581;4209.873703788891;4399.450068741407;4885;4958.801647934042;5091.1926266175715;2801.7898657600763;2891.66983187736;2892.7685785137137;2901.7823663225345;2908.636420447444;4954.482317554504;5601.047821870292;5650.654978184008;5690.630109042899;5724.885502289931;5032.094223039815;5126.38483381989;5366.865828354323;5674.290713660793;6095;5139.743012849342;5160.432352441304;5337.653052551572;6105.48103411215;6165.938340616716;4984.401871775265;5219.660722053054;5946.464818166386;5954.345022047658;5969.030969030969;5429.592780541554;5708.315002199763;5743.282089738783;5749.511291540099;5781.508571771446;5511.4213007633625;5587.916181257203;5788.758295354615;6031.728572214349;6038.5772995889865;3757.1734218471893;3795.1650636859845;3926.9607303926596;3964.286428442908;3999.7800120993625;4580.954190458053;5798.768049277982;5813.6221145625395;5834.18321435008;5942.494887934401;5113.696007518059;5126.6923984561045;5378.973105134606;5448.482394172547;5658.886822263614;5225.764840582106;5608.775648973995;5631.493165615114;5645.781904314501;5705.343885453226;5088.796448142181;5542.584306176972;5553.972230138824;5554.333479982428;5561.694106824163;5254.60590455725;5646.887062258814;5668;5669.185860524757;5679;4860.854174374775;5375.59683023767;5454.618176727591;5499.807506737245;5537.501624853782 14:38:50 INFO - PROCESS | 1643 | |5;yui.html;743.126825979474;760.9124950630679;800.6437135474716;837.8952630921135;850.6002178975883;15233.238338083092;15810.762838557403;15811.051336919778;15839.049657020572;15872.365105395798;14465.132092074484;14511.346989385476;14515.782263266059;14601.634959126;14632.634184145401;730.6054730445553;757.5038349880837;902.4765635931177;917.9495127767971;922.3128769067021;754.2269174096567;896.708569714842;919.3702313914989;925.296774451415;926.7590426489094;953.5851904421598;983.4640121133964;984.8227319082598;986.4919566423298;989.2728844299434;978.3298440568198;980.6371642492288;980.7401038724744;981.9983616710987;982.287841315048;734.4638413957788;735.860186564551;736.6169591812228;737.3732327521617;738.0663460722191;15319.31063102163;15618.219089045502;15644.296006679726;16005.679886402208;16216.432424865192;14719;14895.92552037233;15233.23833808305;15244;15309;11948.940255298668;11974.521019159223;12205.267683938991;12290.20113692607;12365.07261955357;3779.45197946299;3858.6334298241622;3952.3676211805973;3955.307821131319;4036.6972477064337;94410.39127261094;96421;109295;110603.44698276538;111519.88480115257;10527.684169474927;10880.401577913291;11035.44822758859;11071.391073490875;11924.046076313874;22278.777212227993;22483.775162248494;22514.324570262917;22738.43153921165;22748.31755047351;7905.56519391439;7905.920940790634;8008.639611217509;8157.46976446541;8198.549079800548;4143.316352801754;4333.046729719456;4362.367456718758;4413.205622987893;4488.551144885485;3713.090292878262;3809.104860357814;3816.2749077675153;3820.56063552695;3827.1771569112775;686.8042607856737;696.2132789947327;699.937005669482;717.0534893939949;725.6190499987443;705.8059033765755;727.4798519058793;738.0700317599756;740.1414359343136;777.1878387085509;9932.268651058956;10530.36817790935;10634.574617015387;10984.06635435997;11087.168462365355;683.4771399879096;684.8394658650392;723.0961298377028;733.3143510817403;739.1573606089063;4824.6863953842885;5057.342545469065;5137.229415587617;5156.226566015052;5162.716050617177;107897;109751.45124274328;111163;112623.87376126298;114891;74020.62989685017;96835.51582242044;97764;100863.49568252111;101001;63507.999999999076;64597;84986.4504064879;89428;90170.09829901748;10272.435016074187;10792.892071079188;11284.7743045137;11395.943020284845;11412.828807567726;41907.7904610475;47022.76488617535;49462.50537494579;51831;52171.73914130405;52615.21077183769;53448.1982770251;64392;65689;67468;13629.386677599334;13647.658808529866;13853.86146138566;14045.929770351082;14581.85418145805;14795.852041479448;15006.423388077184;15042;15382.769258460909;15656.138912359474;13721.856667195243;14038.929805350908;14081.014328996871;14404.351804169048;14406.783898241745;13580.388882500114;13721.45114195421;14439.92780036093;14866.554003379915;14879.702405952037;13400.06199566021;13980.300984950914;14138.717225655635;14316.570502884513;14438.566842994727;9952.552135154081;9999.950000249952;10155.593776249163;10179.389236645826;10255.435951022766;10786.191035672198;10842.403667798348;10899.455027248447;11037.834432483358;11779.35213563228 14:38:50 INFO - PROCESS | 1643 | __end_tp_report 14:38:50 INFO - PROCESS | 1643 | __start_cc_report 14:38:50 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,1291 14:38:50 INFO - PROCESS | 1643 | __end_cc_report 14:38:50 INFO - PROCESS | 1643 | __startTimestamp1490909930935__endTimestamp 14:38:50 INFO - PROCESS | 1643 | 14:38:50 INFO - PROCESS | 1643 | ------- Summary: start ------- 14:38:50 INFO - PROCESS | 1643 | Number of tests: 6 14:38:50 INFO - PROCESS | 1643 | 14:38:50 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5811.33 Median:5996.31 stddev:672.49 (11.2%) stddev-sans-first:644.25 14:38:50 INFO - PROCESS | 1643 | Values: 3266.9 3433.7 3455.7 3472.1 3493.2 4856.9 5848.5 5856.0 5857.2 5870.0 5800.7 5854.2 5874.2 5876.0 5885.8 5256.4 5295.0 5297.2 5320.7 5333.0 5239.6 5248.0 5251.2 5366.4 5368.2 3964.3 5167.4 5269.8 5328.5 5333.1 5307.8 5343.3 5345.8 5346.5 5352.3 5218.9 5259.7 5293.0 5303.7 5335.1 5678.3 5706.0 5709.6 5718.9 5858.7 5226.5 6361.2 6375.9 6377.1 6384.5 6302.0 6360.6 6363.9 6368.9 6372.1 5779.1 5867.7 5910.0 5951.2 5953.4 6263.7 6368.0 6375.8 6383.7 6428.2 6337.1 6341.7 6347.5 6348.7 6352.6 6238.8 6348.1 6351.0 6362.3 6362.4 6160.6 6226.8 6269.0 6324.0 6343.9 6363.8 6381.8 6383.5 6392.4 6403.1 5052.0 5054.5 5054.8 5065.9 5085.6 4434.8 4443.9 4448.0 4467.0 4486.3 5812.2 5848.2 5862.3 5870.7 5886.6 6323.0 6351.2 6370.4 6374.2 6388.9 5532.1 5824.7 5831.1 5851.5 5888.0 5483.1 5529.8 5539.4 5550.8 5562.1 5373.5 6318.2 6380.2 6384.0 6397.1 5323.2 6311.6 6331.2 6335.5 6360.7 6379.8 6419.6 6422.7 6437.6 6462.5 6150.6 6216.7 6350.1 6351.7 6376.4 5661.2 6159.7 6304.9 6308.7 6348.3 6251.4 6271.8 6274.9 6280.4 6292.6 6060.6 6292.5 6296.2 6303.0 6326.0 5996.3 6052.1 6058.8 6120.6 6128.0 5265.6 5356.8 5954.6 6288.5 6336.0 6093.1 6102.1 6130.9 6132.5 6134.3 14:38:50 INFO - PROCESS | 1643 | 14:38:50 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:71382.42 Median:34733.57 stddev:153772.03 (442.7%) stddev-sans-first:154111.31 14:38:50 INFO - PROCESS | 1643 | Values: 500.8 518.6 538.6 539.1 544.8 26252.7 34142.7 42717.0 42975.9 45077.0 43981.0 44470.3 44478.6 44490.8 44566.6 8855.2 9505.9 9725.5 9732.9 9733.3 8968.9 11459.7 11681.4 11708.1 11879.9 11596.9 11712.5 11719.2 11719.5 11723.0 11581.5 11631.7 11637.5 11656.6 11658.7 11476.5 11573.4 11595.1 11600.4 11604.4 40616.8 40724.8 40800.6 40879.0 40907.4 3512.6 4098.0 4098.8 4157.4 4185.8 30274.8 32405.7 32699.5 33005.8 33163.8 3253.6 3292.2 3380.3 3406.4 3416.5 498090.0 501927.0 502671.0 504016.0 505307.0 67653.7 67930.0 67961.7 68079.7 68184.7 71197.6 71272.3 71403.3 71637.0 71659.0 17039.0 17682.0 17715.6 17719.7 17745.6 12628.4 12846.4 13820.4 13879.1 13954.8 18126.5 18303.7 18310.0 18506.9 18543.0 6589.0 6651.1 6695.3 6712.7 6734.4 828.4 866.7 881.4 884.2 915.3 24867.8 30585.7 30803.4 30972.2 31418.5 986.7 1096.7 1125.7 1137.5 1198.6 15683.6 16048.7 16085.4 16182.8 16474.8 632561.0 633030.0 634462.0 638145.8 640184.0 63234.0 63948.0 64100.0 64226.4 64425.7 1194.4 1344.1 1391.8 1495.0 1495.8 24865.9 31532.4 32275.8 32293.7 32933.2 53737.5 54304.0 54474.9 54491.7 54506.7 520934.0 521387.0 522028.8 522033.0 774916.0 33151.7 34275.0 34351.8 35739.0 45913.0 47833.5 48237.3 48780.0 51194.7 51234.7 30415.8 31643.8 34030.0 34883.8 35154.6 33176.5 33327.8 33380.0 34520.5 34583.3 37375.1 37986.1 40081.4 40150.6 40267.6 30630.5 30916.0 31116.2 31739.7 31888.4 19078.6 20278.7 24907.9 25016.0 25574.6 14:38:50 INFO - PROCESS | 1643 | 14:38:50 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:41898.63 Median:21161.63 stddev:128962.41 (609.4%) stddev-sans-first:129286.53 14:38:50 INFO - PROCESS | 1643 | Values: 396.3 398.2 402.7 406.9 427.1 19933.3 21159.3 21164.0 21186.8 21882.5 12479.1 12598.7 12619.7 12721.0 12764.4 5445.0 5478.8 5650.3 5704.8 5736.3 5531.4 5689.6 5700.7 5705.4 5705.9 4153.4 4358.9 4362.0 5617.7 6283.5 6290.3 6370.1 6373.3 6391.3 6948.7 6192.5 6240.0 6279.6 6290.3 6295.6 14111.2 14260.8 14262.4 14271.8 23076.1 2711.3 2721.1 2758.1 2758.2 2789.3 8863.3 10258.5 10269.0 10602.8 10734.8 1790.7 1874.9 1898.3 1921.5 1976.2 130895.0 145402.0 146367.0 149352.0 152822.2 11893.8 12283.5 12347.4 12451.0 12466.3 15859.1 15891.4 16064.3 16267.4 16302.8 6913.2 7017.8 8843.4 9198.0 9318.3 8971.3 9000.9 9006.7 9160.1 9185.7 4799.0 4865.4 4873.1 4890.3 4942.5 1769.5 2040.8 2088.0 2089.6 2090.5 882.7 930.5 1032.7 1061.7 1064.4 21646.6 21903.0 22021.2 22021.2 22072.0 1054.8 1069.6 1091.3 1100.8 1107.2 9833.5 11241.6 11260.4 11293.3 11310.9 758528.0 760039.0 768177.0 781948.0 786438.0 150180.2 164104.0 170375.0 171397.6 172714.0 1068.2 1092.4 1116.9 1122.9 1128.9 19822.0 20059.4 20545.7 20665.9 20666.1 58891.2 59701.4 59740.0 59750.4 60050.7 83791.0 89484.6 92053.0 93033.6 95696.0 7457.1 8083.5 8376.5 8512.4 8849.9 11366.3 12806.0 13106.1 13273.7 13364.7 10983.9 11169.4 11399.4 11554.4 11610.8 9005.9 10074.1 10548.6 10629.9 11009.9 11431.6 11615.9 11793.9 11817.8 11935.1 7581.4 7621.0 7659.8 7919.9 7970.5 10449.8 10921.5 11465.7 11512.9 11519.0 14:38:50 INFO - PROCESS | 1643 | 14:38:50 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:5481.30 Median:5207.11 stddev:2967.87 (57.0%) stddev-sans-first:2960.26 14:38:50 INFO - PROCESS | 1643 | Values: 1389.3 1483.1 1488.9 1510.6 1511.7 7595.1 8017.4 8216.3 8360.0 8485.8 8419.4 8520.2 8537.1 8537.1 8542.7 2123.5 2370.5 2405.4 2408.3 2413.5 2204.0 2223.1 2224.2 2224.4 2331.2 2369.5 2392.9 2395.7 2396.1 2400.9 2342.9 2367.7 2369.8 2377.0 2380.2 2091.2 2399.2 2414.8 2429.1 2433.2 8305.6 8477.3 8568.4 8576.8 8593.2 5157.7 5321.8 5321.9 5330.5 5338.0 3473.3 3576.3 3604.2 3643.2 3644.3 1236.8 1247.0 1289.5 1289.9 1290.7 10904.5 10960.1 10961.5 10965.7 10966.6 4289.7 4594.5 4645.5 4828.2 4835.4 8703.7 8859.0 8863.3 8871.9 8880.9 5239.2 5242.2 5273.3 5292.0 5292.7 4737.4 4745.0 4832.8 4953.2 4965.4 3549.0 3661.6 3666.9 3758.1 3863.4 1080.1 1112.9 1116.6 1123.5 1124.7 797.3 801.6 812.9 818.3 828.0 5188.6 5548.2 5880.2 5898.7 5981.6 967.9 986.6 1032.4 1046.7 1064.3 3047.4 3711.9 3841.3 3957.7 4003.2 9907.4 10047.3 10131.6 10158.8 10166.1 9725.7 10004.1 10091.6 10110.6 10113.0 7966.3 8155.6 8163.9 8164.0 8175.2 5539.4 5586.9 5602.1 5754.7 5775.4 9369.1 9436.5 9456.6 9464.9 9507.6 8111.7 9247.5 9396.2 9489.4 9633.6 6834.7 6841.7 6896.3 6940.7 6966.3 7967.1 7979.4 8051.3 8059.1 8061.8 6883.1 7094.8 7101.7 7218.3 7230.9 6866.5 6927.1 6935.9 7116.5 7122.1 6434.2 6579.8 6581.6 6587.9 6591.7 5011.1 5030.7 5046.6 5051.5 5073.8 5021.4 5064.4 5180.9 5225.6 5239.9 14:38:50 INFO - PROCESS | 1643 | 14:38:50 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4600.56 Median:5126.54 stddev:1363.62 (26.6%) stddev-sans-first:1329.36 14:38:50 INFO - PROCESS | 1643 | Values: 336.4 367.2 371.7 383.1 384.5 5114.4 5306.8 5374.7 5382.0 5478.5 5179.6 5272.3 5350.9 5373.7 5400.2 3851.3 4006.9 4232.5 4244.0 4248.3 3448.9 3634.2 3740.6 3969.4 4295.0 3836.1 4079.3 4181.2 4198.8 4237.4 3846.2 4156.2 4164.5 4170.3 4188.8 3733.0 3733.9 3756.2 3780.2 3824.1 5052.9 5177.9 5212.4 5226.5 5306.3 4814.4 4830.5 4847.5 4857.5 4898.8 5382.5 5655.3 5686.5 5699.8 5716.8 3859.4 3955.7 4094.7 4126.5 4150.3 5476.7 5928.5 5958.5 5972.0 5972.2 3601.8 4217.9 4231.6 4259.8 4268.7 4088.9 4089.8 4258.0 4264.8 4308.8 4314.6 4563.3 4853.7 4863.4 4891.3 5520.3 5713.7 5721.1 5762.4 5785.8 1255.9 1316.6 1353.6 1392.0 1405.6 940.0 943.0 976.0 978.1 983.3 4223.3 4413.1 4898.8 5062.2 5083.9 4994.5 5189.3 5466.6 5511.3 5524.6 4209.9 4399.5 4885.0 4958.8 5091.2 2801.8 2891.7 2892.8 2901.8 2908.6 4954.5 5601.0 5650.7 5690.6 5724.9 5032.1 5126.4 5366.9 5674.3 6095.0 5139.7 5160.4 5337.7 6105.5 6165.9 4984.4 5219.7 5946.5 5954.3 5969.0 5429.6 5708.3 5743.3 5749.5 5781.5 5511.4 5587.9 5788.8 6031.7 6038.6 3757.2 3795.2 3927.0 3964.3 3999.8 4581.0 5798.8 5813.6 5834.2 5942.5 5113.7 5126.7 5379.0 5448.5 5658.9 5225.8 5608.8 5631.5 5645.8 5705.3 5088.8 5542.6 5554.0 5554.3 5561.7 5254.6 5646.9 5668.0 5669.2 5679.0 4860.9 5375.6 5454.6 5499.8 5537.5 14:38:50 INFO - PROCESS | 1643 | 14:38:50 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:20873.60 Median:3818.42 stddev:30071.20 (787.5%) stddev-sans-first:30117.57 14:38:50 INFO - PROCESS | 1643 | Values: 743.1 760.9 800.6 837.9 850.6 15233.2 15810.8 15811.1 15839.0 15872.4 14465.1 14511.3 14515.8 14601.6 14632.6 730.6 757.5 902.5 917.9 922.3 754.2 896.7 919.4 925.3 926.8 953.6 983.5 984.8 986.5 989.3 978.3 980.6 980.7 982.0 982.3 734.5 735.9 736.6 737.4 738.1 15319.3 15618.2 15644.3 16005.7 16216.4 14719.0 14895.9 15233.2 15244.0 15309.0 11948.9 11974.5 12205.3 12290.2 12365.1 3779.5 3858.6 3952.4 3955.3 4036.7 94410.4 96421.0 109295.0 110603.4 111519.9 10527.7 10880.4 11035.4 11071.4 11924.0 22278.8 22483.8 22514.3 22738.4 22748.3 7905.6 7905.9 8008.6 8157.5 8198.5 4143.3 4333.0 4362.4 4413.2 4488.6 3713.1 3809.1 3816.3 3820.6 3827.2 686.8 696.2 699.9 717.1 725.6 705.8 727.5 738.1 740.1 777.2 9932.3 10530.4 10634.6 10984.1 11087.2 683.5 684.8 723.1 733.3 739.2 4824.7 5057.3 5137.2 5156.2 5162.7 107897.0 109751.5 111163.0 112623.9 114891.0 74020.6 96835.5 97764.0 100863.5 101001.0 63508.0 64597.0 84986.5 89428.0 90170.1 10272.4 10792.9 11284.8 11395.9 11412.8 41907.8 47022.8 49462.5 51831.0 52171.7 52615.2 53448.2 64392.0 65689.0 67468.0 13629.4 13647.7 13853.9 14045.9 14581.9 14795.9 15006.4 15042.0 15382.8 15656.1 13721.9 14038.9 14081.0 14404.4 14406.8 13580.4 13721.5 14439.9 14866.6 14879.7 13400.1 13980.3 14138.7 14316.6 14438.6 9952.6 10000.0 10155.6 10179.4 10255.4 10786.2 10842.4 10899.5 11037.8 11779.4 14:38:50 INFO - PROCESS | 1643 | -------- Summary: end -------- 14:38:50 INFO - PROCESS | 1643 | 14:38:51 INFO - TEST-INFO | 1643: exit 0 14:38:51 INFO - TEST-OK | dromaeo_css | took 1116557ms 14:38:51 INFO - TEST-START | kraken 14:38:51 INFO - operating with platform_type : mac_ 14:38:51 INFO - Initialising browser for kraken test... 14:38:51 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmprf_Auw/profile http://localhost:49242/getInfo.html) 14:38:53 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 14:38:53 INFO - PROCESS | 1654 | colorDepth:24 14:38:53 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 14:38:53 INFO - PROCESS | 1654 | __metrics 14:38:53 INFO - PROCESS | 1654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:38:53 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:38:54 INFO - TEST-INFO | 1654: exit 0 14:38:54 INFO - Browser initialized. 14:38:54 INFO - Running cycle 1/1 for kraken test... 14:38:54 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmprf_Auw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:39:06 INFO - PROCESS | 1656 | RSS: Main: 163385344 14:39:06 INFO - PROCESS | 1656 | 14:39:08 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 14:39:09 INFO - PROCESS | 1656 | RSS: Main: 214241280 14:39:09 INFO - PROCESS | 1656 | 14:39:12 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 14:39:12 INFO - PROCESS | 1656 | RSS: Main: 228401152 14:39:12 INFO - PROCESS | 1656 | 14:39:16 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 14:39:16 INFO - PROCESS | 1656 | RSS: Main: 324730880 14:39:16 INFO - PROCESS | 1656 | 14:39:18 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 14:39:19 INFO - PROCESS | 1656 | RSS: Main: 228433920 14:39:19 INFO - PROCESS | 1656 | 14:39:21 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:39:21 INFO - PROCESS | 1656 | RSS: Main: 229728256 14:39:21 INFO - PROCESS | 1656 | 14:39:24 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 14:39:25 INFO - PROCESS | 1656 | RSS: Main: 272691200 14:39:25 INFO - PROCESS | 1656 | 14:39:28 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 14:39:28 INFO - PROCESS | 1656 | RSS: Main: 270970880 14:39:28 INFO - PROCESS | 1656 | 14:39:31 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 14:39:32 INFO - PROCESS | 1656 | RSS: Main: 265818112 14:39:32 INFO - PROCESS | 1656 | 14:39:33 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:39:34 INFO - PROCESS | 1656 | RSS: Main: 245538816 14:39:34 INFO - PROCESS | 1656 | 14:39:36 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:39:37 INFO - PROCESS | 1656 | RSS: Main: 247500800 14:39:37 INFO - PROCESS | 1656 | 14:39:39 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:39:39 INFO - PROCESS | 1656 | RSS: Main: 255590400 14:39:39 INFO - PROCESS | 1656 | 14:39:42 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:39:43 INFO - PROCESS | 1656 | RSS: Main: 268845056 14:39:43 INFO - PROCESS | 1656 | 14:39:46 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:39:46 INFO - PROCESS | 1656 | RSS: Main: 263135232 14:39:46 INFO - PROCESS | 1656 | 14:39:48 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 14:39:49 INFO - PROCESS | 1656 | RSS: Main: 307400704 14:39:49 INFO - PROCESS | 1656 | 14:39:49 INFO - PROCESS | 1656 | __start_tp_report 14:39:49 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 14:39:49 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 14:39:49 INFO - PROCESS | 1656 | |i|pagename|runs| 14:39:49 INFO - PROCESS | 1656 | |0;ai-astar;104;115;114;113;114;115;114;113;113;114 14:39:49 INFO - PROCESS | 1656 | |1;audio-beat-detection;139;107;106;142;108;107;106;107;126;103 14:39:49 INFO - PROCESS | 1656 | |2;audio-dft;184;186;182;185;185;183;186;185;183;184 14:39:49 INFO - PROCESS | 1656 | |3;audio-fft;81;58;58;88;58;57;58;58;72;57 14:39:49 INFO - PROCESS | 1656 | |4;audio-oscillator;82;71;85;69;67;68;81;67;67;79 14:39:49 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;88;85;89;86;88;85;89;86;88;86 14:39:49 INFO - PROCESS | 1656 | |6;imaging-darkroom;94;94;94;95;93;94;94;95;105;149 14:39:49 INFO - PROCESS | 1656 | |7;imaging-desaturate;86;89;85;87;87;87;87;88;85;86 14:39:49 INFO - PROCESS | 1656 | |8;json-parse-financial;55;52;49;70;80;88;83;72;55;54 14:39:49 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;72;80;63;73;72;67;69;68;81;99 14:39:49 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;81;81;83;83;81;80;74;87;99;102 14:39:49 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;134;142;143;143;152;137;135;122;187;161 14:39:49 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;160;164;164;161;159;158;163;161;160;160 14:39:49 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;64;64;65;64;72;85;83;81;81;80 14:39:49 INFO - PROCESS | 1656 | __end_tp_report 14:39:49 INFO - PROCESS | 1656 | __start_cc_report 14:39:49 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,2057 14:39:49 INFO - PROCESS | 1656 | __end_cc_report 14:39:49 INFO - PROCESS | 1656 | __startTimestamp1490909989003__endTimestamp 14:39:49 INFO - PROCESS | 1656 | 14:39:49 INFO - PROCESS | 1656 | ------- Summary: start ------- 14:39:49 INFO - PROCESS | 1656 | Number of tests: 14 14:39:49 INFO - PROCESS | 1656 | 14:39:49 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:3.21 (2.8%) stddev-sans-first:0.78 14:39:49 INFO - PROCESS | 1656 | Values: 104.0 115.0 114.0 113.0 114.0 115.0 114.0 113.0 113.0 114.0 14:39:49 INFO - PROCESS | 1656 | 14:39:49 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:115.10 Median:107.50 stddev:14.81 (13.8%) stddev-sans-first:12.93 14:39:49 INFO - PROCESS | 1656 | Values: 139.0 107.0 106.0 142.0 108.0 107.0 106.0 107.0 126.0 103.0 14:39:49 INFO - PROCESS | 1656 | 14:39:49 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:184.30 Median:185.00 stddev:1.34 (0.7%) stddev-sans-first:1.41 14:39:49 INFO - PROCESS | 1656 | Values: 184.0 186.0 182.0 185.0 185.0 183.0 186.0 185.0 183.0 184.0 14:39:49 INFO - PROCESS | 1656 | 14:39:49 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:64.50 Median:58.00 stddev:11.57 (19.9%) stddev-sans-first:10.62 14:39:49 INFO - PROCESS | 1656 | Values: 81.0 58.0 58.0 88.0 58.0 57.0 58.0 58.0 72.0 57.0 14:39:49 INFO - PROCESS | 1656 | 14:39:49 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:73.60 Median:75.00 stddev:7.26 (9.7%) stddev-sans-first:7.04 14:39:49 INFO - PROCESS | 1656 | Values: 82.0 71.0 85.0 69.0 67.0 68.0 81.0 67.0 67.0 79.0 14:39:49 INFO - PROCESS | 1656 | 14:39:49 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:87.00 Median:88.00 stddev:1.56 (1.8%) stddev-sans-first:1.62 14:39:49 INFO - PROCESS | 1656 | Values: 88.0 85.0 89.0 86.0 88.0 85.0 89.0 86.0 88.0 86.0 14:39:49 INFO - PROCESS | 1656 | 14:39:49 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:100.70 Median:94.00 stddev:17.32 (18.4%) stddev-sans-first:18.20 14:39:49 INFO - PROCESS | 1656 | Values: 94.0 94.0 94.0 95.0 93.0 94.0 94.0 95.0 105.0 149.0 14:39:49 INFO - PROCESS | 1656 | 14:39:49 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:86.70 Median:87.00 stddev:1.25 (1.4%) stddev-sans-first:1.30 14:39:49 INFO - PROCESS | 1656 | Values: 86.0 89.0 85.0 87.0 87.0 87.0 87.0 88.0 85.0 86.0 14:39:49 INFO - PROCESS | 1656 | 14:39:49 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:71.00 stddev:14.50 (20.4%) stddev-sans-first:14.84 14:39:49 INFO - PROCESS | 1656 | Values: 55.0 52.0 49.0 70.0 80.0 88.0 83.0 72.0 55.0 54.0 14:39:49 INFO - PROCESS | 1656 | 14:39:49 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:74.40 Median:72.50 stddev:10.27 (14.2%) stddev-sans-first:10.85 14:39:49 INFO - PROCESS | 1656 | Values: 72.0 80.0 63.0 73.0 72.0 67.0 69.0 68.0 81.0 99.0 14:39:49 INFO - PROCESS | 1656 | 14:39:49 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:82.00 stddev:8.76 (10.7%) stddev-sans-first:9.17 14:39:49 INFO - PROCESS | 1656 | Values: 81.0 81.0 83.0 83.0 81.0 80.0 74.0 87.0 99.0 102.0 14:39:49 INFO - PROCESS | 1656 | 14:39:49 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:145.60 Median:143.00 stddev:17.94 (12.5%) stddev-sans-first:18.53 14:39:49 INFO - PROCESS | 1656 | Values: 134.0 142.0 143.0 143.0 152.0 137.0 135.0 122.0 187.0 161.0 14:39:49 INFO - PROCESS | 1656 | 14:39:49 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:161.00 stddev:2.05 (1.3%) stddev-sans-first:2.15 14:39:49 INFO - PROCESS | 1656 | Values: 160.0 164.0 164.0 161.0 159.0 158.0 163.0 161.0 160.0 160.0 14:39:49 INFO - PROCESS | 1656 | 14:39:49 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:80.50 stddev:8.95 (11.1%) stddev-sans-first:8.75 14:39:49 INFO - PROCESS | 1656 | Values: 64.0 64.0 65.0 64.0 72.0 85.0 83.0 81.0 81.0 80.0 14:39:49 INFO - PROCESS | 1656 | -------- Summary: end -------- 14:39:49 INFO - PROCESS | 1656 | 14:39:49 INFO - TEST-INFO | 1656: exit 0 14:39:49 INFO - TEST-OK | kraken | took 58353ms 14:39:49 INFO - SUITE-END | took 1174s 14:39:50 INFO - Completed test suite (00:19:35) 14:39:50 INFO - javascript benchmark 14:39:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3266.9346613067737, 3433.742469314802, 3455.6889879910805, 3472.114610774252, 3493.16164120611, 4856.927146092807, 5848.502877255439, 5856.004479238529, 5857.209276747638, 5869.9999999999945, 5800.709964501779, 5854.238948936632, 5874.206982057421, 5875.970620146904, 5885.823425297237, 5256.3955145158225, 5294.973525132369, 5297.17893726473, 5320.680759154444, 5333.040052790496, 5239.633225674204, 5247.973760131213, 5251.2385704072885, 5366.356037275533, 5368.248445217672, 3964.2864284428933, 5167.379914410257, 5269.841904742864, 5328.5470734987375, 5333.120035194188, 5307.840764777044, 5343.305370301855, 5345.786168553253, 5346.545543628797, 5352.304200453955, 5218.8695282617855, 5259.710715910624, 5293.020791153649, 5303.681779093266, 5335.0663633863915, 5678.26182596264, 5706.0, 5709.628874123168, 5718.942810571883, 5858.677772722499, 5226.503482169188, 6361.173047503795, 6375.87248255037, 6377.07532407803, 6384.52116091295, 6302.0, 6360.618362898241, 6363.854506188884, 6368.936310636927, 6372.139761132281, 5779.075347944308, 5867.735951882176, 5910.0, 5951.196588460546, 5953.374895635982, 6263.655498947511, 6367.968160159169, 6375.776847810397, 6383.680815959184, 6428.19647544057, 6337.144485494491, 6341.714622841983, 6347.460465860361, 6348.682565871688, 6352.587081839758, 6238.844028899314, 6348.111264422984, 6351.0, 6362.331955144736, 6362.363763623694, 6160.599561028519, 6226.750929962751, 6268.9969604863, 6324.0, 6343.904841427382, 6363.7772677956045, 6381.8085457436355, 6383.521235907326, 6392.4246817786625, 6403.103565500834, 5051.974740126276, 5054.545090941833, 5054.823081192214, 5065.949340506621, 5085.593152547787, 4434.84478043267, 4443.866683999485, 4447.977760111244, 4466.977665111654, 4486.3494793254795, 5812.157237200582, 5848.210491583667, 5862.267216597926, 5870.735816888165, 5886.587938844325, 6322.968385158045, 6351.237851457762, 6370.362963703593, 6374.203224596926, 6388.872222555523, 5532.1425179097305, 5824.650520968756, 5831.096180092092, 5851.473367396955, 5887.970560147258, 5483.122700367922, 5529.778808847601, 5539.362973258047, 5550.833474995757, 5562.137868630369, 5373.516383525502, 6318.178636777189, 6380.202474690664, 6383.968080159662, 6397.136386587751, 5323.201519772065, 6311.621302721851, 6331.240251169889, 6335.524835637253, 6360.745570177141, 6379.840503987438, 6419.582727122722, 6422.678866056772, 6437.613743175424, 6462.515311351762, 6150.569460137926, 6216.689165541615, 6350.110984462087, 6351.745930162741, 6376.426121649074, 5661.179129026351, 6159.692015399301, 6304.936950630435, 6308.747650093945, 6348.269948955744, 6251.437370636664, 6271.811845644455, 6274.874502509833, 6280.403361680633, 6292.559520833498, 6060.606060606046, 6292.496600271876, 6296.181496405438, 6302.9684851577285, 6326.0, 5996.310424301261, 6052.122442245938, 6058.787942421994, 6120.60216085953, 6127.9837278401355, 5265.552428043506, 5356.758945847524, 5954.583179177416, 6288.5283603728985, 6336.017917222838, 6093.086037094471, 6102.0541816018585, 6130.856783744145, 6132.540059495466, 6134.294556126102], "value": 5769.406511521411, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.82971789591545, 518.5566340778635, 538.6148903533972, 539.094321539813, 544.7902557515356, 26252.737472625293, 34142.65857341429, 42717.0, 42975.92560185997, 45077.0, 43981.0, 44470.33294500585, 44478.55521444784, 44490.7775461123, 44566.55433445665, 8855.203031727144, 9505.904940950588, 9725.465099419529, 9732.854007189862, 9733.270004749636, 8968.910310896905, 11459.656210313662, 11681.357525336103, 11708.12189085822, 11879.881201188007, 11596.942015289911, 11712.53149874004, 11719.238249513797, 11719.472623731952, 11723.0, 11581.478833452515, 11631.6510504685, 11637.47631356591, 11656.59201927937, 11658.6502404928, 11476.540938362456, 11573.42132893352, 11595.130365222642, 11600.361980091091, 11604.361760103191, 40616.78149655515, 40724.796376017934, 40800.59199407998, 40879.0, 40907.386389204185, 3512.5960514540643, 4097.97951010243, 4098.754074755494, 4157.397177409289, 4185.811638476276, 30274.84862575695, 32405.675943240738, 32699.509507357172, 33005.834970824995, 33163.83418082894, 3253.5607692961385, 3292.209869631295, 3380.3070370573973, 3406.42090844557, 3416.521686963827, 498090.0, 501927.0, 502671.0, 504016.0, 505307.0, 67653.66173169202, 67930.0, 67961.66019169873, 68079.65960170167, 68184.6590767043, 71197.64401178065, 71272.28727712657, 71403.28596713966, 71637.0, 71659.0, 17039.0, 17682.0, 17715.645687086442, 17719.73420398695, 17745.556361090818, 12628.431720572597, 12846.421911014028, 13820.447182112805, 13879.097858639156, 13954.790678139836, 18126.456206313833, 18303.72544411835, 18309.992950387856, 18506.907465462587, 18543.0, 6588.96705516479, 6651.102101216371, 6695.263521012685, 6712.697928593225, 6734.427573656294, 828.411827602397, 866.6663334616092, 881.3918396306528, 884.186548375496, 915.2677857713802, 24867.751322486543, 30585.694143058285, 30803.383932321227, 30972.22569435737, 31418.528722069186, 986.659602437158, 1096.7313008312856, 1125.6904351303458, 1137.4530638331862, 1198.5984695127056, 15683.607909802118, 16048.679026419406, 16085.35658573644, 16182.838171618369, 16474.75287870683, 632561.0, 633030.0, 634462.0, 638145.8092709506, 640184.0, 63234.0, 63948.0, 64100.0, 64226.35773642204, 64425.67787161034, 1194.4445832687843, 1344.0860215053663, 1391.7912313153108, 1494.9701005980037, 1495.7532007218688, 24865.87567062153, 31532.369352613277, 32275.838620807684, 32293.677063230007, 32933.17667058247, 53737.46262537324, 54304.0, 54474.91050179054, 54491.72754136204, 54506.72746636241, 520934.0, 521387.0, 522028.779712198, 522033.0, 774916.0, 33151.66848331486, 34275.0, 34351.82824085864, 35739.0, 45913.0, 47833.52166478291, 48237.276440852715, 48780.02439951252, 51194.74402627963, 51234.74382628063, 30415.847920760254, 31643.84178079187, 34030.0, 34883.82558087193, 35154.64845351616, 33176.50235246425, 33327.83336083304, 33380.0, 34520.48219276763, 34583.308333832676, 37375.06562335963, 37986.050348741504, 40081.398779017756, 40150.59849401469, 40267.597324027556, 30630.540541892336, 30916.0, 31116.22209444782, 31739.682603174595, 31888.36223275475, 19078.61842763165, 20278.695819562425, 24907.87546062258, 25016.0, 25574.616380754676], "value": 20772.849226703755, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.34602905206407, 398.2353880549345, 402.74828232354776, 406.90844559974, 427.1350515206708, 19933.3023344183, 21159.259425920096, 21164.0, 21186.788132118676, 21882.452938676543, 12479.1264611477, 12598.685032874182, 12619.684507887307, 12721.0, 12764.361781910913, 5444.972775136119, 5478.753456094475, 5650.29371328584, 5704.828855134353, 5736.254286942692, 5531.363893152278, 5689.6017278790505, 5700.743466543995, 5705.400932902048, 5705.942940570603, 4153.439285696438, 4358.912821743564, 4361.95313124851, 5617.691026993513, 6283.528735344845, 6290.276618188921, 6370.0763389308295, 6373.298937116913, 6391.265004524469, 6948.6525673716615, 6192.504599632019, 6239.968800156015, 6279.623222606659, 6290.276618188921, 6295.5907865988565, 14111.223882686449, 14260.786088208684, 14262.358193881197, 14271.78592321116, 23076.076956921872, 2711.3357227479196, 2721.142840005392, 2758.1449750577185, 2758.2276962450546, 2789.27478855497, 8863.335249856287, 10258.487075646188, 10268.973102689746, 10602.787944241149, 10734.838977415346, 1790.7134858422721, 1874.9437516874516, 1898.2691663709434, 1921.4619906426083, 1976.2193933396372, 130895.0, 145402.0, 146367.0, 149352.0, 152822.23588882096, 11893.821592676117, 12283.508659653693, 12347.38263086842, 12451.003919686404, 12466.252024878537, 15859.127747973742, 15891.364345426053, 16064.27710753019, 16267.430639927547, 16302.83697163037, 6913.239543650195, 7017.754378596725, 8843.425177363451, 9197.954010229905, 9318.30112741547, 8971.282297416192, 9000.8649870252, 9006.729798106067, 9160.083991600919, 9185.724428267162, 4798.976005119952, 4865.367502224759, 4873.074115917964, 4890.266460030953, 4942.5304596063315, 1769.4868488138552, 2040.8163265306193, 2087.9895600522204, 2089.613421517024, 2090.4669309326327, 882.6998820401094, 930.4835816122118, 1032.6643840751785, 1061.6708820265587, 1064.4305296666246, 21646.56706865854, 21903.0, 22021.22925697593, 22021.22925697625, 22072.00675969585, 1054.841773733946, 1069.550788668761, 1091.3342860854873, 1100.7523307255963, 1107.2360071550604, 9833.508324583741, 11241.55033798639, 11260.380679062566, 11293.322400655987, 11310.943445282886, 758528.0, 760039.0, 768177.0, 781948.0, 786438.0, 150180.24909875382, 164104.0, 170375.0, 171397.57204855833, 172714.0, 1068.1721665708983, 1092.415557676639, 1116.9497372618252, 1122.9382383968796, 1128.8758236593967, 19822.0, 20059.39821805348, 20545.691814623093, 20665.863377514383, 20666.070026849127, 58891.17207381506, 59701.40298596959, 59740.0, 59750.402495974486, 60050.699746500984, 83791.0, 89484.5525772367, 92053.0, 93033.60449593126, 95696.0, 7457.105147382349, 8083.474574152661, 8376.455530390505, 8512.446690965067, 8849.91150088491, 11366.261193022427, 12806.039547034195, 13106.148100373444, 13273.66815829612, 13364.732705345645, 10983.890161098287, 11169.385683787144, 11399.373034483184, 11554.364509952033, 11610.767784644091, 9005.909940900507, 10074.14369778577, 10548.578056877639, 10629.9468502657, 11009.944950275198, 11431.59989400367, 11615.941920290345, 11793.941030294794, 11817.82273265919, 11935.104867134825, 7581.355584775356, 7620.961895190489, 7659.77020689358, 7919.881201782093, 7970.4819186752675, 10449.84325235107, 10921.508532115915, 11465.656030319104, 11512.906273903965, 11519.0], "value": 9868.855453571075, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1389.3192335755482, 1483.0582580061657, 1488.8660020598147, 1510.6147932277272, 1511.667433164704, 7595.126560445544, 8017.398695097869, 8216.30161436278, 8360.0, 8485.78785530362, 8419.410641255115, 8520.19058189471, 8537.060923298432, 8537.10360412157, 8542.743717688463, 2123.479747461874, 2370.5021945391445, 2405.4467472481338, 2408.301592538162, 2413.5293617744546, 2204.019211450905, 2223.0774228695072, 2224.2215224671318, 2224.3660556741333, 2331.160782118436, 2369.5497855407502, 2392.868392238426, 2395.724491683461, 2396.0535588442553, 2400.9039638414442, 2342.9179978700836, 2367.656689779972, 2369.763023697634, 2377.025419577965, 2380.155044959049, 2091.215794077221, 2399.1602938971396, 2414.770596793302, 2429.125514814665, 2433.1605596069326, 8305.584720763998, 8477.279431248351, 8568.400211985101, 8576.785580360478, 8593.226609605103, 5157.742112894341, 5321.813736519242, 5321.893562128775, 5330.466953304638, 5338.0, 3473.322702073097, 3576.3204991051875, 3604.189057462076, 3643.1802844360072, 3644.2711457708565, 1236.8021116621387, 1246.9875301246961, 1289.5164313382481, 1289.851667058291, 1290.7289469211478, 10904.50929708165, 10960.12319014477, 10961.451927403677, 10965.671029869038, 10966.616168434146, 4289.691644048595, 4594.494605593382, 4645.535446455395, 4828.203346447867, 4835.44392394872, 8703.738887833375, 8858.98121715998, 8863.290936725047, 8871.866921996176, 8880.911190888137, 5239.214117882349, 5242.213667949762, 5273.34083239595, 5292.047431462373, 5292.735363231823, 4737.38414006177, 4745.0, 4832.782524786393, 4953.23224900141, 4965.404151501771, 3549.0, 3661.6338366163704, 3666.926661466756, 3758.1356288053903, 3863.36254518007, 1080.0873262093519, 1112.8775834658181, 1116.6203490813, 1123.528118190362, 1124.651358078998, 797.2744802229943, 801.6192308653459, 812.9147587970008, 818.2553875972956, 827.9793005174919, 5188.584913206934, 5548.195511650869, 5880.176775251468, 5898.675572843449, 5981.581289309794, 967.9032096790264, 986.6398764451068, 1032.4218437674926, 1046.6755305855208, 1064.2656566968767, 3047.4362242985117, 3711.888643340704, 3841.3469710148784, 3957.703172262092, 4003.2393845169327, 9907.356021858555, 10047.346922450017, 10131.594736210469, 10158.796824063478, 10166.135878450414, 9725.6596019139, 10004.149647280063, 10091.596336146618, 10110.646127385506, 10113.039261270167, 7966.322862556747, 8155.632996515171, 8163.918360816435, 8163.959180204061, 8175.182481751896, 5539.390667026543, 5586.944130558642, 5602.13166959122, 5754.741036653444, 5775.364709881826, 9369.109934556207, 9436.480993545421, 9456.574454149717, 9464.858027129461, 9507.572159252988, 8111.675532978615, 9247.491387973727, 9396.201322887631, 9489.383190092622, 9633.614655413705, 6834.726610935507, 6841.726330946706, 6896.344847239504, 6940.687669055005, 6966.338197871194, 7967.083785364757, 7979.361651067785, 8051.315638170821, 8059.073206581318, 8061.798455038671, 6883.139607549057, 7094.758417277059, 7101.680424381018, 7218.27817218274, 7230.855382892418, 6866.485013623898, 6927.064846245692, 6935.89596156048, 7116.537425067561, 7122.074130363019, 6434.195725534309, 6579.769708060195, 6581.572197807127, 6587.934120658732, 6591.670416479253, 5011.09800235961, 5030.723310217973, 5046.646734728533, 5051.494850514919, 5073.797048118182, 5021.397432308147, 5064.366954130734, 5180.870478238075, 5225.634205605571, 5239.869003274796], "value": 4455.083435806568, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.4012058535806, 367.2251549231122, 371.715637537284, 383.0786957367532, 384.54815591679767, 5114.411842638097, 5306.787728490865, 5374.677519348842, 5382.004329199096, 5478.479544443281, 5179.637425380225, 5272.314599102121, 5350.866228344294, 5373.704446255454, 5400.1909360364225, 3851.2682590307822, 4006.939895901564, 4232.545123828188, 4244.0026593750445, 4248.27779277522, 3448.8789394522314, 3634.200475895299, 3740.5698344690436, 3969.4045893115976, 4295.0, 3836.139472355905, 4079.327475734949, 4181.205570941526, 4198.8320467181275, 4237.449131612886, 3846.230753849213, 4156.233600719682, 4164.521080075785, 4170.270202714543, 4188.769617671027, 3732.962670373289, 3733.8693145739767, 3756.2487502499607, 3780.2250538639787, 3824.139568597071, 5052.867222322184, 5177.922331165036, 5212.400573934008, 5226.536569760473, 5306.283651707047, 4814.448342378545, 4830.468648448667, 4847.5394837490385, 4857.465678775332, 4898.828541001048, 5382.515573598395, 5655.293088363955, 5686.526361032964, 5699.779624512179, 5716.799912003102, 3859.363205071188, 3955.703322250814, 4094.6896992962265, 4126.525449573308, 4150.335946248586, 5476.698781566973, 5928.49607783339, 5958.454719441925, 5972.044472884318, 5972.163897054415, 3601.837917293728, 4217.8523751668545, 4231.640310573574, 4259.829606815754, 4268.743875367488, 4088.8959980805016, 4089.8159582818844, 4258.041940563348, 4264.848490907438, 4308.80610372534, 4314.576189857339, 4563.338315944236, 4853.733044682505, 4863.367762190964, 4891.26631005352, 5520.282363292747, 5713.74288157034, 5721.05484135396, 5762.366139724627, 5785.797497087582, 1255.8744125587368, 1316.5655333739842, 1353.627752368087, 1391.9930400347932, 1405.5994041698068, 939.9765005874908, 942.9528523573794, 976.0191008037019, 978.0952618827556, 983.2527279267808, 4223.260929337353, 4413.051193993243, 4898.779554920037, 5062.215356619729, 5083.872903177376, 4994.450610432849, 5189.325387699575, 5466.590005749585, 5511.255980442589, 5524.58565607581, 4209.873703788891, 4399.450068741407, 4885.0, 4958.801647934042, 5091.1926266175715, 2801.7898657600763, 2891.66983187736, 2892.7685785137137, 2901.7823663225345, 2908.636420447444, 4954.482317554504, 5601.047821870292, 5650.654978184008, 5690.630109042899, 5724.885502289931, 5032.094223039815, 5126.38483381989, 5366.865828354323, 5674.290713660793, 6095.0, 5139.743012849342, 5160.432352441304, 5337.653052551572, 6105.48103411215, 6165.938340616716, 4984.401871775265, 5219.660722053054, 5946.464818166386, 5954.345022047658, 5969.030969030969, 5429.592780541554, 5708.315002199763, 5743.282089738783, 5749.511291540099, 5781.508571771446, 5511.4213007633625, 5587.916181257203, 5788.758295354615, 6031.728572214349, 6038.5772995889865, 3757.1734218471893, 3795.1650636859845, 3926.9607303926596, 3964.286428442908, 3999.7800120993625, 4580.954190458053, 5798.768049277982, 5813.6221145625395, 5834.18321435008, 5942.494887934401, 5113.696007518059, 5126.6923984561045, 5378.973105134606, 5448.482394172547, 5658.886822263614, 5225.764840582106, 5608.775648973995, 5631.493165615114, 5645.781904314501, 5705.343885453226, 5088.796448142181, 5542.584306176972, 5553.972230138824, 5554.333479982428, 5561.694106824163, 5254.60590455725, 5646.887062258814, 5668.0, 5669.185860524757, 5679.0, 4860.854174374775, 5375.59683023767, 5454.618176727591, 5499.807506737245, 5537.501624853782], "value": 4183.14009757508, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.126825979474, 760.9124950630679, 800.6437135474716, 837.8952630921135, 850.6002178975883, 15233.238338083092, 15810.762838557403, 15811.051336919778, 15839.049657020572, 15872.365105395798, 14465.132092074484, 14511.346989385476, 14515.782263266059, 14601.634959126, 14632.634184145401, 730.6054730445553, 757.5038349880837, 902.4765635931177, 917.9495127767971, 922.3128769067021, 754.2269174096567, 896.708569714842, 919.3702313914989, 925.296774451415, 926.7590426489094, 953.5851904421598, 983.4640121133964, 984.8227319082598, 986.4919566423298, 989.2728844299434, 978.3298440568198, 980.6371642492288, 980.7401038724744, 981.9983616710987, 982.287841315048, 734.4638413957788, 735.860186564551, 736.6169591812228, 737.3732327521617, 738.0663460722191, 15319.31063102163, 15618.219089045502, 15644.296006679726, 16005.679886402208, 16216.432424865192, 14719.0, 14895.92552037233, 15233.23833808305, 15244.0, 15309.0, 11948.940255298668, 11974.521019159223, 12205.267683938991, 12290.20113692607, 12365.07261955357, 3779.45197946299, 3858.6334298241622, 3952.3676211805973, 3955.307821131319, 4036.6972477064337, 94410.39127261094, 96421.0, 109295.0, 110603.44698276538, 111519.88480115257, 10527.684169474927, 10880.401577913291, 11035.44822758859, 11071.391073490875, 11924.046076313874, 22278.777212227993, 22483.775162248494, 22514.324570262917, 22738.43153921165, 22748.31755047351, 7905.56519391439, 7905.920940790634, 8008.639611217509, 8157.46976446541, 8198.549079800548, 4143.316352801754, 4333.046729719456, 4362.367456718758, 4413.205622987893, 4488.551144885485, 3713.090292878262, 3809.104860357814, 3816.2749077675153, 3820.56063552695, 3827.1771569112775, 686.8042607856737, 696.2132789947327, 699.937005669482, 717.0534893939949, 725.6190499987443, 705.8059033765755, 727.4798519058793, 738.0700317599756, 740.1414359343136, 777.1878387085509, 9932.268651058956, 10530.36817790935, 10634.574617015387, 10984.06635435997, 11087.168462365355, 683.4771399879096, 684.8394658650392, 723.0961298377028, 733.3143510817403, 739.1573606089063, 4824.6863953842885, 5057.342545469065, 5137.229415587617, 5156.226566015052, 5162.716050617177, 107897.0, 109751.45124274328, 111163.0, 112623.87376126298, 114891.0, 74020.62989685017, 96835.51582242044, 97764.0, 100863.49568252111, 101001.0, 63507.999999999076, 64597.0, 84986.4504064879, 89428.0, 90170.09829901748, 10272.435016074187, 10792.892071079188, 11284.7743045137, 11395.943020284845, 11412.828807567726, 41907.7904610475, 47022.76488617535, 49462.50537494579, 51831.0, 52171.73914130405, 52615.21077183769, 53448.1982770251, 64392.0, 65689.0, 67468.0, 13629.386677599334, 13647.658808529866, 13853.86146138566, 14045.929770351082, 14581.85418145805, 14795.852041479448, 15006.423388077184, 15042.0, 15382.769258460909, 15656.138912359474, 13721.856667195243, 14038.929805350908, 14081.014328996871, 14404.351804169048, 14406.783898241745, 13580.388882500114, 13721.45114195421, 14439.92780036093, 14866.554003379915, 14879.702405952037, 13400.06199566021, 13980.300984950914, 14138.717225655635, 14316.570502884513, 14438.566842994727, 9952.552135154081, 9999.950000249952, 10155.593776249163, 10179.389236645826, 10255.435951022766, 10786.191035672198, 10842.403667798348, 10899.455027248447, 11037.834432483358, 11779.35213563228], "value": 7811.050687118082, "unit": "score"}], "name": "dromaeo_css", "value": 7458.78756604341, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 114.0, 113.0, 114.0, 115.0, 114.0, 113.0, 113.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 107.0, 106.0, 142.0, 108.0, 107.0, 106.0, 107.0, 126.0, 103.0], "value": 115.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 186.0, 182.0, 185.0, 185.0, 183.0, 186.0, 185.0, 183.0, 184.0], "value": 184.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 58.0, 88.0, 58.0, 57.0, 58.0, 58.0, 72.0, 57.0], "value": 64.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 71.0, 85.0, 69.0, 67.0, 68.0, 81.0, 67.0, 67.0, 79.0], "value": 73.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 89.0, 86.0, 88.0, 85.0, 89.0, 86.0, 88.0, 86.0], "value": 87.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 93.0, 94.0, 94.0, 95.0, 105.0, 149.0], "value": 100.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 89.0, 85.0, 87.0, 87.0, 87.0, 87.0, 88.0, 85.0, 86.0], "value": 86.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 49.0, 70.0, 80.0, 88.0, 83.0, 72.0, 55.0, 54.0], "value": 65.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 80.0, 63.0, 73.0, 72.0, 67.0, 69.0, 68.0, 81.0, 99.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 83.0, 83.0, 81.0, 80.0, 74.0, 87.0, 99.0, 102.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 142.0, 143.0, 143.0, 152.0, 137.0, 135.0, 122.0, 187.0, 161.0], "value": 145.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 164.0, 164.0, 161.0, 159.0, 158.0, 163.0, 161.0, 160.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 72.0, 85.0, 83.0, 81.0, 81.0, 80.0], "value": 73.9, "unit": "score"}], "name": "kraken", "value": 1430.6, "alertThreshold": 2.0}]} 14:39:50 INFO - Return code: 0 14:39:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:39:50 INFO - # TBPL SUCCESS # 14:39:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:39:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:39:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:39:50 INFO - 2017-03-30 14:39:50.293 screenresolution[1660:9925] starting screenresolution argv=screenresolution get 14:39:50 INFO - 2017-03-30 14:39:50.296 screenresolution[1660:9925] Display 0: 1600x1200x32@60 14:39:50 INFO - 2017-03-30 14:39:50.302 screenresolution[1661:9928] starting screenresolution argv=screenresolution list 14:39:50 INFO - Available Modes on Display 0 14:39:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:39:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:39:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:39:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:39:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:39:50 INFO - Intel Iris: 14:39:50 INFO - Chipset Model: Intel Iris 14:39:50 INFO - Type: GPU 14:39:50 INFO - Bus: Built-In 14:39:50 INFO - VRAM (Dynamic, Max): 1536 MB 14:39:50 INFO - Vendor: Intel (0x8086) 14:39:50 INFO - Device ID: 0x0a2e 14:39:50 INFO - Revision ID: 0x0009 14:39:50 INFO - Displays: 14:39:50 INFO - Display: 14:39:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:39:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:39:50 INFO - Display Serial Number: 1600x1200 60 14:39:50 INFO - Main Display: Yes 14:39:50 INFO - Mirror: Off 14:39:50 INFO - Online: Yes 14:39:50 INFO - Rotation: Supported 14:39:50 INFO - Return code: 0 14:39:50 INFO - Running post-action listener: _resource_record_post_action 14:39:50 INFO - [mozharness: 2017-03-30 21:39:50.541462Z] Finished run-tests step (success) 14:39:50 INFO - Running post-run listener: _resource_record_post_run 14:39:50 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 38228992; Write bytes: 424088576; Read time: 382; Write time: 1476 14:39:50 INFO - TinderboxPrint: CPU usage
54.1% 14:39:50 INFO - TinderboxPrint: I/O read bytes / time
38,228,992 / 382 14:39:50 INFO - TinderboxPrint: I/O write bytes / time
424,088,576 / 1,476 14:39:50 INFO - TinderboxPrint: CPU idle
2,185.7 (45.9%) 14:39:50 INFO - TinderboxPrint: CPU system
960.3 (20.2%) 14:39:50 INFO - TinderboxPrint: CPU user
1,615.7 (33.9%) 14:39:50 INFO - TinderboxPrint: Swap in / out
159,903,744 / 0 14:39:50 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 111888896; Write bytes: 108369920; Read time: 9976; Write time: 259 14:39:50 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 37262336; Write bytes: 297327616; Read time: 367; Write time: 1160 14:39:50 INFO - Running post-run listener: _upload_blobber_files 14:39:50 INFO - Blob upload gear active. 14:39:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:39:50 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:39:51 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:39:51 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:39:51 INFO - (blobuploader) - INFO - Open directory for files ... 14:39:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:39:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:39:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:39:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:39:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:39:52 INFO - (blobuploader) - INFO - Done attempting. 14:39:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:39:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:39:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:39:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:39:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:39:53 INFO - (blobuploader) - INFO - Done attempting. 14:39:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:39:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:39:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:39:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:39:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:39:54 INFO - (blobuploader) - INFO - Done attempting. 14:39:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:39:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:39:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:39:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:39:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:39:56 INFO - (blobuploader) - INFO - Done attempting. 14:39:56 INFO - (blobuploader) - INFO - Iteration through files over. 14:39:56 INFO - Return code: 0 14:39:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:39:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:39:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d8be2b8e552c018727703cb6270d8f4eb0415091ba9a51e2b2d31189bde50bbfd8bebe37a6152713161da803341c5806b1c4f889b1888688d1685538666adf86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6bdd4ebe357b2a93edd67d0fcf20f3c9d155c26992bacd1c937cb5698a65512790e98bb70f9d024e29311bd7040e30f23d9d215126737837b481c1bc919b86dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/06a069af727c57c67ffb490fbb20ff9690dcb1aab9cd1af00d8401dcb945a02332a79ac18a81dbf60302db3a3313d24cce62c182caf54f987302ef47ab6515c1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8fa815e33426105940f9c91d9b9d5e7a5334d979fa9eefaf4e607e3909db5fa657d2f1dd0b33ef1c9e9af071aeabd4e839fde5854752c1dcd458119da41541ce"} 14:39:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:39:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:39:56 INFO - Contents: 14:39:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d8be2b8e552c018727703cb6270d8f4eb0415091ba9a51e2b2d31189bde50bbfd8bebe37a6152713161da803341c5806b1c4f889b1888688d1685538666adf86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6bdd4ebe357b2a93edd67d0fcf20f3c9d155c26992bacd1c937cb5698a65512790e98bb70f9d024e29311bd7040e30f23d9d215126737837b481c1bc919b86dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/06a069af727c57c67ffb490fbb20ff9690dcb1aab9cd1af00d8401dcb945a02332a79ac18a81dbf60302db3a3313d24cce62c182caf54f987302ef47ab6515c1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8fa815e33426105940f9c91d9b9d5e7a5334d979fa9eefaf4e607e3909db5fa657d2f1dd0b33ef1c9e9af071aeabd4e839fde5854752c1dcd458119da41541ce"} 14:39:56 INFO - Running post-run listener: copy_logs_to_upload_dir 14:39:56 INFO - Copying logs to upload dir... 14:39:56 INFO - mkdir: /builds/slave/test/build/upload/logs 14:39:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.445834 ========= master_lag: 1.75 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-03-30 14:39:58.761898) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 14:39:58.765054) ========= 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.XHJo4hCk5e/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.OgsOdV7p6b/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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/Mozilla-Beta/sha512/d8be2b8e552c018727703cb6270d8f4eb0415091ba9a51e2b2d31189bde50bbfd8bebe37a6152713161da803341c5806b1c4f889b1888688d1685538666adf86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6bdd4ebe357b2a93edd67d0fcf20f3c9d155c26992bacd1c937cb5698a65512790e98bb70f9d024e29311bd7040e30f23d9d215126737837b481c1bc919b86dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/06a069af727c57c67ffb490fbb20ff9690dcb1aab9cd1af00d8401dcb945a02332a79ac18a81dbf60302db3a3313d24cce62c182caf54f987302ef47ab6515c1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8fa815e33426105940f9c91d9b9d5e7a5334d979fa9eefaf4e607e3909db5fa657d2f1dd0b33ef1c9e9af071aeabd4e839fde5854752c1dcd458119da41541ce"} build_url:https://queue.taskcluster.net/v1/task/FZnecyPcSui5Yo0HLDNHjg/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011074 build_url: 'https://queue.taskcluster.net/v1/task/FZnecyPcSui5Yo0HLDNHjg/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d8be2b8e552c018727703cb6270d8f4eb0415091ba9a51e2b2d31189bde50bbfd8bebe37a6152713161da803341c5806b1c4f889b1888688d1685538666adf86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6bdd4ebe357b2a93edd67d0fcf20f3c9d155c26992bacd1c937cb5698a65512790e98bb70f9d024e29311bd7040e30f23d9d215126737837b481c1bc919b86dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/06a069af727c57c67ffb490fbb20ff9690dcb1aab9cd1af00d8401dcb945a02332a79ac18a81dbf60302db3a3313d24cce62c182caf54f987302ef47ab6515c1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8fa815e33426105940f9c91d9b9d5e7a5334d979fa9eefaf4e607e3909db5fa657d2f1dd0b33ef1c9e9af071aeabd4e839fde5854752c1dcd458119da41541ce"}' ========= master_lag: 0.17 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 14:39:58.942017) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 14:39:58.942350) ========= 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.XHJo4hCk5e/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.OgsOdV7p6b/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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.005326 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 14:39:58.969917) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 14:39:58.970229) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 14:39:58.970553) ========= ========= Total master_lag: 2.02 =========