builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0065 starttime: 1492076743.66 results: success (0) buildid: 20170413004808 builduid: 63cb3c55edd44a6998687f3376e58254 revision: 48958ca4267adc86ea57f3701645d5e0222d792e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-13 02:45:43.657198) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-13 02:45:43.657636) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-13 02:45:43.657907) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-13 02:45:43.682313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 02:45:43.682621) ========= 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.olHTfXeKxr/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.feSj2efi9h/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-13 02:45:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 34.1M=0s 2017-04-13 02:45:43 (34.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.095388 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 02:45:43.801147) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 02:45:43.801471) ========= 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.olHTfXeKxr/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.feSj2efi9h/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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.021935 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 02:45:43.849951) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-13 02:45:43.850291) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 48958ca4267adc86ea57f3701645d5e0222d792e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 48958ca4267adc86ea57f3701645d5e0222d792e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.olHTfXeKxr/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.feSj2efi9h/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-13 02:45:43,943 truncating revision to first 12 chars 2017-04-13 02:45:43,943 Setting DEBUG logging. 2017-04-13 02:45:43,943 attempt 1/10 2017-04-13 02:45:43,943 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/48958ca4267a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-13 02:45:45,095 unpacking tar archive at: mozilla-central-48958ca4267a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.415961 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-13 02:45:45.289985) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-13 02:45:45.290337) ========= script_repo_revision: 48958ca4267adc86ea57f3701645d5e0222d792e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-13 02:45:45.290760) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-13 02:45:45.291026) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-13 02:45:45.311031) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-04-13 02:45:45.311388) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.olHTfXeKxr/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.feSj2efi9h/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 02:45:45 INFO - MultiFileLogger online at 20170413 02:45:45 in /builds/slave/test 02:45:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:45:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:45:45 INFO - {'append_to_log': False, 02:45:45 INFO - 'base_work_dir': '/builds/slave/test', 02:45:45 INFO - 'blob_upload_branch': 'Firefox', 02:45:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:45:45 INFO - 'branch': 'Firefox', 02:45:45 INFO - 'buildbot_json_path': 'buildprops.json', 02:45:45 INFO - 'config_files': ('talos/mac_config.py',), 02:45:45 INFO - 'default_actions': ('clobber', 02:45:45 INFO - 'read-buildbot-config', 02:45:45 INFO - 'download-and-extract', 02:45:45 INFO - 'populate-webroot', 02:45:45 INFO - 'create-virtualenv', 02:45:45 INFO - 'install', 02:45:45 INFO - 'run-tests'), 02:45:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:45:45 INFO - 'download_minidump_stackwalk': True, 02:45:45 INFO - 'download_symbols': 'ondemand', 02:45:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:45:45 INFO - 'tooltool.py': '/tools/tooltool.py', 02:45:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:45:45 INFO - '/tools/misc-python/virtualenv.py')}, 02:45:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:45:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:45:45 INFO - 'gecko_profile': False, 02:45:45 INFO - 'gecko_profile_interval': 0, 02:45:45 INFO - 'installer_path': 'installer.exe', 02:45:45 INFO - 'log_level': 'info', 02:45:45 INFO - 'log_name': 'talos', 02:45:45 INFO - 'log_to_console': True, 02:45:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:45:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:45:45 INFO - 'opt_config_files': (), 02:45:45 INFO - 'pip_index': False, 02:45:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:45:45 INFO - 'cmd': ('bash', 02:45:45 INFO - '-c', 02:45:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:45:45 INFO - 'enabled': True, 02:45:45 INFO - 'halt_on_failure': False, 02:45:45 INFO - 'name': 'check_screen_resolution'},), 02:45:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:45:45 INFO - 'cmd': ('bash', 02:45:45 INFO - '-c', 02:45:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:45:45 INFO - 'enabled': True, 02:45:45 INFO - 'halt_on_failure': False, 02:45:45 INFO - 'name': 'check_screen_resolution'},), 02:45:45 INFO - 'run_cmd_checks_enabled': True, 02:45:45 INFO - 'suite': 'dromaeojs', 02:45:45 INFO - 'system_bits': '32', 02:45:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:45:45 INFO - 'title': 't-yosemite-r7-0065', 02:45:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:45:45 INFO - 'use_talos_json': True, 02:45:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:45:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:45:45 INFO - 'work_dir': 'build'} 02:45:45 INFO - [mozharness: 2017-04-13 09:45:45.527684Z] Running clobber step. 02:45:45 INFO - Running pre-action listener: _resource_record_pre_action 02:45:45 INFO - Running main action method: clobber 02:45:45 INFO - rmtree: /builds/slave/test/build 02:45:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:45:48 INFO - Running post-action listener: _resource_record_post_action 02:45:48 INFO - [mozharness: 2017-04-13 09:45:48.830212Z] Finished clobber step (success) 02:45:48 INFO - [mozharness: 2017-04-13 09:45:48.830339Z] Running read-buildbot-config step. 02:45:48 INFO - Running pre-action listener: _resource_record_pre_action 02:45:48 INFO - Running main action method: read_buildbot_config 02:45:48 INFO - Using buildbot properties: 02:45:48 INFO - { 02:45:48 INFO - "project": "", 02:45:48 INFO - "product": "firefox", 02:45:48 INFO - "script_repo_revision": "production", 02:45:48 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 02:45:48 INFO - "repository": "", 02:45:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 02:45:48 INFO - "buildid": "20170413004808", 02:45:48 INFO - "pgo_build": "False", 02:45:48 INFO - "basedir": "/builds/slave/test", 02:45:48 INFO - "buildnumber": 11, 02:45:48 INFO - "slavename": "t-yosemite-r7-0065", 02:45:48 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 02:45:48 INFO - "platform": "yosemite_r7", 02:45:48 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 02:45:48 INFO - "branch": "mozilla-central", 02:45:48 INFO - "repo_path": "mozilla-central", 02:45:48 INFO - "revision": "48958ca4267adc86ea57f3701645d5e0222d792e", 02:45:48 INFO - "stage_platform": "macosx64", 02:45:48 INFO - "builduid": "63cb3c55edd44a6998687f3376e58254", 02:45:48 INFO - "slavebuilddir": "test" 02:45:48 INFO - } 02:45:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/AYTCeNvtRAKmmurEonYcaw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 02:45:48 INFO - Running post-action listener: _resource_record_post_action 02:45:48 INFO - [mozharness: 2017-04-13 09:45:48.833734Z] Finished read-buildbot-config step (success) 02:45:48 INFO - [mozharness: 2017-04-13 09:45:48.833824Z] Running download-and-extract step. 02:45:48 INFO - Running pre-action listener: _resource_record_pre_action 02:45:48 INFO - Running main action method: download_and_extract 02:45:48 INFO - mkdir: /builds/slave/test/build/tests 02:45:48 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')]} 02:45:48 INFO - trying https://queue.taskcluster.net/v1/task/AYTCeNvtRAKmmurEonYcaw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 02:45:48 INFO - Downloading https://queue.taskcluster.net/v1/task/AYTCeNvtRAKmmurEonYcaw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 02:45:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AYTCeNvtRAKmmurEonYcaw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 02:45:50 INFO - Downloaded 1325 bytes. 02:45:50 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 02:45:50 INFO - Using the following test package requirements: 02:45:50 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:45:50 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 02:45:50 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 02:45:50 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:45:50 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 02:45:50 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:45:50 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 02:45:50 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:45:50 INFO - u'jsshell-mac.zip'], 02:45:50 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:45:50 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 02:45:50 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 02:45:50 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:45:50 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 02:45:50 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:45:50 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 02:45:50 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:45:50 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 02:45:50 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:45:50 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 02:45:50 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:45:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AYTCeNvtRAKmmurEonYcaw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 02:45:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AYTCeNvtRAKmmurEonYcaw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:45:50 INFO - Fetch https://queue.taskcluster.net/v1/task/AYTCeNvtRAKmmurEonYcaw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 02:45:51 INFO - Expected file size: 52593585 02:45:51 INFO - Obtained file size: 52593585 02:46:07 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 02:46:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AYTCeNvtRAKmmurEonYcaw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 02:46:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AYTCeNvtRAKmmurEonYcaw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:46:07 INFO - Fetch https://queue.taskcluster.net/v1/task/AYTCeNvtRAKmmurEonYcaw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 02:46:09 INFO - Expected file size: 52593585 02:46:09 INFO - Obtained file size: 52593585 02:46:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AYTCeNvtRAKmmurEonYcaw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 02:46:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AYTCeNvtRAKmmurEonYcaw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:46:25 INFO - Fetch https://queue.taskcluster.net/v1/task/AYTCeNvtRAKmmurEonYcaw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 02:46:26 INFO - Expected file size: 14407739 02:46:26 INFO - Obtained file size: 14407739 02:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:26 INFO - trying https://queue.taskcluster.net/v1/task/AYTCeNvtRAKmmurEonYcaw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 02:46:26 INFO - Downloading https://queue.taskcluster.net/v1/task/AYTCeNvtRAKmmurEonYcaw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 02:46:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AYTCeNvtRAKmmurEonYcaw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 02:46:28 INFO - Downloaded 71068969 bytes. 02:46:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AYTCeNvtRAKmmurEonYcaw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 02:46:28 INFO - mkdir: /builds/slave/test/properties 02:46:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:46:28 INFO - Writing to file /builds/slave/test/properties/build_url 02:46:28 INFO - Contents: 02:46:28 INFO - build_url:https://queue.taskcluster.net/v1/task/AYTCeNvtRAKmmurEonYcaw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 02:46:29 INFO - Running post-action listener: _resource_record_post_action 02:46:29 INFO - Running post-action listener: set_extra_try_arguments 02:46:29 INFO - [mozharness: 2017-04-13 09:46:29.378508Z] Finished download-and-extract step (success) 02:46:29 INFO - [mozharness: 2017-04-13 09:46:29.378637Z] Running populate-webroot step. 02:46:29 INFO - Running pre-action listener: _resource_record_pre_action 02:46:29 INFO - Running main action method: populate_webroot 02:46:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:46:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:46:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:46:29 INFO - '--tppagecycles', 02:46:29 INFO - '7'], 02:46:29 INFO - 'tests': ['tsvgm']}}, 02:46:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:46:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:46:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:46:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:46:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:46:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:46:29 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:46:29 INFO - 'talos_options': ['--disable-e10s'], 02:46:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:46:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:46:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:46:29 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:46:29 INFO - 'talos_options': ['--disable-e10s'], 02:46:29 INFO - 'tests': ['damp', 'tps']}, 02:46:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:46:29 INFO - 'tests': ['damp', 'tps']}, 02:46:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:46:29 INFO - 'tests': ['dromaeo_dom']}, 02:46:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:46:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:46:29 INFO - 'tests': ['basic_compositor_video']}, 02:46:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:46:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:46:29 INFO - 'tests': ['a11yr', 02:46:29 INFO - 'ts_paint', 02:46:29 INFO - 'tpaint', 02:46:29 INFO - 'sessionrestore', 02:46:29 INFO - 'sessionrestore_no_auto_restore', 02:46:29 INFO - 'tabpaint']}, 02:46:29 INFO - 'other-e10s': {'tests': ['a11yr', 02:46:29 INFO - 'ts_paint', 02:46:29 INFO - 'tpaint', 02:46:29 INFO - 'sessionrestore', 02:46:29 INFO - 'sessionrestore_no_auto_restore', 02:46:29 INFO - 'tabpaint']}, 02:46:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:46:29 INFO - 'ts_paint', 02:46:29 INFO - 'tpaint', 02:46:29 INFO - 'sessionrestore', 02:46:29 INFO - 'sessionrestore_no_auto_restore', 02:46:29 INFO - 'tabpaint']}, 02:46:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:46:29 INFO - 'ts_paint', 02:46:29 INFO - 'tpaint', 02:46:29 INFO - 'sessionrestore', 02:46:29 INFO - 'sessionrestore_no_auto_restore', 02:46:29 INFO - 'tabpaint']}, 02:46:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:46:29 INFO - 'tests': ['a11yr', 02:46:29 INFO - 'ts_paint', 02:46:29 INFO - 'tpaint', 02:46:29 INFO - 'sessionrestore', 02:46:29 INFO - 'sessionrestore_no_auto_restore', 02:46:29 INFO - 'tabpaint']}, 02:46:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:46:29 INFO - 'tests': ['a11yr', 02:46:29 INFO - 'ts_paint', 02:46:29 INFO - 'tpaint', 02:46:29 INFO - 'sessionrestore', 02:46:29 INFO - 'sessionrestore_no_auto_restore', 02:46:29 INFO - 'tabpaint']}, 02:46:29 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:46:29 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:46:29 INFO - 'bloom_basic_ref']}, 02:46:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:46:29 INFO - 'tests': ['tsvgx', 02:46:29 INFO - 'tsvgr_opacity', 02:46:29 INFO - 'tart', 02:46:29 INFO - 'tscrollx', 02:46:29 INFO - 'cart', 02:46:29 INFO - 'tsvg_static']}, 02:46:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:46:29 INFO - 'tsvgr_opacity', 02:46:29 INFO - 'tart', 02:46:29 INFO - 'tscrollx', 02:46:29 INFO - 'cart', 02:46:29 INFO - 'tsvg_static']}, 02:46:29 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:46:29 INFO - 'talos_options': ['--disable-e10s'], 02:46:29 INFO - 'tests': ['tp5o']}, 02:46:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:46:29 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:46:29 INFO - 'talos_options': ['--disable-e10s', 02:46:29 INFO - '--xperf_path', 02:46:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:46:29 INFO - 'tests': ['tp5n']}, 02:46:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:46:29 INFO - 'talos_options': ['--xperf_path', 02:46:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:46:29 INFO - 'tests': ['tp5n']}}, 02:46:29 INFO - 'talos.zip': {'path': '', 02:46:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:46:29 INFO - Running post-action listener: _resource_record_post_action 02:46:29 INFO - [mozharness: 2017-04-13 09:46:29.397598Z] Finished populate-webroot step (success) 02:46:29 INFO - [mozharness: 2017-04-13 09:46:29.397771Z] Running create-virtualenv step. 02:46:29 INFO - Running pre-action listener: _resource_record_pre_action 02:46:29 INFO - Running main action method: create_virtualenv 02:46:29 INFO - Creating virtualenv /builds/slave/test/build/venv 02:46:29 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 02:46:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:46:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:46:29 INFO - Using real prefix '/tools/python27' 02:46:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:46:30 INFO - Installing distribute.............................................................................................................................................................................................done. 02:46:33 INFO - Installing pip.................done. 02:46:33 INFO - Return code: 0 02:46:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:46:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:46:33 INFO - Reading from file tmpfile_stdout 02:46:33 INFO - Output received: 02:46:33 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) 02:46:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:46: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')]} 02:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46: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')]} 02:46:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa36b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa39768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7094d0930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f814d30>, '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 0x10f73bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f809be8>, '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.olHTfXeKxr/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.feSj2efi9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 02:46: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', 'pip>=1.5'] in /builds/slave/test/build 02:46: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 pip>=1.5 02:46:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.olHTfXeKxr/Render', 02:46:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:33 INFO - 'HOME': '/Users/cltbld', 02:46:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:33 INFO - 'LOGNAME': 'cltbld', 02:46:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:33 INFO - 'MOZ_NO_REMOTE': '1', 02:46:33 INFO - 'NO_EM_RESTART': '1', 02:46:33 INFO - 'PAGER': '/bin/cat', 02:46:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:33 INFO - 'PWD': '/builds/slave/test', 02:46:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:33 INFO - 'SHELL': '/bin/bash', 02:46:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.feSj2efi9h/Listeners', 02:46:33 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 02:46:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:33 INFO - 'USER': 'cltbld', 02:46:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:33 INFO - 'XPC_FLAGS': '0x0', 02:46:33 INFO - 'XPC_SERVICE_NAME': '0', 02:46:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:33 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 02:46:33 INFO - Cleaning up... 02:46:33 INFO - Return code: 0 02:46:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:46: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')]} 02:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46: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')]} 02:46:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46: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', '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 0x10fa36b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa39768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7094d0930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f814d30>, '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 0x10f73bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f809be8>, '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.olHTfXeKxr/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.feSj2efi9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 02:46: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', 'psutil>=3.1.1'] in /builds/slave/test/build 02:46: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 psutil>=3.1.1 02:46:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.olHTfXeKxr/Render', 02:46:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:33 INFO - 'HOME': '/Users/cltbld', 02:46:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:33 INFO - 'LOGNAME': 'cltbld', 02:46:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:33 INFO - 'MOZ_NO_REMOTE': '1', 02:46:33 INFO - 'NO_EM_RESTART': '1', 02:46:33 INFO - 'PAGER': '/bin/cat', 02:46:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:33 INFO - 'PWD': '/builds/slave/test', 02:46:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:33 INFO - 'SHELL': '/bin/bash', 02:46:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.feSj2efi9h/Listeners', 02:46:33 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 02:46:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:33 INFO - 'USER': 'cltbld', 02:46:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:33 INFO - 'XPC_FLAGS': '0x0', 02:46:33 INFO - 'XPC_SERVICE_NAME': '0', 02:46:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:34 INFO - Downloading/unpacking psutil>=3.1.1 02:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:46:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:46:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:46:37 INFO - Installing collected packages: psutil 02:46:37 INFO - Running setup.py install for psutil 02:46:37 INFO - building 'psutil._psutil_osx' extension 02:46:37 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 02:46:38 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 02:46:38 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 02:46:38 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 02:46:38 INFO - building 'psutil._psutil_posix' extension 02:46:38 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 02:46:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:46:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:46:38 INFO - ^ 02:46:38 INFO - 1 warning generated. 02:46:38 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 02:46:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:46:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:46:38 INFO - Successfully installed psutil 02:46:38 INFO - Cleaning up... 02:46:38 INFO - Return code: 0 02:46:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa36b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa39768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7094d0930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f814d30>, '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 0x10f73bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f809be8>, '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.olHTfXeKxr/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.feSj2efi9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 02:46:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:46:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:46:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.olHTfXeKxr/Render', 02:46:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:38 INFO - 'HOME': '/Users/cltbld', 02:46:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:38 INFO - 'LOGNAME': 'cltbld', 02:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:38 INFO - 'MOZ_NO_REMOTE': '1', 02:46:38 INFO - 'NO_EM_RESTART': '1', 02:46:38 INFO - 'PAGER': '/bin/cat', 02:46:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:38 INFO - 'PWD': '/builds/slave/test', 02:46:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:38 INFO - 'SHELL': '/bin/bash', 02:46:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.feSj2efi9h/Listeners', 02:46:38 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 02:46:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:38 INFO - 'USER': 'cltbld', 02:46:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:38 INFO - 'XPC_FLAGS': '0x0', 02:46:38 INFO - 'XPC_SERVICE_NAME': '0', 02:46:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:46:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:46:41 INFO - Installing collected packages: mozsystemmonitor 02:46:41 INFO - Running setup.py install for mozsystemmonitor 02:46:41 INFO - Successfully installed mozsystemmonitor 02:46:41 INFO - Cleaning up... 02:46:41 INFO - Return code: 0 02:46:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:46:41 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')]} 02:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fa36b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa39768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7094d0930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f814d30>, '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 0x10f73bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f809be8>, '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.olHTfXeKxr/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.feSj2efi9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 02:46:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:46:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:46:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.olHTfXeKxr/Render', 02:46:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:42 INFO - 'HOME': '/Users/cltbld', 02:46:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:42 INFO - 'LOGNAME': 'cltbld', 02:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:42 INFO - 'MOZ_NO_REMOTE': '1', 02:46:42 INFO - 'NO_EM_RESTART': '1', 02:46:42 INFO - 'PAGER': '/bin/cat', 02:46:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:42 INFO - 'PWD': '/builds/slave/test', 02:46:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:42 INFO - 'SHELL': '/bin/bash', 02:46:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.feSj2efi9h/Listeners', 02:46:42 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 02:46:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:42 INFO - 'USER': 'cltbld', 02:46:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:42 INFO - 'XPC_FLAGS': '0x0', 02:46:42 INFO - 'XPC_SERVICE_NAME': '0', 02:46:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:42 INFO - Downloading/unpacking jsonschema==2.5.1 02:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:46:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:46 INFO - Downloading functools32-3.2.3-2.tar.gz 02:46:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:46:46 INFO - warning: no files found matching '*.txt' 02:46:46 INFO - no previously-included directories found matching 'build' 02:46:46 INFO - no previously-included directories found matching 'dist' 02:46:46 INFO - no previously-included directories found matching '.git*' 02:46:46 INFO - Installing collected packages: jsonschema, functools32 02:46:46 INFO - Running setup.py install for functools32 02:46:46 INFO - warning: no files found matching '*.txt' 02:46:46 INFO - no previously-included directories found matching 'build' 02:46:46 INFO - no previously-included directories found matching 'dist' 02:46:46 INFO - no previously-included directories found matching '.git*' 02:46:46 INFO - Successfully installed jsonschema functools32 02:46:46 INFO - Cleaning up... 02:46:46 INFO - Return code: 0 02:46:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fa36b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa39768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7094d0930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f814d30>, '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 0x10f73bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f809be8>, '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.olHTfXeKxr/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.feSj2efi9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 02:46:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:46:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:46:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.olHTfXeKxr/Render', 02:46:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:46 INFO - 'HOME': '/Users/cltbld', 02:46:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:46 INFO - 'LOGNAME': 'cltbld', 02:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:46 INFO - 'MOZ_NO_REMOTE': '1', 02:46:46 INFO - 'NO_EM_RESTART': '1', 02:46:46 INFO - 'PAGER': '/bin/cat', 02:46:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:46 INFO - 'PWD': '/builds/slave/test', 02:46:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:46 INFO - 'SHELL': '/bin/bash', 02:46:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.feSj2efi9h/Listeners', 02:46:46 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 02:46:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:46 INFO - 'USER': 'cltbld', 02:46:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:46 INFO - 'XPC_FLAGS': '0x0', 02:46:46 INFO - 'XPC_SERVICE_NAME': '0', 02:46:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:46:46 INFO - Cleaning up... 02:46:46 INFO - Return code: 0 02:46:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fa36b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa39768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7094d0930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f814d30>, '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 0x10f73bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f809be8>, '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.olHTfXeKxr/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.feSj2efi9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 02:46:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:46:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:46:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.olHTfXeKxr/Render', 02:46:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:46 INFO - 'HOME': '/Users/cltbld', 02:46:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:46 INFO - 'LOGNAME': 'cltbld', 02:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:46 INFO - 'MOZ_NO_REMOTE': '1', 02:46:46 INFO - 'NO_EM_RESTART': '1', 02:46:46 INFO - 'PAGER': '/bin/cat', 02:46:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:46 INFO - 'PWD': '/builds/slave/test', 02:46:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:46 INFO - 'SHELL': '/bin/bash', 02:46:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.feSj2efi9h/Listeners', 02:46:46 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 02:46:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:46 INFO - 'USER': 'cltbld', 02:46:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:46 INFO - 'XPC_FLAGS': '0x0', 02:46:46 INFO - 'XPC_SERVICE_NAME': '0', 02:46:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:47 INFO - Downloading/unpacking blobuploader==1.2.4 02:46:47 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 02:46:47 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 02:46:47 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 02:46:47 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 02:46:47 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 02:46:47 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 02:46:49 INFO - Downloading blobuploader-1.2.4.tar.gz 02:46:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:46:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:46:49 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 02:46:49 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 02:46:49 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 02:46:49 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 02:46:49 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 02:46:49 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 02:46:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:46:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:46:50 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 02:46:50 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 02:46:50 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 02:46:50 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 02:46:50 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 02:46:50 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 02:46:51 INFO - Downloading docopt-0.6.1.tar.gz 02:46:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:46:51 INFO - Installing collected packages: blobuploader, requests, docopt 02:46:51 INFO - Running setup.py install for blobuploader 02:46:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:46:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:46:51 INFO - Running setup.py install for requests 02:46:51 INFO - Running setup.py install for docopt 02:46:51 INFO - Successfully installed blobuploader requests docopt 02:46:51 INFO - Cleaning up... 02:46:52 INFO - Return code: 0 02:46:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:52 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 0x10fa36b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa39768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7094d0930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f814d30>, '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 0x10f73bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f809be8>, '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.olHTfXeKxr/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.feSj2efi9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 02:46:52 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 02:46:52 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 02:46:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.olHTfXeKxr/Render', 02:46:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:52 INFO - 'HOME': '/Users/cltbld', 02:46:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:52 INFO - 'LOGNAME': 'cltbld', 02:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:52 INFO - 'MOZ_NO_REMOTE': '1', 02:46:52 INFO - 'NO_EM_RESTART': '1', 02:46:52 INFO - 'PAGER': '/bin/cat', 02:46:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:52 INFO - 'PWD': '/builds/slave/test', 02:46:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:52 INFO - 'SHELL': '/bin/bash', 02:46:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.feSj2efi9h/Listeners', 02:46:52 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 02:46:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:52 INFO - 'USER': 'cltbld', 02:46:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:52 INFO - 'XPC_FLAGS': '0x0', 02:46:52 INFO - 'XPC_SERVICE_NAME': '0', 02:46:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:46:52 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-WDK5wQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:46:52 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-GjBRMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:46:52 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-7JOJ9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:46:52 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-lLQFHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:46:52 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-cS_q3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:46:52 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-tc4VcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:46:52 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-J6l1zT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:46:53 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-6Ym3TI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:46:53 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-_BLVLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:46:53 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-s9f3ZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:46:53 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-1KQoUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:46:53 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-biRzqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:46:53 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-BEgucn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:46:53 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-jWF9Rq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:53 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-vuo2NA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:46:53 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-1hEhSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:46:53 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-xu8iNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:46:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:46:54 INFO - Running setup.py install for manifestparser 02:46:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:46:54 INFO - Running setup.py install for mozcrash 02:46:54 INFO - Running setup.py install for mozdebug 02:46:54 INFO - Running setup.py install for mozdevice 02:46:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:46:54 INFO - Running setup.py install for mozfile 02:46:54 INFO - Running setup.py install for mozhttpd 02:46:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:46:54 INFO - Running setup.py install for mozinfo 02:46:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:46:55 INFO - Running setup.py install for mozInstall 02:46:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:46:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:46:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:46:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:46:55 INFO - Running setup.py install for mozleak 02:46:55 INFO - Running setup.py install for mozlog 02:46:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:46:55 INFO - Running setup.py install for moznetwork 02:46:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:46:55 INFO - Running setup.py install for mozprocess 02:46:55 INFO - Running setup.py install for mozprofile 02:46:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:46:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:46:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:46:56 INFO - Running setup.py install for mozrunner 02:46:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:46:56 INFO - Running setup.py install for mozscreenshot 02:46:56 INFO - Running setup.py install for moztest 02:46:56 INFO - Running setup.py install for mozversion 02:46:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:46:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:46:56 INFO - Cleaning up... 02:46:56 INFO - Return code: 0 02:46:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:56 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 0x10fa36b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa39768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7094d0930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f814d30>, '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 0x10f73bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f809be8>, '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.olHTfXeKxr/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.feSj2efi9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 02:46:56 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 02:46:56 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 02:46:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.olHTfXeKxr/Render', 02:46:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:56 INFO - 'HOME': '/Users/cltbld', 02:46:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:56 INFO - 'LOGNAME': 'cltbld', 02:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:56 INFO - 'MOZ_NO_REMOTE': '1', 02:46:56 INFO - 'NO_EM_RESTART': '1', 02:46:56 INFO - 'PAGER': '/bin/cat', 02:46:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:56 INFO - 'PWD': '/builds/slave/test', 02:46:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:56 INFO - 'SHELL': '/bin/bash', 02:46:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.feSj2efi9h/Listeners', 02:46:56 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 02:46:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:56 INFO - 'USER': 'cltbld', 02:46:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:56 INFO - 'XPC_FLAGS': '0x0', 02:46:56 INFO - 'XPC_SERVICE_NAME': '0', 02:46:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:46:56 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-PrNttq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:46:57 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)) 02:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:46:57 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-bKrIsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:46:57 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)) 02:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:46:57 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-nXmTTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:46:57 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)) 02:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:46:57 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-TvXLiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:46:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:46:57 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-gj2r9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:46:57 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)) 02:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:46:57 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-FjWcDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:46:57 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)) 02:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:46:57 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-hCQhz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:46:57 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)) 02:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:46:57 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-g4ktCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:46:57 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)) 02:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:46:57 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-yzB5Qx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:46:57 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)) 02:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:46:57 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-X2euL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:46:57 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)) 02:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:46:57 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-c26w7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:46:58 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)) 02:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:46:58 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-1MxvLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:46:58 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-gkuMoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:46:58 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)) 02:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:46:58 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-04135s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:46:58 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)) 02:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:58 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-obo3IL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:58 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)) 02:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:46:58 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-VE6aBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:46:58 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)) 02:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:46:58 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-ueG6Yi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:46:58 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)) 02:46:58 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)) 02:46:58 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)) 02:46:58 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)) 02:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:46:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:46:58 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 02:46:58 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 02:46:58 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 02:46:58 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 02:46:58 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 02:46:58 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 02:47:01 INFO - Downloading blessings-1.6.tar.gz 02:47:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:47:01 INFO - Installing collected packages: blessings 02:47:01 INFO - Running setup.py install for blessings 02:47:01 INFO - Successfully installed blessings 02:47:01 INFO - Cleaning up... 02:47:01 INFO - Return code: 0 02:47:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:47:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:47:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:47:02 INFO - Reading from file tmpfile_stdout 02:47:02 INFO - Current package versions: 02:47:02 INFO - blessings == 1.6 02:47:02 INFO - blobuploader == 1.2.4 02:47:02 INFO - docopt == 0.6.1 02:47:02 INFO - functools32 == 3.2.3-2 02:47:02 INFO - jsonschema == 2.5.1 02:47:02 INFO - manifestparser == 1.1 02:47:02 INFO - mozInstall == 1.12 02:47:02 INFO - mozcrash == 1.0 02:47:02 INFO - mozdebug == 0.1 02:47:02 INFO - mozdevice == 0.50 02:47:02 INFO - mozfile == 1.2 02:47:02 INFO - mozhttpd == 0.7 02:47:02 INFO - mozinfo == 0.9 02:47:02 INFO - mozleak == 0.1 02:47:02 INFO - mozlog == 3.4 02:47:02 INFO - moznetwork == 0.27 02:47:02 INFO - mozprocess == 0.25 02:47:02 INFO - mozprofile == 0.28 02:47:02 INFO - mozrunner == 6.13 02:47:02 INFO - mozscreenshot == 0.1 02:47:02 INFO - mozsystemmonitor == 0.3 02:47:02 INFO - moztest == 0.8 02:47:02 INFO - mozversion == 1.4 02:47:02 INFO - psutil == 3.1.1 02:47:02 INFO - requests == 1.2.3 02:47:02 INFO - wsgiref == 0.1.2 02:47:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:47:02 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')]} 02:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:02 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')]} 02:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:02 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 0x10fa36b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa39768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7094d0930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f814d30>, '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 0x10f73bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f809be8>, '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.olHTfXeKxr/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.feSj2efi9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 02:47:02 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 02:47:02 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 02:47:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.olHTfXeKxr/Render', 02:47:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:47:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:47:02 INFO - 'HOME': '/Users/cltbld', 02:47:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:47:02 INFO - 'LOGNAME': 'cltbld', 02:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:02 INFO - 'MOZ_NO_REMOTE': '1', 02:47:02 INFO - 'NO_EM_RESTART': '1', 02:47:02 INFO - 'PAGER': '/bin/cat', 02:47:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:02 INFO - 'PWD': '/builds/slave/test', 02:47:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:47:02 INFO - 'SHELL': '/bin/bash', 02:47:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.feSj2efi9h/Listeners', 02:47:02 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 02:47:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:47:02 INFO - 'USER': 'cltbld', 02:47:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:47:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:02 INFO - 'XPC_FLAGS': '0x0', 02:47:02 INFO - 'XPC_SERVICE_NAME': '0', 02:47:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:02 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)) 02:47:02 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)) 02:47:02 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)) 02:47:02 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)) 02:47:02 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)) 02:47:02 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)) 02:47:02 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)) 02:47:02 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)) 02:47:02 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)) 02:47:02 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)) 02:47:02 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)) 02:47:02 INFO - Cleaning up... 02:47:02 INFO - Return code: 0 02:47:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:47:02 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')]} 02:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:02 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')]} 02:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:02 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 0x10fa36b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa39768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7094d0930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f814d30>, '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 0x10f73bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f809be8>, '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.olHTfXeKxr/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.feSj2efi9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 02:47:02 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 02:47:02 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 02:47:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.olHTfXeKxr/Render', 02:47:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:47:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:47:02 INFO - 'HOME': '/Users/cltbld', 02:47:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:47:02 INFO - 'LOGNAME': 'cltbld', 02:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:02 INFO - 'MOZ_NO_REMOTE': '1', 02:47:02 INFO - 'NO_EM_RESTART': '1', 02:47:02 INFO - 'PAGER': '/bin/cat', 02:47:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:02 INFO - 'PWD': '/builds/slave/test', 02:47:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:47:02 INFO - 'SHELL': '/bin/bash', 02:47:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.feSj2efi9h/Listeners', 02:47:02 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 02:47:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:47:02 INFO - 'USER': 'cltbld', 02:47:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:47:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:02 INFO - 'XPC_FLAGS': '0x0', 02:47:02 INFO - 'XPC_SERVICE_NAME': '0', 02:47:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:47:02 INFO - Cleaning up... 02:47:02 INFO - Return code: 0 02:47:02 INFO - Running post-action listener: _resource_record_post_action 02:47:02 INFO - Running post-action listener: _start_resource_monitoring 02:47:02 INFO - Starting resource monitoring. 02:47:02 INFO - [mozharness: 2017-04-13 09:47:02.590834Z] Finished create-virtualenv step (success) 02:47:02 INFO - [mozharness: 2017-04-13 09:47:02.591794Z] Running install step. 02:47:02 INFO - Running pre-action listener: _resource_record_pre_action 02:47:02 INFO - Running main action method: install 02:47:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:47:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:47:02 INFO - Reading from file tmpfile_stdout 02:47:02 INFO - Detecting whether we're running mozinstall >=1.0... 02:47:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:47:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:47:02 INFO - Reading from file tmpfile_stdout 02:47:02 INFO - Output received: 02:47:02 INFO - Usage: mozinstall [options] installer 02:47:02 INFO - Options: 02:47:02 INFO - -h, --help show this help message and exit 02:47:02 INFO - -d DEST, --destination=DEST 02:47:02 INFO - Directory to install application into. [default: 02:47:02 INFO - "/builds/slave/test"] 02:47:02 INFO - --app=APP Application being installed. [default: firefox] 02:47:02 INFO - mkdir: /builds/slave/test/build/application 02:47:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:47:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 02:47:22 INFO - Reading from file tmpfile_stdout 02:47:22 INFO - Output received: 02:47:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:47:22 INFO - Running post-action listener: _resource_record_post_action 02:47:22 INFO - [mozharness: 2017-04-13 09:47:22.854254Z] Finished install step (success) 02:47:22 INFO - [mozharness: 2017-04-13 09:47:22.854423Z] Running run-tests step. 02:47:22 INFO - Running pre-action listener: _resource_record_pre_action 02:47:22 INFO - Running main action method: run_tests 02:47:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:47:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:47:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:47:22 INFO - 2017-04-13 02:47:22.869 screenresolution[1893:18261] starting screenresolution argv=screenresolution get 02:47:22 INFO - 2017-04-13 02:47:22.871 screenresolution[1893:18261] Display 0: 1600x1200x32@60 02:47:22 INFO - 2017-04-13 02:47:22.877 screenresolution[1894:18264] starting screenresolution argv=screenresolution list 02:47:22 INFO - Available Modes on Display 0 02:47:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:47:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:47:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:47:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:47:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:47:23 INFO - Intel Iris: 02:47:23 INFO - Chipset Model: Intel Iris 02:47:23 INFO - Type: GPU 02:47:23 INFO - Bus: Built-In 02:47:23 INFO - VRAM (Dynamic, Max): 1536 MB 02:47:23 INFO - Vendor: Intel (0x8086) 02:47:23 INFO - Device ID: 0x0a2e 02:47:23 INFO - Revision ID: 0x0009 02:47:23 INFO - Displays: 02:47:23 INFO - Display: 02:47:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:47:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:47:23 INFO - Display Serial Number: 1600x1200 60 02:47:23 INFO - Main Display: Yes 02:47:23 INFO - Mirror: Off 02:47:23 INFO - Online: Yes 02:47:23 INFO - Rotation: Supported 02:47:23 INFO - Return code: 0 02:47:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:47:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:47:23 INFO - Python 2.7.3 02:47:23 INFO - Return code: 0 02:47:23 INFO - grabbing minidump binary from tooltool 02:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:23 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 0x10f814d30>, '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 0x10f73bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f809be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:47:23 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 02:47:23 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 02:47:23 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 02:47:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:47:23 INFO - Return code: 0 02:47:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:47:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:47:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:47:23 INFO - ENV: RUST_BACKTRACE is now 1 02:47:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:47:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:47:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AYTCeNvtRAKmmurEonYcaw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:47:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AYTCeNvtRAKmmurEonYcaw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:47:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.olHTfXeKxr/Render', 02:47:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:47:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:47:23 INFO - 'HOME': '/Users/cltbld', 02:47:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:47:23 INFO - 'LOGNAME': 'cltbld', 02:47:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:47:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:47:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:23 INFO - 'MOZ_NO_REMOTE': '1', 02:47:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:47:23 INFO - 'NO_EM_RESTART': '1', 02:47:23 INFO - 'PAGER': '/bin/cat', 02:47:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:47:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:23 INFO - 'PWD': '/builds/slave/test', 02:47:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:47:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:47:23 INFO - 'RUST_BACKTRACE': '1', 02:47:23 INFO - 'SHELL': '/bin/bash', 02:47:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.feSj2efi9h/Listeners', 02:47:23 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 02:47:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:47:23 INFO - 'USER': 'cltbld', 02:47:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:47:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:47:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:23 INFO - 'XPC_FLAGS': '0x0', 02:47:23 INFO - 'XPC_SERVICE_NAME': '0', 02:47:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:47:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AYTCeNvtRAKmmurEonYcaw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:47:23 INFO - mozversion application_buildid: 20170413004808 02:47:23 INFO - mozversion application_changeset: 48958ca4267adc86ea57f3701645d5e0222d792e 02:47:23 INFO - mozversion application_display_name: Nightly 02:47:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:47:23 INFO - mozversion application_name: Firefox 02:47:23 INFO - mozversion application_remotingname: firefox 02:47:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:47:23 INFO - mozversion application_vendor: Mozilla 02:47:23 INFO - mozversion application_version: 55.0a1 02:47:23 INFO - mozversion platform_buildid: 20170413004808 02:47:23 INFO - mozversion platform_changeset: 48958ca4267adc86ea57f3701645d5e0222d792e 02:47:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:47:23 INFO - mozversion platform_version: 55.0a1 02:47:23 INFO - using testdate: 1492076843 02:47:23 INFO - actual date: 1492076843 02:47:23 INFO - starting webserver on 'localhost:57187' 02:47:23 INFO - SUITE-START | Running 2 tests 02:47:23 INFO - TEST-START | dromaeo_css 02:47:23 INFO - operating with platform_type : mac_ 02:47:23 INFO - Initialising browser for dromaeo_css test... 02:47:23 INFO - TEST-INFO | started process 1904 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmpz_Cm14/profile http://localhost:57187/getInfo.html) 02:47:26 INFO - PID 1904 | __metrics Screen width/height:1600/1200 02:47:26 INFO - PID 1904 | colorDepth:24 02:47:26 INFO - PID 1904 | Browser inner width/height: 1024/689 02:47:26 INFO - PID 1904 | __metrics 02:47:26 INFO - PID 1904 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:47:26 INFO - PID 1904 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:47:27 INFO - TEST-INFO | 1904: exit 0 02:47:27 INFO - Browser initialized. 02:47:27 INFO - Running cycle 1/1 for dromaeo_css test... 02:47:27 INFO - TEST-INFO | started process 1906 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmpz_Cm14/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:47:39 INFO - PID 1906 | RSS: Main: 239882240 02:47:39 INFO - PID 1906 | 02:50:43 INFO - PID 1906 | Cycle 1(1): loaded http://localhost:57187/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57187/tests/dromaeo/cssquery-ext.html) 02:50:46 INFO - PID 1906 | RSS: Main: 468217856 02:50:46 INFO - PID 1906 | 02:52:29 INFO - PID 1906 | ************************* 02:52:29 INFO - PID 1906 | A coding exception was thrown and uncaught in a Task. 02:52:29 INFO - PID 1906 | 02:52:29 ERROR - PID 1906 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:52:29 INFO - PID 1906 | Full stack: 02:52:29 INFO - PID 1906 | ************************* 02:52:29 INFO - PID 1906 | ************************* 02:52:29 INFO - PID 1906 | A coding exception was thrown and uncaught in a Task. 02:52:29 INFO - PID 1906 | 02:52:29 ERROR - PID 1906 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:52:29 INFO - PID 1906 | Full stack: 02:52:29 INFO - PID 1906 | ************************* 02:52:29 INFO - PID 1906 | ************************* 02:52:29 INFO - PID 1906 | A coding exception was thrown and uncaught in a Task. 02:52:29 INFO - PID 1906 | 02:52:29 ERROR - PID 1906 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:52:29 INFO - PID 1906 | Full stack: 02:52:29 INFO - PID 1906 | ************************* 02:52:29 INFO - PID 1906 | ************************* 02:52:29 INFO - PID 1906 | A coding exception was thrown and uncaught in a Task. 02:52:29 INFO - PID 1906 | 02:52:29 ERROR - PID 1906 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:52:29 INFO - PID 1906 | Full stack: 02:52:29 INFO - PID 1906 | ************************* 02:53:49 INFO - PID 1906 | Cycle 1(1): loaded http://localhost:57187/tests/dromaeo/cssquery-ext.html (next: http://localhost:57187/tests/dromaeo/cssquery-jquery.html) 02:53:49 INFO - PID 1906 | RSS: Main: 371113984 02:53:49 INFO - PID 1906 | 02:56:52 INFO - PID 1906 | Cycle 1(1): loaded http://localhost:57187/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57187/tests/dromaeo/cssquery-mootools.html) 02:56:52 INFO - PID 1906 | RSS: Main: 360718336 02:56:52 INFO - PID 1906 | 02:59:55 INFO - PID 1906 | Cycle 1(1): loaded http://localhost:57187/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57187/tests/dromaeo/cssquery-prototype.html) 02:59:55 INFO - PID 1906 | RSS: Main: 329515008 02:59:55 INFO - PID 1906 | 03:02:59 INFO - PID 1906 | Cycle 1(1): loaded http://localhost:57187/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57187/tests/dromaeo/cssquery-yui.html) 03:03:00 INFO - PID 1906 | RSS: Main: 340922368 03:03:00 INFO - PID 1906 | 03:06:02 INFO - PID 1906 | Cycle 1(1): loaded http://localhost:57187/tests/dromaeo/cssquery-yui.html (next: http://localhost:57187/tests/dromaeo/cssquery-dojo.html) 03:06:02 INFO - PID 1906 | RSS: Main: 378609664 03:06:02 INFO - PID 1906 | 03:06:02 INFO - PID 1906 | __start_tp_report 03:06:02 INFO - PID 1906 | _x_x_mozilla_page_load 03:06:02 INFO - PID 1906 | _x_x_mozilla_page_load_details 03:06:02 INFO - PID 1906 | |i|pagename|runs| 03:06:02 INFO - PID 1906 | |0;dojo.html;3400.132966093646;3434.879779207728;3438.570178727659;3459.3427248822723;3511.1748739046334;6062.484688801452;6096.390360963901;6119.571629985897;6129.938700612993;6140.105498721233;6070.757169713217;6102.145699602048;6118.602290851091;6127.662978536178;6131.969340153293;4838.854834354957;5055.393352797661;5222.895542089156;5278.261043453919;5397.325334333208;5140.485951404867;5280.392754833186;5286.735663216843;5392.1911713243135;5392.703401312926;5261.15821468567;5266.526012658841;5277.12927366984;5288.735563221823;5373.1402975524115;5250.7112108834;5294.073537130987;5302.655327403706;5329.280547126127;5375.3280839895015;5271.103912334912;5301.151815709506;5332.840014799563;5333.706646134461;5341.732913354317;5941.9108713368905;5982.252218472691;5988.191594134823;5996.820095397145;6122.081687746829;5344.946550534483;6311.242650881878;6326.240851097898;6326.367363263683;6328.145700330442;5285.86785330366;6371.362863713638;6461.967690161566;6511.08844761729;6541.018847172914;6155.10750941111;6204.3795620437595;6207.751689932443;6223.471004964629;6226.097215903714;6394.136791533177;6679.0315404267085;6693.732250710014;6694.866102678016;6699.665016749143;6308.873822523524;6318.399752023551;6335.303116657164;6336.714847831859;6341.397567231105;6329.620222786648;6346.841328966812;6363.936360636427;6398.9040164397575;6502.122213501211;6399.776007839703;6412.39082287182;6426.710798014101;6427.839304017437;6447.6131432114225;6410.903836442457;6412.070249813844;6413.390727880844;6426.839329016719;6431.292557818636;5088.643794934319;5179.870503237374;5252.474752524793;5253.55344795689;5299.788008479694;4526.592606665416;4593.63250939924;4595.563421474954;4617.215073437524;4644.256918893028;5196.9740151299;6081.8479538011015;6084.817455476343;6091.662371644938;6177;5384.6769193848495;6454.709538070798;6493.448056915121;6495.382938620824;6507.674616269168;6198.101275315054;6208.627482351073;6211.844703882349;6217.440430361289;6228.813135605939;5580.86047848807;5652.208690783294;5705.600607957404;5715.685637289989;5724.74238659253;6491.7078731457195;6567.047778072153;6630.801075967729;6639.966800165968;6677.098591690254;6479.8056058318325;6511.186101737283;6516.804495865132;6555.573887697285;6565.573237739532;6692.765753198614;6707.228668702966;6708.6981085850275;6719.025741267586;6721.899171512529;6239.407256310643;6341.968290158519;6342.39747224013;6346.524010699124;6356.745730170926;6233.470155036873;6344.841378965562;6352.714127864165;6382.393672601095;6439.581427207217;5280.891012887183;5747.109198074305;6098.878022439615;6272.153259309935;6334;5890.352061273171;6331.335209803088;6338.968305158444;6339.175907132043;6348.523860710373;6102.307478454246;6159.9836027055035;6179.227596550431;6296;6303.275123360872;6253.687315634109;6255.96872015637;6277.435030847246;6290.961991271389;6316.842078948063;6224.906626400698;6243.719032643451;6263.96868015657;6291.1192433058495;6291.685415729104 03:06:02 INFO - PID 1906 | |1;ext.html;798.4570492065396;812.2446125103653;1039.1998161415715;1145.5532342386466;1158.2934410009898;31657;35041.77353792614;35797.46303805442;36384.09039774007;36715;38449.61550384502;38590;38591.80704096483;38612;38714.22571548567;6155.969220153893;8553.230209281179;8749;8749.431286966359;8753.693620723276;6200.410960958701;8414.621342039623;8602.741917742478;8607.526586037766;8617.439866408695;8665.17680820321;8701.69474578815;8704.216620504154;8712.564371781416;8724.345674074439;8603.655853765842;8670.479771213748;8673.306135509145;8681.17528834766;8690.130986901322;8497.065322814486;8550.61522231495;8564.571771411467;8573.571321433903;8576.442531235512;36929.630703692885;37131;37155;37212.81393593042;37227;3621.963780362189;3676.3015027145025;3682.3371793077235;3684.9815750921343;3685.1708365617787;30383.69616303831;30477;30497.695023049706;30512.84743576268;30522.694773052208;2864.5559938209612;2881.6109825173544;2890.1474065150833;2896.6379202599674;2910.0687779910436;223637;287613;288861;289012;289542.9999999979;38395.84812455631;39435;47471.76264118657;47581;47660;40525.594744052185;48736.53790386294;49409.50590494121;49702;49824.50175498271;14443.205623690797;14577.125372477685;14577.635559110895;14579.635509112357;14595.905307101797;11891.524339026515;11904.940475297568;11911.761764764657;11921.105917056255;11937.925586697065;10708.929107089229;12041.458134383798;12097.697557560956;12139;12170;5609.298837645294;5643.604947653625;5662.801801936913;5666.291713535808;5678.176664383724;928.9581968811284;972.3290929258789;1009.9143420822645;1016.7051555048953;1069.401135364183;22163.44591385196;23985.760142398703;24016;24080.638790418157;24130.396740081287;1001.1840350114634;1099.2689861242184;1141.7545227775902;1143.1369316166242;1145.7765735681462;12236.082293827998;12335.753284934251;12353.567625133077;12395.62813115608;12404.25574465535;356312;356365;356522;356628;357020;47898.5210147894;48008.5199148011;48019.27971080437;48032.5196748035;48089.75955120202;1534.6136757342217;1541.5452441529776;1582.374961890047;1584.4612831637298;1587.0715631355556;22280.442988925406;23537.88231058834;23597.764022360243;23642.408939776644;23799.524009519366;37326.813365933;37369.813150934075;37375.813120934225;37443.81278093592;37521.43717844289;317893;319476;319665;319827;319833.4008329943;29131.271718207216;29643.85178074096;29963.85018074983;33877.83061084679;34055.31889362248;41444.37833432441;42298.36552451654;42326.788366057976;42388.78805605952;42534.93662658458;21203.89398053;27801.165965021082;28922.132336029954;29342.55986160252;29814.70185298206;28589.28526786847;29341.26646833846;29515.262118447212;29530.852345738134;29611.40777184487;34125.82937085398;34791.65208347985;34851.65148348484;34863.77976770801;34881.47677784784;28831.711682883742;29253.976110836018;29752.851235744547;30000.849995749883;30112.54831177578;20565.97170141457;20921.476963076046;21036.26373076935;23321;23427.297181084596 03:06:02 INFO - PID 1906 | |2;jquery.html;428.2612790340329;429.76148237728046;436.87330674104504;440.223006393715;458.70184380152915;20021.399358019247;21417.464563385904;22009.559808803853;22201.555968880613;22284.442888927784;21779.782202177972;22733;23423.4144146396;23424.5315093698;23656.88171559144;6057.878842423149;6094.66479343637;6331.873362532747;6335.714892829834;6351.777687780928;6141.416565426277;6354.586951848139;6365.2998170201245;6377.362263773632;6383.2340119185765;6074.787382441594;6257.780977665782;6319.241690997063;6336.398042185985;6340.365963403646;6344.873102537969;6392.6484043377595;6401.455876250524;6402.583832050948;6414.615123092606;4881.194602890519;5550.555955523549;5622.803201887914;5695.943040569583;5697.1739097831;27591.86204068967;27629.585556216472;27632.86183569069;27679.169624911287;28017;2252.6170551006367;2338.088145623208;2340.1107579119994;2340.719113706366;2342.1334106380577;17819.10904454785;17914.83553569027;18078.186481608358;18144;18527.907360463112;2125.7130287411155;2177.6733489976473;2199.2522542335682;2203.6914831923546;2205.5809396214827;148328;162099;171562;171951;173645.13177434032;10924.836127458095;12548.749025019448;12686.873131268754;12709.237445753284;12936.606727755396;17057.573560660836;17069.829301707072;17077.316907323817;17079.573010674583;17132.657346852993;8831.867521987175;9104.8634270486;9152.90847091534;9294.86057709135;9316.487593182304;8741.082186370466;8778.034416214212;8785.989611194795;8950.104989500998;8950.314905528316;6878.828029299208;7455.589942553212;7881.921180788233;7941.64262608184;7952.045754509496;2010.3767831972136;2095.0991073838395;2118.248021952185;2119.9894000530207;2121.2363549122306;959.1271942532262;959.7984423271051;965.99034009659;995.6415690351467;1011.4487604255698;21208;21526.89236553807;21618.89190554037;21734.782652173275;21735.45661358447;986.9062439068421;995.4326034160459;1008.4705529596873;1021.8160731068479;1025.6717850287985;10639.946800265949;11340.546378144947;11383.430828458544;11403.828942565868;11423.371714555778;702859;703137;715520;722419;728638;152203;165596;166350.1682491604;169808;172170;1019.887812340642;1026.4970164619283;1242.577523641966;1243.7325974915257;1244.5892855357529;18989.050547472296;22234.332970010924;22458.550828983654;22507.21224757191;22757.544849102593;64526.354736452035;65010.02484962824;65193.67403162954;65333;66529;93097.53451232701;93188;93263;93686;95504;9014.504202268938;9058.592363343534;9150.816983660423;9218.631254750004;9244.306676999118;14119.647008824451;14139.505117320845;14389.926053155998;14600.196989165697;14655.706885862437;10210.132138768287;11634.592789252336;11726.775136837437;11822.054235661299;11940.761184776082;10223.795524089328;10675.786484270426;11240.662780116609;11487.597934072268;11778.46996885125;10599.62901298451;11567.305961642329;11569.595064172714;11672.241304315192;11936.940315298369;8802.955985220033;9005.909940900507;9187.18441395958;9322.766930826783;9367.156955874005;11123.234436887997;11641.417929103342;11665.88334116648;11866.347350895438;12077.879221207675 03:06:02 INFO - PID 1906 | |3;mootools.html;1198.7242934125156;1391.2348208485332;1462.327329428463;1467.911925284483;1486.7249558831625;9832.164266037387;11164.888351116486;11828.053755699544;11844.881551184486;11891.940540297308;11483.540658373677;11720.179587428884;11728.941355293211;11736.7652646947;11746.823797643021;2138.7326584176976;2505.649209110717;2524.0408644714985;2524.8737563121863;2526.355779276282;2104.8947552622385;2200;2200.8129309008755;2201.7798220178015;2203.0857194264363;2382.642603609464;2476.5913624251975;2477.690288713911;2482.2056941778637;2485.2792690119845;1977.9406617801417;2457.4225057111744;2476.1457297232428;2480.5162993216422;2484.24230609664;2460.9753902460925;2473.6660550825586;2491.5141547398266;2500.9374765630823;2503.4742704032174;11631.418429078512;11637.185397022211;11761.235519691192;11765.352905590189;11765.882341176564;5438.265834112423;6458.257300410466;6702.463802895757;6719.899201511981;6726.697298621574;3855.730098893079;4078.145298291208;4101.200265948141;4179.498460184797;4183.226103170893;1101.2016288190998;1105.6351404036648;1128.9040431563326;1229.4037391864938;1275.2794671010943;16250.674986500322;16633.417830375878;16636.417725379673;16646.50544353018;16660.75008874868;5808.448197421239;5875.588708790344;5946.256717910262;5958.2850057992455;6052.243469566304;13593.932030339984;13598.864011359958;13600.727985440235;13603.183808971295;13605.591832245049;6745.898811517831;6756.662166891734;6761.647670465828;6762.830929226809;6768.69540870662;5998.1602575639445;6119.204503414617;6194.969025154845;6214.161088253028;6222.502199824004;4164.208800327989;4300;4529.682922195415;4662.323963025342;4738.881527961828;1300.3602686546326;1328.873756993084;1330.554264321463;1330.9068365214537;1332.2339654698394;701.6877489517218;752.913414957276;781.675604624086;786.6538722961878;818.4720855048579;5921.881562368729;6127.952854217685;6228.875422491616;6279.686015699197;6398.952335252768;922.561783152997;923.9953800230955;924.1451657217048;944.951104274255;947.3415975896686;4468.642508599304;4542.273236282179;4608.907821843544;4616.169089563844;4738.905221895543;14696.926515367355;15289.082655040733;15300.846991529943;15321.23393830304;15326.00380975233;14872.553823385315;15008.62478438026;15405.537833865003;15446.922765386102;15454.768178477332;10738.78522429547;11033.448327583588;11046.779064418828;11066.114710823114;11078.889211107786;6401.391867772554;6438.645874476949;6939.826504337432;7145.356917877416;7181.784546463615;13280.136791108547;13413.530526431528;13563.79654305206;13592.320383980563;13639.38622761998;13718.588442346745;13763.79354309666;13811.309434528433;13960.371783269575;14015.229162396166;9516.333856630246;9719.514024298898;9725.221982241545;9728.610855565697;9745.805083898424;10532.157427405942;10967.177461690246;11036.779264414507;11062.612808551663;11082.335059896432;7263.34629883313;8408.159184081544;9091.54542272897;9278.536073196448;9395.765105872408;8962.283017358464;9036;9110.772230694285;9121.726348209564;9299.76750581241;8185.017797864056;8226.835463290821;8283.83432331362;8303.501789892625;8323.791905202419;5938.881222375615;5976.551758618208;6049.758009679564;6083.482903953213;6124.14262003311;5405.675659460445;5628.662280263197;6106.175666285172;6215.34738852414;6269.868244796791 03:06:02 INFO - PID 1906 | |4;prototype.html;353.3145697347146;389.9044734040161;390.05022769556126;399.88203479973424;401.24365570898846;4626.907461850761;5586.608937374385;5611.148321054053;5626.634268772537;5708.543316534678;4421.425214722081;5233.267342572043;5366;5514.5864060195545;5588.804391846286;4062.8420900043493;4310.267254566716;4316.589923957219;4319.2441322768545;4327.307630779061;3954.5056867891512;4179.226843034034;4319.6393136162005;4338.544452832439;4366.956330436687;3785.977785997779;4078.653314468274;4306.35404689296;4311.525732169474;4319.784010799463;3654.177809992757;4023.8189281482405;4171.520275168364;4287.6141147296585;4302.2471067563365;3351.6480769519094;3635.054885729703;3823.254465379252;3825.464434979105;3832.7508711933633;5306.442823503554;5485.75314110862;5515.7242137893345;5519.454552725203;5584.944150558483;4286.249906266391;4725.385699859031;5121.308623335876;5170.793168273264;5170.922436163461;5977.671228082454;5990.820275391745;6004.5796794224425;6006.519478441714;6040.456358927674;3888.941665875014;4370.672199585012;4371.038371558252;4371.825126994916;4378.868633940987;6064.727087281083;6236.532260080467;6283;6289.433950944345;6397.744090236385;4136.6483848872585;4174.3947127666315;4199.748015119041;4218.924174335525;4219.43037689914;4124.257633625976;4249.794002347162;4288.863451185376;4292.055747735493;4307.483102027777;4692.7653617319;4757.14371413142;4815.15734746418;4958.752062396866;4970.90058198834;5984.3417224105315;6024.367441418675;6025.0359942409;6033.81975449214;6037.366076561985;1292.7866901961072;1427.3719563392074;1455.1269238457053;1455.2650911289732;1459.058907004976;918.4397517514444;932.9393589416666;968.099667309409;973.6202880876464;974.8635191073255;5709.286339207599;5710.71446427677;5714.428557144252;5716.199397189955;5732.42041081515;5437.374701909252;6178.66017369049;6192.225971753531;6255.718492667841;6259.499240060784;4991.801967527767;5416.702081385482;5694.430556944272;5719.542436605062;5721.914171287434;2656.6413534173025;2975.1966968918273;3244.12408649668;3248.2204270975267;3280.5243239730107;6059.394060593905;6108.236470441195;6309.211348581427;6382.648954307465;6416.326285740023;4854.077725232195;5979.910301345483;6207.227278630827;6311.2644022893155;6332.873342533124;6002.8499287516415;6353.3329000455215;6396.232452105684;6409.807705768834;6456;5361.276227709365;6142.508599311955;6182.783602573888;6192.266165473675;6222.782202622887;5688;5893.410658934073;6095.664738439428;6108.541859360477;6117;4583.358329833893;4994.001199760135;5994.9508835952665;6347.619142851444;6432.195975503062;4159.584041595937;4179.9582004179565;4195.77623859355;4196.622303992655;4200.94976255936;5255.605829562722;5316.401312864422;6039.698015099315;6217.098520714561;6274.749010039547;5020.673656212334;5063.87340316495;6028.728707208274;6036.9094463582205;6080.179175811209;5274.630775845654;5737.971310143589;5823.912641310299;5995.340512543704;6167.537434692326;5231.979763945994;5287.9471205287455;5716.799912003226;5821.825345239649;5946.405359464019;5102.540771330598;6001.879962400815;6017.819465416044;6026.246719160105;6027.57806953509;5164.896702066013;5865.912011319749;5887.793927212527;5910.70446477683;5944.900193464223 03:06:02 INFO - PID 1906 | |5;yui.html;713.9857202855947;863.9352048596355;873.3188113271647;882.1002577371082;893.0667452512124;13376.66558336042;13519.594412167626;13534.72930541391;13698.315084245785;13716.588502344921;13237.735245295113;16840.410585629506;17260.136993150354;17336.306547738106;17338.913305433456;733.9192688804214;991.2565575818137;991.2565575818137;992.4392718114278;994.9801453510138;1015.1371334365804;1017.4149863828292;1018.5721996761378;1018.6078359831445;1021.0759262867117;727.6943683652878;742.7697413801711;1019.11846252991;1064.9989010330303;1075.2419544221304;1060.6128763001525;1061.3737894642197;1062.596213438896;1064.0795711709354;1066.2589500297297;791.8693415586421;792.2948575767572;794.4875555266879;794.6900708723603;797.2227078598378;16050.919745401316;16422.014679119293;16539.751903721455;16584.1707914605;16740.748888766677;14160.15039097647;14510;14516.637084072983;16783.748243776354;17175.398861039805;13637.113587616774;13896.374663140083;14036.929815350857;14063.01558890878;14266.785998210034;3544.379733546619;3568.286342731464;3568.50040994261;3571.2678900825267;3571.5535558055244;107493.3875991853;110914;112246.87753122445;112805.97552195887;113391.43304283425;11314.830277545843;13605.115667481581;13895.58313250604;13924.025318227626;13965.301734913417;16909.7463538047;20569.280075197297;25762.227133186036;25792.61311080335;25839.224823255332;8314.251717345347;8684.044755076937;8840.381173317806;8843;8860.64557417709;4818.301346304836;4908.950910490849;4911.901761964741;4912.582430493377;4917.926231106536;4250.36244563318;4269.679774016961;4383.517813040563;4390.143921935192;4400;927.7216834949488;957.363353370015;962.485070487286;964.238251781099;967.032967032967;607.2166904692984;674.369464550637;682.8668409660168;687.6458623808743;709.2340272505681;10708.464576771286;11722.824157637642;11867.643970680721;11948.283103013848;11976.101792365607;649.4479692261634;650.9511786615928;654.4927681047132;668.7893313606296;686.4782765098461;4892.633052521075;5394.406615272317;5398.028354896078;5427.240186373911;5549.916751248735;100738.496307518;103817;104294;104499;105809.47095264628;93342;93521.5323923376;96835.51582242185;97501.02498975061;97695.02304977001;62363;77974.44051118946;78403.60798196087;79514.01214969557;80181.59909200533;10236;12221.266723996589;12627.431765570387;12709.04682148824;12783.552575659807;38690.6130938687;39073.023174420865;40148;41054.79472602618;42246.57753422426;53001.4699853012;53099;53449.73275133599;53684.73157634187;54526;15806;15806.76289855676;15972;16168.757468637745;16220.67558648844;17896;18057.54856128555;18314.084295785426;18336.266549337877;18342.331533693046;16255.67488650244;16306.510804675878;16390.918045409697;16555.834441655912;16640.583985400463;16017.958832676304;16225.756613650568;16293.42972995987;16323.510294691177;16488.505344839676;13302.534411295559;15687.058776473448;16428.342866285213;16492.42276520316;16575.25411356468;10506.317089389166;11162.49768760424;11500.769984600429;11649;11727.88272117302;12212.90083892454;12596.244225346509;13518.256495892427;13706.931465343008;14082.366293517021 03:06:02 INFO - PID 1906 | __end_tp_report 03:06:02 INFO - PID 1906 | __start_cc_report 03:06:02 INFO - PID 1906 | _x_x_mozilla_cycle_collect,2887 03:06:02 INFO - PID 1906 | __end_cc_report 03:06:02 INFO - PID 1906 | __startTimestamp1492077962721__endTimestamp 03:06:02 INFO - PID 1906 | 03:06:02 INFO - PID 1906 | ------- Summary: start ------- 03:06:02 INFO - PID 1906 | Number of tests: 6 03:06:02 INFO - PID 1906 | 03:06:02 INFO - PID 1906 | [#0] dojo.html Cycles:165 Average:5944.23 Median:6223.47 stddev:690.55 (11.1%) stddev-sans-first:663.20 03:06:02 INFO - PID 1906 | Values: 3400.1 3434.9 3438.6 3459.3 3511.2 6062.5 6096.4 6119.6 6129.9 6140.1 6070.8 6102.1 6118.6 6127.7 6132.0 4838.9 5055.4 5222.9 5278.3 5397.3 5140.5 5280.4 5286.7 5392.2 5392.7 5261.2 5266.5 5277.1 5288.7 5373.1 5250.7 5294.1 5302.7 5329.3 5375.3 5271.1 5301.2 5332.8 5333.7 5341.7 5941.9 5982.3 5988.2 5996.8 6122.1 5344.9 6311.2 6326.2 6326.4 6328.1 5285.9 6371.4 6462.0 6511.1 6541.0 6155.1 6204.4 6207.8 6223.5 6226.1 6394.1 6679.0 6693.7 6694.9 6699.7 6308.9 6318.4 6335.3 6336.7 6341.4 6329.6 6346.8 6363.9 6398.9 6502.1 6399.8 6412.4 6426.7 6427.8 6447.6 6410.9 6412.1 6413.4 6426.8 6431.3 5088.6 5179.9 5252.5 5253.6 5299.8 4526.6 4593.6 4595.6 4617.2 4644.3 5197.0 6081.8 6084.8 6091.7 6177.0 5384.7 6454.7 6493.4 6495.4 6507.7 6198.1 6208.6 6211.8 6217.4 6228.8 5580.9 5652.2 5705.6 5715.7 5724.7 6491.7 6567.0 6630.8 6640.0 6677.1 6479.8 6511.2 6516.8 6555.6 6565.6 6692.8 6707.2 6708.7 6719.0 6721.9 6239.4 6342.0 6342.4 6346.5 6356.7 6233.5 6344.8 6352.7 6382.4 6439.6 5280.9 5747.1 6098.9 6272.2 6334.0 5890.4 6331.3 6339.0 6339.2 6348.5 6102.3 6160.0 6179.2 6296.0 6303.3 6253.7 6256.0 6277.4 6291.0 6316.8 6224.9 6243.7 6264.0 6291.1 6291.7 03:06:02 INFO - PID 1906 | 03:06:02 INFO - PID 1906 | [#1] ext.html Cycles:180 Average:45647.39 Median:33966.57 stddev:84052.20 (247.5%) stddev-sans-first:84220.54 03:06:02 INFO - PID 1906 | Values: 798.5 812.2 1039.2 1145.6 1158.3 31657.0 35041.8 35797.5 36384.1 36715.0 38449.6 38590.0 38591.8 38612.0 38714.2 6156.0 8553.2 8749.0 8749.4 8753.7 6200.4 8414.6 8602.7 8607.5 8617.4 8665.2 8701.7 8704.2 8712.6 8724.3 8603.7 8670.5 8673.3 8681.2 8690.1 8497.1 8550.6 8564.6 8573.6 8576.4 36929.6 37131.0 37155.0 37212.8 37227.0 3622.0 3676.3 3682.3 3685.0 3685.2 30383.7 30477.0 30497.7 30512.8 30522.7 2864.6 2881.6 2890.1 2896.6 2910.1 223637.0 287613.0 288861.0 289012.0 289543.0 38395.8 39435.0 47471.8 47581.0 47660.0 40525.6 48736.5 49409.5 49702.0 49824.5 14443.2 14577.1 14577.6 14579.6 14595.9 11891.5 11904.9 11911.8 11921.1 11937.9 10708.9 12041.5 12097.7 12139.0 12170.0 5609.3 5643.6 5662.8 5666.3 5678.2 929.0 972.3 1009.9 1016.7 1069.4 22163.4 23985.8 24016.0 24080.6 24130.4 1001.2 1099.3 1141.8 1143.1 1145.8 12236.1 12335.8 12353.6 12395.6 12404.3 356312.0 356365.0 356522.0 356628.0 357020.0 47898.5 48008.5 48019.3 48032.5 48089.8 1534.6 1541.5 1582.4 1584.5 1587.1 22280.4 23537.9 23597.8 23642.4 23799.5 37326.8 37369.8 37375.8 37443.8 37521.4 317893.0 319476.0 319665.0 319827.0 319833.4 29131.3 29643.9 29963.9 33877.8 34055.3 41444.4 42298.4 42326.8 42388.8 42534.9 21203.9 27801.2 28922.1 29342.6 29814.7 28589.3 29341.3 29515.3 29530.9 29611.4 34125.8 34791.7 34851.7 34863.8 34881.5 28831.7 29254.0 29752.9 30000.8 30112.5 20566.0 20921.5 21036.3 23321.0 23427.3 03:06:02 INFO - PID 1906 | 03:06:02 INFO - PID 1906 | [#2] jquery.html Cycles:180 Average:42322.01 Median:22745.27 stddev:120401.42 (529.3%) stddev-sans-first:120698.09 03:06:02 INFO - PID 1906 | Values: 428.3 429.8 436.9 440.2 458.7 20021.4 21417.5 22009.6 22201.6 22284.4 21779.8 22733.0 23423.4 23424.5 23656.9 6057.9 6094.7 6331.9 6335.7 6351.8 6141.4 6354.6 6365.3 6377.4 6383.2 6074.8 6257.8 6319.2 6336.4 6340.4 6344.9 6392.6 6401.5 6402.6 6414.6 4881.2 5550.6 5622.8 5695.9 5697.2 27591.9 27629.6 27632.9 27679.2 28017.0 2252.6 2338.1 2340.1 2340.7 2342.1 17819.1 17914.8 18078.2 18144.0 18527.9 2125.7 2177.7 2199.3 2203.7 2205.6 148328.0 162099.0 171562.0 171951.0 173645.1 10924.8 12548.7 12686.9 12709.2 12936.6 17057.6 17069.8 17077.3 17079.6 17132.7 8831.9 9104.9 9152.9 9294.9 9316.5 8741.1 8778.0 8786.0 8950.1 8950.3 6878.8 7455.6 7881.9 7941.6 7952.0 2010.4 2095.1 2118.2 2120.0 2121.2 959.1 959.8 966.0 995.6 1011.4 21208.0 21526.9 21618.9 21734.8 21735.5 986.9 995.4 1008.5 1021.8 1025.7 10639.9 11340.5 11383.4 11403.8 11423.4 702859.0 703137.0 715520.0 722419.0 728638.0 152203.0 165596.0 166350.2 169808.0 172170.0 1019.9 1026.5 1242.6 1243.7 1244.6 18989.1 22234.3 22458.6 22507.2 22757.5 64526.4 65010.0 65193.7 65333.0 66529.0 93097.5 93188.0 93263.0 93686.0 95504.0 9014.5 9058.6 9150.8 9218.6 9244.3 14119.6 14139.5 14389.9 14600.2 14655.7 10210.1 11634.6 11726.8 11822.1 11940.8 10223.8 10675.8 11240.7 11487.6 11778.5 10599.6 11567.3 11569.6 11672.2 11936.9 8803.0 9005.9 9187.2 9322.8 9367.2 11123.2 11641.4 11665.9 11866.3 12077.9 03:06:02 INFO - PID 1906 | 03:06:02 INFO - PID 1906 | [#3] mootools.html Cycles:180 Average:7256.67 Median:2514.85 stddev:4651.28 (185.0%) stddev-sans-first:4642.05 03:06:02 INFO - PID 1906 | Values: 1198.7 1391.2 1462.3 1467.9 1486.7 9832.2 11164.9 11828.1 11844.9 11891.9 11483.5 11720.2 11728.9 11736.8 11746.8 2138.7 2505.6 2524.0 2524.9 2526.4 2104.9 2200.0 2200.8 2201.8 2203.1 2382.6 2476.6 2477.7 2482.2 2485.3 1977.9 2457.4 2476.1 2480.5 2484.2 2461.0 2473.7 2491.5 2500.9 2503.5 11631.4 11637.2 11761.2 11765.4 11765.9 5438.3 6458.3 6702.5 6719.9 6726.7 3855.7 4078.1 4101.2 4179.5 4183.2 1101.2 1105.6 1128.9 1229.4 1275.3 16250.7 16633.4 16636.4 16646.5 16660.8 5808.4 5875.6 5946.3 5958.3 6052.2 13593.9 13598.9 13600.7 13603.2 13605.6 6745.9 6756.7 6761.6 6762.8 6768.7 5998.2 6119.2 6195.0 6214.2 6222.5 4164.2 4300.0 4529.7 4662.3 4738.9 1300.4 1328.9 1330.6 1330.9 1332.2 701.7 752.9 781.7 786.7 818.5 5921.9 6128.0 6228.9 6279.7 6399.0 922.6 924.0 924.1 945.0 947.3 4468.6 4542.3 4608.9 4616.2 4738.9 14696.9 15289.1 15300.8 15321.2 15326.0 14872.6 15008.6 15405.5 15446.9 15454.8 10738.8 11033.4 11046.8 11066.1 11078.9 6401.4 6438.6 6939.8 7145.4 7181.8 13280.1 13413.5 13563.8 13592.3 13639.4 13718.6 13763.8 13811.3 13960.4 14015.2 9516.3 9719.5 9725.2 9728.6 9745.8 10532.2 10967.2 11036.8 11062.6 11082.3 7263.3 8408.2 9091.5 9278.5 9395.8 8962.3 9036.0 9110.8 9121.7 9299.8 8185.0 8226.8 8283.8 8303.5 8323.8 5938.9 5976.6 6049.8 6083.5 6124.1 5405.7 5628.7 6106.2 6215.3 6269.9 03:06:02 INFO - PID 1906 | 03:06:02 INFO - PID 1906 | [#4] prototype.html Cycles:180 Average:4868.69 Median:5461.56 stddev:1487.45 (27.2%) stddev-sans-first:1452.50 03:06:02 INFO - PID 1906 | Values: 353.3 389.9 390.1 399.9 401.2 4626.9 5586.6 5611.1 5626.6 5708.5 4421.4 5233.3 5366.0 5514.6 5588.8 4062.8 4310.3 4316.6 4319.2 4327.3 3954.5 4179.2 4319.6 4338.5 4367.0 3786.0 4078.7 4306.4 4311.5 4319.8 3654.2 4023.8 4171.5 4287.6 4302.2 3351.6 3635.1 3823.3 3825.5 3832.8 5306.4 5485.8 5515.7 5519.5 5584.9 4286.2 4725.4 5121.3 5170.8 5170.9 5977.7 5990.8 6004.6 6006.5 6040.5 3888.9 4370.7 4371.0 4371.8 4378.9 6064.7 6236.5 6283.0 6289.4 6397.7 4136.6 4174.4 4199.7 4218.9 4219.4 4124.3 4249.8 4288.9 4292.1 4307.5 4692.8 4757.1 4815.2 4958.8 4970.9 5984.3 6024.4 6025.0 6033.8 6037.4 1292.8 1427.4 1455.1 1455.3 1459.1 918.4 932.9 968.1 973.6 974.9 5709.3 5710.7 5714.4 5716.2 5732.4 5437.4 6178.7 6192.2 6255.7 6259.5 4991.8 5416.7 5694.4 5719.5 5721.9 2656.6 2975.2 3244.1 3248.2 3280.5 6059.4 6108.2 6309.2 6382.6 6416.3 4854.1 5979.9 6207.2 6311.3 6332.9 6002.8 6353.3 6396.2 6409.8 6456.0 5361.3 6142.5 6182.8 6192.3 6222.8 5688.0 5893.4 6095.7 6108.5 6117.0 4583.4 4994.0 5995.0 6347.6 6432.2 4159.6 4180.0 4195.8 4196.6 4200.9 5255.6 5316.4 6039.7 6217.1 6274.7 5020.7 5063.9 6028.7 6036.9 6080.2 5274.6 5738.0 5823.9 5995.3 6167.5 5232.0 5287.9 5716.8 5821.8 5946.4 5102.5 6001.9 6017.8 6026.2 6027.6 5164.9 5865.9 5887.8 5910.7 5944.9 03:06:02 INFO - PID 1906 | 03:06:02 INFO - PID 1906 | [#5] yui.html Cycles:180 Average:21061.58 Median:17217.77 stddev:29268.65 (170.0%) stddev-sans-first:29310.88 03:06:02 INFO - PID 1906 | Values: 714.0 863.9 873.3 882.1 893.1 13376.7 13519.6 13534.7 13698.3 13716.6 13237.7 16840.4 17260.1 17336.3 17338.9 733.9 991.3 991.3 992.4 995.0 1015.1 1017.4 1018.6 1018.6 1021.1 727.7 742.8 1019.1 1065.0 1075.2 1060.6 1061.4 1062.6 1064.1 1066.3 791.9 792.3 794.5 794.7 797.2 16050.9 16422.0 16539.8 16584.2 16740.7 14160.2 14510.0 14516.6 16783.7 17175.4 13637.1 13896.4 14036.9 14063.0 14266.8 3544.4 3568.3 3568.5 3571.3 3571.6 107493.4 110914.0 112246.9 112806.0 113391.4 11314.8 13605.1 13895.6 13924.0 13965.3 16909.7 20569.3 25762.2 25792.6 25839.2 8314.3 8684.0 8840.4 8843.0 8860.6 4818.3 4909.0 4911.9 4912.6 4917.9 4250.4 4269.7 4383.5 4390.1 4400.0 927.7 957.4 962.5 964.2 967.0 607.2 674.4 682.9 687.6 709.2 10708.5 11722.8 11867.6 11948.3 11976.1 649.4 651.0 654.5 668.8 686.5 4892.6 5394.4 5398.0 5427.2 5549.9 100738.5 103817.0 104294.0 104499.0 105809.5 93342.0 93521.5 96835.5 97501.0 97695.0 62363.0 77974.4 78403.6 79514.0 80181.6 10236.0 12221.3 12627.4 12709.0 12783.6 38690.6 39073.0 40148.0 41054.8 42246.6 53001.5 53099.0 53449.7 53684.7 54526.0 15806.0 15806.8 15972.0 16168.8 16220.7 17896.0 18057.5 18314.1 18336.3 18342.3 16255.7 16306.5 16390.9 16555.8 16640.6 16018.0 16225.8 16293.4 16323.5 16488.5 13302.5 15687.1 16428.3 16492.4 16575.3 10506.3 11162.5 11500.8 11649.0 11727.9 12212.9 12596.2 13518.3 13706.9 14082.4 03:06:02 INFO - PID 1906 | -------- Summary: end -------- 03:06:02 INFO - PID 1906 | 03:06:03 INFO - TEST-INFO | 1906: exit 0 03:06:03 INFO - TEST-OK | dromaeo_css | took 1119906ms 03:06:03 INFO - TEST-START | kraken 03:06:03 INFO - operating with platform_type : mac_ 03:06:03 INFO - Initialising browser for kraken test... 03:06:03 INFO - TEST-INFO | started process 1912 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmpjBKYqh/profile http://localhost:57187/getInfo.html) 03:06:06 INFO - PID 1912 | __metrics Screen width/height:1600/1200 03:06:06 INFO - PID 1912 | colorDepth:24 03:06:06 INFO - PID 1912 | Browser inner width/height: 1024/689 03:06:06 INFO - PID 1912 | __metrics 03:06:06 INFO - PID 1912 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:06:06 INFO - PID 1912 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:06:07 INFO - TEST-INFO | 1912: exit 0 03:06:07 INFO - Browser initialized. 03:06:07 INFO - Running cycle 1/1 for kraken test... 03:06:07 INFO - TEST-INFO | started process 1913 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmpjBKYqh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:06:19 INFO - PID 1913 | RSS: Main: 239964160 03:06:19 INFO - PID 1913 | 03:06:22 INFO - PID 1913 | Cycle 1(1): loaded http://localhost:57187/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57187/tests/kraken/driver.html?testName=audio-beat-detection) 03:06:23 INFO - PID 1913 | RSS: Main: 290889728 03:06:23 INFO - PID 1913 | 03:06:25 INFO - PID 1913 | Cycle 1(1): loaded http://localhost:57187/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57187/tests/kraken/driver.html?testName=audio-dft) 03:06:26 INFO - PID 1913 | RSS: Main: 290619392 03:06:26 INFO - PID 1913 | 03:06:29 INFO - PID 1913 | Cycle 1(1): loaded http://localhost:57187/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57187/tests/kraken/driver.html?testName=audio-fft) 03:06:30 INFO - PID 1913 | RSS: Main: 384192512 03:06:30 INFO - PID 1913 | 03:06:32 INFO - PID 1913 | Cycle 1(1): loaded http://localhost:57187/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57187/tests/kraken/driver.html?testName=audio-oscillator) 03:06:33 INFO - PID 1913 | RSS: Main: 288030720 03:06:33 INFO - PID 1913 | 03:06:35 INFO - PID 1913 | Cycle 1(1): loaded http://localhost:57187/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57187/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:06:35 INFO - PID 1913 | RSS: Main: 291090432 03:06:35 INFO - PID 1913 | 03:06:38 INFO - PID 1913 | Cycle 1(1): loaded http://localhost:57187/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57187/tests/kraken/driver.html?testName=imaging-darkroom) 03:06:39 INFO - PID 1913 | RSS: Main: 333946880 03:06:39 INFO - PID 1913 | 03:06:42 INFO - PID 1913 | Cycle 1(1): loaded http://localhost:57187/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57187/tests/kraken/driver.html?testName=imaging-desaturate) 03:06:42 INFO - PID 1913 | RSS: Main: 347906048 03:06:42 INFO - PID 1913 | 03:06:45 INFO - PID 1913 | Cycle 1(1): loaded http://localhost:57187/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57187/tests/kraken/driver.html?testName=json-parse-financial) 03:06:46 INFO - PID 1913 | RSS: Main: 359215104 03:06:46 INFO - PID 1913 | 03:06:48 INFO - PID 1913 | Cycle 1(1): loaded http://localhost:57187/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57187/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:06:48 INFO - PID 1913 | RSS: Main: 307888128 03:06:48 INFO - PID 1913 | 03:06:50 INFO - PID 1913 | Cycle 1(1): loaded http://localhost:57187/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57187/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:06:51 INFO - PID 1913 | RSS: Main: 312963072 03:06:51 INFO - PID 1913 | 03:06:53 INFO - PID 1913 | Cycle 1(1): loaded http://localhost:57187/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57187/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:06:54 INFO - PID 1913 | RSS: Main: 315457536 03:06:54 INFO - PID 1913 | 03:06:57 INFO - PID 1913 | Cycle 1(1): loaded http://localhost:57187/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57187/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:06:57 INFO - PID 1913 | RSS: Main: 331890688 03:06:57 INFO - PID 1913 | 03:07:01 INFO - PID 1913 | Cycle 1(1): loaded http://localhost:57187/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57187/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:07:01 INFO - PID 1913 | RSS: Main: 325865472 03:07:01 INFO - PID 1913 | 03:07:03 INFO - PID 1913 | Cycle 1(1): loaded http://localhost:57187/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57187/tests/kraken/driver.html?testName=ai-astar) 03:07:03 INFO - PID 1913 | RSS: Main: 387145728 03:07:03 INFO - PID 1913 | 03:07:03 INFO - PID 1913 | __start_tp_report 03:07:03 INFO - PID 1913 | _x_x_mozilla_page_load 03:07:03 INFO - PID 1913 | _x_x_mozilla_page_load_details 03:07:03 INFO - PID 1913 | |i|pagename|runs| 03:07:03 INFO - PID 1913 | |0;ai-astar;110;111;109;111;111;109;111;111;111;109 03:07:03 INFO - PID 1913 | |1;audio-beat-detection;142;108;108;150;112;110;109;107;130;110 03:07:03 INFO - PID 1913 | |2;audio-dft;184;184;183;186;187;182;181;183;183;185 03:07:03 INFO - PID 1913 | |3;audio-fft;82;62;60;90;61;60;64;70;105;60 03:07:03 INFO - PID 1913 | |4;audio-oscillator;92;69;87;69;69;69;86;68;69;84 03:07:03 INFO - PID 1913 | |5;imaging-gaussian-blur;89;88;88;88;88;87;87;88;87;87 03:07:03 INFO - PID 1913 | |6;imaging-darkroom;95;94;94;94;93;93;95;95;95;96 03:07:03 INFO - PID 1913 | |7;imaging-desaturate;83;83;84;84;84;86;84;86;84;84 03:07:03 INFO - PID 1913 | |8;json-parse-financial;51;49;51;48;51;49;50;49;50;51 03:07:03 INFO - PID 1913 | |9;json-stringify-tinderbox;50;89;85;91;54;91;85;86;74;60 03:07:03 INFO - PID 1913 | |10;stanford-crypto-aes;83;84;83;84;83;83;82;83;80;83 03:07:03 INFO - PID 1913 | |11;stanford-crypto-ccm;139;140;135;135;137;141;142;142;190;186 03:07:03 INFO - PID 1913 | |12;stanford-crypto-pbkdf2;189;188;187;187;188;229;184;188;234;186 03:07:03 INFO - PID 1913 | |13;stanford-crypto-sha256-iterative;68;67;67;67;71;68;68;67;70;66 03:07:03 INFO - PID 1913 | __end_tp_report 03:07:03 INFO - PID 1913 | __start_cc_report 03:07:03 INFO - PID 1913 | _x_x_mozilla_cycle_collect,2214 03:07:03 INFO - PID 1913 | __end_cc_report 03:07:03 INFO - PID 1913 | __startTimestamp1492078023700__endTimestamp 03:07:03 INFO - PID 1913 | 03:07:03 INFO - PID 1913 | ------- Summary: start ------- 03:07:03 INFO - PID 1913 | Number of tests: 14 03:07:03 INFO - PID 1913 | 03:07:03 INFO - PID 1913 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:0.95 (0.9%) stddev-sans-first:1.00 03:07:03 INFO - PID 1913 | Values: 110.0 111.0 109.0 111.0 111.0 109.0 111.0 111.0 111.0 109.0 03:07:03 INFO - PID 1913 | 03:07:03 INFO - PID 1913 | [#1] audio-beat-detection Cycles:10 Average:118.60 Median:111.00 stddev:16.01 (14.4%) stddev-sans-first:14.57 03:07:03 INFO - PID 1913 | Values: 142.0 108.0 108.0 150.0 112.0 110.0 109.0 107.0 130.0 110.0 03:07:03 INFO - PID 1913 | 03:07:03 INFO - PID 1913 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.00 stddev:1.81 (1.0%) stddev-sans-first:1.92 03:07:03 INFO - PID 1913 | Values: 184.0 184.0 183.0 186.0 187.0 182.0 181.0 183.0 183.0 185.0 03:07:03 INFO - PID 1913 | 03:07:03 INFO - PID 1913 | [#3] audio-fft Cycles:10 Average:71.40 Median:63.00 stddev:15.74 (25.0%) stddev-sans-first:16.22 03:07:03 INFO - PID 1913 | Values: 82.0 62.0 60.0 90.0 61.0 60.0 64.0 70.0 105.0 60.0 03:07:03 INFO - PID 1913 | 03:07:03 INFO - PID 1913 | [#4] audio-oscillator Cycles:10 Average:76.20 Median:76.50 stddev:9.72 (12.7%) stddev-sans-first:8.46 03:07:03 INFO - PID 1913 | Values: 92.0 69.0 87.0 69.0 69.0 69.0 86.0 68.0 69.0 84.0 03:07:03 INFO - PID 1913 | 03:07:03 INFO - PID 1913 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:88.00 stddev:0.67 (0.8%) stddev-sans-first:0.53 03:07:03 INFO - PID 1913 | Values: 89.0 88.0 88.0 88.0 88.0 87.0 87.0 88.0 87.0 87.0 03:07:03 INFO - PID 1913 | 03:07:03 INFO - PID 1913 | [#6] imaging-darkroom Cycles:10 Average:94.40 Median:95.00 stddev:0.97 (1.0%) stddev-sans-first:1.00 03:07:03 INFO - PID 1913 | Values: 95.0 94.0 94.0 94.0 93.0 93.0 95.0 95.0 95.0 96.0 03:07:03 INFO - PID 1913 | 03:07:03 INFO - PID 1913 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:1.03 (1.2%) stddev-sans-first:1.00 03:07:03 INFO - PID 1913 | Values: 83.0 83.0 84.0 84.0 84.0 86.0 84.0 86.0 84.0 84.0 03:07:03 INFO - PID 1913 | 03:07:03 INFO - PID 1913 | [#8] json-parse-financial Cycles:10 Average:49.90 Median:50.50 stddev:1.10 (2.2%) stddev-sans-first:1.09 03:07:03 INFO - PID 1913 | Values: 51.0 49.0 51.0 48.0 51.0 49.0 50.0 49.0 50.0 51.0 03:07:03 INFO - PID 1913 | 03:07:03 INFO - PID 1913 | [#9] json-stringify-tinderbox Cycles:10 Average:76.50 Median:85.50 stddev:15.98 (18.7%) stddev-sans-first:13.78 03:07:03 INFO - PID 1913 | Values: 50.0 89.0 85.0 91.0 54.0 91.0 85.0 86.0 74.0 60.0 03:07:03 INFO - PID 1913 | 03:07:03 INFO - PID 1913 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:1.14 (1.4%) stddev-sans-first:1.20 03:07:03 INFO - PID 1913 | Values: 83.0 84.0 83.0 84.0 83.0 83.0 82.0 83.0 80.0 83.0 03:07:03 INFO - PID 1913 | 03:07:03 INFO - PID 1913 | [#11] stanford-crypto-ccm Cycles:10 Average:148.70 Median:141.50 stddev:20.89 (14.8%) stddev-sans-first:21.86 03:07:03 INFO - PID 1913 | Values: 139.0 140.0 135.0 135.0 137.0 141.0 142.0 142.0 190.0 186.0 03:07:03 INFO - PID 1913 | 03:07:03 INFO - PID 1913 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.00 Median:188.00 stddev:18.80 (10.0%) stddev-sans-first:19.77 03:07:03 INFO - PID 1913 | Values: 189.0 188.0 187.0 187.0 188.0 229.0 184.0 188.0 234.0 186.0 03:07:03 INFO - PID 1913 | 03:07:03 INFO - PID 1913 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.52 (2.2%) stddev-sans-first:1.62 03:07:03 INFO - PID 1913 | Values: 68.0 67.0 67.0 67.0 71.0 68.0 68.0 67.0 70.0 66.0 03:07:03 INFO - PID 1913 | -------- Summary: end -------- 03:07:03 INFO - PID 1913 | 03:07:04 INFO - TEST-INFO | 1913: exit 0 03:07:04 INFO - TEST-OK | kraken | took 61418ms 03:07:04 INFO - SUITE-END | took 1181s 03:07:04 INFO - Completed test suite (00:19:41) 03:07:04 INFO - javascript benchmark 03:07:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7754.565961977898, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3400.132966093646, 3434.879779207728, 3438.570178727659, 3459.3427248822723, 3511.1748739046334, 6062.484688801452, 6096.390360963901, 6119.571629985897, 6129.938700612993, 6140.105498721233, 6070.757169713217, 6102.145699602048, 6118.602290851091, 6127.662978536178, 6131.969340153293, 4838.854834354957, 5055.393352797661, 5222.895542089156, 5278.261043453919, 5397.325334333208, 5140.485951404867, 5280.392754833186, 5286.735663216843, 5392.1911713243135, 5392.703401312926, 5261.15821468567, 5266.526012658841, 5277.12927366984, 5288.735563221823, 5373.1402975524115, 5250.7112108834, 5294.073537130987, 5302.655327403706, 5329.280547126127, 5375.3280839895015, 5271.103912334912, 5301.151815709506, 5332.840014799563, 5333.706646134461, 5341.732913354317, 5941.9108713368905, 5982.252218472691, 5988.191594134823, 5996.820095397145, 6122.081687746829, 5344.946550534483, 6311.242650881878, 6326.240851097898, 6326.367363263683, 6328.145700330442, 5285.86785330366, 6371.362863713638, 6461.967690161566, 6511.08844761729, 6541.018847172914, 6155.10750941111, 6204.3795620437595, 6207.751689932443, 6223.471004964629, 6226.097215903714, 6394.136791533177, 6679.0315404267085, 6693.732250710014, 6694.866102678016, 6699.665016749143, 6308.873822523524, 6318.399752023551, 6335.303116657164, 6336.714847831859, 6341.397567231105, 6329.620222786648, 6346.841328966812, 6363.936360636427, 6398.9040164397575, 6502.122213501211, 6399.776007839703, 6412.39082287182, 6426.710798014101, 6427.839304017437, 6447.6131432114225, 6410.903836442457, 6412.070249813844, 6413.390727880844, 6426.839329016719, 6431.292557818636, 5088.643794934319, 5179.870503237374, 5252.474752524793, 5253.55344795689, 5299.788008479694, 4526.592606665416, 4593.63250939924, 4595.563421474954, 4617.215073437524, 4644.256918893028, 5196.9740151299, 6081.8479538011015, 6084.817455476343, 6091.662371644938, 6177.0, 5384.6769193848495, 6454.709538070798, 6493.448056915121, 6495.382938620824, 6507.674616269168, 6198.101275315054, 6208.627482351073, 6211.844703882349, 6217.440430361289, 6228.813135605939, 5580.86047848807, 5652.208690783294, 5705.600607957404, 5715.685637289989, 5724.74238659253, 6491.7078731457195, 6567.047778072153, 6630.801075967729, 6639.966800165968, 6677.098591690254, 6479.8056058318325, 6511.186101737283, 6516.804495865132, 6555.573887697285, 6565.573237739532, 6692.765753198614, 6707.228668702966, 6708.6981085850275, 6719.025741267586, 6721.899171512529, 6239.407256310643, 6341.968290158519, 6342.39747224013, 6346.524010699124, 6356.745730170926, 6233.470155036873, 6344.841378965562, 6352.714127864165, 6382.393672601095, 6439.581427207217, 5280.891012887183, 5747.109198074305, 6098.878022439615, 6272.153259309935, 6334.0, 5890.352061273171, 6331.335209803088, 6338.968305158444, 6339.175907132043, 6348.523860710373, 6102.307478454246, 6159.9836027055035, 6179.227596550431, 6296.0, 6303.275123360872, 6253.687315634109, 6255.96872015637, 6277.435030847246, 6290.961991271389, 6316.842078948063, 6224.906626400698, 6243.719032643451, 6263.96868015657, 6291.1192433058495, 6291.685415729104], "value": 5899.591235702449, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [798.4570492065396, 812.2446125103653, 1039.1998161415715, 1145.5532342386466, 1158.2934410009898, 31657.0, 35041.77353792614, 35797.46303805442, 36384.09039774007, 36715.0, 38449.61550384502, 38590.0, 38591.80704096483, 38612.0, 38714.22571548567, 6155.969220153893, 8553.230209281179, 8749.0, 8749.431286966359, 8753.693620723276, 6200.410960958701, 8414.621342039623, 8602.741917742478, 8607.526586037766, 8617.439866408695, 8665.17680820321, 8701.69474578815, 8704.216620504154, 8712.564371781416, 8724.345674074439, 8603.655853765842, 8670.479771213748, 8673.306135509145, 8681.17528834766, 8690.130986901322, 8497.065322814486, 8550.61522231495, 8564.571771411467, 8573.571321433903, 8576.442531235512, 36929.630703692885, 37131.0, 37155.0, 37212.81393593042, 37227.0, 3621.963780362189, 3676.3015027145025, 3682.3371793077235, 3684.9815750921343, 3685.1708365617787, 30383.69616303831, 30477.0, 30497.695023049706, 30512.84743576268, 30522.694773052208, 2864.5559938209612, 2881.6109825173544, 2890.1474065150833, 2896.6379202599674, 2910.0687779910436, 223637.0, 287613.0, 288861.0, 289012.0, 289542.9999999979, 38395.84812455631, 39435.0, 47471.76264118657, 47581.0, 47660.0, 40525.594744052185, 48736.53790386294, 49409.50590494121, 49702.0, 49824.50175498271, 14443.205623690797, 14577.125372477685, 14577.635559110895, 14579.635509112357, 14595.905307101797, 11891.524339026515, 11904.940475297568, 11911.761764764657, 11921.105917056255, 11937.925586697065, 10708.929107089229, 12041.458134383798, 12097.697557560956, 12139.0, 12170.0, 5609.298837645294, 5643.604947653625, 5662.801801936913, 5666.291713535808, 5678.176664383724, 928.9581968811284, 972.3290929258789, 1009.9143420822645, 1016.7051555048953, 1069.401135364183, 22163.44591385196, 23985.760142398703, 24016.0, 24080.638790418157, 24130.396740081287, 1001.1840350114634, 1099.2689861242184, 1141.7545227775902, 1143.1369316166242, 1145.7765735681462, 12236.082293827998, 12335.753284934251, 12353.567625133077, 12395.62813115608, 12404.25574465535, 356312.0, 356365.0, 356522.0, 356628.0, 357020.0, 47898.5210147894, 48008.5199148011, 48019.27971080437, 48032.5196748035, 48089.75955120202, 1534.6136757342217, 1541.5452441529776, 1582.374961890047, 1584.4612831637298, 1587.0715631355556, 22280.442988925406, 23537.88231058834, 23597.764022360243, 23642.408939776644, 23799.524009519366, 37326.813365933, 37369.813150934075, 37375.813120934225, 37443.81278093592, 37521.43717844289, 317893.0, 319476.0, 319665.0, 319827.0, 319833.4008329943, 29131.271718207216, 29643.85178074096, 29963.85018074983, 33877.83061084679, 34055.31889362248, 41444.37833432441, 42298.36552451654, 42326.788366057976, 42388.78805605952, 42534.93662658458, 21203.89398053, 27801.165965021082, 28922.132336029954, 29342.55986160252, 29814.70185298206, 28589.28526786847, 29341.26646833846, 29515.262118447212, 29530.852345738134, 29611.40777184487, 34125.82937085398, 34791.65208347985, 34851.65148348484, 34863.77976770801, 34881.47677784784, 28831.711682883742, 29253.976110836018, 29752.851235744547, 30000.849995749883, 30112.54831177578, 20565.97170141457, 20921.476963076046, 21036.26373076935, 23321.0, 23427.297181084596], "value": 17143.66429771126, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.2612790340329, 429.76148237728046, 436.87330674104504, 440.223006393715, 458.70184380152915, 20021.399358019247, 21417.464563385904, 22009.559808803853, 22201.555968880613, 22284.442888927784, 21779.782202177972, 22733.0, 23423.4144146396, 23424.5315093698, 23656.88171559144, 6057.878842423149, 6094.66479343637, 6331.873362532747, 6335.714892829834, 6351.777687780928, 6141.416565426277, 6354.586951848139, 6365.2998170201245, 6377.362263773632, 6383.2340119185765, 6074.787382441594, 6257.780977665782, 6319.241690997063, 6336.398042185985, 6340.365963403646, 6344.873102537969, 6392.6484043377595, 6401.455876250524, 6402.583832050948, 6414.615123092606, 4881.194602890519, 5550.555955523549, 5622.803201887914, 5695.943040569583, 5697.1739097831, 27591.86204068967, 27629.585556216472, 27632.86183569069, 27679.169624911287, 28017.0, 2252.6170551006367, 2338.088145623208, 2340.1107579119994, 2340.719113706366, 2342.1334106380577, 17819.10904454785, 17914.83553569027, 18078.186481608358, 18144.0, 18527.907360463112, 2125.7130287411155, 2177.6733489976473, 2199.2522542335682, 2203.6914831923546, 2205.5809396214827, 148328.0, 162099.0, 171562.0, 171951.0, 173645.13177434032, 10924.836127458095, 12548.749025019448, 12686.873131268754, 12709.237445753284, 12936.606727755396, 17057.573560660836, 17069.829301707072, 17077.316907323817, 17079.573010674583, 17132.657346852993, 8831.867521987175, 9104.8634270486, 9152.90847091534, 9294.86057709135, 9316.487593182304, 8741.082186370466, 8778.034416214212, 8785.989611194795, 8950.104989500998, 8950.314905528316, 6878.828029299208, 7455.589942553212, 7881.921180788233, 7941.64262608184, 7952.045754509496, 2010.3767831972136, 2095.0991073838395, 2118.248021952185, 2119.9894000530207, 2121.2363549122306, 959.1271942532262, 959.7984423271051, 965.99034009659, 995.6415690351467, 1011.4487604255698, 21208.0, 21526.89236553807, 21618.89190554037, 21734.782652173275, 21735.45661358447, 986.9062439068421, 995.4326034160459, 1008.4705529596873, 1021.8160731068479, 1025.6717850287985, 10639.946800265949, 11340.546378144947, 11383.430828458544, 11403.828942565868, 11423.371714555778, 702859.0, 703137.0, 715520.0, 722419.0, 728638.0, 152203.0, 165596.0, 166350.1682491604, 169808.0, 172170.0, 1019.887812340642, 1026.4970164619283, 1242.577523641966, 1243.7325974915257, 1244.5892855357529, 18989.050547472296, 22234.332970010924, 22458.550828983654, 22507.21224757191, 22757.544849102593, 64526.354736452035, 65010.02484962824, 65193.67403162954, 65333.0, 66529.0, 93097.53451232701, 93188.0, 93263.0, 93686.0, 95504.0, 9014.504202268938, 9058.592363343534, 9150.816983660423, 9218.631254750004, 9244.306676999118, 14119.647008824451, 14139.505117320845, 14389.926053155998, 14600.196989165697, 14655.706885862437, 10210.132138768287, 11634.592789252336, 11726.775136837437, 11822.054235661299, 11940.761184776082, 10223.795524089328, 10675.786484270426, 11240.662780116609, 11487.597934072268, 11778.46996885125, 10599.62901298451, 11567.305961642329, 11569.595064172714, 11672.241304315192, 11936.940315298369, 8802.955985220033, 9005.909940900507, 9187.18441395958, 9322.766930826783, 9367.156955874005, 11123.234436887997, 11641.417929103342, 11665.88334116648, 11866.347350895438, 12077.879221207675], "value": 10857.363822618443, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1198.7242934125156, 1391.2348208485332, 1462.327329428463, 1467.911925284483, 1486.7249558831625, 9832.164266037387, 11164.888351116486, 11828.053755699544, 11844.881551184486, 11891.940540297308, 11483.540658373677, 11720.179587428884, 11728.941355293211, 11736.7652646947, 11746.823797643021, 2138.7326584176976, 2505.649209110717, 2524.0408644714985, 2524.8737563121863, 2526.355779276282, 2104.8947552622385, 2200.0, 2200.8129309008755, 2201.7798220178015, 2203.0857194264363, 2382.642603609464, 2476.5913624251975, 2477.690288713911, 2482.2056941778637, 2485.2792690119845, 1977.9406617801417, 2457.4225057111744, 2476.1457297232428, 2480.5162993216422, 2484.24230609664, 2460.9753902460925, 2473.6660550825586, 2491.5141547398266, 2500.9374765630823, 2503.4742704032174, 11631.418429078512, 11637.185397022211, 11761.235519691192, 11765.352905590189, 11765.882341176564, 5438.265834112423, 6458.257300410466, 6702.463802895757, 6719.899201511981, 6726.697298621574, 3855.730098893079, 4078.145298291208, 4101.200265948141, 4179.498460184797, 4183.226103170893, 1101.2016288190998, 1105.6351404036648, 1128.9040431563326, 1229.4037391864938, 1275.2794671010943, 16250.674986500322, 16633.417830375878, 16636.417725379673, 16646.50544353018, 16660.75008874868, 5808.448197421239, 5875.588708790344, 5946.256717910262, 5958.2850057992455, 6052.243469566304, 13593.932030339984, 13598.864011359958, 13600.727985440235, 13603.183808971295, 13605.591832245049, 6745.898811517831, 6756.662166891734, 6761.647670465828, 6762.830929226809, 6768.69540870662, 5998.1602575639445, 6119.204503414617, 6194.969025154845, 6214.161088253028, 6222.502199824004, 4164.208800327989, 4300.0, 4529.682922195415, 4662.323963025342, 4738.881527961828, 1300.3602686546326, 1328.873756993084, 1330.554264321463, 1330.9068365214537, 1332.2339654698394, 701.6877489517218, 752.913414957276, 781.675604624086, 786.6538722961878, 818.4720855048579, 5921.881562368729, 6127.952854217685, 6228.875422491616, 6279.686015699197, 6398.952335252768, 922.561783152997, 923.9953800230955, 924.1451657217048, 944.951104274255, 947.3415975896686, 4468.642508599304, 4542.273236282179, 4608.907821843544, 4616.169089563844, 4738.905221895543, 14696.926515367355, 15289.082655040733, 15300.846991529943, 15321.23393830304, 15326.00380975233, 14872.553823385315, 15008.62478438026, 15405.537833865003, 15446.922765386102, 15454.768178477332, 10738.78522429547, 11033.448327583588, 11046.779064418828, 11066.114710823114, 11078.889211107786, 6401.391867772554, 6438.645874476949, 6939.826504337432, 7145.356917877416, 7181.784546463615, 13280.136791108547, 13413.530526431528, 13563.79654305206, 13592.320383980563, 13639.38622761998, 13718.588442346745, 13763.79354309666, 13811.309434528433, 13960.371783269575, 14015.229162396166, 9516.333856630246, 9719.514024298898, 9725.221982241545, 9728.610855565697, 9745.805083898424, 10532.157427405942, 10967.177461690246, 11036.779264414507, 11062.612808551663, 11082.335059896432, 7263.34629883313, 8408.159184081544, 9091.54542272897, 9278.536073196448, 9395.765105872408, 8962.283017358464, 9036.0, 9110.772230694285, 9121.726348209564, 9299.76750581241, 8185.017797864056, 8226.835463290821, 8283.83432331362, 8303.501789892625, 8323.791905202419, 5938.881222375615, 5976.551758618208, 6049.758009679564, 6083.482903953213, 6124.14262003311, 5405.675659460445, 5628.662280263197, 6106.175666285172, 6215.34738852414, 6269.868244796791], "value": 5426.953589978151, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.3145697347146, 389.9044734040161, 390.05022769556126, 399.88203479973424, 401.24365570898846, 4626.907461850761, 5586.608937374385, 5611.148321054053, 5626.634268772537, 5708.543316534678, 4421.425214722081, 5233.267342572043, 5366.0, 5514.5864060195545, 5588.804391846286, 4062.8420900043493, 4310.267254566716, 4316.589923957219, 4319.2441322768545, 4327.307630779061, 3954.5056867891512, 4179.226843034034, 4319.6393136162005, 4338.544452832439, 4366.956330436687, 3785.977785997779, 4078.653314468274, 4306.35404689296, 4311.525732169474, 4319.784010799463, 3654.177809992757, 4023.8189281482405, 4171.520275168364, 4287.6141147296585, 4302.2471067563365, 3351.6480769519094, 3635.054885729703, 3823.254465379252, 3825.464434979105, 3832.7508711933633, 5306.442823503554, 5485.75314110862, 5515.7242137893345, 5519.454552725203, 5584.944150558483, 4286.249906266391, 4725.385699859031, 5121.308623335876, 5170.793168273264, 5170.922436163461, 5977.671228082454, 5990.820275391745, 6004.5796794224425, 6006.519478441714, 6040.456358927674, 3888.941665875014, 4370.672199585012, 4371.038371558252, 4371.825126994916, 4378.868633940987, 6064.727087281083, 6236.532260080467, 6283.0, 6289.433950944345, 6397.744090236385, 4136.6483848872585, 4174.3947127666315, 4199.748015119041, 4218.924174335525, 4219.43037689914, 4124.257633625976, 4249.794002347162, 4288.863451185376, 4292.055747735493, 4307.483102027777, 4692.7653617319, 4757.14371413142, 4815.15734746418, 4958.752062396866, 4970.90058198834, 5984.3417224105315, 6024.367441418675, 6025.0359942409, 6033.81975449214, 6037.366076561985, 1292.7866901961072, 1427.3719563392074, 1455.1269238457053, 1455.2650911289732, 1459.058907004976, 918.4397517514444, 932.9393589416666, 968.099667309409, 973.6202880876464, 974.8635191073255, 5709.286339207599, 5710.71446427677, 5714.428557144252, 5716.199397189955, 5732.42041081515, 5437.374701909252, 6178.66017369049, 6192.225971753531, 6255.718492667841, 6259.499240060784, 4991.801967527767, 5416.702081385482, 5694.430556944272, 5719.542436605062, 5721.914171287434, 2656.6413534173025, 2975.1966968918273, 3244.12408649668, 3248.2204270975267, 3280.5243239730107, 6059.394060593905, 6108.236470441195, 6309.211348581427, 6382.648954307465, 6416.326285740023, 4854.077725232195, 5979.910301345483, 6207.227278630827, 6311.2644022893155, 6332.873342533124, 6002.8499287516415, 6353.3329000455215, 6396.232452105684, 6409.807705768834, 6456.0, 5361.276227709365, 6142.508599311955, 6182.783602573888, 6192.266165473675, 6222.782202622887, 5688.0, 5893.410658934073, 6095.664738439428, 6108.541859360477, 6117.0, 4583.358329833893, 4994.001199760135, 5994.9508835952665, 6347.619142851444, 6432.195975503062, 4159.584041595937, 4179.9582004179565, 4195.77623859355, 4196.622303992655, 4200.94976255936, 5255.605829562722, 5316.401312864422, 6039.698015099315, 6217.098520714561, 6274.749010039547, 5020.673656212334, 5063.87340316495, 6028.728707208274, 6036.9094463582205, 6080.179175811209, 5274.630775845654, 5737.971310143589, 5823.912641310299, 5995.340512543704, 6167.537434692326, 5231.979763945994, 5287.9471205287455, 5716.799912003226, 5821.825345239649, 5946.405359464019, 5102.540771330598, 6001.879962400815, 6017.819465416044, 6026.246719160105, 6027.57806953509, 5164.896702066013, 5865.912011319749, 5887.793927212527, 5910.70446477683, 5944.900193464223], "value": 4411.193470551553, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.9857202855947, 863.9352048596355, 873.3188113271647, 882.1002577371082, 893.0667452512124, 13376.66558336042, 13519.594412167626, 13534.72930541391, 13698.315084245785, 13716.588502344921, 13237.735245295113, 16840.410585629506, 17260.136993150354, 17336.306547738106, 17338.913305433456, 733.9192688804214, 991.2565575818137, 991.2565575818137, 992.4392718114278, 994.9801453510138, 1015.1371334365804, 1017.4149863828292, 1018.5721996761378, 1018.6078359831445, 1021.0759262867117, 727.6943683652878, 742.7697413801711, 1019.11846252991, 1064.9989010330303, 1075.2419544221304, 1060.6128763001525, 1061.3737894642197, 1062.596213438896, 1064.0795711709354, 1066.2589500297297, 791.8693415586421, 792.2948575767572, 794.4875555266879, 794.6900708723603, 797.2227078598378, 16050.919745401316, 16422.014679119293, 16539.751903721455, 16584.1707914605, 16740.748888766677, 14160.15039097647, 14510.0, 14516.637084072983, 16783.748243776354, 17175.398861039805, 13637.113587616774, 13896.374663140083, 14036.929815350857, 14063.01558890878, 14266.785998210034, 3544.379733546619, 3568.286342731464, 3568.50040994261, 3571.2678900825267, 3571.5535558055244, 107493.3875991853, 110914.0, 112246.87753122445, 112805.97552195887, 113391.43304283425, 11314.830277545843, 13605.115667481581, 13895.58313250604, 13924.025318227626, 13965.301734913417, 16909.7463538047, 20569.280075197297, 25762.227133186036, 25792.61311080335, 25839.224823255332, 8314.251717345347, 8684.044755076937, 8840.381173317806, 8843.0, 8860.64557417709, 4818.301346304836, 4908.950910490849, 4911.901761964741, 4912.582430493377, 4917.926231106536, 4250.36244563318, 4269.679774016961, 4383.517813040563, 4390.143921935192, 4400.0, 927.7216834949488, 957.363353370015, 962.485070487286, 964.238251781099, 967.032967032967, 607.2166904692984, 674.369464550637, 682.8668409660168, 687.6458623808743, 709.2340272505681, 10708.464576771286, 11722.824157637642, 11867.643970680721, 11948.283103013848, 11976.101792365607, 649.4479692261634, 650.9511786615928, 654.4927681047132, 668.7893313606296, 686.4782765098461, 4892.633052521075, 5394.406615272317, 5398.028354896078, 5427.240186373911, 5549.916751248735, 100738.496307518, 103817.0, 104294.0, 104499.0, 105809.47095264628, 93342.0, 93521.5323923376, 96835.51582242185, 97501.02498975061, 97695.02304977001, 62363.0, 77974.44051118946, 78403.60798196087, 79514.01214969557, 80181.59909200533, 10236.0, 12221.266723996589, 12627.431765570387, 12709.04682148824, 12783.552575659807, 38690.6130938687, 39073.023174420865, 40148.0, 41054.79472602618, 42246.57753422426, 53001.4699853012, 53099.0, 53449.73275133599, 53684.73157634187, 54526.0, 15806.0, 15806.76289855676, 15972.0, 16168.757468637745, 16220.67558648844, 17896.0, 18057.54856128555, 18314.084295785426, 18336.266549337877, 18342.331533693046, 16255.67488650244, 16306.510804675878, 16390.918045409697, 16555.834441655912, 16640.583985400463, 16017.958832676304, 16225.756613650568, 16293.42972995987, 16323.510294691177, 16488.505344839676, 13302.534411295559, 15687.058776473448, 16428.342866285213, 16492.42276520316, 16575.25411356468, 10506.317089389166, 11162.49768760424, 11500.769984600429, 11649.0, 11727.88272117302, 12212.90083892454, 12596.244225346509, 13518.256495892427, 13706.931465343008, 14082.366293517021], "value": 8270.826134921093, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1448.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 109.0, 111.0, 111.0, 109.0, 111.0, 111.0, 111.0, 109.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 108.0, 108.0, 150.0, 112.0, 110.0, 109.0, 107.0, 130.0, 110.0], "value": 118.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 183.0, 186.0, 187.0, 182.0, 181.0, 183.0, 183.0, 185.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 62.0, 60.0, 90.0, 61.0, 60.0, 64.0, 70.0, 105.0, 60.0], "value": 71.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 69.0, 87.0, 69.0, 69.0, 69.0, 86.0, 68.0, 69.0, 84.0], "value": 76.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 88.0, 88.0, 88.0, 87.0, 87.0, 88.0, 87.0, 87.0], "value": 87.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 93.0, 93.0, 95.0, 95.0, 95.0, 96.0], "value": 94.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 84.0, 84.0, 84.0, 86.0, 84.0, 86.0, 84.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 51.0, 48.0, 51.0, 49.0, 50.0, 49.0, 50.0, 51.0], "value": 49.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 89.0, 85.0, 91.0, 54.0, 91.0, 85.0, 86.0, 74.0, 60.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 83.0, 84.0, 83.0, 83.0, 82.0, 83.0, 80.0, 83.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 140.0, 135.0, 135.0, 137.0, 141.0, 142.0, 142.0, 190.0, 186.0], "value": 148.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 188.0, 187.0, 187.0, 188.0, 229.0, 184.0, 188.0, 234.0, 186.0], "value": 196.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 67.0, 71.0, 68.0, 68.0, 67.0, 70.0, 66.0], "value": 67.9, "unit": "score"}]}]} 03:07:04 INFO - Return code: 0 03:07:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:07:05 ERROR - # TBPL SUCCESS # 03:07:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:07:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:07:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:07:05 INFO - 2017-04-13 03:07:05.043 screenresolution[1917:20511] starting screenresolution argv=screenresolution get 03:07:05 INFO - 2017-04-13 03:07:05.046 screenresolution[1917:20511] Display 0: 1600x1200x32@60 03:07:05 INFO - 2017-04-13 03:07:05.051 screenresolution[1918:20514] starting screenresolution argv=screenresolution list 03:07:05 INFO - Available Modes on Display 0 03:07:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:07:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:07:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:07:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:07:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:07:05 INFO - Intel Iris: 03:07:05 INFO - Chipset Model: Intel Iris 03:07:05 INFO - Type: GPU 03:07:05 INFO - Bus: Built-In 03:07:05 INFO - VRAM (Dynamic, Max): 1536 MB 03:07:05 INFO - Vendor: Intel (0x8086) 03:07:05 INFO - Device ID: 0x0a2e 03:07:05 INFO - Revision ID: 0x0009 03:07:05 INFO - Displays: 03:07:05 INFO - Display: 03:07:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:07:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:07:05 INFO - Display Serial Number: 1600x1200 60 03:07:05 INFO - Main Display: Yes 03:07:05 INFO - Mirror: Off 03:07:05 INFO - Online: Yes 03:07:05 INFO - Rotation: Supported 03:07:05 INFO - Return code: 0 03:07:05 INFO - Running post-action listener: _resource_record_post_action 03:07:05 INFO - [mozharness: 2017-04-13 10:07:05.304313Z] Finished run-tests step (success) 03:07:05 INFO - Running post-run listener: _resource_record_post_run 03:07:05 INFO - Total resource usage - Wall time: 1202s; CPU: 53.0%; Read bytes: 2838528; Write bytes: 520816640; Read time: 12; Write time: 2042 03:07:05 INFO - TinderboxPrint: CPU usage
53.3% 03:07:05 INFO - TinderboxPrint: I/O read bytes / time
2,838,528 / 12 03:07:05 INFO - TinderboxPrint: I/O write bytes / time
520,816,640 / 2,042 03:07:05 INFO - TinderboxPrint: CPU idle
2,247.9 (46.7%) 03:07:05 INFO - TinderboxPrint: CPU system
956.1 (19.9%) 03:07:05 INFO - TinderboxPrint: CPU user
1,605.6 (33.4%) 03:07:05 INFO - TinderboxPrint: Swap in / out
211,111,936 / 0 03:07:05 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207294976; Write bytes: 202964992; Read time: 16277; Write time: 434 03:07:05 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 2838528; Write bytes: 306987008; Read time: 12; Write time: 1448 03:07:05 INFO - Running post-run listener: _upload_blobber_files 03:07:05 INFO - Blob upload gear active. 03:07:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:07:05 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 03:07:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:07:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:07:06 INFO - (blobuploader) - INFO - Open directory for files ... 03:07:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:07:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:07:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:07:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:07:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:07:07 INFO - (blobuploader) - INFO - Done attempting. 03:07:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:07:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:07:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:07:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:07:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:07:08 INFO - (blobuploader) - INFO - Done attempting. 03:07:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:07:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:07:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:07:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:07:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:07:09 INFO - (blobuploader) - INFO - Done attempting. 03:07:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:07:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:07:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:07:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:07:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:07:11 INFO - (blobuploader) - INFO - Done attempting. 03:07:11 INFO - (blobuploader) - INFO - Iteration through files over. 03:07:11 INFO - Return code: 0 03:07:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:07:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:07:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2ba64f30fb75efd083ed19587f0d947387356e27f7b7dcfd102f1448191b10fed5be1776d1a8358653447941921e90ef09960e7616e521b570c5c67cd3c5394", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/019fe4a2409796859907433b9767c577c4cd8adb436e2d1faa27c265c42876a2561dd4ed7d6f18018975d9bd609e2b73877d40ad1a709f7d1f75821680c3cfff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d52d732933b9b0e4e3d9bbeb07712a3c9cb35ee94344708517e137566473c5e64328d9ae28de632354bedbfd2244efb79c912c3fa03015132fc68e8a9299765", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9ee812e3e34ef184259362abff553039d95651b89862b771de0795f5aadea0962f1d74962f8c75e1de48e3d240a6cce6a309ff84ab9a7ae9323f7d32bae567b"} 03:07:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:07:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:07:11 INFO - Contents: 03:07:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2ba64f30fb75efd083ed19587f0d947387356e27f7b7dcfd102f1448191b10fed5be1776d1a8358653447941921e90ef09960e7616e521b570c5c67cd3c5394", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/019fe4a2409796859907433b9767c577c4cd8adb436e2d1faa27c265c42876a2561dd4ed7d6f18018975d9bd609e2b73877d40ad1a709f7d1f75821680c3cfff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d52d732933b9b0e4e3d9bbeb07712a3c9cb35ee94344708517e137566473c5e64328d9ae28de632354bedbfd2244efb79c912c3fa03015132fc68e8a9299765", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9ee812e3e34ef184259362abff553039d95651b89862b771de0795f5aadea0962f1d74962f8c75e1de48e3d240a6cce6a309ff84ab9a7ae9323f7d32bae567b"} 03:07:11 INFO - Running post-run listener: copy_logs_to_upload_dir 03:07:11 INFO - Copying logs to upload dir... 03:07:11 INFO - mkdir: /builds/slave/test/build/upload/logs 03:07:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.401519 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-04-13 03:07:11.754573) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-13 03:07:11.757788) ========= 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.olHTfXeKxr/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.feSj2efi9h/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2ba64f30fb75efd083ed19587f0d947387356e27f7b7dcfd102f1448191b10fed5be1776d1a8358653447941921e90ef09960e7616e521b570c5c67cd3c5394", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/019fe4a2409796859907433b9767c577c4cd8adb436e2d1faa27c265c42876a2561dd4ed7d6f18018975d9bd609e2b73877d40ad1a709f7d1f75821680c3cfff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d52d732933b9b0e4e3d9bbeb07712a3c9cb35ee94344708517e137566473c5e64328d9ae28de632354bedbfd2244efb79c912c3fa03015132fc68e8a9299765", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9ee812e3e34ef184259362abff553039d95651b89862b771de0795f5aadea0962f1d74962f8c75e1de48e3d240a6cce6a309ff84ab9a7ae9323f7d32bae567b"} build_url:https://queue.taskcluster.net/v1/task/AYTCeNvtRAKmmurEonYcaw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010877 build_url: 'https://queue.taskcluster.net/v1/task/AYTCeNvtRAKmmurEonYcaw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2ba64f30fb75efd083ed19587f0d947387356e27f7b7dcfd102f1448191b10fed5be1776d1a8358653447941921e90ef09960e7616e521b570c5c67cd3c5394", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/019fe4a2409796859907433b9767c577c4cd8adb436e2d1faa27c265c42876a2561dd4ed7d6f18018975d9bd609e2b73877d40ad1a709f7d1f75821680c3cfff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d52d732933b9b0e4e3d9bbeb07712a3c9cb35ee94344708517e137566473c5e64328d9ae28de632354bedbfd2244efb79c912c3fa03015132fc68e8a9299765", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9ee812e3e34ef184259362abff553039d95651b89862b771de0795f5aadea0962f1d74962f8c75e1de48e3d240a6cce6a309ff84ab9a7ae9323f7d32bae567b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-13 03:07:11.791325) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 03:07:11.791662) ========= 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.olHTfXeKxr/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.feSj2efi9h/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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.005245 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 03:07:11.840267) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-13 03:07:11.840593) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-13 03:07:11.840905) ========= ========= Total master_lag: 0.18 =========