builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0153 starttime: 1490205935.35 results: success (0) buildid: 20170322095635 builduid: 7c25221d4da84dd1be88f135b6d73892 revision: 69b1e67f3da3960f6c32df56d5e627c73c1b0a82 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 11:05:35.354773) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 11:05:35.355214) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 11:05:35.355501) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 11:05:35.382031) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 11:05:35.382403) ========= 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.ytJyEnYfXC/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.0zADjzTxSA/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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-22 11:05:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 197M=0s 2017-03-22 11:05:35 (197 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.110071 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 11:05:35.517006) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 11:05:35.517369) ========= 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.ytJyEnYfXC/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.0zADjzTxSA/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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.029369 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 11:05:35.568971) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-22 11:05:35.569375) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 69b1e67f3da3960f6c32df56d5e627c73c1b0a82 --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 69b1e67f3da3960f6c32df56d5e627c73c1b0a82 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ytJyEnYfXC/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.0zADjzTxSA/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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-22 11:05:35,706 truncating revision to first 12 chars 2017-03-22 11:05:35,706 Setting DEBUG logging. 2017-03-22 11:05:35,706 attempt 1/10 2017-03-22 11:05:35,706 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/69b1e67f3da3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-22 11:05:37,507 unpacking tar archive at: mozilla-beta-69b1e67f3da3/testing/mozharness/ program finished with exit code 0 elapsedTime=2.092531 ========= master_lag: 0.18 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-22 11:05:37.843036) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 11:05:37.843564) ========= script_repo_revision: 69b1e67f3da3960f6c32df56d5e627c73c1b0a82 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 11:05:37.844185) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 11:05:37.844609) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 11:05:37.866902) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-22 11:05:37.867357) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.ytJyEnYfXC/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.0zADjzTxSA/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 11:05:38 INFO - MultiFileLogger online at 20170322 11:05:38 in /builds/slave/test 11:05:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:05:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:05:38 INFO - {'append_to_log': False, 11:05:38 INFO - 'base_work_dir': '/builds/slave/test', 11:05:38 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:05:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:05:38 INFO - 'branch': 'Mozilla-Beta', 11:05:38 INFO - 'buildbot_json_path': 'buildprops.json', 11:05:38 INFO - 'config_files': ('talos/mac_config.py',), 11:05:38 INFO - 'default_actions': ('clobber', 11:05:38 INFO - 'read-buildbot-config', 11:05:38 INFO - 'download-and-extract', 11:05:38 INFO - 'populate-webroot', 11:05:38 INFO - 'create-virtualenv', 11:05:38 INFO - 'install', 11:05:38 INFO - 'run-tests'), 11:05:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:05:38 INFO - 'download_minidump_stackwalk': True, 11:05:38 INFO - 'download_symbols': 'ondemand', 11:05:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:05:38 INFO - 'tooltool.py': '/tools/tooltool.py', 11:05:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:05:38 INFO - '/tools/misc-python/virtualenv.py')}, 11:05:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:05:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:05:38 INFO - 'installer_path': 'installer.exe', 11:05:38 INFO - 'log_level': 'info', 11:05:38 INFO - 'log_name': 'talos', 11:05:38 INFO - 'log_to_console': True, 11:05:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:05:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:05:38 INFO - 'opt_config_files': (), 11:05:38 INFO - 'pip_index': False, 11:05:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:05:38 INFO - 'cmd': ('bash', 11:05:38 INFO - '-c', 11:05:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:05:38 INFO - 'enabled': True, 11:05:38 INFO - 'halt_on_failure': False, 11:05:38 INFO - 'name': 'check_screen_resolution'},), 11:05:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:05:38 INFO - 'cmd': ('bash', 11:05:38 INFO - '-c', 11:05:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:05:38 INFO - 'enabled': True, 11:05:38 INFO - 'halt_on_failure': False, 11:05:38 INFO - 'name': 'check_screen_resolution'},), 11:05:38 INFO - 'run_cmd_checks_enabled': True, 11:05:38 INFO - 'sps_profile': False, 11:05:38 INFO - 'sps_profile_interval': 0, 11:05:38 INFO - 'suite': 'dromaeojs-e10s', 11:05:38 INFO - 'system_bits': '32', 11:05:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:05:38 INFO - 'title': 't-yosemite-r7-0153', 11:05:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:05:38 INFO - 'use_talos_json': True, 11:05:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:05:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:05:38 INFO - 'work_dir': 'build'} 11:05:38 INFO - [mozharness: 2017-03-22 18:05:38.114927Z] Running clobber step. 11:05:38 INFO - Running pre-action listener: _resource_record_pre_action 11:05:38 INFO - Running main action method: clobber 11:05:38 INFO - rmtree: /builds/slave/test/build 11:05:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:05:40 INFO - Running post-action listener: _resource_record_post_action 11:05:40 INFO - [mozharness: 2017-03-22 18:05:40.820072Z] Finished clobber step (success) 11:05:40 INFO - [mozharness: 2017-03-22 18:05:40.820247Z] Running read-buildbot-config step. 11:05:40 INFO - Running pre-action listener: _resource_record_pre_action 11:05:40 INFO - Running main action method: read_buildbot_config 11:05:40 INFO - Using buildbot properties: 11:05:40 INFO - { 11:05:40 INFO - "project": "", 11:05:40 INFO - "product": "firefox", 11:05:40 INFO - "script_repo_revision": "production", 11:05:40 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 11:05:40 INFO - "repository": "", 11:05:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 11:05:40 INFO - "buildid": "20170322095635", 11:05:40 INFO - "pgo_build": "False", 11:05:40 INFO - "basedir": "/builds/slave/test", 11:05:40 INFO - "buildnumber": 6, 11:05:40 INFO - "slavename": "t-yosemite-r7-0153", 11:05:40 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 11:05:40 INFO - "platform": "yosemite_r7", 11:05:40 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:05:40 INFO - "branch": "mozilla-beta", 11:05:40 INFO - "repo_path": "releases/mozilla-beta", 11:05:40 INFO - "revision": "69b1e67f3da3960f6c32df56d5e627c73c1b0a82", 11:05:40 INFO - "stage_platform": "macosx64", 11:05:40 INFO - "builduid": "7c25221d4da84dd1be88f135b6d73892", 11:05:40 INFO - "slavebuilddir": "test" 11:05:40 INFO - } 11:05:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/Tiu6srBDSo64s6RlpNneZw/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 11:05:40 INFO - Running post-action listener: _resource_record_post_action 11:05:40 INFO - [mozharness: 2017-03-22 18:05:40.823706Z] Finished read-buildbot-config step (success) 11:05:40 INFO - [mozharness: 2017-03-22 18:05:40.823838Z] Running download-and-extract step. 11:05:40 INFO - Running pre-action listener: _resource_record_pre_action 11:05:40 INFO - Running main action method: download_and_extract 11:05:40 INFO - mkdir: /builds/slave/test/build/tests 11:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:40 INFO - trying https://queue.taskcluster.net/v1/task/Tiu6srBDSo64s6RlpNneZw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 11:05:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Tiu6srBDSo64s6RlpNneZw/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 11:05:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tiu6srBDSo64s6RlpNneZw/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 11:05:42 INFO - Downloaded 1165 bytes. 11:05:42 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 11:05:42 INFO - Using the following test package requirements: 11:05:42 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 11:05:42 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:05:42 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 11:05:42 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:05:42 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 11:05:42 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:05:42 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:05:42 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 11:05:42 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 11:05:42 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:05:42 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 11:05:42 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:05:42 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 11:05:42 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:05:42 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 11:05:42 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:05:42 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 11:05:42 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 11:05:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tiu6srBDSo64s6RlpNneZw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 11:05:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tiu6srBDSo64s6RlpNneZw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 11:05:42 INFO - Fetch https://queue.taskcluster.net/v1/task/Tiu6srBDSo64s6RlpNneZw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 11:05:43 INFO - Expected file size: 16108209 11:05:43 INFO - Obtained file size: 16108209 11:05:49 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 11:05:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tiu6srBDSo64s6RlpNneZw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 11:05:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tiu6srBDSo64s6RlpNneZw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 11:05:49 INFO - Fetch https://queue.taskcluster.net/v1/task/Tiu6srBDSo64s6RlpNneZw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 11:05:50 INFO - Expected file size: 16108209 11:05:50 INFO - Obtained file size: 16108209 11:05:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tiu6srBDSo64s6RlpNneZw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 11:05:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tiu6srBDSo64s6RlpNneZw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 11:05:57 INFO - Fetch https://queue.taskcluster.net/v1/task/Tiu6srBDSo64s6RlpNneZw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 11:05:58 INFO - Expected file size: 14403663 11:05:58 INFO - Obtained file size: 14403663 11:05: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')]} 11:05:58 INFO - trying https://queue.taskcluster.net/v1/task/Tiu6srBDSo64s6RlpNneZw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 11:05:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Tiu6srBDSo64s6RlpNneZw/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 11:05:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tiu6srBDSo64s6RlpNneZw/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 11:06:00 INFO - Downloaded 58762172 bytes. 11:06:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Tiu6srBDSo64s6RlpNneZw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 11:06:00 INFO - mkdir: /builds/slave/test/properties 11:06:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:06:00 INFO - Writing to file /builds/slave/test/properties/build_url 11:06:00 INFO - Contents: 11:06:00 INFO - build_url:https://queue.taskcluster.net/v1/task/Tiu6srBDSo64s6RlpNneZw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 11:06:01 INFO - Running post-action listener: _resource_record_post_action 11:06:01 INFO - Running post-action listener: set_extra_try_arguments 11:06:01 INFO - [mozharness: 2017-03-22 18:06:01.051466Z] Finished download-and-extract step (success) 11:06:01 INFO - [mozharness: 2017-03-22 18:06:01.051600Z] Running populate-webroot step. 11:06:01 INFO - Running pre-action listener: _resource_record_pre_action 11:06:01 INFO - Running main action method: populate_webroot 11:06:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:06:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:06:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:06:01 INFO - '--tppagecycles', 11:06:01 INFO - '7'], 11:06:01 INFO - 'tests': ['tsvgm']}}, 11:06:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:06:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:06:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:06:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:06:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:06:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:06:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:06:01 INFO - 'talos_options': ['--disable-e10s'], 11:06:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:06:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:06:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:06:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:06:01 INFO - 'talos_options': ['--disable-e10s'], 11:06:01 INFO - 'tests': ['damp', 'tps']}, 11:06:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:06:01 INFO - 'tests': ['damp', 'tps']}, 11:06:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:06:01 INFO - 'tests': ['dromaeo_dom']}, 11:06:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:06:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:06:01 INFO - 'tests': ['basic_compositor_video']}, 11:06:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:06:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:06:01 INFO - 'tests': ['a11yr', 11:06:01 INFO - 'ts_paint', 11:06:01 INFO - 'tpaint', 11:06:01 INFO - 'sessionrestore', 11:06:01 INFO - 'sessionrestore_no_auto_restore', 11:06:01 INFO - 'tabpaint']}, 11:06:01 INFO - 'other-e10s': {'tests': ['a11yr', 11:06:01 INFO - 'ts_paint', 11:06:01 INFO - 'tpaint', 11:06:01 INFO - 'sessionrestore', 11:06:01 INFO - 'sessionrestore_no_auto_restore', 11:06:01 INFO - 'tabpaint']}, 11:06:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:06:01 INFO - 'ts_paint', 11:06:01 INFO - 'tpaint', 11:06:01 INFO - 'sessionrestore', 11:06:01 INFO - 'sessionrestore_no_auto_restore', 11:06:01 INFO - 'tabpaint']}, 11:06:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:06:01 INFO - 'ts_paint', 11:06:01 INFO - 'tpaint', 11:06:01 INFO - 'sessionrestore', 11:06:01 INFO - 'sessionrestore_no_auto_restore', 11:06:01 INFO - 'tabpaint']}, 11:06:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:06:01 INFO - 'tests': ['a11yr', 11:06:01 INFO - 'ts_paint', 11:06:01 INFO - 'tpaint', 11:06:01 INFO - 'sessionrestore', 11:06:01 INFO - 'sessionrestore_no_auto_restore', 11:06:01 INFO - 'tabpaint']}, 11:06:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:06:01 INFO - 'tests': ['a11yr', 11:06:01 INFO - 'ts_paint', 11:06:01 INFO - 'tpaint', 11:06:01 INFO - 'sessionrestore', 11:06:01 INFO - 'sessionrestore_no_auto_restore', 11:06:01 INFO - 'tabpaint']}, 11:06:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:06:01 INFO - 'tests': ['tsvgx', 11:06:01 INFO - 'tsvgr_opacity', 11:06:01 INFO - 'tart', 11:06:01 INFO - 'tscrollx', 11:06:01 INFO - 'cart', 11:06:01 INFO - 'tsvg_static']}, 11:06:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:06:01 INFO - 'tsvgr_opacity', 11:06:01 INFO - 'tart', 11:06:01 INFO - 'tscrollx', 11:06:01 INFO - 'cart', 11:06:01 INFO - 'tsvg_static']}, 11:06:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:06:01 INFO - 'talos_options': ['--disable-e10s'], 11:06:01 INFO - 'tests': ['tp5o']}, 11:06:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:06:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:06:01 INFO - 'talos_options': ['--disable-e10s', 11:06:01 INFO - '--xperf_path', 11:06:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:06:01 INFO - 'tests': ['tp5n']}, 11:06:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:06:01 INFO - 'talos_options': ['--xperf_path', 11:06:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:06:01 INFO - 'tests': ['tp5n']}}, 11:06:01 INFO - 'talos.zip': {'path': '', 11:06:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:06:01 INFO - Running post-action listener: _resource_record_post_action 11:06:01 INFO - [mozharness: 2017-03-22 18:06:01.069638Z] Finished populate-webroot step (success) 11:06:01 INFO - [mozharness: 2017-03-22 18:06:01.069746Z] Running create-virtualenv step. 11:06:01 INFO - Running pre-action listener: _resource_record_pre_action 11:06:01 INFO - Running main action method: create_virtualenv 11:06:01 INFO - Creating virtualenv /builds/slave/test/build/venv 11:06:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:06:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:06:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:06:01 INFO - Using real prefix '/tools/python27' 11:06:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:06:01 INFO - Installing distribute.............................................................................................................................................................................................done. 11:06:05 INFO - Installing pip.................done. 11:06:05 INFO - Return code: 0 11:06:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:06:05 INFO - Reading from file tmpfile_stdout 11:06:05 INFO - Output received: 11:06:05 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:06:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014e7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4e1cb59f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012c5d30>, '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 0x1011ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012babe8>, '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.ytJyEnYfXC/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.0zADjzTxSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 11:06:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:06:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ytJyEnYfXC/Render', 11:06:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:05 INFO - 'HOME': '/Users/cltbld', 11:06:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:05 INFO - 'LOGNAME': 'cltbld', 11:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:05 INFO - 'MOZ_NO_REMOTE': '1', 11:06:05 INFO - 'NO_EM_RESTART': '1', 11:06:05 INFO - 'PAGER': '/bin/cat', 11:06:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:05 INFO - 'PWD': '/builds/slave/test', 11:06:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:05 INFO - 'SHELL': '/bin/bash', 11:06:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0zADjzTxSA/Listeners', 11:06:05 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 11:06:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:05 INFO - 'USER': 'cltbld', 11:06:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:05 INFO - 'XPC_FLAGS': '0x0', 11:06:05 INFO - 'XPC_SERVICE_NAME': '0', 11:06:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:06:05 INFO - Cleaning up... 11:06:05 INFO - Return code: 0 11:06:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014e7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4e1cb59f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012c5d30>, '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 0x1011ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012babe8>, '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.ytJyEnYfXC/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.0zADjzTxSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 11:06:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:06:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ytJyEnYfXC/Render', 11:06:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:05 INFO - 'HOME': '/Users/cltbld', 11:06:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:05 INFO - 'LOGNAME': 'cltbld', 11:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:05 INFO - 'MOZ_NO_REMOTE': '1', 11:06:05 INFO - 'NO_EM_RESTART': '1', 11:06:05 INFO - 'PAGER': '/bin/cat', 11:06:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:05 INFO - 'PWD': '/builds/slave/test', 11:06:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:05 INFO - 'SHELL': '/bin/bash', 11:06:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0zADjzTxSA/Listeners', 11:06:05 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 11:06:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:05 INFO - 'USER': 'cltbld', 11:06:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:05 INFO - 'XPC_FLAGS': '0x0', 11:06:05 INFO - 'XPC_SERVICE_NAME': '0', 11:06:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:05 INFO - Downloading/unpacking psutil>=3.1.1 11:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:06:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:06:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:06:09 INFO - Installing collected packages: psutil 11:06:09 INFO - Running setup.py install for psutil 11:06:09 INFO - building 'psutil._psutil_osx' extension 11:06:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 11:06:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 11:06:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 11:06:10 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 11:06:10 INFO - building 'psutil._psutil_posix' extension 11:06:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 11:06:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:06:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:06:10 INFO - ^ 11:06:10 INFO - 1 warning generated. 11:06:10 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 11:06:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:06:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:06:10 INFO - Successfully installed psutil 11:06:10 INFO - Cleaning up... 11:06:10 INFO - Return code: 0 11:06:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014e7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4e1cb59f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012c5d30>, '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 0x1011ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012babe8>, '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.ytJyEnYfXC/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.0zADjzTxSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 11:06:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:06:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ytJyEnYfXC/Render', 11:06:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:10 INFO - 'HOME': '/Users/cltbld', 11:06:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:10 INFO - 'LOGNAME': 'cltbld', 11:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:10 INFO - 'MOZ_NO_REMOTE': '1', 11:06:10 INFO - 'NO_EM_RESTART': '1', 11:06:10 INFO - 'PAGER': '/bin/cat', 11:06:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:10 INFO - 'PWD': '/builds/slave/test', 11:06:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:10 INFO - 'SHELL': '/bin/bash', 11:06:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0zADjzTxSA/Listeners', 11:06:10 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 11:06:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:10 INFO - 'USER': 'cltbld', 11:06:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:10 INFO - 'XPC_FLAGS': '0x0', 11:06:10 INFO - 'XPC_SERVICE_NAME': '0', 11:06:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:06:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:06:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:06:13 INFO - Installing collected packages: mozsystemmonitor 11:06:13 INFO - Running setup.py install for mozsystemmonitor 11:06:13 INFO - Successfully installed mozsystemmonitor 11:06:13 INFO - Cleaning up... 11:06:13 INFO - Return code: 0 11:06:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1014e7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4e1cb59f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012c5d30>, '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 0x1011ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012babe8>, '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.ytJyEnYfXC/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.0zADjzTxSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 11:06:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:06:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:06:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ytJyEnYfXC/Render', 11:06:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:13 INFO - 'HOME': '/Users/cltbld', 11:06:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:13 INFO - 'LOGNAME': 'cltbld', 11:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:13 INFO - 'MOZ_NO_REMOTE': '1', 11:06:13 INFO - 'NO_EM_RESTART': '1', 11:06:13 INFO - 'PAGER': '/bin/cat', 11:06:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:13 INFO - 'PWD': '/builds/slave/test', 11:06:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:13 INFO - 'SHELL': '/bin/bash', 11:06:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0zADjzTxSA/Listeners', 11:06:13 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 11:06:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:13 INFO - 'USER': 'cltbld', 11:06:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:13 INFO - 'XPC_FLAGS': '0x0', 11:06:13 INFO - 'XPC_SERVICE_NAME': '0', 11:06:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:14 INFO - Downloading/unpacking jsonschema==2.5.1 11:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:06:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:17 INFO - Downloading functools32-3.2.3-2.tar.gz 11:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:06:17 INFO - warning: no files found matching '*.txt' 11:06:17 INFO - no previously-included directories found matching 'build' 11:06:17 INFO - no previously-included directories found matching 'dist' 11:06:17 INFO - no previously-included directories found matching '.git*' 11:06:17 INFO - Installing collected packages: jsonschema, functools32 11:06:17 INFO - Running setup.py install for functools32 11:06:17 INFO - warning: no files found matching '*.txt' 11:06:17 INFO - no previously-included directories found matching 'build' 11:06:17 INFO - no previously-included directories found matching 'dist' 11:06:17 INFO - no previously-included directories found matching '.git*' 11:06:17 INFO - Successfully installed jsonschema functools32 11:06:17 INFO - Cleaning up... 11:06:17 INFO - Return code: 0 11:06:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1014e7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4e1cb59f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012c5d30>, '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 0x1011ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012babe8>, '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.ytJyEnYfXC/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.0zADjzTxSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 11:06:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:06:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ytJyEnYfXC/Render', 11:06:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:17 INFO - 'HOME': '/Users/cltbld', 11:06:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:17 INFO - 'LOGNAME': 'cltbld', 11:06:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:17 INFO - 'MOZ_NO_REMOTE': '1', 11:06:17 INFO - 'NO_EM_RESTART': '1', 11:06:17 INFO - 'PAGER': '/bin/cat', 11:06:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:17 INFO - 'PWD': '/builds/slave/test', 11:06:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:17 INFO - 'SHELL': '/bin/bash', 11:06:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0zADjzTxSA/Listeners', 11:06:17 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 11:06:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:17 INFO - 'USER': 'cltbld', 11:06:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:17 INFO - 'XPC_FLAGS': '0x0', 11:06:17 INFO - 'XPC_SERVICE_NAME': '0', 11:06:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:06:17 INFO - Cleaning up... 11:06:17 INFO - Return code: 0 11:06:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1014e7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4e1cb59f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012c5d30>, '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 0x1011ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012babe8>, '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.ytJyEnYfXC/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.0zADjzTxSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 11:06:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:06:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ytJyEnYfXC/Render', 11:06:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:17 INFO - 'HOME': '/Users/cltbld', 11:06:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:17 INFO - 'LOGNAME': 'cltbld', 11:06:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:17 INFO - 'MOZ_NO_REMOTE': '1', 11:06:17 INFO - 'NO_EM_RESTART': '1', 11:06:17 INFO - 'PAGER': '/bin/cat', 11:06:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:17 INFO - 'PWD': '/builds/slave/test', 11:06:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:17 INFO - 'SHELL': '/bin/bash', 11:06:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0zADjzTxSA/Listeners', 11:06:17 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 11:06:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:17 INFO - 'USER': 'cltbld', 11:06:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:17 INFO - 'XPC_FLAGS': '0x0', 11:06:17 INFO - 'XPC_SERVICE_NAME': '0', 11:06:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:18 INFO - Downloading/unpacking blobuploader==1.2.4 11:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:20 INFO - Downloading blobuploader-1.2.4.tar.gz 11:06:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:06:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:06:20 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 11:06:20 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 11:06:20 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 11:06:20 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 11:06:20 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 11:06:20 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 11:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:06:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:21 INFO - Downloading docopt-0.6.1.tar.gz 11:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:06:21 INFO - Installing collected packages: blobuploader, requests, docopt 11:06:21 INFO - Running setup.py install for blobuploader 11:06:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:06:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:06:22 INFO - Running setup.py install for requests 11:06:22 INFO - Running setup.py install for docopt 11:06:22 INFO - Successfully installed blobuploader requests docopt 11:06:22 INFO - Cleaning up... 11:06:22 INFO - Return code: 0 11:06:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:22 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 0x1014e7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4e1cb59f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012c5d30>, '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 0x1011ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012babe8>, '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.ytJyEnYfXC/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.0zADjzTxSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 11:06:22 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 11:06:22 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 11:06:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ytJyEnYfXC/Render', 11:06:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:22 INFO - 'HOME': '/Users/cltbld', 11:06:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:22 INFO - 'LOGNAME': 'cltbld', 11:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:22 INFO - 'MOZ_NO_REMOTE': '1', 11:06:22 INFO - 'NO_EM_RESTART': '1', 11:06:22 INFO - 'PAGER': '/bin/cat', 11:06:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:22 INFO - 'PWD': '/builds/slave/test', 11:06:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:22 INFO - 'SHELL': '/bin/bash', 11:06:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0zADjzTxSA/Listeners', 11:06:22 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 11:06:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:22 INFO - 'USER': 'cltbld', 11:06:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:22 INFO - 'XPC_FLAGS': '0x0', 11:06:22 INFO - 'XPC_SERVICE_NAME': '0', 11:06:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:06:23 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-T5eKha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:06:23 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-Fan52i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:06:23 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-X8A7GD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:06:23 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-8WQTnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:06:23 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-o87_kT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:06:23 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-C035Si-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:06:23 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-iijFp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:06:23 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-2hEqzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:06:23 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-pgadsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:06:24 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-2RdTd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:06:24 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-86Zaae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:06:24 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-lOhal1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:06:24 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-VEqySW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:06:24 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-FC7GbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:24 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-f8u0Ra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:06:24 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-E3DHhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:06:24 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-3zD0wJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:06:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:06:24 INFO - Running setup.py install for manifestparser 11:06:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:06:24 INFO - Running setup.py install for mozcrash 11:06:25 INFO - Running setup.py install for mozdebug 11:06:25 INFO - Running setup.py install for mozdevice 11:06:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:06:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:06:25 INFO - Running setup.py install for mozfile 11:06:25 INFO - Running setup.py install for mozhttpd 11:06:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:06:25 INFO - Running setup.py install for mozinfo 11:06:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:06:25 INFO - Running setup.py install for mozInstall 11:06:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:06:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:06:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:06:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:06:25 INFO - Running setup.py install for mozleak 11:06:26 INFO - Running setup.py install for mozlog 11:06:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:06:26 INFO - Running setup.py install for moznetwork 11:06:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:06:26 INFO - Running setup.py install for mozprocess 11:06:26 INFO - Running setup.py install for mozprofile 11:06:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:06:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:06:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:06:26 INFO - Running setup.py install for mozrunner 11:06:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:06:26 INFO - Running setup.py install for mozscreenshot 11:06:27 INFO - Running setup.py install for moztest 11:06:27 INFO - Running setup.py install for mozversion 11:06:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:06:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:06:27 INFO - Cleaning up... 11:06:27 INFO - Return code: 0 11:06:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:27 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 0x1014e7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4e1cb59f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012c5d30>, '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 0x1011ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012babe8>, '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.ytJyEnYfXC/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.0zADjzTxSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 11:06:27 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 11:06:27 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 11:06:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ytJyEnYfXC/Render', 11:06:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:27 INFO - 'HOME': '/Users/cltbld', 11:06:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:27 INFO - 'LOGNAME': 'cltbld', 11:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:27 INFO - 'MOZ_NO_REMOTE': '1', 11:06:27 INFO - 'NO_EM_RESTART': '1', 11:06:27 INFO - 'PAGER': '/bin/cat', 11:06:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:27 INFO - 'PWD': '/builds/slave/test', 11:06:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:27 INFO - 'SHELL': '/bin/bash', 11:06:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0zADjzTxSA/Listeners', 11:06:27 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 11:06:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:27 INFO - 'USER': 'cltbld', 11:06:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:27 INFO - 'XPC_FLAGS': '0x0', 11:06:27 INFO - 'XPC_SERVICE_NAME': '0', 11:06:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:06:27 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-e5sUyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:06:27 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)) 11:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:06:27 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-xJGHkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:06:27 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)) 11:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:06:27 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-sNhdys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:06:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:06:28 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-vfyCDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:06:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:06:28 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-MymwBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:06:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:06:28 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-AVrUMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:06:28 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)) 11:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:06:28 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-1c3OOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:06:28 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)) 11:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:06:28 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-CSx5gv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:06:28 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)) 11:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:06:28 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-MqbL_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:06:28 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)) 11:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:06:28 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-W8OYAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:06:28 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)) 11:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:06:28 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-8OSYd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:06:28 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)) 11:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:06:28 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-5KbeZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:06:28 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)) 11:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:06:28 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-IZL9si-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:06:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:06:29 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-cTVJtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:06:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:29 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-QuqWtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:29 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)) 11:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:06:29 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-rix2oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:06:29 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)) 11:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:06:29 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-tbUnTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:06:29 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)) 11:06:29 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)) 11:06:29 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)) 11:06:29 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)) 11:06:29 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)) 11:06:29 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)) 11:06:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:32 INFO - Downloading blessings-1.6.tar.gz 11:06:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:06:32 INFO - Installing collected packages: blessings 11:06:32 INFO - Running setup.py install for blessings 11:06:32 INFO - Successfully installed blessings 11:06:32 INFO - Cleaning up... 11:06:32 INFO - Return code: 0 11:06:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:06:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:06:32 INFO - Reading from file tmpfile_stdout 11:06:32 INFO - Current package versions: 11:06:32 INFO - blessings == 1.6 11:06:32 INFO - blobuploader == 1.2.4 11:06:32 INFO - docopt == 0.6.1 11:06:32 INFO - functools32 == 3.2.3-2 11:06:32 INFO - jsonschema == 2.5.1 11:06:32 INFO - manifestparser == 1.1 11:06:32 INFO - mozInstall == 1.12 11:06:32 INFO - mozcrash == 1.0 11:06:32 INFO - mozdebug == 0.1 11:06:32 INFO - mozdevice == 0.49 11:06:32 INFO - mozfile == 1.2 11:06:32 INFO - mozhttpd == 0.7 11:06:32 INFO - mozinfo == 0.9 11:06:32 INFO - mozleak == 0.1 11:06:32 INFO - mozlog == 3.4 11:06:32 INFO - moznetwork == 0.27 11:06:32 INFO - mozprocess == 0.24 11:06:32 INFO - mozprofile == 0.28 11:06:32 INFO - mozrunner == 6.13 11:06:32 INFO - mozscreenshot == 0.1 11:06:32 INFO - mozsystemmonitor == 0.3 11:06:32 INFO - moztest == 0.8 11:06:32 INFO - mozversion == 1.4 11:06:32 INFO - psutil == 3.1.1 11:06:32 INFO - requests == 1.2.3 11:06:32 INFO - wsgiref == 0.1.2 11:06:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:32 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')]} 11:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:32 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')]} 11:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014e7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4e1cb59f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012c5d30>, '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 0x1011ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012babe8>, '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.ytJyEnYfXC/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.0zADjzTxSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 11:06:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:06:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ytJyEnYfXC/Render', 11:06:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:33 INFO - 'HOME': '/Users/cltbld', 11:06:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:33 INFO - 'LOGNAME': 'cltbld', 11:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:33 INFO - 'MOZ_NO_REMOTE': '1', 11:06:33 INFO - 'NO_EM_RESTART': '1', 11:06:33 INFO - 'PAGER': '/bin/cat', 11:06:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:33 INFO - 'PWD': '/builds/slave/test', 11:06:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:33 INFO - 'SHELL': '/bin/bash', 11:06:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0zADjzTxSA/Listeners', 11:06:33 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 11:06:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:33 INFO - 'USER': 'cltbld', 11:06:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:33 INFO - 'XPC_FLAGS': '0x0', 11:06:33 INFO - 'XPC_SERVICE_NAME': '0', 11:06:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:06:33 INFO - Cleaning up... 11:06:33 INFO - Return code: 0 11:06:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014e7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4e1cb59f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012c5d30>, '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 0x1011ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012babe8>, '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.ytJyEnYfXC/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.0zADjzTxSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 11:06:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:06:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ytJyEnYfXC/Render', 11:06:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:33 INFO - 'HOME': '/Users/cltbld', 11:06:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:33 INFO - 'LOGNAME': 'cltbld', 11:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:33 INFO - 'MOZ_NO_REMOTE': '1', 11:06:33 INFO - 'NO_EM_RESTART': '1', 11:06:33 INFO - 'PAGER': '/bin/cat', 11:06:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:33 INFO - 'PWD': '/builds/slave/test', 11:06:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:33 INFO - 'SHELL': '/bin/bash', 11:06:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0zADjzTxSA/Listeners', 11:06:33 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 11:06:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:33 INFO - 'USER': 'cltbld', 11:06:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:33 INFO - 'XPC_FLAGS': '0x0', 11:06:33 INFO - 'XPC_SERVICE_NAME': '0', 11:06:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:06:34 INFO - Cleaning up... 11:06:34 INFO - Return code: 0 11:06:34 INFO - Running post-action listener: _resource_record_post_action 11:06:34 INFO - Running post-action listener: _start_resource_monitoring 11:06:34 INFO - Starting resource monitoring. 11:06:34 INFO - [mozharness: 2017-03-22 18:06:34.095424Z] Finished create-virtualenv step (success) 11:06:34 INFO - [mozharness: 2017-03-22 18:06:34.096361Z] Running install step. 11:06:34 INFO - Running pre-action listener: _resource_record_pre_action 11:06:34 INFO - Running main action method: install 11:06:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:06:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:06:34 INFO - Reading from file tmpfile_stdout 11:06:34 INFO - Detecting whether we're running mozinstall >=1.0... 11:06:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:06:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:06:34 INFO - Reading from file tmpfile_stdout 11:06:34 INFO - Output received: 11:06:34 INFO - Usage: mozinstall [options] installer 11:06:34 INFO - Options: 11:06:34 INFO - -h, --help show this help message and exit 11:06:34 INFO - -d DEST, --destination=DEST 11:06:34 INFO - Directory to install application into. [default: 11:06:34 INFO - "/builds/slave/test"] 11:06:34 INFO - --app=APP Application being installed. [default: firefox] 11:06:34 INFO - mkdir: /builds/slave/test/build/application 11:06:34 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'] 11:06:34 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 11:06:48 INFO - Reading from file tmpfile_stdout 11:06:48 INFO - Output received: 11:06:48 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:06:48 INFO - Running post-action listener: _resource_record_post_action 11:06:48 INFO - [mozharness: 2017-03-22 18:06:48.943435Z] Finished install step (success) 11:06:48 INFO - [mozharness: 2017-03-22 18:06:48.943576Z] Running run-tests step. 11:06:48 INFO - Running pre-action listener: _resource_record_pre_action 11:06:48 INFO - Running main action method: run_tests 11:06:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:06:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:06:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:06:48 INFO - 2017-03-22 11:06:48.957 screenresolution[1622:7487] starting screenresolution argv=screenresolution get 11:06:48 INFO - 2017-03-22 11:06:48.960 screenresolution[1622:7487] Display 0: 1600x1200x32@60 11:06:48 INFO - 2017-03-22 11:06:48.966 screenresolution[1623:7489] starting screenresolution argv=screenresolution list 11:06:48 INFO - Available Modes on Display 0 11:06:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:06:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:06:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:06:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:06:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:06:49 INFO - Intel Iris: 11:06:49 INFO - Chipset Model: Intel Iris 11:06:49 INFO - Type: GPU 11:06:49 INFO - Bus: Built-In 11:06:49 INFO - VRAM (Dynamic, Max): 1536 MB 11:06:49 INFO - Vendor: Intel (0x8086) 11:06:49 INFO - Device ID: 0x0a2e 11:06:49 INFO - Revision ID: 0x0009 11:06:49 INFO - Displays: 11:06:49 INFO - Display: 11:06:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:06:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:06:49 INFO - Display Serial Number: 1600x1200 60 11:06:49 INFO - Main Display: Yes 11:06:49 INFO - Mirror: Off 11:06:49 INFO - Online: Yes 11:06:49 INFO - Rotation: Supported 11:06:49 INFO - Return code: 0 11:06:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:06:49 INFO - Python 2.7.3 11:06:49 INFO - Return code: 0 11:06:49 INFO - grabbing minidump binary from tooltool 11:06:49 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')]} 11:06:49 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 0x1012c5d30>, '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 0x1011ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012babe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:06:49 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 11:06:49 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 11:06:49 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 11:06:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:06:49 INFO - Return code: 0 11:06:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:06:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:06:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:06:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:06:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:06:49 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-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tiu6srBDSo64s6RlpNneZw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0153', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:06:49 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-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Tiu6srBDSo64s6RlpNneZw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0153 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:06:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ytJyEnYfXC/Render', 11:06:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:49 INFO - 'HOME': '/Users/cltbld', 11:06:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:49 INFO - 'LOGNAME': 'cltbld', 11:06:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:06:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:49 INFO - 'MOZ_NO_REMOTE': '1', 11:06:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:06:49 INFO - 'NO_EM_RESTART': '1', 11:06:49 INFO - 'PAGER': '/bin/cat', 11:06:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:49 INFO - 'PWD': '/builds/slave/test', 11:06:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:06:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:49 INFO - 'SHELL': '/bin/bash', 11:06:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0zADjzTxSA/Listeners', 11:06:49 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 11:06:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:49 INFO - 'USER': 'cltbld', 11:06:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:49 INFO - 'XPC_FLAGS': '0x0', 11:06:49 INFO - 'XPC_SERVICE_NAME': '0', 11:06:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tiu6srBDSo64s6RlpNneZw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0153', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:06:49 INFO - mozversion application_buildid: 20170322095635 11:06:49 INFO - mozversion application_changeset: 69b1e67f3da3960f6c32df56d5e627c73c1b0a82 11:06:49 INFO - mozversion application_display_name: Firefox 11:06:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:06:49 INFO - mozversion application_name: Firefox 11:06:49 INFO - mozversion application_remotingname: firefox 11:06:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:06:49 INFO - mozversion application_vendor: Mozilla 11:06:49 INFO - mozversion application_version: 53.0 11:06:49 INFO - mozversion platform_buildid: 20170322095635 11:06:49 INFO - mozversion platform_changeset: 69b1e67f3da3960f6c32df56d5e627c73c1b0a82 11:06:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:06:49 INFO - mozversion platform_version: 53.0 11:06:49 INFO - using testdate: 1490206009 11:06:49 INFO - actual date: 1490206009 11:06:49 INFO - starting webserver on 'localhost:49241' 11:06:49 INFO - SUITE-START | Running 2 tests 11:06:49 INFO - TEST-START | dromaeo_css 11:06:49 INFO - operating with platform_type : mac_ 11:06:49 INFO - Initialising browser for dromaeo_css test... 11:06:49 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmp7FVxWo/profile http://localhost:49241/getInfo.html) 11:06:52 INFO - PROCESS | 1633 | 2017-03-22 11:06:52.441 plugin-container[1636:7663] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d4f, name = 'com.apple.tsm.portname' 11:06:52 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:06:52 INFO - PROCESS | 1633 | 2017-03-22 11:06:52.442 plugin-container[1636:7663] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e1f, name = 'com.apple.CFPasteboardClient' 11:06:52 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:06:52 INFO - PROCESS | 1633 | 2017-03-22 11:06:52.442 plugin-container[1636:7663] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:06:52 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 11:06:52 INFO - PROCESS | 1633 | colorDepth:24 11:06:52 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 11:06:52 INFO - PROCESS | 1633 | __metrics 11:06:52 ERROR - PROCESS | 1633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 11:06:53 INFO - TEST-INFO | 1633: exit 0 11:06:53 INFO - Browser initialized. 11:06:53 INFO - Running cycle 1/1 for dromaeo_css test... 11:06:53 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmp7FVxWo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:06:55 INFO - PROCESS | 1637 | 2017-03-22 11:06:55.748 plugin-container[1638:7785] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 11:06:55 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:06:55 INFO - PROCESS | 1637 | 2017-03-22 11:06:55.749 plugin-container[1638:7785] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b23, name = 'com.apple.CFPasteboardClient' 11:06:55 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:06:55 INFO - PROCESS | 1637 | 2017-03-22 11:06:55.749 plugin-container[1638:7785] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:07:05 INFO - PROCESS | 1637 | RSS: Main: 172896256 11:07:05 INFO - PROCESS | 1637 | 11:10:07 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 11:10:08 INFO - PROCESS | 1637 | RSS: Main: 190451712 11:10:08 INFO - PROCESS | 1637 | 11:13:11 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 11:13:11 INFO - PROCESS | 1637 | RSS: Main: 201023488 11:13:11 INFO - PROCESS | 1637 | 11:16:13 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 11:16:14 INFO - PROCESS | 1637 | RSS: Main: 202768384 11:16:14 INFO - PROCESS | 1637 | 11:19:16 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 11:19:16 INFO - PROCESS | 1637 | RSS: Main: 205774848 11:19:16 INFO - PROCESS | 1637 | 11:22:19 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 11:22:20 INFO - PROCESS | 1637 | RSS: Main: 207998976 11:22:20 INFO - PROCESS | 1637 | 11:25:23 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 11:25:23 INFO - PROCESS | 1637 | RSS: Main: 208793600 11:25:23 INFO - PROCESS | 1637 | 11:25:23 INFO - PROCESS | 1637 | __start_tp_report 11:25:23 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 11:25:23 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 11:25:23 INFO - PROCESS | 1637 | |i|pagename|runs| 11:25:23 INFO - PROCESS | 1637 | |0;dojo.html;3295.6210035845875;3525.488804123402;3544.273423948091;3545.929081418372;3549.183687751817;5963.433473819986;5979.760809567618;5988.011978023632;6021.187139736135;6042.788502402417;4913.877153071175;5943.078822782465;6021;6047.455728984391;6077.483413909823;5354.330708661418;5409.080456322435;5443.537299329542;5497.532709719679;5501.972490137544;5445.128779395298;5471.945280547203;5496.258005169311;5496.725163741817;5511.311086114236;5192.039472697544;5261.631685781997;5339.22581225722;5342.358916929974;5486.1222204447295;5345.198220266952;5363.195520671911;5437.293151890229;5443.1835224716215;5506.779728810843;5330.067238233293;5384.542313903284;5386.461353864622;5391.649542779707;5404.540614047811;4600.930986035212;5765.509931655814;5906.202662640531;5958.016927207005;6033.5173186145;6233.376662333731;6252.937470625327;6258.780942666985;6295.464885484739;6346.968265158691;6391.169148010729;6424.93575064248;6425.550211485198;6428.485721142344;6445.709943052574;6084.939150608526;6115.663638499836;6118.969405153035;6122.357152499013;6131.3868613138775;5341.439148889388;6288.088227207029;6429.260635027032;6435.099086127946;6445;6215.564910456315;6257.56197066201;6270.6864656766975;6275.309715931336;6314.147590075373;5383.407825139231;6354.745810167541;6377.96811015942;6406.487481001509;6414.583052101599;6241.812745617639;6256.43692067707;6271.466925311308;6281.811545653638;6292.307846136921;6266.467350275278;6289.433950944437;6310.305866354697;6316.747330106744;6342.5243106767175;5095.617828662791;5112.054269960069;5116.820911268088;5128.820371314619;5130.358705161855;4429.202743506135;4477.7984990675495;4535.909281814345;4580.312953057001;4632.837850675211;6112.969435152796;6205.28639206488;6205.906911396332;6229.813105606839;6237.877182107264;6407.263164736022;6426.1003459515705;6426.4537514311805;6436.678166091677;6453.580517266362;6071.878562428727;6111.84720381994;6135.753292002367;6160.507159427235;6185.134081228632;5541.33503979517;5591.245181900473;5614.747336369873;5624.521915637217;5649;6586.242582103119;6594.175728033996;6597.373249541286;6638.634875081917;6639.402453779279;6184.474319682878;6218.720157592828;6255.437010669061;6293.716782744696;6385.840353991001;6604.0754294399785;6632.83417914556;6646.90029649546;6655.068290439439;6660.800175994728;6343.429091381798;6360.045993101072;6360.204974378203;6367.713452894538;6376.426121649074;4661.463931647904;5127.871803204801;6256.405641464054;6327.873442531031;6385.074164246251;6253.280872699698;6258.780942666985;6262.2172228471445;6292.3078461368295;6301.7164227608955;6280.591761535486;6284.214473190851;6289.874202516015;6295.716692748929;6331.3352098029045;4903.485134061015;6010.87978240424;6108.389161083856;6135.355158799568;6158.476529495043;5205.349331333583;6265.216847894013;6267.185265915402;6282.842928926813;6309.305976342691;6261.467775239155;6266.467350275278;6268.780592679234;6270.968645156745;6284.528660350401 11:25:23 INFO - PROCESS | 1637 | |1;ext.html;466.48453458927884;477.78022109829476;495.63570775480036;519.6907839835296;526.5918912842548;38312;42668;42777.14445711084;42869.92825179372;42920.78539607301;43626.78186609071;44467.11065778683;44574;44595.777021114845;44963.32555011677;9503.619855205801;9747.658831940884;9771.364861283993;11582.884171158306;11996.220245684002;11701.239419437752;11745.412729363541;11828.290302581872;11831.290122592629;11854.110941679366;11582.536698532049;11798.351090690052;11813.881861181408;11831.290122592629;11853;11671.941640291829;11686;11760.823587646191;11779.17545771792;11816.881831181665;11586.826197607043;11618.767624647544;11646.70883227926;11783.234089784137;11846.111541634413;38228.04429889247;38317.85046448611;38748.41877371842;38779;38846.22307553861;3965.9603403966166;4048.959510404917;4062.5531191568903;4097.487814023247;4145.79271036447;28267.434651307063;28721.856390718123;28814.711852881414;28876.855615721997;30703.846480767454;3152.7320177784914;3355.8154301513405;3357.1271469417884;3361.4957756336744;3364.4280472319765;519284.4035779835;521893;522428.38785806205;523197;527162;45995;46450.83872903137;57792;58615.70692146512;58628;57798.8440231193;59061.70469147627;61352.693236534426;61564;61596;16505;16724.83275167257;16744.41394551185;16754.99470031802;16821.495355139366;11893.345865977455;12174.878251217375;12748.298843563507;12999.675008124683;13051.738965220833;18410.447686569423;18485.7227141593;18529.90735046316;18553.44339669812;18560.350387736366;6658.400743932973;8261.504309741435;8278.83442331162;8308.252257296872;8403.915960840313;787.4055088408215;869.6608322754131;886.5522910929939;890.9688160914337;930.3022732950287;31182.532262016088;31196.844015779774;31221.37557248842;31295.06114816559;32160.035198944068;963.9951800241095;1045.4563626914114;1090.1823632275793;1114.3202646385698;1253.6239128261668;13934.721305574034;17242.482725518254;17278.740818887727;17683.911580442014;17762.11189440523;688546;704572;705247;706108;717155;62780.686096569225;63209;63309.73380532364;63457.04814427787;63457.04814427787;1456.8251809782894;1467.4130347860942;1487.0259979713305;1510.2222355486933;1516.1358025925117;30143;32238.838805805823;32320;32354.35291294208;32840;41172.79413602913;41591.792041039604;51904.740476297375;51911.2213316793;51916.740416297675;461981;468957;469784;470344;471724.64137679094;26518.337041574116;27567.448651026465;27830.860845695643;27882.581761274003;27911.16266512008;43657;43956.34065489084;45615.771921140185;45702.77148614236;45710.54289457063;36623.45064824083;36666.63333366739;37005.81497092497;37685.765487470075;37805.4329185068;36468.90593282206;36589;37442.43836342511;37488;37620.811895940344;35905.82047089748;35955.280894381445;36253.637463625026;36363.63636363708;36828.631713682524;30986.845065774527;32631.510527341634;32751.836240818644;33022.33955320928;33141.50287745734;24081.916313766273;24324.87837560801;24349.87825060863;24738.752612473643;24869.626955596043 11:25:23 INFO - PROCESS | 1637 | |2;jquery.html;337.21597286309327;394.8775879477364;405.30287904803737;407.559835377792;425.57655133142526;19190.040497975115;20061.899690501545;21971.34085977423;21996.670049949244;22280.55438891223;22199.89301979131;22501.774982250172;22588;22692.65961010582;22733;5707.65754054757;5828.795992140276;5887.322957859837;5973.970130149343;5980.760769569234;4451.376807246988;5844.3279022912275;5954.196183515235;5960.821175364746;6652.201735791712;6769.221539522944;6776.2546119926765;6777.559458635197;6779.118714567099;6784.626845523494;6416.262129855057;6547.836304092388;6585.308542603054;6635.336466353374;6708.094407255007;5753.51095156908;5824.184614154022;5831.533477321804;5836.38717934615;5853.648781073107;22926;27592;27786.444271114666;27871.86064069667;27888.442231155263;2795.8182718123257;2798.398344355973;2813.7608303294246;2842.559403292493;2844.431113777253;15970;16281.348746050262;16411.261493232832;16524.09117498537;17010.40463583781;1858.628274345123;1868.6169335286233;1911.5794525204433;1915.2051898462262;1915.8275755181962;130960.6903930958;133015.33492332572;137388;138830.6116938828;140975.5902440983;9175;10521.368717876952;10555.208359373079;10998.505067271832;11322.26405283654;11401.828972565418;13330.26683532415;13331.200127992352;13393.19640821554;13526.458941642224;8626.353023523261;8707.825843483095;8743.34424918121;8795.560221988875;8843.248323892542;9089.954550227207;9134.314926380548;9136.908630913606;9177.311701622404;9304.488253146143;4083.3262511685834;4200.15996800635;4218.451601291812;4254.340577210537;4306.289462238696;1295.6048405236493;1807.2228941555256;1997.9800201998085;2071.968920466194;2133.9359819205447;910.239949642043;1010.2271762101998;1037.6523864505475;1043.3583346242006;1094.3379255550278;22271.55456890853;22555.774442255697;22835.657465138036;22867.885660571592;22947.426314342276;1036.7770929250248;1047.3925123428394;1050.6060227414719;1054.2936232724094;1102.7739313440725;10854.67435976922;11718.414079296;11748.412579371168;11908.583199588145;11918.880811191777;659626;741143;827603;832146;849352;138124;149232;158295.41704582807;161258;162910;457.4190777712287;475.602871602216;478.5477723551211;481.860260524451;482.07441711913214;11518.94240528792;11646.592369267035;11700.765984680429;11726.472308745957;12028;59658.40341596702;62903;64273;65073;66161.33838661744;84482.31035379136;89307.55346223488;93615;94761.19863456795;95342.61643458968;8006.959095317571;8129.593520324079;8583.871241931502;8829.337799664921;9167.08329167078;13024.674383140497;13091.476340946636;13747.725045498833;13780.65548361299;14042.859571404155;11515.942420287845;11768.293902365886;11800.409979501163;11830.40847957616;12150.817737734118;10227.693169204937;10788.676339709822;11485.655430337103;11699.181057325906;11707.941460292644;11636.06911447099;11662;11739.589114381297;11973.880261197277;12136.211146275464;8634;8897.510636915033;12978;13105.344732763133;13267.071305008556;10964.506597202986;11275.04162146194;12076.577319793765;12231.327276999495;12288.262704237774 11:25:23 INFO - PROCESS | 1637 | |3;mootools.html;1254.8682388349223;1452.8256609206894;1466.516049703598;1473.3959076778524;1483.2064845307762;7610.619469026547;7799.727009554666;8019.478733882308;8312.127226641198;8763.561821908903;8270.83458330833;8428.662853485868;8538.530380829052;8662.52356120413;8676.479411235314;2405.182238039062;2436.2691192642224;2444.706635203778;2447.645091461737;2455.9754402456015;2052.5176583502866;2386.486905315357;2419.4556224849357;2460.138951367025;2484.9378765530823;2415.0943396226417;2420.552197843396;2431.55016321981;2464.6179842124498;2470.29596564979;2383.3922349800864;2407.5305315463315;2411.505641343529;2412.2522018174423;2414.5291668124723;2376.964345534818;2381.5117900830287;2430.9149179778624;2440.7437219091917;2441.060191826142;8705.825883482295;8722.781930451725;8750.824983500293;8778.166074222938;8784.12158784123;5301.284326615934;5448.509634132907;5450.29146210994;5462.071447853875;5472.98749731301;3032.9848350758325;3518.6488388458743;3604.189057462076;3608.1881576645305;3689.6863766579872;1122.8098215891182;1246.8316777235048;1264.7091169031175;1269.6762325607003;1272.204871955028;11205.383703896365;11252.987231149154;11315.207935444521;11316.528851249368;11342.546298148065;4477.977610111929;4621.95378046222;4666.160091183619;4692.343071969927;4705.670603057822;8986.685466008788;8988.415752976036;8999.77500562478;9017.413868098552;9022.503762293005;4898.804047838046;5007.69953802773;5250.7637156328055;5332.706701131475;5341.465853414705;4829.6860704054125;4947.356843610308;4950.8267210647455;5001.574866136347;5014.674046186986;3839.1170030892495;3846.11539345952;3895.7272990890933;3955.604439556079;3974.105826189142;1108.8558487396588;1151.0503834336705;1164.5400066973668;1187.7683851648846;1206.6802297391198;904.3307952115518;910.7085732565515;917.9581175365875;923.1230331185401;943.4433684126261;5760.251167348218;5919.940800592025;5995.970020149872;6009.609375390585;6270;961.4423634292094;990.9058639429243;1008.606643409071;1018.1498448795339;1048.9685309440729;3569.910752231215;3849.1147036181274;3854;3913.4325522799036;3923.4507168996365;10179.083882450466;10469.581216751398;10525.21060920434;10528.052475277109;10587.205959553065;10375.740606484747;10444.164466842634;10482.161427085815;10487.632932847313;10503;7725.111612164673;8039.437239393304;8084.989376327959;8105.75682729519;8251.29863961558;5274.156135018378;5377.843763590847;5549.472800083986;5771.643663738934;5841.912371314349;7986.440949133737;9091.318151138823;9422.633718110972;9539.761505962406;9558.85661715061;8180.731986542096;9300.534973251175;9505.714828555154;9509.809803804024;9615.990321016472;6107.877842443215;7474.663640136098;7479.70081196746;7485.438592105723;7494.475386723095;5996.730147143477;7990.8002299940645;7994.800129996796;7998.680052797823;8035.276825085771;6690.565113267622;7297.854042919218;7300.525465844916;7408.851822963618;7422.96288518554;6750.594964302158;6795.490338224752;6833.145856767904;6877.759278425431;6889.414399775875;6455.870882582228;6551.115599394021;6563.212414510289;6640.435562977008;6651.33486651331;5009.5992320615;5077.543021128116;5095.923561146512;5191.32512773337;5258.6844789311235;5010.824621138243;5042.84871453857;5127.743612819269;5161.174212126042;5301.761420736153 11:25:23 INFO - PROCESS | 1637 | |4;prototype.html;335.8119453106259;362.2465272233754;370.60715641420086;379.90122568132284;384.67302792626253;4690.921088149723;4845.709257444556;4945.802167913279;5347.278117454142;5530.225768392424;5301.469853014697;5400.567954563635;5426.484483974026;5541.506322155026;5590.496855283024;3629.491871138043;4279.572042795727;4346.326319420495;4359.803808828602;4368.667556395299;3576.3204991051616;4191.853285135021;4343.239933011726;4384.89037774055;4455.910881782363;4269.722468039583;4274.273373526493;4305.24658184818;4312.310030395138;4339.696221264513;3504.526888869995;4295.2912769393015;4306.440162778835;4308.3537469379535;4337.9132417351475;3182.4908014717766;3807.9809600951817;3837.7505462144873;3869.9226015479812;3878.4182372644045;4388.71473354231;5057.041368597078;5194.142966410538;5332.600054995891;5499.615026948115;3955.960440395617;4461.661501549522;4472.121708882245;4999.8000079996755;5028.22062580297;4885.560299573055;5543.722813859291;5549.944500554983;5853;5853.151293062482;3515.9648403515894;3901.9804900975314;4168.6039826216465;4185.602367775056;4200.025987785736;5866.706664666793;6130.693465326761;6138.202033735631;6174.104754810573;6223.159873417076;4285.228658841376;4290.420793192941;4312.396264522969;4328.675349348749;4336.482231219111;4017.5982401760175;4184.497860256789;4323.416338794285;4354.4992325882295;4388.341748737651;4119.876403707894;4344.826206951687;4489.73061616304;4970.676906001098;4974.850754477371;4953.529414705597;5067.670601410897;5391.840754237857;5859.824205273849;5943.919628130207;1218.0986070307908;1270.9959132285576;1393.9930300348635;1397.7134687389062;1420.898803427352;912.7307444303947;953.7281874665687;997.8852431970271;1008.1430783833682;1014.5383850348074;4372.644480211145;5191.844244672666;5218.869528261748;5246.31797866275;5282.788688452496;4711.905761884743;5437.564994800407;5717.256756621613;5739.507727990753;5828.706780668908;4789.928151077736;4871.832864127991;4904.485029071896;5176.559992400688;5191.740412979336;2512.271441282008;2591.740825917431;2704.5131876262462;2969.3170570768843;3044.543318502198;4897.314375987365;5376.193570964387;5993.7712768882275;6018.729157187937;6036.607620504653;4914.967856750051;5479.082456043948;5566;5918.437748413894;5923.674197919069;4807.6394270429855;4867.853964381075;5322.176400690978;5355.705436201047;5397.245895084192;5435.728213589384;5448.073827449422;5747.212601887997;5791.681457519709;5799.652020878761;4820.060088282891;4940.086084074458;4995.000999799981;5323.254744335719;5573.9343361150395;5345.471988487579;5350.866228344323;5376.843978544632;5874.735636896265;5948.078047902582;3584.193556449778;3667.449882517644;3921.941170882496;4074.9405154660594;4094.488188976378;4880.487548807466;5047.772850221822;5188.377394712658;5337.252784610236;5354.919676204938;4624.560666736655;5678.346990096192;5705.515031222392;5809.82570522885;5869.618474799125;5109;5778.959787238337;5781.248437703071;5795.536357091507;5840.94159058404;5014.84955451337;5380.515753582196;5755.309362876482;5761.654300741969;5793.37785420083;4883.682560633548;5199.584033277253;5813.709314534341;5820.592558520862;5822.970885145547;5044.890124172676;5313.830957189412;5771.278590176228;5808;5838.474537291664 11:25:23 INFO - PROCESS | 1637 | |5;yui.html;728.5118970289906;737.7639155470248;745.0835472368987;806.7136166660836;874.9956250218748;15300.54098377049;15806.683866322666;16227.594310142238;16341;16475.01149931005;14781.778273325908;14977.326020329085;15058;15422.383104675828;15448;894.5214310343983;924.3344791749929;926.9443833369986;928.7817362919709;934.1172591900656;799.9880001799978;895.0870112485261;933.5425641435681;936.9765755856124;943.5423819447562;987.3187500624546;987.3976874106789;990.9504524773769;991.0683957080322;993.6472552243957;979.5591983607405;981.5239608789767;981.6564202529094;982.3271059324386;982.3516479123743;740.9110906691178;741.3957624535985;741.7663436017638;743.9516431431994;744.8994385757908;15671.354507776634;16109.355625774955;16113.033218006956;16544.338226470925;16782.83217167825;14299.78550321746;14417.639559011004;14659.193744344057;14690.412383504647;14779.630509237248;11789.097763007838;11794.174407791457;12255.93872030643;12268.38658067102;12592.68518287041;3744.2324323513612;3853.7880416577077;3905.1799122184375;4018.296798060357;4022.4770779798732;108379;108731.99999999921;109163;109177.45411272973;110562.44718776435;11010.559577616805;11025.393603351893;11137.888621113847;11558.711032224262;11730.530778768923;22889.656655149854;23201;23219.651705224434;23375.298741037797;23464.882675586854;8020.19798020205;8041.597920103972;8072.475289106189;8138.308243799225;8226.218509241613;4427.247367947457;4486.371907932892;4505.459344878635;4515.345274935116;4532.773361331921;3700.9444858327147;3771.377722675728;3782.0544863784053;3787.962120378816;3811.5807261201244;522.8222404382452;674.0832467843728;681.5637991685326;690.5338896245014;696.1611258433576;658.4304576541354;686.4371215603257;690.8169335126196;692.9514933954575;693.7710555516768;10457;10619.044286014141;10761.30051546647;10780.568777248978;10988.890111098786;676.3709749932511;693.8404167041608;695.062471101206;703.1807943745581;708.6917191021819;5158.92261616076;5160.767765450564;5175.430702622709;5179;5194.506521880416;99606.00393995967;112978;113298.43350783193;114348;116561;78294.608526957;97584;100468.49765751271;101742.49128754457;102399.4880025595;84587;84591;86803.56598216969;87593.5620321907;88295.55852220826;9747.756306092404;10090.798184036425;10101.141402980535;10104.646337378157;10142.695719128438;54439.455605443436;54775.35673929789;56146;56375.71812140913;56826.84821018593;56188;64895;67552.3244767546;74810;76728.61635691786;11220.158488113588;13719.862801371859;13864.237466939416;13979.860201397856;14083.647908802363;14526.782098268746;14671.55985320442;15451.768223476882;15476.458323958608;15765.921170394075;13989;14150.929245353707;14493.85506144925;14636.780448293497;14644.780328295297;12897.733213181473;14115.505957291856;14170.220637865017;14271.358783790556;14648.85351146475;13072.673183170116;14510.1293922365;14562.635934101732;14593.051451655609;14593.1973741441;11116.52755255348;11371.601993930173;11387.43062846871;11398.373089480157;11581.82627260575;8728.738137855875;10095.596176152872;11333.433328333385;11592.246503977214;11627.59303424376 11:25:23 INFO - PROCESS | 1637 | __end_tp_report 11:25:23 INFO - PROCESS | 1637 | __start_cc_report 11:25:23 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,364 11:25:23 INFO - PROCESS | 1637 | __end_cc_report 11:25:23 INFO - PROCESS | 1637 | __startTimestamp1490207123823__endTimestamp 11:25:23 INFO - PROCESS | 1637 | 11:25:23 INFO - PROCESS | 1637 | ------- Summary: start ------- 11:25:23 INFO - PROCESS | 1637 | Number of tests: 6 11:25:23 INFO - PROCESS | 1637 | 11:25:23 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5892.10 Median:6205.29 stddev:672.84 (10.8%) stddev-sans-first:643.33 11:25:23 INFO - PROCESS | 1637 | Values: 3295.6 3525.5 3544.3 3545.9 3549.2 5963.4 5979.8 5988.0 6021.2 6042.8 4913.9 5943.1 6021.0 6047.5 6077.5 5354.3 5409.1 5443.5 5497.5 5502.0 5445.1 5471.9 5496.3 5496.7 5511.3 5192.0 5261.6 5339.2 5342.4 5486.1 5345.2 5363.2 5437.3 5443.2 5506.8 5330.1 5384.5 5386.5 5391.6 5404.5 4600.9 5765.5 5906.2 5958.0 6033.5 6233.4 6252.9 6258.8 6295.5 6347.0 6391.2 6424.9 6425.6 6428.5 6445.7 6084.9 6115.7 6119.0 6122.4 6131.4 5341.4 6288.1 6429.3 6435.1 6445.0 6215.6 6257.6 6270.7 6275.3 6314.1 5383.4 6354.7 6378.0 6406.5 6414.6 6241.8 6256.4 6271.5 6281.8 6292.3 6266.5 6289.4 6310.3 6316.7 6342.5 5095.6 5112.1 5116.8 5128.8 5130.4 4429.2 4477.8 4535.9 4580.3 4632.8 6113.0 6205.3 6205.9 6229.8 6237.9 6407.3 6426.1 6426.5 6436.7 6453.6 6071.9 6111.8 6135.8 6160.5 6185.1 5541.3 5591.2 5614.7 5624.5 5649.0 6586.2 6594.2 6597.4 6638.6 6639.4 6184.5 6218.7 6255.4 6293.7 6385.8 6604.1 6632.8 6646.9 6655.1 6660.8 6343.4 6360.0 6360.2 6367.7 6376.4 4661.5 5127.9 6256.4 6327.9 6385.1 6253.3 6258.8 6262.2 6292.3 6301.7 6280.6 6284.2 6289.9 6295.7 6331.3 4903.5 6010.9 6108.4 6135.4 6158.5 5205.3 6265.2 6267.2 6282.8 6309.3 6261.5 6266.5 6268.8 6271.0 6284.5 11:25:23 INFO - PROCESS | 1637 | 11:25:23 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:69977.85 Median:36528.95 stddev:153542.41 (420.3%) stddev-sans-first:153884.44 11:25:23 INFO - PROCESS | 1637 | Values: 466.5 477.8 495.6 519.7 526.6 38312.0 42668.0 42777.1 42869.9 42920.8 43626.8 44467.1 44574.0 44595.8 44963.3 9503.6 9747.7 9771.4 11582.9 11996.2 11701.2 11745.4 11828.3 11831.3 11854.1 11582.5 11798.4 11813.9 11831.3 11853.0 11671.9 11686.0 11760.8 11779.2 11816.9 11586.8 11618.8 11646.7 11783.2 11846.1 38228.0 38317.9 38748.4 38779.0 38846.2 3966.0 4049.0 4062.6 4097.5 4145.8 28267.4 28721.9 28814.7 28876.9 30703.8 3152.7 3355.8 3357.1 3361.5 3364.4 519284.4 521893.0 522428.4 523197.0 527162.0 45995.0 46450.8 57792.0 58615.7 58628.0 57798.8 59061.7 61352.7 61564.0 61596.0 16505.0 16724.8 16744.4 16755.0 16821.5 11893.3 12174.9 12748.3 12999.7 13051.7 18410.4 18485.7 18529.9 18553.4 18560.4 6658.4 8261.5 8278.8 8308.3 8403.9 787.4 869.7 886.6 891.0 930.3 31182.5 31196.8 31221.4 31295.1 32160.0 964.0 1045.5 1090.2 1114.3 1253.6 13934.7 17242.5 17278.7 17683.9 17762.1 688546.0 704572.0 705247.0 706108.0 717155.0 62780.7 63209.0 63309.7 63457.0 63457.0 1456.8 1467.4 1487.0 1510.2 1516.1 30143.0 32238.8 32320.0 32354.4 32840.0 41172.8 41591.8 51904.7 51911.2 51916.7 461981.0 468957.0 469784.0 470344.0 471724.6 26518.3 27567.4 27830.9 27882.6 27911.2 43657.0 43956.3 45615.8 45702.8 45710.5 36623.5 36666.6 37005.8 37685.8 37805.4 36468.9 36589.0 37442.4 37488.0 37620.8 35905.8 35955.3 36253.6 36363.6 36828.6 30986.8 32631.5 32751.8 33022.3 33141.5 24081.9 24324.9 24349.9 24738.8 24869.6 11:25:23 INFO - PROCESS | 1637 | 11:25:23 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:42396.17 Median:22640.33 stddev:130648.75 (577.1%) stddev-sans-first:130977.08 11:25:23 INFO - PROCESS | 1637 | Values: 337.2 394.9 405.3 407.6 425.6 19190.0 20061.9 21971.3 21996.7 22280.6 22199.9 22501.8 22588.0 22692.7 22733.0 5707.7 5828.8 5887.3 5974.0 5980.8 4451.4 5844.3 5954.2 5960.8 6652.2 6769.2 6776.3 6777.6 6779.1 6784.6 6416.3 6547.8 6585.3 6635.3 6708.1 5753.5 5824.2 5831.5 5836.4 5853.6 22926.0 27592.0 27786.4 27871.9 27888.4 2795.8 2798.4 2813.8 2842.6 2844.4 15970.0 16281.3 16411.3 16524.1 17010.4 1858.6 1868.6 1911.6 1915.2 1915.8 130960.7 133015.3 137388.0 138830.6 140975.6 9175.0 10521.4 10555.2 10998.5 11322.3 11401.8 13330.3 13331.2 13393.2 13526.5 8626.4 8707.8 8743.3 8795.6 8843.2 9090.0 9134.3 9136.9 9177.3 9304.5 4083.3 4200.2 4218.5 4254.3 4306.3 1295.6 1807.2 1998.0 2072.0 2133.9 910.2 1010.2 1037.7 1043.4 1094.3 22271.6 22555.8 22835.7 22867.9 22947.4 1036.8 1047.4 1050.6 1054.3 1102.8 10854.7 11718.4 11748.4 11908.6 11918.9 659626.0 741143.0 827603.0 832146.0 849352.0 138124.0 149232.0 158295.4 161258.0 162910.0 457.4 475.6 478.5 481.9 482.1 11518.9 11646.6 11700.8 11726.5 12028.0 59658.4 62903.0 64273.0 65073.0 66161.3 84482.3 89307.6 93615.0 94761.2 95342.6 8007.0 8129.6 8583.9 8829.3 9167.1 13024.7 13091.5 13747.7 13780.7 14042.9 11515.9 11768.3 11800.4 11830.4 12150.8 10227.7 10788.7 11485.7 11699.2 11707.9 11636.1 11662.0 11739.6 11973.9 12136.2 8634.0 8897.5 12978.0 13105.3 13267.1 10964.5 11275.0 12076.6 12231.3 12288.3 11:25:23 INFO - PROCESS | 1637 | 11:25:23 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5538.92 Median:5144.46 stddev:3006.70 (58.4%) stddev-sans-first:2997.89 11:25:23 INFO - PROCESS | 1637 | Values: 1254.9 1452.8 1466.5 1473.4 1483.2 7610.6 7799.7 8019.5 8312.1 8763.6 8270.8 8428.7 8538.5 8662.5 8676.5 2405.2 2436.3 2444.7 2447.6 2456.0 2052.5 2386.5 2419.5 2460.1 2484.9 2415.1 2420.6 2431.6 2464.6 2470.3 2383.4 2407.5 2411.5 2412.3 2414.5 2377.0 2381.5 2430.9 2440.7 2441.1 8705.8 8722.8 8750.8 8778.2 8784.1 5301.3 5448.5 5450.3 5462.1 5473.0 3033.0 3518.6 3604.2 3608.2 3689.7 1122.8 1246.8 1264.7 1269.7 1272.2 11205.4 11253.0 11315.2 11316.5 11342.5 4478.0 4622.0 4666.2 4692.3 4705.7 8986.7 8988.4 8999.8 9017.4 9022.5 4898.8 5007.7 5250.8 5332.7 5341.5 4829.7 4947.4 4950.8 5001.6 5014.7 3839.1 3846.1 3895.7 3955.6 3974.1 1108.9 1151.1 1164.5 1187.8 1206.7 904.3 910.7 918.0 923.1 943.4 5760.3 5919.9 5996.0 6009.6 6270.0 961.4 990.9 1008.6 1018.1 1049.0 3569.9 3849.1 3854.0 3913.4 3923.5 10179.1 10469.6 10525.2 10528.1 10587.2 10375.7 10444.2 10482.2 10487.6 10503.0 7725.1 8039.4 8085.0 8105.8 8251.3 5274.2 5377.8 5549.5 5771.6 5841.9 7986.4 9091.3 9422.6 9539.8 9558.9 8180.7 9300.5 9505.7 9509.8 9616.0 6107.9 7474.7 7479.7 7485.4 7494.5 5996.7 7990.8 7994.8 7998.7 8035.3 6690.6 7297.9 7300.5 7408.9 7423.0 6750.6 6795.5 6833.1 6877.8 6889.4 6455.9 6551.1 6563.2 6640.4 6651.3 5009.6 5077.5 5095.9 5191.3 5258.7 5010.8 5042.8 5127.7 5161.2 5301.8 11:25:23 INFO - PROCESS | 1637 | 11:25:23 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4598.03 Median:4997.40 stddev:1361.26 (27.2%) stddev-sans-first:1326.96 11:25:23 INFO - PROCESS | 1637 | Values: 335.8 362.2 370.6 379.9 384.7 4690.9 4845.7 4945.8 5347.3 5530.2 5301.5 5400.6 5426.5 5541.5 5590.5 3629.5 4279.6 4346.3 4359.8 4368.7 3576.3 4191.9 4343.2 4384.9 4455.9 4269.7 4274.3 4305.2 4312.3 4339.7 3504.5 4295.3 4306.4 4308.4 4337.9 3182.5 3808.0 3837.8 3869.9 3878.4 4388.7 5057.0 5194.1 5332.6 5499.6 3956.0 4461.7 4472.1 4999.8 5028.2 4885.6 5543.7 5549.9 5853.0 5853.2 3516.0 3902.0 4168.6 4185.6 4200.0 5866.7 6130.7 6138.2 6174.1 6223.2 4285.2 4290.4 4312.4 4328.7 4336.5 4017.6 4184.5 4323.4 4354.5 4388.3 4119.9 4344.8 4489.7 4970.7 4974.9 4953.5 5067.7 5391.8 5859.8 5943.9 1218.1 1271.0 1394.0 1397.7 1420.9 912.7 953.7 997.9 1008.1 1014.5 4372.6 5191.8 5218.9 5246.3 5282.8 4711.9 5437.6 5717.3 5739.5 5828.7 4789.9 4871.8 4904.5 5176.6 5191.7 2512.3 2591.7 2704.5 2969.3 3044.5 4897.3 5376.2 5993.8 6018.7 6036.6 4915.0 5479.1 5566.0 5918.4 5923.7 4807.6 4867.9 5322.2 5355.7 5397.2 5435.7 5448.1 5747.2 5791.7 5799.7 4820.1 4940.1 4995.0 5323.3 5573.9 5345.5 5350.9 5376.8 5874.7 5948.1 3584.2 3667.4 3921.9 4074.9 4094.5 4880.5 5047.8 5188.4 5337.3 5354.9 4624.6 5678.3 5705.5 5809.8 5869.6 5109.0 5779.0 5781.2 5795.5 5840.9 5014.8 5380.5 5755.3 5761.7 5793.4 4883.7 5199.6 5813.7 5820.6 5823.0 5044.9 5313.8 5771.3 5808.0 5838.5 11:25:23 INFO - PROCESS | 1637 | 11:25:23 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:21729.11 Median:3722.59 stddev:31417.58 (844.0%) stddev-sans-first:31466.14 11:25:23 INFO - PROCESS | 1637 | Values: 728.5 737.8 745.1 806.7 875.0 15300.5 15806.7 16227.6 16341.0 16475.0 14781.8 14977.3 15058.0 15422.4 15448.0 894.5 924.3 926.9 928.8 934.1 800.0 895.1 933.5 937.0 943.5 987.3 987.4 991.0 991.1 993.6 979.6 981.5 981.7 982.3 982.4 740.9 741.4 741.8 744.0 744.9 15671.4 16109.4 16113.0 16544.3 16782.8 14299.8 14417.6 14659.2 14690.4 14779.6 11789.1 11794.2 12255.9 12268.4 12592.7 3744.2 3853.8 3905.2 4018.3 4022.5 108379.0 108732.0 109163.0 109177.5 110562.4 11010.6 11025.4 11137.9 11558.7 11730.5 22889.7 23201.0 23219.7 23375.3 23464.9 8020.2 8041.6 8072.5 8138.3 8226.2 4427.2 4486.4 4505.5 4515.3 4532.8 3700.9 3771.4 3782.1 3788.0 3811.6 522.8 674.1 681.6 690.5 696.2 658.4 686.4 690.8 693.0 693.8 10457.0 10619.0 10761.3 10780.6 10988.9 676.4 693.8 695.1 703.2 708.7 5158.9 5160.8 5175.4 5179.0 5194.5 99606.0 112978.0 113298.4 114348.0 116561.0 78294.6 97584.0 100468.5 101742.5 102399.5 84587.0 84591.0 86803.6 87593.6 88295.6 9747.8 10090.8 10101.1 10104.6 10142.7 54439.5 54775.4 56146.0 56375.7 56826.8 56188.0 64895.0 67552.3 74810.0 76728.6 11220.2 13719.9 13864.2 13979.9 14083.6 14526.8 14671.6 15451.8 15476.5 15765.9 13989.0 14150.9 14493.9 14636.8 14644.8 12897.7 14115.5 14170.2 14271.4 14648.9 13072.7 14510.1 14562.6 14593.1 14593.2 11116.5 11371.6 11387.4 11398.4 11581.8 8728.7 10095.6 11333.4 11592.2 11627.6 11:25:23 INFO - PROCESS | 1637 | -------- Summary: end -------- 11:25:23 INFO - PROCESS | 1637 | 11:25:24 INFO - TEST-INFO | 1637: exit 0 11:25:24 INFO - TEST-OK | dromaeo_css | took 1114848ms 11:25:24 INFO - TEST-START | kraken 11:25:24 INFO - operating with platform_type : mac_ 11:25:24 INFO - Initialising browser for kraken test... 11:25:24 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpNwT9x0/profile http://localhost:49241/getInfo.html) 11:25:26 INFO - PROCESS | 1649 | 2017-03-22 11:25:26.954 plugin-container[1651:10135] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8653, name = 'com.apple.tsm.portname' 11:25:26 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:25:26 INFO - PROCESS | 1649 | 2017-03-22 11:25:26.955 plugin-container[1651:10135] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4607, name = 'com.apple.CFPasteboardClient' 11:25:26 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:25:26 INFO - PROCESS | 1649 | 2017-03-22 11:25:26.955 plugin-container[1651:10135] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:25:27 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 11:25:27 INFO - PROCESS | 1649 | colorDepth:24 11:25:27 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 11:25:27 INFO - PROCESS | 1649 | __metrics 11:25:27 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 11:25:27 INFO - TEST-INFO | 1649: exit 0 11:25:27 INFO - Browser initialized. 11:25:27 INFO - Running cycle 1/1 for kraken test... 11:25:27 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpNwT9x0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:30 INFO - PROCESS | 1652 | 2017-03-22 11:25:30.127 plugin-container[1653:10262] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4247, name = 'com.apple.tsm.portname' 11:25:30 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:25:30 INFO - PROCESS | 1652 | 2017-03-22 11:25:30.128 plugin-container[1653:10262] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x451b, name = 'com.apple.CFPasteboardClient' 11:25:30 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:25:30 INFO - PROCESS | 1652 | 2017-03-22 11:25:30.128 plugin-container[1653:10262] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:25:39 INFO - PROCESS | 1652 | RSS: Main: 172920832 11:25:39 INFO - PROCESS | 1652 | 11:25:42 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 11:25:43 INFO - PROCESS | 1652 | RSS: Main: 185974784 11:25:43 INFO - PROCESS | 1652 | 11:25:46 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 11:25:46 INFO - PROCESS | 1652 | RSS: Main: 194990080 11:25:46 INFO - PROCESS | 1652 | 11:25:49 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 11:25:50 INFO - PROCESS | 1652 | RSS: Main: 197984256 11:25:50 INFO - PROCESS | 1652 | 11:25:52 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 11:25:53 INFO - PROCESS | 1652 | RSS: Main: 197902336 11:25:53 INFO - PROCESS | 1652 | 11:25:54 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:25:55 INFO - PROCESS | 1652 | RSS: Main: 197947392 11:25:55 INFO - PROCESS | 1652 | 11:25:58 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 11:25:58 INFO - PROCESS | 1652 | RSS: Main: 202412032 11:25:58 INFO - PROCESS | 1652 | 11:26:01 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 11:26:02 INFO - PROCESS | 1652 | RSS: Main: 203907072 11:26:02 INFO - PROCESS | 1652 | 11:26:05 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 11:26:05 INFO - PROCESS | 1652 | RSS: Main: 203423744 11:26:05 INFO - PROCESS | 1652 | 11:26:07 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:26:08 INFO - PROCESS | 1652 | RSS: Main: 203177984 11:26:08 INFO - PROCESS | 1652 | 11:26:10 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:26:10 INFO - PROCESS | 1652 | RSS: Main: 202502144 11:26:10 INFO - PROCESS | 1652 | 11:26:12 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:26:13 INFO - PROCESS | 1652 | RSS: Main: 202444800 11:26:13 INFO - PROCESS | 1652 | 11:26:16 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:26:17 INFO - PROCESS | 1652 | RSS: Main: 202674176 11:26:17 INFO - PROCESS | 1652 | 11:26:20 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:26:20 INFO - PROCESS | 1652 | RSS: Main: 203005952 11:26:20 INFO - PROCESS | 1652 | 11:26:22 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 11:26:22 INFO - PROCESS | 1652 | RSS: Main: 205082624 11:26:22 INFO - PROCESS | 1652 | 11:26:22 INFO - PROCESS | 1652 | __start_tp_report 11:26:22 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 11:26:22 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 11:26:22 INFO - PROCESS | 1652 | |i|pagename|runs| 11:26:22 INFO - PROCESS | 1652 | |0;ai-astar;115;120;116;117;116;137;158;117;115;119 11:26:22 INFO - PROCESS | 1652 | |1;audio-beat-detection;143;115;144;182;144;111;110;109;132;113 11:26:22 INFO - PROCESS | 1652 | |2;audio-dft;189;203;200;198;197;199;193;192;197;193 11:26:22 INFO - PROCESS | 1652 | |3;audio-fft;79;58;59;83;63;75;85;83;64;75 11:26:22 INFO - PROCESS | 1652 | |4;audio-oscillator;84;70;84;75;69;70;79;70;71;82 11:26:22 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;88;87;88;85;89;84;90;86;88;90 11:26:22 INFO - PROCESS | 1652 | |6;imaging-darkroom;99;101;100;102;98;99;98;121;126;98 11:26:22 INFO - PROCESS | 1652 | |7;imaging-desaturate;92;91;91;93;96;90;101;109;93;93 11:26:22 INFO - PROCESS | 1652 | |8;json-parse-financial;57;56;58;61;61;55;54;56;57;62 11:26:22 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;72;68;71;78;73;68;64;78;104;103 11:26:22 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;88;96;103;102;78;85;86;86;93;101 11:26:22 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;164;158;145;152;131;137;149;152;199;160 11:26:22 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;168;164;165;165;168;168;176;210;164;166 11:26:22 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;66;65;63;64;66;64;65;66;65;64 11:26:22 INFO - PROCESS | 1652 | __end_tp_report 11:26:22 INFO - PROCESS | 1652 | __start_cc_report 11:26:22 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,939 11:26:22 INFO - PROCESS | 1652 | __end_cc_report 11:26:22 INFO - PROCESS | 1652 | __startTimestamp1490207182677__endTimestamp 11:26:22 INFO - PROCESS | 1652 | 11:26:22 INFO - PROCESS | 1652 | ------- Summary: start ------- 11:26:22 INFO - PROCESS | 1652 | Number of tests: 14 11:26:22 INFO - PROCESS | 1652 | 11:26:22 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:123.00 Median:118.00 stddev:13.92 (11.8%) stddev-sans-first:14.46 11:26:22 INFO - PROCESS | 1652 | Values: 115.0 120.0 116.0 117.0 116.0 137.0 158.0 117.0 115.0 119.0 11:26:22 INFO - PROCESS | 1652 | 11:26:22 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:130.30 Median:137.50 stddev:23.53 (17.1%) stddev-sans-first:24.51 11:26:22 INFO - PROCESS | 1652 | Values: 143.0 115.0 144.0 182.0 144.0 111.0 110.0 109.0 132.0 113.0 11:26:22 INFO - PROCESS | 1652 | 11:26:22 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:196.10 Median:197.50 stddev:4.25 (2.2%) stddev-sans-first:3.66 11:26:22 INFO - PROCESS | 1652 | Values: 189.0 203.0 200.0 198.0 197.0 199.0 193.0 192.0 197.0 193.0 11:26:22 INFO - PROCESS | 1652 | 11:26:22 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:72.40 Median:77.00 stddev:10.47 (13.6%) stddev-sans-first:10.83 11:26:22 INFO - PROCESS | 1652 | Values: 79.0 58.0 59.0 83.0 63.0 75.0 85.0 83.0 64.0 75.0 11:26:22 INFO - PROCESS | 1652 | 11:26:22 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:75.40 Median:77.00 stddev:6.26 (8.1%) stddev-sans-first:5.81 11:26:22 INFO - PROCESS | 1652 | Values: 84.0 70.0 84.0 75.0 69.0 70.0 79.0 70.0 71.0 82.0 11:26:22 INFO - PROCESS | 1652 | 11:26:22 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:87.50 Median:88.00 stddev:2.01 (2.3%) stddev-sans-first:2.13 11:26:22 INFO - PROCESS | 1652 | Values: 88.0 87.0 88.0 85.0 89.0 84.0 90.0 86.0 88.0 90.0 11:26:22 INFO - PROCESS | 1652 | 11:26:22 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:104.20 Median:98.00 stddev:10.33 (10.5%) stddev-sans-first:10.78 11:26:22 INFO - PROCESS | 1652 | Values: 99.0 101.0 100.0 102.0 98.0 99.0 98.0 121.0 126.0 98.0 11:26:22 INFO - PROCESS | 1652 | 11:26:22 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:92.50 stddev:5.88 (6.4%) stddev-sans-first:6.14 11:26:22 INFO - PROCESS | 1652 | Values: 92.0 91.0 91.0 93.0 96.0 90.0 101.0 109.0 93.0 93.0 11:26:22 INFO - PROCESS | 1652 | 11:26:22 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.50 stddev:2.75 (4.8%) stddev-sans-first:2.91 11:26:22 INFO - PROCESS | 1652 | Values: 57.0 56.0 58.0 61.0 61.0 55.0 54.0 56.0 57.0 62.0 11:26:22 INFO - PROCESS | 1652 | 11:26:22 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:77.90 Median:71.50 stddev:14.17 (19.8%) stddev-sans-first:14.87 11:26:22 INFO - PROCESS | 1652 | Values: 72.0 68.0 71.0 78.0 73.0 68.0 64.0 78.0 104.0 103.0 11:26:22 INFO - PROCESS | 1652 | 11:26:22 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:91.80 Median:86.00 stddev:8.51 (9.9%) stddev-sans-first:8.91 11:26:22 INFO - PROCESS | 1652 | Values: 88.0 96.0 103.0 102.0 78.0 85.0 86.0 86.0 93.0 101.0 11:26:22 INFO - PROCESS | 1652 | 11:26:22 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:154.70 Median:155.00 stddev:18.57 (12.0%) stddev-sans-first:19.39 11:26:22 INFO - PROCESS | 1652 | Values: 164.0 158.0 145.0 152.0 131.0 137.0 149.0 152.0 199.0 160.0 11:26:22 INFO - PROCESS | 1652 | 11:26:22 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:168.00 stddev:14.01 (8.3%) stddev-sans-first:14.81 11:26:22 INFO - PROCESS | 1652 | Values: 168.0 164.0 165.0 165.0 168.0 168.0 176.0 210.0 164.0 166.0 11:26:22 INFO - PROCESS | 1652 | 11:26:22 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:1.03 (1.6%) stddev-sans-first:1.00 11:26:22 INFO - PROCESS | 1652 | Values: 66.0 65.0 63.0 64.0 66.0 64.0 65.0 66.0 65.0 64.0 11:26:22 INFO - PROCESS | 1652 | -------- Summary: end -------- 11:26:22 INFO - PROCESS | 1652 | 11:26:23 INFO - TEST-INFO | 1652: exit 0 11:26:23 INFO - TEST-OK | kraken | took 59073ms 11:26:23 INFO - SUITE-END | took 1173s 11:26:23 INFO - Completed test suite (00:19:34) 11:26:23 INFO - javascript benchmark 11:26:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7517.5587387753085, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3295.6210035845875, 3525.488804123402, 3544.273423948091, 3545.929081418372, 3549.183687751817, 5963.433473819986, 5979.760809567618, 5988.011978023632, 6021.187139736135, 6042.788502402417, 4913.877153071175, 5943.078822782465, 6021.0, 6047.455728984391, 6077.483413909823, 5354.330708661418, 5409.080456322435, 5443.537299329542, 5497.532709719679, 5501.972490137544, 5445.128779395298, 5471.945280547203, 5496.258005169311, 5496.725163741817, 5511.311086114236, 5192.039472697544, 5261.631685781997, 5339.22581225722, 5342.358916929974, 5486.1222204447295, 5345.198220266952, 5363.195520671911, 5437.293151890229, 5443.1835224716215, 5506.779728810843, 5330.067238233293, 5384.542313903284, 5386.461353864622, 5391.649542779707, 5404.540614047811, 4600.930986035212, 5765.509931655814, 5906.202662640531, 5958.016927207005, 6033.5173186145, 6233.376662333731, 6252.937470625327, 6258.780942666985, 6295.464885484739, 6346.968265158691, 6391.169148010729, 6424.93575064248, 6425.550211485198, 6428.485721142344, 6445.709943052574, 6084.939150608526, 6115.663638499836, 6118.969405153035, 6122.357152499013, 6131.3868613138775, 5341.439148889388, 6288.088227207029, 6429.260635027032, 6435.099086127946, 6445.0, 6215.564910456315, 6257.56197066201, 6270.6864656766975, 6275.309715931336, 6314.147590075373, 5383.407825139231, 6354.745810167541, 6377.96811015942, 6406.487481001509, 6414.583052101599, 6241.812745617639, 6256.43692067707, 6271.466925311308, 6281.811545653638, 6292.307846136921, 6266.467350275278, 6289.433950944437, 6310.305866354697, 6316.747330106744, 6342.5243106767175, 5095.617828662791, 5112.054269960069, 5116.820911268088, 5128.820371314619, 5130.358705161855, 4429.202743506135, 4477.7984990675495, 4535.909281814345, 4580.312953057001, 4632.837850675211, 6112.969435152796, 6205.28639206488, 6205.906911396332, 6229.813105606839, 6237.877182107264, 6407.263164736022, 6426.1003459515705, 6426.4537514311805, 6436.678166091677, 6453.580517266362, 6071.878562428727, 6111.84720381994, 6135.753292002367, 6160.507159427235, 6185.134081228632, 5541.33503979517, 5591.245181900473, 5614.747336369873, 5624.521915637217, 5649.0, 6586.242582103119, 6594.175728033996, 6597.373249541286, 6638.634875081917, 6639.402453779279, 6184.474319682878, 6218.720157592828, 6255.437010669061, 6293.716782744696, 6385.840353991001, 6604.0754294399785, 6632.83417914556, 6646.90029649546, 6655.068290439439, 6660.800175994728, 6343.429091381798, 6360.045993101072, 6360.204974378203, 6367.713452894538, 6376.426121649074, 4661.463931647904, 5127.871803204801, 6256.405641464054, 6327.873442531031, 6385.074164246251, 6253.280872699698, 6258.780942666985, 6262.2172228471445, 6292.3078461368295, 6301.7164227608955, 6280.591761535486, 6284.214473190851, 6289.874202516015, 6295.716692748929, 6331.3352098029045, 4903.485134061015, 6010.87978240424, 6108.389161083856, 6135.355158799568, 6158.476529495043, 5205.349331333583, 6265.216847894013, 6267.185265915402, 6282.842928926813, 6309.305976342691, 6261.467775239155, 6266.467350275278, 6268.780592679234, 6270.968645156745, 6284.528660350401], "value": 5852.098394999077, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.48453458927884, 477.78022109829476, 495.63570775480036, 519.6907839835296, 526.5918912842548, 38312.0, 42668.0, 42777.14445711084, 42869.92825179372, 42920.78539607301, 43626.78186609071, 44467.11065778683, 44574.0, 44595.777021114845, 44963.32555011677, 9503.619855205801, 9747.658831940884, 9771.364861283993, 11582.884171158306, 11996.220245684002, 11701.239419437752, 11745.412729363541, 11828.290302581872, 11831.290122592629, 11854.110941679366, 11582.536698532049, 11798.351090690052, 11813.881861181408, 11831.290122592629, 11853.0, 11671.941640291829, 11686.0, 11760.823587646191, 11779.17545771792, 11816.881831181665, 11586.826197607043, 11618.767624647544, 11646.70883227926, 11783.234089784137, 11846.111541634413, 38228.04429889247, 38317.85046448611, 38748.41877371842, 38779.0, 38846.22307553861, 3965.9603403966166, 4048.959510404917, 4062.5531191568903, 4097.487814023247, 4145.79271036447, 28267.434651307063, 28721.856390718123, 28814.711852881414, 28876.855615721997, 30703.846480767454, 3152.7320177784914, 3355.8154301513405, 3357.1271469417884, 3361.4957756336744, 3364.4280472319765, 519284.4035779835, 521893.0, 522428.38785806205, 523197.0, 527162.0, 45995.0, 46450.83872903137, 57792.0, 58615.70692146512, 58628.0, 57798.8440231193, 59061.70469147627, 61352.693236534426, 61564.0, 61596.0, 16505.0, 16724.83275167257, 16744.41394551185, 16754.99470031802, 16821.495355139366, 11893.345865977455, 12174.878251217375, 12748.298843563507, 12999.675008124683, 13051.738965220833, 18410.447686569423, 18485.7227141593, 18529.90735046316, 18553.44339669812, 18560.350387736366, 6658.400743932973, 8261.504309741435, 8278.83442331162, 8308.252257296872, 8403.915960840313, 787.4055088408215, 869.6608322754131, 886.5522910929939, 890.9688160914337, 930.3022732950287, 31182.532262016088, 31196.844015779774, 31221.37557248842, 31295.06114816559, 32160.035198944068, 963.9951800241095, 1045.4563626914114, 1090.1823632275793, 1114.3202646385698, 1253.6239128261668, 13934.721305574034, 17242.482725518254, 17278.740818887727, 17683.911580442014, 17762.11189440523, 688546.0, 704572.0, 705247.0, 706108.0, 717155.0, 62780.686096569225, 63209.0, 63309.73380532364, 63457.04814427787, 63457.04814427787, 1456.8251809782894, 1467.4130347860942, 1487.0259979713305, 1510.2222355486933, 1516.1358025925117, 30143.0, 32238.838805805823, 32320.0, 32354.35291294208, 32840.0, 41172.79413602913, 41591.792041039604, 51904.740476297375, 51911.2213316793, 51916.740416297675, 461981.0, 468957.0, 469784.0, 470344.0, 471724.64137679094, 26518.337041574116, 27567.448651026465, 27830.860845695643, 27882.581761274003, 27911.16266512008, 43657.0, 43956.34065489084, 45615.771921140185, 45702.77148614236, 45710.54289457063, 36623.45064824083, 36666.63333366739, 37005.81497092497, 37685.765487470075, 37805.4329185068, 36468.90593282206, 36589.0, 37442.43836342511, 37488.0, 37620.811895940344, 35905.82047089748, 35955.280894381445, 36253.637463625026, 36363.63636363708, 36828.631713682524, 30986.845065774527, 32631.510527341634, 32751.836240818644, 33022.33955320928, 33141.50287745734, 24081.916313766273, 24324.87837560801, 24349.87825060863, 24738.752612473643, 24869.626955596043], "value": 20521.052915202017, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.21597286309327, 394.8775879477364, 405.30287904803737, 407.559835377792, 425.57655133142526, 19190.040497975115, 20061.899690501545, 21971.34085977423, 21996.670049949244, 22280.55438891223, 22199.89301979131, 22501.774982250172, 22588.0, 22692.65961010582, 22733.0, 5707.65754054757, 5828.795992140276, 5887.322957859837, 5973.970130149343, 5980.760769569234, 4451.376807246988, 5844.3279022912275, 5954.196183515235, 5960.821175364746, 6652.201735791712, 6769.221539522944, 6776.2546119926765, 6777.559458635197, 6779.118714567099, 6784.626845523494, 6416.262129855057, 6547.836304092388, 6585.308542603054, 6635.336466353374, 6708.094407255007, 5753.51095156908, 5824.184614154022, 5831.533477321804, 5836.38717934615, 5853.648781073107, 22926.0, 27592.0, 27786.444271114666, 27871.86064069667, 27888.442231155263, 2795.8182718123257, 2798.398344355973, 2813.7608303294246, 2842.559403292493, 2844.431113777253, 15970.0, 16281.348746050262, 16411.261493232832, 16524.09117498537, 17010.40463583781, 1858.628274345123, 1868.6169335286233, 1911.5794525204433, 1915.2051898462262, 1915.8275755181962, 130960.6903930958, 133015.33492332572, 137388.0, 138830.6116938828, 140975.5902440983, 9175.0, 10521.368717876952, 10555.208359373079, 10998.505067271832, 11322.26405283654, 11401.828972565418, 13330.26683532415, 13331.200127992352, 13393.19640821554, 13526.458941642224, 8626.353023523261, 8707.825843483095, 8743.34424918121, 8795.560221988875, 8843.248323892542, 9089.954550227207, 9134.314926380548, 9136.908630913606, 9177.311701622404, 9304.488253146143, 4083.3262511685834, 4200.15996800635, 4218.451601291812, 4254.340577210537, 4306.289462238696, 1295.6048405236493, 1807.2228941555256, 1997.9800201998085, 2071.968920466194, 2133.9359819205447, 910.239949642043, 1010.2271762101998, 1037.6523864505475, 1043.3583346242006, 1094.3379255550278, 22271.55456890853, 22555.774442255697, 22835.657465138036, 22867.885660571592, 22947.426314342276, 1036.7770929250248, 1047.3925123428394, 1050.6060227414719, 1054.2936232724094, 1102.7739313440725, 10854.67435976922, 11718.414079296, 11748.412579371168, 11908.583199588145, 11918.880811191777, 659626.0, 741143.0, 827603.0, 832146.0, 849352.0, 138124.0, 149232.0, 158295.41704582807, 161258.0, 162910.0, 457.4190777712287, 475.602871602216, 478.5477723551211, 481.860260524451, 482.07441711913214, 11518.94240528792, 11646.592369267035, 11700.765984680429, 11726.472308745957, 12028.0, 59658.40341596702, 62903.0, 64273.0, 65073.0, 66161.33838661744, 84482.31035379136, 89307.55346223488, 93615.0, 94761.19863456795, 95342.61643458968, 8006.959095317571, 8129.593520324079, 8583.871241931502, 8829.337799664921, 9167.08329167078, 13024.674383140497, 13091.476340946636, 13747.725045498833, 13780.65548361299, 14042.859571404155, 11515.942420287845, 11768.293902365886, 11800.409979501163, 11830.40847957616, 12150.817737734118, 10227.693169204937, 10788.676339709822, 11485.655430337103, 11699.181057325906, 11707.941460292644, 11636.06911447099, 11662.0, 11739.589114381297, 11973.880261197277, 12136.211146275464, 8634.0, 8897.510636915033, 12978.0, 13105.344732763133, 13267.071305008556, 10964.506597202986, 11275.04162146194, 12076.577319793765, 12231.327276999495, 12288.262704237774], "value": 10057.69165287954, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1254.8682388349223, 1452.8256609206894, 1466.516049703598, 1473.3959076778524, 1483.2064845307762, 7610.619469026547, 7799.727009554666, 8019.478733882308, 8312.127226641198, 8763.561821908903, 8270.83458330833, 8428.662853485868, 8538.530380829052, 8662.52356120413, 8676.479411235314, 2405.182238039062, 2436.2691192642224, 2444.706635203778, 2447.645091461737, 2455.9754402456015, 2052.5176583502866, 2386.486905315357, 2419.4556224849357, 2460.138951367025, 2484.9378765530823, 2415.0943396226417, 2420.552197843396, 2431.55016321981, 2464.6179842124498, 2470.29596564979, 2383.3922349800864, 2407.5305315463315, 2411.505641343529, 2412.2522018174423, 2414.5291668124723, 2376.964345534818, 2381.5117900830287, 2430.9149179778624, 2440.7437219091917, 2441.060191826142, 8705.825883482295, 8722.781930451725, 8750.824983500293, 8778.166074222938, 8784.12158784123, 5301.284326615934, 5448.509634132907, 5450.29146210994, 5462.071447853875, 5472.98749731301, 3032.9848350758325, 3518.6488388458743, 3604.189057462076, 3608.1881576645305, 3689.6863766579872, 1122.8098215891182, 1246.8316777235048, 1264.7091169031175, 1269.6762325607003, 1272.204871955028, 11205.383703896365, 11252.987231149154, 11315.207935444521, 11316.528851249368, 11342.546298148065, 4477.977610111929, 4621.95378046222, 4666.160091183619, 4692.343071969927, 4705.670603057822, 8986.685466008788, 8988.415752976036, 8999.77500562478, 9017.413868098552, 9022.503762293005, 4898.804047838046, 5007.69953802773, 5250.7637156328055, 5332.706701131475, 5341.465853414705, 4829.6860704054125, 4947.356843610308, 4950.8267210647455, 5001.574866136347, 5014.674046186986, 3839.1170030892495, 3846.11539345952, 3895.7272990890933, 3955.604439556079, 3974.105826189142, 1108.8558487396588, 1151.0503834336705, 1164.5400066973668, 1187.7683851648846, 1206.6802297391198, 904.3307952115518, 910.7085732565515, 917.9581175365875, 923.1230331185401, 943.4433684126261, 5760.251167348218, 5919.940800592025, 5995.970020149872, 6009.609375390585, 6270.0, 961.4423634292094, 990.9058639429243, 1008.606643409071, 1018.1498448795339, 1048.9685309440729, 3569.910752231215, 3849.1147036181274, 3854.0, 3913.4325522799036, 3923.4507168996365, 10179.083882450466, 10469.581216751398, 10525.21060920434, 10528.052475277109, 10587.205959553065, 10375.740606484747, 10444.164466842634, 10482.161427085815, 10487.632932847313, 10503.0, 7725.111612164673, 8039.437239393304, 8084.989376327959, 8105.75682729519, 8251.29863961558, 5274.156135018378, 5377.843763590847, 5549.472800083986, 5771.643663738934, 5841.912371314349, 7986.440949133737, 9091.318151138823, 9422.633718110972, 9539.761505962406, 9558.85661715061, 8180.731986542096, 9300.534973251175, 9505.714828555154, 9509.809803804024, 9615.990321016472, 6107.877842443215, 7474.663640136098, 7479.70081196746, 7485.438592105723, 7494.475386723095, 5996.730147143477, 7990.8002299940645, 7994.800129996796, 7998.680052797823, 8035.276825085771, 6690.565113267622, 7297.854042919218, 7300.525465844916, 7408.851822963618, 7422.96288518554, 6750.594964302158, 6795.490338224752, 6833.145856767904, 6877.759278425431, 6889.414399775875, 6455.870882582228, 6551.115599394021, 6563.212414510289, 6640.435562977008, 6651.33486651331, 5009.5992320615, 5077.543021128116, 5095.923561146512, 5191.32512773337, 5258.6844789311235, 5010.824621138243, 5042.84871453857, 5127.743612819269, 5161.174212126042, 5301.761420736153], "value": 4514.055491241081, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.8119453106259, 362.2465272233754, 370.60715641420086, 379.90122568132284, 384.67302792626253, 4690.921088149723, 4845.709257444556, 4945.802167913279, 5347.278117454142, 5530.225768392424, 5301.469853014697, 5400.567954563635, 5426.484483974026, 5541.506322155026, 5590.496855283024, 3629.491871138043, 4279.572042795727, 4346.326319420495, 4359.803808828602, 4368.667556395299, 3576.3204991051616, 4191.853285135021, 4343.239933011726, 4384.89037774055, 4455.910881782363, 4269.722468039583, 4274.273373526493, 4305.24658184818, 4312.310030395138, 4339.696221264513, 3504.526888869995, 4295.2912769393015, 4306.440162778835, 4308.3537469379535, 4337.9132417351475, 3182.4908014717766, 3807.9809600951817, 3837.7505462144873, 3869.9226015479812, 3878.4182372644045, 4388.71473354231, 5057.041368597078, 5194.142966410538, 5332.600054995891, 5499.615026948115, 3955.960440395617, 4461.661501549522, 4472.121708882245, 4999.8000079996755, 5028.22062580297, 4885.560299573055, 5543.722813859291, 5549.944500554983, 5853.0, 5853.151293062482, 3515.9648403515894, 3901.9804900975314, 4168.6039826216465, 4185.602367775056, 4200.025987785736, 5866.706664666793, 6130.693465326761, 6138.202033735631, 6174.104754810573, 6223.159873417076, 4285.228658841376, 4290.420793192941, 4312.396264522969, 4328.675349348749, 4336.482231219111, 4017.5982401760175, 4184.497860256789, 4323.416338794285, 4354.4992325882295, 4388.341748737651, 4119.876403707894, 4344.826206951687, 4489.73061616304, 4970.676906001098, 4974.850754477371, 4953.529414705597, 5067.670601410897, 5391.840754237857, 5859.824205273849, 5943.919628130207, 1218.0986070307908, 1270.9959132285576, 1393.9930300348635, 1397.7134687389062, 1420.898803427352, 912.7307444303947, 953.7281874665687, 997.8852431970271, 1008.1430783833682, 1014.5383850348074, 4372.644480211145, 5191.844244672666, 5218.869528261748, 5246.31797866275, 5282.788688452496, 4711.905761884743, 5437.564994800407, 5717.256756621613, 5739.507727990753, 5828.706780668908, 4789.928151077736, 4871.832864127991, 4904.485029071896, 5176.559992400688, 5191.740412979336, 2512.271441282008, 2591.740825917431, 2704.5131876262462, 2969.3170570768843, 3044.543318502198, 4897.314375987365, 5376.193570964387, 5993.7712768882275, 6018.729157187937, 6036.607620504653, 4914.967856750051, 5479.082456043948, 5566.0, 5918.437748413894, 5923.674197919069, 4807.6394270429855, 4867.853964381075, 5322.176400690978, 5355.705436201047, 5397.245895084192, 5435.728213589384, 5448.073827449422, 5747.212601887997, 5791.681457519709, 5799.652020878761, 4820.060088282891, 4940.086084074458, 4995.000999799981, 5323.254744335719, 5573.9343361150395, 5345.471988487579, 5350.866228344323, 5376.843978544632, 5874.735636896265, 5948.078047902582, 3584.193556449778, 3667.449882517644, 3921.941170882496, 4074.9405154660594, 4094.488188976378, 4880.487548807466, 5047.772850221822, 5188.377394712658, 5337.252784610236, 5354.919676204938, 4624.560666736655, 5678.346990096192, 5705.515031222392, 5809.82570522885, 5869.618474799125, 5109.0, 5778.959787238337, 5781.248437703071, 5795.536357091507, 5840.94159058404, 5014.84955451337, 5380.515753582196, 5755.309362876482, 5761.654300741969, 5793.37785420083, 4883.682560633548, 5199.584033277253, 5813.709314534341, 5820.592558520862, 5822.970885145547, 5044.890124172676, 5313.830957189412, 5771.278590176228, 5808.0, 5838.474537291664], "value": 4184.075557312355, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.5118970289906, 737.7639155470248, 745.0835472368987, 806.7136166660836, 874.9956250218748, 15300.54098377049, 15806.683866322666, 16227.594310142238, 16341.0, 16475.01149931005, 14781.778273325908, 14977.326020329085, 15058.0, 15422.383104675828, 15448.0, 894.5214310343983, 924.3344791749929, 926.9443833369986, 928.7817362919709, 934.1172591900656, 799.9880001799978, 895.0870112485261, 933.5425641435681, 936.9765755856124, 943.5423819447562, 987.3187500624546, 987.3976874106789, 990.9504524773769, 991.0683957080322, 993.6472552243957, 979.5591983607405, 981.5239608789767, 981.6564202529094, 982.3271059324386, 982.3516479123743, 740.9110906691178, 741.3957624535985, 741.7663436017638, 743.9516431431994, 744.8994385757908, 15671.354507776634, 16109.355625774955, 16113.033218006956, 16544.338226470925, 16782.83217167825, 14299.78550321746, 14417.639559011004, 14659.193744344057, 14690.412383504647, 14779.630509237248, 11789.097763007838, 11794.174407791457, 12255.93872030643, 12268.38658067102, 12592.68518287041, 3744.2324323513612, 3853.7880416577077, 3905.1799122184375, 4018.296798060357, 4022.4770779798732, 108379.0, 108731.99999999921, 109163.0, 109177.45411272973, 110562.44718776435, 11010.559577616805, 11025.393603351893, 11137.888621113847, 11558.711032224262, 11730.530778768923, 22889.656655149854, 23201.0, 23219.651705224434, 23375.298741037797, 23464.882675586854, 8020.19798020205, 8041.597920103972, 8072.475289106189, 8138.308243799225, 8226.218509241613, 4427.247367947457, 4486.371907932892, 4505.459344878635, 4515.345274935116, 4532.773361331921, 3700.9444858327147, 3771.377722675728, 3782.0544863784053, 3787.962120378816, 3811.5807261201244, 522.8222404382452, 674.0832467843728, 681.5637991685326, 690.5338896245014, 696.1611258433576, 658.4304576541354, 686.4371215603257, 690.8169335126196, 692.9514933954575, 693.7710555516768, 10457.0, 10619.044286014141, 10761.30051546647, 10780.568777248978, 10988.890111098786, 676.3709749932511, 693.8404167041608, 695.062471101206, 703.1807943745581, 708.6917191021819, 5158.92261616076, 5160.767765450564, 5175.430702622709, 5179.0, 5194.506521880416, 99606.00393995967, 112978.0, 113298.43350783193, 114348.0, 116561.0, 78294.608526957, 97584.0, 100468.49765751271, 101742.49128754457, 102399.4880025595, 84587.0, 84591.0, 86803.56598216969, 87593.5620321907, 88295.55852220826, 9747.756306092404, 10090.798184036425, 10101.141402980535, 10104.646337378157, 10142.695719128438, 54439.455605443436, 54775.35673929789, 56146.0, 56375.71812140913, 56826.84821018593, 56188.0, 64895.0, 67552.3244767546, 74810.0, 76728.61635691786, 11220.158488113588, 13719.862801371859, 13864.237466939416, 13979.860201397856, 14083.647908802363, 14526.782098268746, 14671.55985320442, 15451.768223476882, 15476.458323958608, 15765.921170394075, 13989.0, 14150.929245353707, 14493.85506144925, 14636.780448293497, 14644.780328295297, 12897.733213181473, 14115.505957291856, 14170.220637865017, 14271.358783790556, 14648.85351146475, 13072.673183170116, 14510.1293922365, 14562.635934101732, 14593.051451655609, 14593.1973741441, 11116.52755255348, 11371.601993930173, 11387.43062846871, 11398.373089480157, 11581.82627260575, 8728.738137855875, 10095.596176152872, 11333.433328333385, 11592.246503977214, 11627.59303424376], "value": 7911.123606452916, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1502.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 120.0, 116.0, 117.0, 116.0, 137.0, 158.0, 117.0, 115.0, 119.0], "value": 123.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 115.0, 144.0, 182.0, 144.0, 111.0, 110.0, 109.0, 132.0, 113.0], "value": 130.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 203.0, 200.0, 198.0, 197.0, 199.0, 193.0, 192.0, 197.0, 193.0], "value": 196.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 59.0, 83.0, 63.0, 75.0, 85.0, 83.0, 64.0, 75.0], "value": 72.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 84.0, 75.0, 69.0, 70.0, 79.0, 70.0, 71.0, 82.0], "value": 75.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 88.0, 85.0, 89.0, 84.0, 90.0, 86.0, 88.0, 90.0], "value": 87.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 101.0, 100.0, 102.0, 98.0, 99.0, 98.0, 121.0, 126.0, 98.0], "value": 104.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 91.0, 93.0, 96.0, 90.0, 101.0, 109.0, 93.0, 93.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 58.0, 61.0, 61.0, 55.0, 54.0, 56.0, 57.0, 62.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 68.0, 71.0, 78.0, 73.0, 68.0, 64.0, 78.0, 104.0, 103.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 96.0, 103.0, 102.0, 78.0, 85.0, 86.0, 86.0, 93.0, 101.0], "value": 91.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 158.0, 145.0, 152.0, 131.0, 137.0, 149.0, 152.0, 199.0, 160.0], "value": 154.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 164.0, 165.0, 165.0, 168.0, 168.0, 176.0, 210.0, 164.0, 166.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 63.0, 64.0, 66.0, 64.0, 65.0, 66.0, 65.0, 64.0], "value": 64.8, "unit": "score"}]}]} 11:26:23 INFO - Return code: 0 11:26:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:26:23 ERROR - # TBPL SUCCESS # 11:26:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:26:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:26:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:26:23 INFO - 2017-03-22 11:26:23.963 screenresolution[1657:10642] starting screenresolution argv=screenresolution get 11:26:23 INFO - 2017-03-22 11:26:23.965 screenresolution[1657:10642] Display 0: 1600x1200x32@60 11:26:23 INFO - 2017-03-22 11:26:23.971 screenresolution[1658:10645] starting screenresolution argv=screenresolution list 11:26:23 INFO - Available Modes on Display 0 11:26:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:26:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:26:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:26:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:26:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:26:24 INFO - Intel Iris: 11:26:24 INFO - Chipset Model: Intel Iris 11:26:24 INFO - Type: GPU 11:26:24 INFO - Bus: Built-In 11:26:24 INFO - VRAM (Dynamic, Max): 1536 MB 11:26:24 INFO - Vendor: Intel (0x8086) 11:26:24 INFO - Device ID: 0x0a2e 11:26:24 INFO - Revision ID: 0x0009 11:26:24 INFO - Displays: 11:26:24 INFO - Display: 11:26:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:26:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:26:24 INFO - Display Serial Number: 1600x1200 60 11:26:24 INFO - Main Display: Yes 11:26:24 INFO - Mirror: Off 11:26:24 INFO - Online: Yes 11:26:24 INFO - Rotation: Supported 11:26:24 INFO - Return code: 0 11:26:24 INFO - Running post-action listener: _resource_record_post_action 11:26:24 INFO - [mozharness: 2017-03-22 18:26:24.206994Z] Finished run-tests step (success) 11:26:24 INFO - Running post-run listener: _resource_record_post_run 11:26:24 INFO - Total resource usage - Wall time: 1189s; CPU: 54.0%; Read bytes: 41711616; Write bytes: 428546048; Read time: 409; Write time: 1713 11:26:24 INFO - TinderboxPrint: CPU usage
54.4% 11:26:24 INFO - TinderboxPrint: I/O read bytes / time
41,711,616 / 409 11:26:24 INFO - TinderboxPrint: I/O write bytes / time
428,546,048 / 1,713 11:26:24 INFO - TinderboxPrint: CPU idle
2,167.5 (45.6%) 11:26:24 INFO - TinderboxPrint: CPU system
960.0 (20.2%) 11:26:24 INFO - TinderboxPrint: CPU user
1,630.2 (34.3%) 11:26:24 INFO - TinderboxPrint: Swap in / out
162,996,224 / 0 11:26:24 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 113349120; Write bytes: 116762624; Read time: 10045; Write time: 275 11:26:24 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 40736768; Write bytes: 301948928; Read time: 394; Write time: 1405 11:26:24 INFO - Running post-run listener: _upload_blobber_files 11:26:24 INFO - Blob upload gear active. 11:26:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:26:24 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 11:26:24 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'] 11:26:24 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 11:26:25 INFO - (blobuploader) - INFO - Open directory for files ... 11:26:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:26:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:26:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:26 INFO - (blobuploader) - INFO - Done attempting. 11:26:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:26:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:26:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:27 INFO - (blobuploader) - INFO - Done attempting. 11:26:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:26:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:26:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:28 INFO - (blobuploader) - INFO - Done attempting. 11:26:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:26:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:26:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:30 INFO - (blobuploader) - INFO - Done attempting. 11:26:30 INFO - (blobuploader) - INFO - Iteration through files over. 11:26:30 INFO - Return code: 0 11:26:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:26:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:26:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e869807f7c20005cdd38e68bbbcf0ac196d91485f3f163219dcf8ab52fb8b0cbf7e69daff1f4565cd0b15909c6da802d01ae4ca4ae6e88001304e2e89b63b086", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/76fa60cb70024ae48a55de296b128894353c0907b82e1c9ae05ae41ab83850d8cb9b0813090b04a13bbe940d3ad9de2e962fff867302e719b7c9ed2cb1f4f706", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d927e7bd259339125e7190a80652bf6529f21a3714eafaf8e301ef3aaac1003cd69aad3e874196135a2458abe652b2770213bcab51a1a5b231c0613bd14b9fab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/87e431085fe8859f6cf4505e71b7b467b17b96dd73a6a2906dd4b5078cb6b3e69278ea53a8130b71a6ba5ba3f7cd9dd4e716db0a1366bac73e04499c710f459f"} 11:26:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:26:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:26:30 INFO - Contents: 11:26:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e869807f7c20005cdd38e68bbbcf0ac196d91485f3f163219dcf8ab52fb8b0cbf7e69daff1f4565cd0b15909c6da802d01ae4ca4ae6e88001304e2e89b63b086", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/76fa60cb70024ae48a55de296b128894353c0907b82e1c9ae05ae41ab83850d8cb9b0813090b04a13bbe940d3ad9de2e962fff867302e719b7c9ed2cb1f4f706", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d927e7bd259339125e7190a80652bf6529f21a3714eafaf8e301ef3aaac1003cd69aad3e874196135a2458abe652b2770213bcab51a1a5b231c0613bd14b9fab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/87e431085fe8859f6cf4505e71b7b467b17b96dd73a6a2906dd4b5078cb6b3e69278ea53a8130b71a6ba5ba3f7cd9dd4e716db0a1366bac73e04499c710f459f"} 11:26:30 INFO - Running post-run listener: copy_logs_to_upload_dir 11:26:30 INFO - Copying logs to upload dir... 11:26:30 INFO - mkdir: /builds/slave/test/build/upload/logs 11:26:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.326403 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-22 11:26:30.294083) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 11:26:30.297839) ========= 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.ytJyEnYfXC/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.0zADjzTxSA/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e869807f7c20005cdd38e68bbbcf0ac196d91485f3f163219dcf8ab52fb8b0cbf7e69daff1f4565cd0b15909c6da802d01ae4ca4ae6e88001304e2e89b63b086", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/76fa60cb70024ae48a55de296b128894353c0907b82e1c9ae05ae41ab83850d8cb9b0813090b04a13bbe940d3ad9de2e962fff867302e719b7c9ed2cb1f4f706", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d927e7bd259339125e7190a80652bf6529f21a3714eafaf8e301ef3aaac1003cd69aad3e874196135a2458abe652b2770213bcab51a1a5b231c0613bd14b9fab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/87e431085fe8859f6cf4505e71b7b467b17b96dd73a6a2906dd4b5078cb6b3e69278ea53a8130b71a6ba5ba3f7cd9dd4e716db0a1366bac73e04499c710f459f"} build_url:https://queue.taskcluster.net/v1/task/Tiu6srBDSo64s6RlpNneZw/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011158 build_url: 'https://queue.taskcluster.net/v1/task/Tiu6srBDSo64s6RlpNneZw/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e869807f7c20005cdd38e68bbbcf0ac196d91485f3f163219dcf8ab52fb8b0cbf7e69daff1f4565cd0b15909c6da802d01ae4ca4ae6e88001304e2e89b63b086", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/76fa60cb70024ae48a55de296b128894353c0907b82e1c9ae05ae41ab83850d8cb9b0813090b04a13bbe940d3ad9de2e962fff867302e719b7c9ed2cb1f4f706", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d927e7bd259339125e7190a80652bf6529f21a3714eafaf8e301ef3aaac1003cd69aad3e874196135a2458abe652b2770213bcab51a1a5b231c0613bd14b9fab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/87e431085fe8859f6cf4505e71b7b467b17b96dd73a6a2906dd4b5078cb6b3e69278ea53a8130b71a6ba5ba3f7cd9dd4e716db0a1366bac73e04499c710f459f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 11:26:30.332088) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 11:26:30.332439) ========= 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.ytJyEnYfXC/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.0zADjzTxSA/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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.005280 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 11:26:30.380439) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 11:26:30.380781) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 11:26:30.381103) ========= ========= Total master_lag: 0.39 =========