builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0008 starttime: 1491565302.76 results: success (0) buildid: 20170407030233 builduid: b4a97fc9b11b4429acc014da5a036589 revision: 10ea10d9993c9701e5525928257a589dea2c05d8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-07 04:41:42.762295) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-07 04:41:42.762738) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-07 04:41:42.763011) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-07 04:41:42.789639) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 04:41:42.790022) ========= 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.fS9m2vcJHL/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.jl4NZQiwMN/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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-07 04:41:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 11.2M=0.001s 2017-04-07 04:41:42 (11.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136588 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 04:41:42.951389) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 04:41:42.951732) ========= 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.fS9m2vcJHL/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.jl4NZQiwMN/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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.028705 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 04:41:43.002184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-07 04:41:43.002537) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 10ea10d9993c9701e5525928257a589dea2c05d8 --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 10ea10d9993c9701e5525928257a589dea2c05d8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fS9m2vcJHL/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.jl4NZQiwMN/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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-07 04:41:43,113 truncating revision to first 12 chars 2017-04-07 04:41:43,113 Setting DEBUG logging. 2017-04-07 04:41:43,113 attempt 1/10 2017-04-07 04:41:43,113 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/10ea10d9993c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-07 04:41:44,695 unpacking tar archive at: mozilla-central-10ea10d9993c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.852411 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-07 04:41:44.879924) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-07 04:41:44.880430) ========= script_repo_revision: 10ea10d9993c9701e5525928257a589dea2c05d8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-07 04:41:44.881011) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-07 04:41:44.881446) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-07 04:41:44.902590) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2017-04-07 04:41:44.903169) ========= /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.fS9m2vcJHL/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.jl4NZQiwMN/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:41:45 INFO - MultiFileLogger online at 20170407 04:41:45 in /builds/slave/test 04:41: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 04:41:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:41:45 INFO - {'append_to_log': False, 04:41:45 INFO - 'base_work_dir': '/builds/slave/test', 04:41:45 INFO - 'blob_upload_branch': 'Firefox', 04:41:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:41:45 INFO - 'branch': 'Firefox', 04:41:45 INFO - 'buildbot_json_path': 'buildprops.json', 04:41:45 INFO - 'config_files': ('talos/mac_config.py',), 04:41:45 INFO - 'default_actions': ('clobber', 04:41:45 INFO - 'read-buildbot-config', 04:41:45 INFO - 'download-and-extract', 04:41:45 INFO - 'populate-webroot', 04:41:45 INFO - 'create-virtualenv', 04:41:45 INFO - 'install', 04:41:45 INFO - 'run-tests'), 04:41:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:41:45 INFO - 'download_minidump_stackwalk': True, 04:41:45 INFO - 'download_symbols': 'ondemand', 04:41:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:41:45 INFO - 'tooltool.py': '/tools/tooltool.py', 04:41:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:41:45 INFO - '/tools/misc-python/virtualenv.py')}, 04:41:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:41:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:41:45 INFO - 'gecko_profile': False, 04:41:45 INFO - 'gecko_profile_interval': 0, 04:41:45 INFO - 'installer_path': 'installer.exe', 04:41:45 INFO - 'log_level': 'info', 04:41:45 INFO - 'log_name': 'talos', 04:41:45 INFO - 'log_to_console': True, 04:41:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:41:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:41:45 INFO - 'opt_config_files': (), 04:41:45 INFO - 'pip_index': False, 04:41:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:41:45 INFO - 'cmd': ('bash', 04:41:45 INFO - '-c', 04:41:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:41:45 INFO - 'enabled': True, 04:41:45 INFO - 'halt_on_failure': False, 04:41:45 INFO - 'name': 'check_screen_resolution'},), 04:41:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:41:45 INFO - 'cmd': ('bash', 04:41:45 INFO - '-c', 04:41:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:41:45 INFO - 'enabled': True, 04:41:45 INFO - 'halt_on_failure': False, 04:41:45 INFO - 'name': 'check_screen_resolution'},), 04:41:45 INFO - 'run_cmd_checks_enabled': True, 04:41:45 INFO - 'suite': 'dromaeojs', 04:41:45 INFO - 'system_bits': '32', 04:41:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:41:45 INFO - 'title': 't-yosemite-r7-0008', 04:41:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:41:45 INFO - 'use_talos_json': True, 04:41:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:41:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:41:45 INFO - 'work_dir': 'build'} 04:41:45 INFO - [mozharness: 2017-04-07 11:41:45.132205Z] Running clobber step. 04:41:45 INFO - Running pre-action listener: _resource_record_pre_action 04:41:45 INFO - Running main action method: clobber 04:41:45 INFO - rmtree: /builds/slave/test/build 04:41:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:41:47 INFO - Running post-action listener: _resource_record_post_action 04:41:47 INFO - [mozharness: 2017-04-07 11:41:47.751394Z] Finished clobber step (success) 04:41:47 INFO - [mozharness: 2017-04-07 11:41:47.751543Z] Running read-buildbot-config step. 04:41:47 INFO - Running pre-action listener: _resource_record_pre_action 04:41:47 INFO - Running main action method: read_buildbot_config 04:41:47 INFO - Using buildbot properties: 04:41:47 INFO - { 04:41:47 INFO - "project": "", 04:41:47 INFO - "product": "firefox", 04:41:47 INFO - "script_repo_revision": "production", 04:41:47 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:41:47 INFO - "repository": "", 04:41:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:41:47 INFO - "buildid": "20170407030233", 04:41:47 INFO - "stage_platform": "macosx64", 04:41:47 INFO - "basedir": "/builds/slave/test", 04:41:47 INFO - "nightly_build": "True", 04:41:47 INFO - "buildnumber": 94, 04:41:47 INFO - "slavename": "t-yosemite-r7-0008", 04:41:47 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:41:47 INFO - "platform": "yosemite_r7", 04:41:47 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:41:47 INFO - "branch": "mozilla-central", 04:41:47 INFO - "repo_path": "mozilla-central", 04:41:47 INFO - "revision": "10ea10d9993c9701e5525928257a589dea2c05d8", 04:41:47 INFO - "pgo_build": "False", 04:41:47 INFO - "builduid": "b4a97fc9b11b4429acc014da5a036589", 04:41:47 INFO - "slavebuilddir": "test" 04:41:47 INFO - } 04:41:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:41:47 INFO - Running post-action listener: _resource_record_post_action 04:41:47 INFO - [mozharness: 2017-04-07 11:41:47.755255Z] Finished read-buildbot-config step (success) 04:41:47 INFO - [mozharness: 2017-04-07 11:41:47.755393Z] Running download-and-extract step. 04:41:47 INFO - Running pre-action listener: _resource_record_pre_action 04:41:47 INFO - Running main action method: download_and_extract 04:41:47 INFO - mkdir: /builds/slave/test/build/tests 04:41:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:47 INFO - trying https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:41:47 INFO - Downloading https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/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 04:41:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/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 04:41:49 INFO - Downloaded 1325 bytes. 04:41:49 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:41:49 INFO - Using the following test package requirements: 04:41:49 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:41:49 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:41:49 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:41:49 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:41:49 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:41:49 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:41:49 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:41:49 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:41:49 INFO - u'jsshell-mac.zip'], 04:41:49 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:41:49 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:41:49 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:41:49 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:41:49 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:41:49 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:41:49 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:41:49 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:41:49 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:41:49 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:41:49 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:41:49 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:41:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:41:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:41:49 INFO - Fetch https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:41:50 INFO - Expected file size: 52519695 04:41:50 INFO - Obtained file size: 52519695 04:42: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 04:42:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:42:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:42:07 INFO - Fetch https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:42:09 INFO - Expected file size: 52519695 04:42:09 INFO - Obtained file size: 52519695 04:42:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:42:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:42:24 INFO - Fetch https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:42:26 INFO - Expected file size: 14404138 04:42:26 INFO - Obtained file size: 14404138 04:42: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')]} 04:42:26 INFO - trying https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:42:26 INFO - Downloading https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:42:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/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 04:42:28 INFO - Downloaded 70954656 bytes. 04:42:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:42:28 INFO - mkdir: /builds/slave/test/properties 04:42:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:42:28 INFO - Writing to file /builds/slave/test/properties/build_url 04:42:28 INFO - Contents: 04:42:28 INFO - build_url:https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:42:29 INFO - Running post-action listener: _resource_record_post_action 04:42:29 INFO - Running post-action listener: set_extra_try_arguments 04:42:29 INFO - [mozharness: 2017-04-07 11:42:29.128917Z] Finished download-and-extract step (success) 04:42:29 INFO - [mozharness: 2017-04-07 11:42:29.129058Z] Running populate-webroot step. 04:42:29 INFO - Running pre-action listener: _resource_record_pre_action 04:42:29 INFO - Running main action method: populate_webroot 04:42:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:42:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:42:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:42:29 INFO - '--tppagecycles', 04:42:29 INFO - '7'], 04:42:29 INFO - 'tests': ['tsvgm']}}, 04:42:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:42:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:42:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:42:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:42:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:42:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:42:29 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:42:29 INFO - 'talos_options': ['--disable-e10s'], 04:42:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:42:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:29 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:42:29 INFO - 'talos_options': ['--disable-e10s'], 04:42:29 INFO - 'tests': ['damp', 'tps']}, 04:42:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:42:29 INFO - 'tests': ['damp', 'tps']}, 04:42:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:42:29 INFO - 'tests': ['dromaeo_dom']}, 04:42:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:42:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:42:29 INFO - 'tests': ['basic_compositor_video']}, 04:42:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:42:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:42:29 INFO - 'tests': ['a11yr', 04:42:29 INFO - 'ts_paint', 04:42:29 INFO - 'tpaint', 04:42:29 INFO - 'sessionrestore', 04:42:29 INFO - 'sessionrestore_no_auto_restore', 04:42:29 INFO - 'tabpaint']}, 04:42:29 INFO - 'other-e10s': {'tests': ['a11yr', 04:42:29 INFO - 'ts_paint', 04:42:29 INFO - 'tpaint', 04:42:29 INFO - 'sessionrestore', 04:42:29 INFO - 'sessionrestore_no_auto_restore', 04:42:29 INFO - 'tabpaint']}, 04:42:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:42:29 INFO - 'ts_paint', 04:42:29 INFO - 'tpaint', 04:42:29 INFO - 'sessionrestore', 04:42:29 INFO - 'sessionrestore_no_auto_restore', 04:42:29 INFO - 'tabpaint']}, 04:42:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:42:29 INFO - 'ts_paint', 04:42:29 INFO - 'tpaint', 04:42:29 INFO - 'sessionrestore', 04:42:29 INFO - 'sessionrestore_no_auto_restore', 04:42:29 INFO - 'tabpaint']}, 04:42:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:42:29 INFO - 'tests': ['a11yr', 04:42:29 INFO - 'ts_paint', 04:42:29 INFO - 'tpaint', 04:42:29 INFO - 'sessionrestore', 04:42:29 INFO - 'sessionrestore_no_auto_restore', 04:42:29 INFO - 'tabpaint']}, 04:42:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:42:29 INFO - 'tests': ['a11yr', 04:42:29 INFO - 'ts_paint', 04:42:29 INFO - 'tpaint', 04:42:29 INFO - 'sessionrestore', 04:42:29 INFO - 'sessionrestore_no_auto_restore', 04:42:29 INFO - 'tabpaint']}, 04:42:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:42:29 INFO - 'tests': ['tsvgx', 04:42:29 INFO - 'tsvgr_opacity', 04:42:29 INFO - 'tart', 04:42:29 INFO - 'tscrollx', 04:42:29 INFO - 'cart', 04:42:29 INFO - 'tsvg_static']}, 04:42:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:42:29 INFO - 'tsvgr_opacity', 04:42:29 INFO - 'tart', 04:42:29 INFO - 'tscrollx', 04:42:29 INFO - 'cart', 04:42:29 INFO - 'tsvg_static']}, 04:42:29 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:42:29 INFO - 'talos_options': ['--disable-e10s'], 04:42:29 INFO - 'tests': ['tp5o']}, 04:42:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:42:29 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:42:29 INFO - 'talos_options': ['--disable-e10s', 04:42:29 INFO - '--xperf_path', 04:42:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:29 INFO - 'tests': ['tp5n']}, 04:42:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:42:29 INFO - 'talos_options': ['--xperf_path', 04:42:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:29 INFO - 'tests': ['tp5n']}}, 04:42:29 INFO - 'talos.zip': {'path': '', 04:42:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:42:29 INFO - Running post-action listener: _resource_record_post_action 04:42:29 INFO - [mozharness: 2017-04-07 11:42:29.147673Z] Finished populate-webroot step (success) 04:42:29 INFO - [mozharness: 2017-04-07 11:42:29.147789Z] Running create-virtualenv step. 04:42:29 INFO - Running pre-action listener: _resource_record_pre_action 04:42:29 INFO - Running main action method: create_virtualenv 04:42:29 INFO - Creating virtualenv /builds/slave/test/build/venv 04:42: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 04:42:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:42:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:42:29 INFO - Using real prefix '/tools/python27' 04:42:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:42:30 INFO - Installing distribute.............................................................................................................................................................................................done. 04:42:32 INFO - Installing pip.................done. 04:42:32 INFO - Return code: 0 04:42:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:42:33 INFO - Reading from file tmpfile_stdout 04:42:33 INFO - Output received: 04:42: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) 04:42:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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 0x10ef74b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef77768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7bbd884f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed52d30>, '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 0x10ec79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed47be8>, '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.fS9m2vcJHL/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.jl4NZQiwMN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:42: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 04:42: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 04:42:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fS9m2vcJHL/Render', 04:42:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:33 INFO - 'HOME': '/Users/cltbld', 04:42:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:33 INFO - 'LOGNAME': 'cltbld', 04:42:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:33 INFO - 'MOZ_NO_REMOTE': '1', 04:42:33 INFO - 'NO_EM_RESTART': '1', 04:42:33 INFO - 'PAGER': '/bin/cat', 04:42:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:33 INFO - 'PWD': '/builds/slave/test', 04:42:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:33 INFO - 'SHELL': '/bin/bash', 04:42:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jl4NZQiwMN/Listeners', 04:42:33 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 04:42:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:33 INFO - 'USER': 'cltbld', 04:42:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:33 INFO - 'XPC_FLAGS': '0x0', 04:42:33 INFO - 'XPC_SERVICE_NAME': '0', 04:42:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42: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 04:42:33 INFO - Cleaning up... 04:42:33 INFO - Return code: 0 04:42:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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 0x10ef74b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef77768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7bbd884f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed52d30>, '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 0x10ec79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed47be8>, '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.fS9m2vcJHL/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.jl4NZQiwMN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:42: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 04:42: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 04:42:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fS9m2vcJHL/Render', 04:42:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:33 INFO - 'HOME': '/Users/cltbld', 04:42:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:33 INFO - 'LOGNAME': 'cltbld', 04:42:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:33 INFO - 'MOZ_NO_REMOTE': '1', 04:42:33 INFO - 'NO_EM_RESTART': '1', 04:42:33 INFO - 'PAGER': '/bin/cat', 04:42:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:33 INFO - 'PWD': '/builds/slave/test', 04:42:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:33 INFO - 'SHELL': '/bin/bash', 04:42:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jl4NZQiwMN/Listeners', 04:42:33 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 04:42:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:33 INFO - 'USER': 'cltbld', 04:42:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:33 INFO - 'XPC_FLAGS': '0x0', 04:42:33 INFO - 'XPC_SERVICE_NAME': '0', 04:42:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:33 INFO - Downloading/unpacking psutil>=3.1.1 04:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:42:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:37 INFO - Installing collected packages: psutil 04:42:37 INFO - Running setup.py install for psutil 04:42:37 INFO - building 'psutil._psutil_osx' extension 04:42: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 04:42: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_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:42: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:42: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 04:42:38 INFO - building 'psutil._psutil_posix' extension 04:42: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 04:42:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:42:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:42:38 INFO - ^ 04:42:38 INFO - 1 warning generated. 04:42: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 04:42:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:38 INFO - Successfully installed psutil 04:42:38 INFO - Cleaning up... 04:42:38 INFO - Return code: 0 04:42:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:42: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')]} 04:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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')]} 04:42:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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 0x10ef74b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef77768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7bbd884f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed52d30>, '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 0x10ec79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed47be8>, '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.fS9m2vcJHL/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.jl4NZQiwMN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:42: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 04:42: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 04:42:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fS9m2vcJHL/Render', 04:42:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:38 INFO - 'HOME': '/Users/cltbld', 04:42:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:38 INFO - 'LOGNAME': 'cltbld', 04:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:38 INFO - 'MOZ_NO_REMOTE': '1', 04:42:38 INFO - 'NO_EM_RESTART': '1', 04:42:38 INFO - 'PAGER': '/bin/cat', 04:42:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:38 INFO - 'PWD': '/builds/slave/test', 04:42:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:38 INFO - 'SHELL': '/bin/bash', 04:42:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jl4NZQiwMN/Listeners', 04:42:38 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 04:42:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:38 INFO - 'USER': 'cltbld', 04:42:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:38 INFO - 'XPC_FLAGS': '0x0', 04:42:38 INFO - 'XPC_SERVICE_NAME': '0', 04:42:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:42: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 04:42: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 04:42: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 04:42: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 04:42: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 04:42: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 04:42:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:42:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:42:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:42:41 INFO - Installing collected packages: mozsystemmonitor 04:42:41 INFO - Running setup.py install for mozsystemmonitor 04:42:41 INFO - Successfully installed mozsystemmonitor 04:42:41 INFO - Cleaning up... 04:42:41 INFO - Return code: 0 04:42:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:42: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')]} 04:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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')]} 04:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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 0x10ef74b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef77768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7bbd884f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed52d30>, '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 0x10ec79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed47be8>, '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.fS9m2vcJHL/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.jl4NZQiwMN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:42: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 04:42: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 04:42:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fS9m2vcJHL/Render', 04:42:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:42 INFO - 'HOME': '/Users/cltbld', 04:42:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:42 INFO - 'LOGNAME': 'cltbld', 04:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:42 INFO - 'MOZ_NO_REMOTE': '1', 04:42:42 INFO - 'NO_EM_RESTART': '1', 04:42:42 INFO - 'PAGER': '/bin/cat', 04:42:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:42 INFO - 'PWD': '/builds/slave/test', 04:42:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:42 INFO - 'SHELL': '/bin/bash', 04:42:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jl4NZQiwMN/Listeners', 04:42:42 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 04:42:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:42 INFO - 'USER': 'cltbld', 04:42:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:42 INFO - 'XPC_FLAGS': '0x0', 04:42:42 INFO - 'XPC_SERVICE_NAME': '0', 04:42:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:42 INFO - Downloading/unpacking jsonschema==2.5.1 04:42: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 04:42: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 04:42: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 04:42: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 04:42: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 04:42: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 04:42:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:42:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:42: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 04:42: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 04:42: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 04:42: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 04:42: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 04:42: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 04:42:45 INFO - Downloading functools32-3.2.3-2.tar.gz 04:42:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:42:45 INFO - warning: no files found matching '*.txt' 04:42:45 INFO - no previously-included directories found matching 'build' 04:42:45 INFO - no previously-included directories found matching 'dist' 04:42:45 INFO - no previously-included directories found matching '.git*' 04:42:45 INFO - Installing collected packages: jsonschema, functools32 04:42:45 INFO - Running setup.py install for functools32 04:42:45 INFO - warning: no files found matching '*.txt' 04:42:45 INFO - no previously-included directories found matching 'build' 04:42:45 INFO - no previously-included directories found matching 'dist' 04:42:45 INFO - no previously-included directories found matching '.git*' 04:42:45 INFO - Successfully installed jsonschema functools32 04:42:45 INFO - Cleaning up... 04:42:45 INFO - Return code: 0 04:42:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:45 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 0x10ef74b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef77768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7bbd884f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed52d30>, '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 0x10ec79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed47be8>, '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.fS9m2vcJHL/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.jl4NZQiwMN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:42:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:42:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:42:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fS9m2vcJHL/Render', 04:42:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:45 INFO - 'HOME': '/Users/cltbld', 04:42:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:45 INFO - 'LOGNAME': 'cltbld', 04:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:45 INFO - 'MOZ_NO_REMOTE': '1', 04:42:45 INFO - 'NO_EM_RESTART': '1', 04:42:45 INFO - 'PAGER': '/bin/cat', 04:42:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:45 INFO - 'PWD': '/builds/slave/test', 04:42:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:45 INFO - 'SHELL': '/bin/bash', 04:42:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jl4NZQiwMN/Listeners', 04:42:45 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 04:42:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:45 INFO - 'USER': 'cltbld', 04:42:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:45 INFO - 'XPC_FLAGS': '0x0', 04:42:45 INFO - 'XPC_SERVICE_NAME': '0', 04:42:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:42:46 INFO - Cleaning up... 04:42:46 INFO - Return code: 0 04:42:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:42: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')]} 04:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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')]} 04:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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 0x10ef74b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef77768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7bbd884f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed52d30>, '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 0x10ec79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed47be8>, '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.fS9m2vcJHL/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.jl4NZQiwMN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:42: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 04:42: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 04:42:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fS9m2vcJHL/Render', 04:42:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:46 INFO - 'HOME': '/Users/cltbld', 04:42:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:46 INFO - 'LOGNAME': 'cltbld', 04:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:46 INFO - 'MOZ_NO_REMOTE': '1', 04:42:46 INFO - 'NO_EM_RESTART': '1', 04:42:46 INFO - 'PAGER': '/bin/cat', 04:42:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:46 INFO - 'PWD': '/builds/slave/test', 04:42:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:46 INFO - 'SHELL': '/bin/bash', 04:42:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jl4NZQiwMN/Listeners', 04:42:46 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 04:42:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:46 INFO - 'USER': 'cltbld', 04:42:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:46 INFO - 'XPC_FLAGS': '0x0', 04:42:46 INFO - 'XPC_SERVICE_NAME': '0', 04:42:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:46 INFO - Downloading/unpacking blobuploader==1.2.4 04:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:49 INFO - Downloading blobuploader-1.2.4.tar.gz 04:42:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:42:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:42: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 04:42: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 04:42: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 04:42: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 04:42: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 04:42: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 04:42:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:42:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:42: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 04:42: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 04:42: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 04:42: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 04:42: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 04:42: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 04:42:50 INFO - Downloading docopt-0.6.1.tar.gz 04:42:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:42:50 INFO - Installing collected packages: blobuploader, requests, docopt 04:42:50 INFO - Running setup.py install for blobuploader 04:42:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:42:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:42:50 INFO - Running setup.py install for requests 04:42:51 INFO - Running setup.py install for docopt 04:42:51 INFO - Successfully installed blobuploader requests docopt 04:42:51 INFO - Cleaning up... 04:42:51 INFO - Return code: 0 04:42:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:51 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 0x10ef74b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef77768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7bbd884f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed52d30>, '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 0x10ec79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed47be8>, '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.fS9m2vcJHL/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.jl4NZQiwMN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:42:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:42:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fS9m2vcJHL/Render', 04:42:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:51 INFO - 'HOME': '/Users/cltbld', 04:42:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:51 INFO - 'LOGNAME': 'cltbld', 04:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:51 INFO - 'MOZ_NO_REMOTE': '1', 04:42:51 INFO - 'NO_EM_RESTART': '1', 04:42:51 INFO - 'PAGER': '/bin/cat', 04:42:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:51 INFO - 'PWD': '/builds/slave/test', 04:42:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:51 INFO - 'SHELL': '/bin/bash', 04:42:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jl4NZQiwMN/Listeners', 04:42:51 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 04:42:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:51 INFO - 'USER': 'cltbld', 04:42:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:51 INFO - 'XPC_FLAGS': '0x0', 04:42:51 INFO - 'XPC_SERVICE_NAME': '0', 04:42:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:42:51 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-_Yc9YZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:42:51 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-ayu59H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:42:51 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-jVmHxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:42:51 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-sXEjm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:42:52 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-xWOtJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:42:52 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-YS9cm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:42:52 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-qrT9hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:42:52 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-Bp0l1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:42:52 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-NnV6Wm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:42:52 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-OFYBGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:42:52 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-M7T3yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:42:52 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-H93BHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:42:52 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-zEjPhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:42:53 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-WxCUfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:53 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-mUKNDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:42:53 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-w_NYmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:42:53 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-HtyQEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:42:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:42:53 INFO - Running setup.py install for manifestparser 04:42:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:42:53 INFO - Running setup.py install for mozcrash 04:42:53 INFO - Running setup.py install for mozdebug 04:42:53 INFO - Running setup.py install for mozdevice 04:42:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:42:54 INFO - Running setup.py install for mozfile 04:42:54 INFO - Running setup.py install for mozhttpd 04:42:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:42:54 INFO - Running setup.py install for mozinfo 04:42:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:42:54 INFO - Running setup.py install for mozInstall 04:42:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:42:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:42:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:42:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:42:54 INFO - Running setup.py install for mozleak 04:42:54 INFO - Running setup.py install for mozlog 04:42:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:42:54 INFO - Running setup.py install for moznetwork 04:42:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:42:55 INFO - Running setup.py install for mozprocess 04:42:55 INFO - Running setup.py install for mozprofile 04:42:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:42:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:42:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:42:55 INFO - Running setup.py install for mozrunner 04:42:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:42:55 INFO - Running setup.py install for mozscreenshot 04:42:55 INFO - Running setup.py install for moztest 04:42:55 INFO - Running setup.py install for mozversion 04:42:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:42:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:42:56 INFO - Cleaning up... 04:42:56 INFO - Return code: 0 04:42:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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 0x10ef74b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef77768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7bbd884f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed52d30>, '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 0x10ec79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed47be8>, '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.fS9m2vcJHL/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.jl4NZQiwMN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:42: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 04:42: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 04:42:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fS9m2vcJHL/Render', 04:42:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:56 INFO - 'HOME': '/Users/cltbld', 04:42:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:56 INFO - 'LOGNAME': 'cltbld', 04:42:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:56 INFO - 'MOZ_NO_REMOTE': '1', 04:42:56 INFO - 'NO_EM_RESTART': '1', 04:42:56 INFO - 'PAGER': '/bin/cat', 04:42:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:56 INFO - 'PWD': '/builds/slave/test', 04:42:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:56 INFO - 'SHELL': '/bin/bash', 04:42:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jl4NZQiwMN/Listeners', 04:42:56 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 04:42:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:56 INFO - 'USER': 'cltbld', 04:42:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:56 INFO - 'XPC_FLAGS': '0x0', 04:42:56 INFO - 'XPC_SERVICE_NAME': '0', 04:42:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:42:56 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-SxIJ7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:42:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:42:56 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-JvSzcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:42:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:42:56 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-B2xHHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:42:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:42:56 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-T74fem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:42:56 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)) 04:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:42:56 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-dGuray-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:42:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:42:56 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-yf8D3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:42:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:42:56 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-RZFhZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:42: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)) 04:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:42:57 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-V4iJeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:42: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)) 04:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:42:57 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-QZIb6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:42: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)) 04:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:42:57 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-EKPzNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:42: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)) 04:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:42:57 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-UQK2_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:42:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:42:57 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-u3cHYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:42:57 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)) 04:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:42:57 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-WQl0qX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:42:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:42:57 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-JM07t0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:42:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:57 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-A3B4tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:42:57 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-KH91VC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:42: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)) 04:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:42:58 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-us5SH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:42: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)) 04:42: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)) 04:42: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)) 04:42: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)) 04:42: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)) 04:42: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)) 04:42:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:42: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 04:42: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 04:42: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 04:42: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 04:42: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 04:42: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 04:43:00 INFO - Downloading blessings-1.6.tar.gz 04:43:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:43:00 INFO - Installing collected packages: blessings 04:43:00 INFO - Running setup.py install for blessings 04:43:00 INFO - Successfully installed blessings 04:43:00 INFO - Cleaning up... 04:43:01 INFO - Return code: 0 04:43:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:43:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:43:01 INFO - Reading from file tmpfile_stdout 04:43:01 INFO - Current package versions: 04:43:01 INFO - blessings == 1.6 04:43:01 INFO - blobuploader == 1.2.4 04:43:01 INFO - docopt == 0.6.1 04:43:01 INFO - functools32 == 3.2.3-2 04:43:01 INFO - jsonschema == 2.5.1 04:43:01 INFO - manifestparser == 1.1 04:43:01 INFO - mozInstall == 1.12 04:43:01 INFO - mozcrash == 1.0 04:43:01 INFO - mozdebug == 0.1 04:43:01 INFO - mozdevice == 0.50 04:43:01 INFO - mozfile == 1.2 04:43:01 INFO - mozhttpd == 0.7 04:43:01 INFO - mozinfo == 0.9 04:43:01 INFO - mozleak == 0.1 04:43:01 INFO - mozlog == 3.4 04:43:01 INFO - moznetwork == 0.27 04:43:01 INFO - mozprocess == 0.25 04:43:01 INFO - mozprofile == 0.28 04:43:01 INFO - mozrunner == 6.13 04:43:01 INFO - mozscreenshot == 0.1 04:43:01 INFO - mozsystemmonitor == 0.3 04:43:01 INFO - moztest == 0.8 04:43:01 INFO - mozversion == 1.4 04:43:01 INFO - psutil == 3.1.1 04:43:01 INFO - requests == 1.2.3 04:43:01 INFO - wsgiref == 0.1.2 04:43:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:01 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 0x10ef74b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef77768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7bbd884f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed52d30>, '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 0x10ec79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed47be8>, '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.fS9m2vcJHL/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.jl4NZQiwMN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:43:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:43:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fS9m2vcJHL/Render', 04:43:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:01 INFO - 'HOME': '/Users/cltbld', 04:43:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:01 INFO - 'LOGNAME': 'cltbld', 04:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:01 INFO - 'MOZ_NO_REMOTE': '1', 04:43:01 INFO - 'NO_EM_RESTART': '1', 04:43:01 INFO - 'PAGER': '/bin/cat', 04:43:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:01 INFO - 'PWD': '/builds/slave/test', 04:43:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:01 INFO - 'SHELL': '/bin/bash', 04:43:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jl4NZQiwMN/Listeners', 04:43:01 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 04:43:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:01 INFO - 'USER': 'cltbld', 04:43:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:01 INFO - 'XPC_FLAGS': '0x0', 04:43:01 INFO - 'XPC_SERVICE_NAME': '0', 04:43:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:43:01 INFO - Cleaning up... 04:43:01 INFO - Return code: 0 04:43:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:01 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 0x10ef74b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef77768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7bbd884f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed52d30>, '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 0x10ec79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed47be8>, '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.fS9m2vcJHL/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.jl4NZQiwMN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:43:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:43:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fS9m2vcJHL/Render', 04:43:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:01 INFO - 'HOME': '/Users/cltbld', 04:43:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:01 INFO - 'LOGNAME': 'cltbld', 04:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:01 INFO - 'MOZ_NO_REMOTE': '1', 04:43:01 INFO - 'NO_EM_RESTART': '1', 04:43:01 INFO - 'PAGER': '/bin/cat', 04:43:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:01 INFO - 'PWD': '/builds/slave/test', 04:43:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:01 INFO - 'SHELL': '/bin/bash', 04:43:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jl4NZQiwMN/Listeners', 04:43:01 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 04:43:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:01 INFO - 'USER': 'cltbld', 04:43:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:01 INFO - 'XPC_FLAGS': '0x0', 04:43:01 INFO - 'XPC_SERVICE_NAME': '0', 04:43:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:43:01 INFO - Cleaning up... 04:43:01 INFO - Return code: 0 04:43:01 INFO - Running post-action listener: _resource_record_post_action 04:43:01 INFO - Running post-action listener: _start_resource_monitoring 04:43:01 INFO - Starting resource monitoring. 04:43:01 INFO - [mozharness: 2017-04-07 11:43:01.912318Z] Finished create-virtualenv step (success) 04:43:01 INFO - [mozharness: 2017-04-07 11:43:01.913315Z] Running install step. 04:43:01 INFO - Running pre-action listener: _resource_record_pre_action 04:43:01 INFO - Running main action method: install 04:43:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:43:02 INFO - Reading from file tmpfile_stdout 04:43:02 INFO - Detecting whether we're running mozinstall >=1.0... 04:43:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:43:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:43:02 INFO - Reading from file tmpfile_stdout 04:43:02 INFO - Output received: 04:43:02 INFO - Usage: mozinstall [options] installer 04:43:02 INFO - Options: 04:43:02 INFO - -h, --help show this help message and exit 04:43:02 INFO - -d DEST, --destination=DEST 04:43:02 INFO - Directory to install application into. [default: 04:43:02 INFO - "/builds/slave/test"] 04:43:02 INFO - --app=APP Application being installed. [default: firefox] 04:43:02 INFO - mkdir: /builds/slave/test/build/application 04:43: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'] 04:43: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 04:43:22 INFO - Reading from file tmpfile_stdout 04:43:22 INFO - Output received: 04:43:22 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:43:22 INFO - Running post-action listener: _resource_record_post_action 04:43:22 INFO - [mozharness: 2017-04-07 11:43:22.108277Z] Finished install step (success) 04:43:22 INFO - [mozharness: 2017-04-07 11:43:22.108435Z] Running run-tests step. 04:43:22 INFO - Running pre-action listener: _resource_record_pre_action 04:43:22 INFO - Running main action method: run_tests 04:43:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:43:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:43:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:43:22 INFO - 2017-04-07 04:43:22.123 screenresolution[1628:7471] starting screenresolution argv=screenresolution get 04:43:22 INFO - 2017-04-07 04:43:22.126 screenresolution[1628:7471] Display 0: 1600x1200x32@60 04:43:22 INFO - 2017-04-07 04:43:22.131 screenresolution[1629:7473] starting screenresolution argv=screenresolution list 04:43:22 INFO - Available Modes on Display 0 04:43:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:43:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:43:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:43:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:43:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:43:22 INFO - Intel Iris: 04:43:22 INFO - Chipset Model: Intel Iris 04:43:22 INFO - Type: GPU 04:43:22 INFO - Bus: Built-In 04:43:22 INFO - VRAM (Dynamic, Max): 1536 MB 04:43:22 INFO - Vendor: Intel (0x8086) 04:43:22 INFO - Device ID: 0x0a2e 04:43:22 INFO - Revision ID: 0x0009 04:43:22 INFO - Displays: 04:43:22 INFO - Display: 04:43:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:43:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:43:22 INFO - Display Serial Number: 1600x1200 60 04:43:22 INFO - Main Display: Yes 04:43:22 INFO - Mirror: Off 04:43:22 INFO - Online: Yes 04:43:22 INFO - Rotation: Supported 04:43:22 INFO - Return code: 0 04:43:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:43:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:43:22 INFO - Python 2.7.3 04:43:22 INFO - Return code: 0 04:43:22 INFO - grabbing minidump binary from tooltool 04:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:22 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 0x10ed52d30>, '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 0x10ec79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed47be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:43:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:43:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:43:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:43:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:43:22 INFO - Return code: 0 04:43:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:43:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:43:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:43:22 INFO - ENV: RUST_BACKTRACE is now 1 04:43:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:43:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:43:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:43:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:43:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fS9m2vcJHL/Render', 04:43:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:22 INFO - 'HOME': '/Users/cltbld', 04:43:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:22 INFO - 'LOGNAME': 'cltbld', 04:43:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:43:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:22 INFO - 'MOZ_NO_REMOTE': '1', 04:43:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:43:22 INFO - 'NO_EM_RESTART': '1', 04:43:22 INFO - 'PAGER': '/bin/cat', 04:43:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:22 INFO - 'PWD': '/builds/slave/test', 04:43:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:43:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:22 INFO - 'RUST_BACKTRACE': '1', 04:43:22 INFO - 'SHELL': '/bin/bash', 04:43:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jl4NZQiwMN/Listeners', 04:43:22 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 04:43:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:22 INFO - 'USER': 'cltbld', 04:43:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:22 INFO - 'XPC_FLAGS': '0x0', 04:43:22 INFO - 'XPC_SERVICE_NAME': '0', 04:43:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:43:22 INFO - mozversion application_buildid: 20170407030233 04:43:22 INFO - mozversion application_changeset: 10ea10d9993c9701e5525928257a589dea2c05d8 04:43:22 INFO - mozversion application_display_name: Nightly 04:43:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:43:22 INFO - mozversion application_name: Firefox 04:43:22 INFO - mozversion application_remotingname: firefox 04:43:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:43:22 INFO - mozversion application_vendor: Mozilla 04:43:22 INFO - mozversion application_version: 55.0a1 04:43:22 INFO - mozversion platform_buildid: 20170407030233 04:43:22 INFO - mozversion platform_changeset: 10ea10d9993c9701e5525928257a589dea2c05d8 04:43:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:43:22 INFO - mozversion platform_version: 55.0a1 04:43:22 INFO - using testdate: 1491565402 04:43:22 INFO - actual date: 1491565402 04:43:22 INFO - starting webserver on 'localhost:49243' 04:43:22 INFO - SUITE-START | Running 2 tests 04:43:22 INFO - TEST-START | dromaeo_css 04:43:22 INFO - operating with platform_type : mac_ 04:43:22 INFO - Initialising browser for dromaeo_css test... 04:43:22 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpGbEw2k/profile http://localhost:49243/getInfo.html) 04:43:25 INFO - PID 1639 | __metrics Screen width/height:1600/1200 04:43:25 INFO - PID 1639 | colorDepth:24 04:43:25 INFO - PID 1639 | Browser inner width/height: 1024/689 04:43:25 INFO - PID 1639 | __metrics 04:43:25 INFO - PID 1639 | 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" 04:43:25 INFO - PID 1639 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:43:27 INFO - TEST-INFO | 1639: exit 0 04:43:27 INFO - Browser initialized. 04:43:27 INFO - Running cycle 1/1 for dromaeo_css test... 04:43:27 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpGbEw2k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:43:39 INFO - PID 1642 | RSS: Main: 237895680 04:43:39 INFO - PID 1642 | 04:46:44 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 04:46:46 INFO - PID 1642 | RSS: Main: 439156736 04:46:46 INFO - PID 1642 | 04:48:28 INFO - PID 1642 | ************************* 04:48:28 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 04:48:28 INFO - PID 1642 | 04:48:28 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:48:28 INFO - PID 1642 | Full stack: 04:48:28 INFO - PID 1642 | ************************* 04:48:28 INFO - PID 1642 | ************************* 04:48:28 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 04:48:28 INFO - PID 1642 | 04:48:28 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:48:28 INFO - PID 1642 | Full stack: 04:48:28 INFO - PID 1642 | ************************* 04:48:28 INFO - PID 1642 | ************************* 04:48:28 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 04:48:28 INFO - PID 1642 | 04:48:28 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:48:28 INFO - PID 1642 | Full stack: 04:48:28 INFO - PID 1642 | ************************* 04:48:28 INFO - PID 1642 | ************************* 04:48:28 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 04:48:28 INFO - PID 1642 | 04:48:28 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:48:28 INFO - PID 1642 | Full stack: 04:48:28 INFO - PID 1642 | ************************* 04:49:49 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 04:49:50 INFO - PID 1642 | RSS: Main: 369967104 04:49:50 INFO - PID 1642 | 04:52:52 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 04:52:53 INFO - PID 1642 | RSS: Main: 331837440 04:52:53 INFO - PID 1642 | 04:55:55 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 04:55:56 INFO - PID 1642 | RSS: Main: 354496512 04:55:56 INFO - PID 1642 | 04:59:00 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 04:59:00 INFO - PID 1642 | RSS: Main: 338276352 04:59:00 INFO - PID 1642 | 05:02:03 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 05:02:03 INFO - PID 1642 | RSS: Main: 422051840 05:02:03 INFO - PID 1642 | 05:02:03 INFO - PID 1642 | __start_tp_report 05:02:03 INFO - PID 1642 | _x_x_mozilla_page_load 05:02:03 INFO - PID 1642 | _x_x_mozilla_page_load_details 05:02:03 INFO - PID 1642 | |i|pagename|runs| 05:02:03 INFO - PID 1642 | |0;dojo.html;3551.7868927864324;3568.9107772305674;3582.7898838873866;3586.211033572613;3613.8012409317494;6103.307364981957;6192.50459963203;6259.593126446778;6262.0293854452575;6278.623282603047;6168;6207.286162091361;6250.000000000001;6251.218597675291;6264.373562643734;5258.553022993031;5426.647267927592;5434.375046869602;5438.510534051935;5456.508914197741;4549.272116461367;5496;5525.226468294442;5536.944630553703;5602.747876345554;5367.409584945653;5439.184122381675;5446.836594902159;5449;5502.80740174094;5450.018996580614;5464.453554644504;5469.234307196995;5473.480019398151;5475.178723191553;5333.386660534049;5409.486098820645;5412.079946409081;5413.810516631938;5429.212764149216;5411.83764487066;6088.4520393164385;6222.844428889269;6260.060990851363;6265.530085243625;6534.77128300512;6536.444402225769;6540.901886471706;6544.312847151028;6553.574017688835;6742.359475849787;6787.117674702306;6800.4219641330055;6855.07456493372;6861.2795656455855;6337.873242535124;6349.428551430301;6354.015127655221;6366.586171898812;6423.903641445382;6669.566478178903;6974.093367862146;6974.58152510851;6976.51164418496;6994.650267486707;6447.1618689571;6476.579022363531;6513.706883190173;6577.83555411109;6614.239362473281;6784.253732089466;6798.388145066869;6811.352921472452;6814.557053791487;6818.420434263143;6619.204343200284;6720.260771315151;6727.327267273234;6727.663616819237;6733.9326606734285;5422.566194704415;6516;6518.902216466757;6572.441342485942;6722.957941519072;5347.839564813062;5378.354597448331;5396.217548455452;5404.297441332602;5422.8915421691345;4740.976295118571;4753.786079626425;4762.928556071662;4767.356406885096;4799.112164249625;6271;6304.18045654062;6343.460805831463;6343.777967771106;6377.17096777416;6647.567908085959;6651.600903945779;6752.459803215829;6816.931830681729;6847.452203823682;6345.302016778151;6357.809265722036;6367.299597044322;6370.77702280418;6378.936210637927;5919.6152250103605;5990.371011043778;6004.219451471281;6016.759329626853;6016.819495415145;5955.970220148872;6787.592744435349;6887.793366199022;6902.654867256718;7006.159260888522;6557.245916719638;6658.067870498231;6730.528862979544;6828.283030281749;6835.863282734417;6909.1018167637885;6992;7019.824504387227;7051.823704407226;7066.399356054793;6677.165354330708;6701.698423571049;6702.966485167543;6704.899426508704;6719.160104986877;6545.345465453416;6765.86468270622;6773.322667733188;6807.795766126826;6812.114425124702;6376.585521941059;6401.93598064032;6509.7396104155305;6534.150560427114;6604.4056034955165;6524.902126468011;6554.410103090745;6556.377144171296;6556.508261880283;6575.079488871657;6249.093881387264;6358.618482891041;6371.458426033839;6399.776007839703;6424.903626445701;6309.305976342507;6359.332270111571;6366.840828979312;6580.1116849224745;6582;6319.115323854756;6363.395477429637;6398.840028999126;6406.327335629878;6411.679416029273 05:02:03 INFO - PID 1642 | |1;ext.html;689.6689588997281;813.6745301879249;1057.693268952004;1092.836074588811;1096.309325125171;28056.71943280569;37030.62969370306;37377.43933840991;37484.62515374846;37737;39762;40169.79915100428;40198.59801401985;40220;40316.596834031654;8384.70653527125;8541.95729021354;8548.187922147386;8552.102029286929;8554;6098.756049758004;6235.659333243374;6243.313235544087;6256.249250089995;7945.245201705829;6420.711068001951;7585.848283034336;7591.696332146707;7592.582407967559;7606.42951778616;7521.285477879593;7554.660040298199;7568.053993250871;7572.469927105105;7589.582572958485;5983.431574000463;6135.9693201534155;8415.831683366298;8467.915320846774;8492.405531612789;27269.318267043283;27613.857921311763;27694.892204312004;36376.45435318472;37851.053723656856;3414.2488652496413;3453.2920751245933;3463.619001909788;3469.60099588548;3473.8610455581747;29837.850810745807;29882;29914.70085299141;29931;30049;3102.9506494025286;3125.5934829326893;3130.6086739157604;3147.590813194293;3150.763692723055;226317;292609;292763;293888;294337;39496;49366;49510.257346139835;49586;49727;41183.58816411858;41197.79401102975;49384.012319754125;49645.269510176564;50412.747936260086;14172.574822755334;14253.78619320711;14261.572152835432;14263.215523146326;14296.785548216785;11664.533418663328;11686.532538698357;11686.70783230426;11702.76594468106;11719.179657423898;12238.81641775374;12246.632601021984;12291;12294.877051229374;12381.938090309492;4709.481956984729;5113.744312784346;5475.260839786578;5665.3201615806365;5671.291088613923;871.6097823970756;953.7997020625746;972.5137431284357;999.5452069308448;1011.8330475471465;21894.45263868384;23149.421264468187;23196.23796372302;23212.18757343485;23489.647655285185;1047.4553232319151;1069.7967386196754;1075.5482697267166;1108.6119858049617;1116.832475128737;8869.556522173865;10829.783404331869;11258.66224013281;11842.11184161174;11846.348450835114;351488;351974;352335;353197;353942;41427.7928610355;51660;51675;51765;51818.44544663666;1429.4425174182077;1475.2181343887758;1516.4843953056013;1518.5899807052035;1523.3221216558748;22655.773442266025;22748.772512274667;22803.657945131166;22833.543329133656;22856.657150143095;36691.266174675824;36722.63277367192;36738.8163059183;36779.81610091932;36817.815910921345;321888;322322;323237.38381307945;323705;324024;26078.86960565185;26274.73725262723;30656.233594160323;31948.041558753273;32864;39757.60242397539;39782.40870365153;39961.60038399695;40646.1870762589;41145.17709645731;26658.466830663667;27159.456810863277;27545.724542755117;29016.56475152832;29138.854305728335;21995.780042199374;22901.885490573106;28991.42017159687;29176.978805741695;29249;34413;34420.79527216536;34472.310553789284;34517.48223776595;34647.30705385929;25806.483870322114;30130.69869301279;30156.69843301539;30338.393232134793;30345.848270758506;18632.81367186365;20950.685739714223;21537.892310538347;23634.818259086634;23944.28167154988 05:02:03 INFO - PID 1642 | |2;jquery.html;370.5701386391786;431.5404094639207;435.98474053408137;443.26860679878195;454.00119736579535;19962.30131945384;21587.244446444376;22303.330900072982;22515.54968900621;22557.210497632586;22015.33953981379;23305.92146374382;23332.65001024986;23373.415664608394;23701.76298237017;6203.472704820096;6242.4069713377385;6452.677366131698;6488.902666460007;6496.415322620963;6107.267127944653;6360.204974378203;6362.427381535661;6380.393862583047;6384.042393640944;6247.250329960389;6258.249010118792;6323.93676063238;6330.0504924261495;6341.112244285804;6170.598911070766;6308.053791931201;6314.368563143695;6332.240131184241;6350.110984462132;5403.7027963462;5596.748146333384;5649.406812284733;5664.546836253131;5667.801626943037;27272.454550909068;27397.31506712348;27428.725712742817;27554.5866811998;27802;2188.2559929623844;2235.1394713035434;2244.2033078257145;2245.1805091141778;2247.685324054634;17444.30222791087;17896.731549026776;18196.27214911402;18268.63462730751;18271.451856444328;2065.555905480329;2098.1607357057146;2142.4108370198164;2150.7526634437086;2163.3618082665494;146290.0741985165;147192.26403868018;147754;148617;151906;11964.76070478603;12517;12542.1847579907;12551.560695375618;12619.936900315439;16708.24812883423;16721;16725.83274167267;16760.413385531447;16766.497005089866;8718.08460111679;8944.776380590538;8974.910250897537;9067.591958361889;9086.045965173695;8550.914490855137;8553.401261911606;8581;8739;8757.56212189388;6234.844128896814;7825.334846538108;7836.804079897935;7854.567998760009;7863.135055144044;2132.637451633226;2149.204794226115;2160.902759375832;2168.241115609524;2171.283476452767;934.705432975334;954.2318433660831;954.3510412919143;960.519740129935;966.1594412860716;18297.176627051813;19288.710669339973;19613.901930490258;21029.579408412053;21211.788101971717;827.4662842466576;972.6255391674256;984.670135504614;1021.341234903483;1021.8569400283966;10470.110040646478;10793.892061079447;10898.836517452244;10907.236493445384;10940.343579385262;696110;700431;712799;723562;729600;122699.77905081703;141315;162727;166664;167990.16004919898;1189.8810118988206;1207.1791181996152;1237.6348977051791;1238.8451443569554;1242.3850194153952;19617.70573441428;19905.701414478506;21436.142554297654;21791;22266.332010039725;61777.691111544154;63509.68245158745;63786.40533986502;64199;64210.357896420435;87136.56431717801;88328;89522;89676.5516172415;90425;8695.347848911231;8734.90362313053;8872;8880.911190888008;9343.906560934303;12941.805872911726;13661.79507307411;14446.638834029234;14876.404943802127;15030.323635436212;11979.820302695642;12118.272903625812;12220.327881966221;12289.07831912628;12332.643409224798;9809.166220871306;11039.061679757311;11311.660650180507;11432.428378581204;11661.941690291495;12159.878401215874;12352.3823808811;12395.132340736423;12414.131010829155;12428.875711242772;8652.8367908023;8680.782980425287;8923.73228803137;8993.235574975939;9247.0752924707;11847.940760296144;11998.40007999579;12162.574309899112;12248.265104093784;12258.448369823558 05:02:03 INFO - PID 1642 | |3;mootools.html;1338.5917295224956;1400.5588239704493;1420.3040510150024;1425.2517428350109;1428.528585566763;11401.54393824247;11946.701332466693;11949.402529873494;11985.460654270557;12010.939945300272;11318.717032074203;11586.768264634702;11669.766604667902;11713.824292635618;11729.592448906144;2482.615194644833;2517.2070797698757;2531.253280282321;2534.974650253492;2545.172818833877;2153.214076861942;2448.2532827487607;2469.64190192422;2516.672832531768;2521;2403.098837935774;2504.3113143885394;2506.4987002599555;2508.3352911478473;2514.9874250628723;2493.7132229793624;2502.0492212959143;2511.949761004779;2533.1134103063873;2534.835235709673;2376.738558758535;2417.5890098683267;2425.3936515871032;2427.368884090132;2493.1772515069983;11632.825507617392;11740.530378784924;11748.412579370997;11753.764924701458;11773.352465614387;6475.417212450902;6748.932510674879;6749.291324410915;6753.189617245913;6760.42536384408;3871.2451072040963;4265.7227280227;4281;4372.934405983913;4379.1022840317655;1212.721074152941;1228.6068458093414;1281.9615411537668;1287.4335292471283;1289.7033682253134;14997.700045999129;15374.769378459332;15434.922825385913;16145.192740363053;16474.341026358932;5415.539679127318;5577.1355439906065;5581.748821303051;5581.888362232733;5583.916241256385;13233.669158271121;13603.795943060863;13615.31923403826;13622.727545449035;13632.318384080756;6455.193100862392;6504.1869766279215;6597.241317248482;6602.669866506655;6913.965430172918;5973.731182096816;6063.393660633989;6123.846903827351;6210.534209934273;6236.18929539157;4609.562091601292;4670.579647831712;4689.413823272091;4714.622830173578;4765.8093676252565;1451.1800832529586;1455.9563213103625;1457.453454954392;1460.4669295707204;1480.8667219950257;744.3077937518052;765.5712800831552;783.169839969634;784.901887264092;795.7612123249073;5179.119549676564;5925.4370834770625;5993.880122397528;6118.663473509;6157.599756015845;560.4591569135804;572.058963005853;588.0385569593745;591.9171316015761;593.27916581353;3874.825632846472;4162.729422587522;4173.64524015456;4239.894002649959;4308.5045219799495;11601.76796464066;15209.771853421986;15215.31531081104;15232.771508427382;15271.563898123055;14717.92641036788;15058.54824355271;15158.393664253306;15163.09021458716;15167.317470713844;8795.648174072965;10855;10871.945640271748;10880.183986201067;10885.18361122919;6340.71466784005;6510.502584405518;6551.246606640298;6635.668216589248;6646.401823835878;13157.60527184186;13542.390592423562;13587.388567514683;13615.387307570985;13634.250116243702;12240.816387754368;12519.687007824878;12526.436310366238;13107.279099649611;13780.310984450536;9178.219851312713;9499.050094990445;9499.335046546952;9508.28687848428;9512.524373781145;10270.6405275815;10546.36721796664;10665.933406659273;10674.8932510677;10676.412797296223;8825.426347287663;9068.591913363782;9077.409968352036;9134.040925702971;9158.129977652112;8771.956140219258;8774.99087604908;8879.822403552022;8913.55432228373;8915.910840891507;7822.491538050009;7989.360851132012;7998.440109192534;7999.840003199787;8013.8397232056195;5625.718714064362;5662.915056274242;5833.504152147115;5901.9933222704485;5933.3769954154195;5918.319393269829;6091.1472393864005;6196.411340922605;6196.597221180609;6216.813495594958 05:02:03 INFO - PID 1642 | |4;prototype.html;357.983327350325;382.8468612554979;389.53645162256913;405.4911086586334;407.3055440473992;4446.577575130365;5805.767769289234;5928.88142237155;5976.402359764022;6126.019836826109;5707.857303567413;5734.741936612852;5764.849308497885;5915.746339513272;5922.851928701784;4505.819767209307;4514;4518.927129551904;4539.160255352754;4540.069285796404;3981.825361518359;4161.271777438951;4356.194104090738;4399.362092496586;4539.659525535581;3696.981515092421;4093;4169.873364584068;4226.562968590679;4312.202242585132;4194.832206711728;4281.752080157911;4294.978525107385;4302.397664326997;4315.223259813232;3125.1874512626655;3697.7596456230526;3715.3126671565847;3732.1416074302792;3732.216234590739;4184.581541845791;5474.39781624021;5738.42615738427;5749.310082790092;5761.740721667535;5078.5175408336145;5083.466236045199;5153.149730294497;5162.6128040397125;5170.741462926839;5166.276721259027;5665;6049.909251361233;6225.501959843202;6249.781257656005;4030.8992275193064;4241.384999175102;4246.978765106154;4253;4285.1429714057;6450.161479007746;6629.801105966829;6639.568428052209;6652.866942661168;6657.866842663119;3827.7894715790344;4118.897027574335;4322.805473753689;4328.7402755834755;4329.307310830315;3841.961580384216;4246.4691913510815;4343.500497442771;4365.192439398721;4374.234508960919;4016.457778199964;4486.416765820422;5066.341375621219;5113.309703190096;5129;5774.711264436762;5966.0454327307425;5991.58058935879;6151.8926593212755;6262.812115636538;1427.5217802036434;1458.8905832062637;1484.1911158418689;1498.6403263216966;1500.9174495402858;962.6438217859437;985.3841349156777;1002.9318775504065;1007.7732510185297;1008.7730260691433;5698.230738850285;5946.70266486674;5959.761609535657;5994.610350327215;6031.668258245751;6444.2266927968;6458.870822583522;6473.676316184172;6479.643619600873;6481.870362592722;5020.723860187652;5099.515546023122;5857.179994800731;5917.201177840936;5937.7921772737745;3057.908262752121;3362.915927101793;3379.442392005341;3387.187075101958;3396.371671240779;5838.474537291664;6492.9284937196735;6627.475680593394;6680.392588002424;6705.631190284484;6629.171353580802;6636.668166591651;6648;6648.33516648341;6649.335066493312;5638.971805140948;6266.091416744638;6386.457151142205;6690.698918548677;6718.966405167846;5678.716064196857;6441.808265470903;6447.935520644921;6478.870422591616;6538.444232240313;6090.756369745161;6134.539909506894;6340.904886426615;6345.619262844244;6411.711472983634;4930.580900623344;5612.719364031864;6674.365935236145;6745.628990405575;6777.254502004677;4020.8592699255387;4083.1221287423346;4773.355596994361;4776;4784.162771515041;6034.336223015377;6203.844903877439;6594.505412094208;6605.834854128685;6656.83357916056;6293.465055470337;6313.936860631335;6322.8735425290315;6355.5551111421755;6359.300476947439;5384.730763461889;5711.371749107512;5776.3717508534355;6252.187215662117;6283.183186185949;5904.822855314347;6161.599496032743;6190.783322583688;6203.286622038523;6246.250449946036;6298.149749783904;6311.2426508819235;6317.6209427434505;6336.809895703136;6377.74489020434;5999.340072592098;6112.755489780537;6192.876142477216;6196.132541444112;6196.938030619816 05:02:03 INFO - PID 1642 | |5;yui.html;716.9856602867943;749.306891125709;792.3502727763237;813.1502579804104;833.8332333533294;16166.83833161668;16263.512094637164;16756.664866702675;16937;16976.236069376875;14699.559013229593;15295.2352382381;15342.539723808275;15397.69204615907;15653.84346156538;928.18783564381;948.5209968965697;951.6241084771546;955.0258736089185;955.126059655418;935.036911980661;994.8855881573603;999.9600015999351;1003.282652903174;1004.2769206171545;884.3676771108657;1063.0485715284815;1063.346042184055;1065.5151905882806;1066.7546464313173;1052.6263176572322;1054.3094273251033;1054.5781687325054;1054.699410667956;1056.5456853552969;785.1324286663269;787.1341524323255;787.1616728184465;787.8030492376906;788.2826627768703;15603.219839008118;15864.444744434004;15878.603034924105;16762.74855877163;16801.915990420093;14595.70808583833;14753.483628073072;14789;14824.629384265372;14898.702025959421;12772.297523636196;12840.422181001877;12968.35158242084;12990.22058676473;13125.803112953314;3306.6197387300285;3365.663433656615;3367.7979321240805;3376.544166537535;3379.6282408935;118747.406262969;119279;119454;121771;122364.26996515277;11456.94271528637;11546.94226528862;11612.825807612893;11949.402529873472;12031.75936481283;24108.517829643308;25104.246872593852;25167.874160629446;25703.10039148621;25826.741732582435;7763.767086987399;7798.181190974866;7861.056673199253;7882.763517094496;7913.507693688026;4098.856540021085;4155.688323375759;4168.2080404723;4219.662427005894;4252.255855225385;4196.118815048813;4238.004069043834;4282.828686852553;4288.206681763883;4335;855.4012191465998;879.134052957836;884.7168905950034;885.7387070814125;885.9158379953894;603.6378173096107;618.4557589321369;631.8767840271195;633.1357696743911;656.0069657451544;9431.48126853016;9820.459874706818;9862.556184971694;10021.599136034623;10217.540210690537;596.2008370699524;613.5613036678797;627.3162253144095;633.8288662061218;647.439964430764;4416.492103408085;4722.834700785456;5096.286519887219;5132.870768430939;5145.288729510241;100157.99842001486;102478;104530.47734761277;104557.49867514567;106264.46867765766;89441;89707;90471.54764226137;91585.1682966337;91725;43365.30972404307;68662.65668671725;77100.61449692716;77514.6124269375;78441.60779196068;10527.473626318806;10750.139988801033;10804.837927431252;10982.121430285399;11054.834177487182;37870.16456188194;38631.80684096674;38891;39137;39744.60255397409;51644.48355516397;61379.46551336074;67653;67853;69137.65431172813;13667.931660341636;13688.178709277476;13906.930465347608;14004.859951400764;14146.22195779242;14515.274236287933;14544.709105818036;14849;15001;15221;13819.585412437644;13972.37124329428;13982.860171398155;14014.159150451005;14626.85373146255;13338.26639534835;13546.458141674222;13946.232957187452;13974.930125349309;13978.510752123628;13500.32498375097;13555.254461004739;13628.31858407056;13669.794953075512;13697.794533081813;8818.691345802867;9853;10233.334833236113;10750.301230419998;10824.729381765519;10098.495075246356;11126.388048657402;11198.429264858194;11249.831252531383;11385.430728463709 05:02:03 INFO - PID 1642 | __end_tp_report 05:02:03 INFO - PID 1642 | __start_cc_report 05:02:03 INFO - PID 1642 | _x_x_mozilla_cycle_collect,2062 05:02:03 INFO - PID 1642 | __end_cc_report 05:02:03 INFO - PID 1642 | __startTimestamp1491566523805__endTimestamp 05:02:03 INFO - PID 1642 | 05:02:03 INFO - PID 1642 | ------- Summary: start ------- 05:02:03 INFO - PID 1642 | Number of tests: 6 05:02:03 INFO - PID 1642 | 05:02:03 INFO - PID 1642 | [#0] dojo.html Cycles:165 Average:6176.71 Median:6376.59 stddev:733.63 (11.5%) stddev-sans-first:706.39 05:02:03 INFO - PID 1642 | Values: 3551.8 3568.9 3582.8 3586.2 3613.8 6103.3 6192.5 6259.6 6262.0 6278.6 6168.0 6207.3 6250.0 6251.2 6264.4 5258.6 5426.6 5434.4 5438.5 5456.5 4549.3 5496.0 5525.2 5536.9 5602.7 5367.4 5439.2 5446.8 5449.0 5502.8 5450.0 5464.5 5469.2 5473.5 5475.2 5333.4 5409.5 5412.1 5413.8 5429.2 5411.8 6088.5 6222.8 6260.1 6265.5 6534.8 6536.4 6540.9 6544.3 6553.6 6742.4 6787.1 6800.4 6855.1 6861.3 6337.9 6349.4 6354.0 6366.6 6423.9 6669.6 6974.1 6974.6 6976.5 6994.7 6447.2 6476.6 6513.7 6577.8 6614.2 6784.3 6798.4 6811.4 6814.6 6818.4 6619.2 6720.3 6727.3 6727.7 6733.9 5422.6 6516.0 6518.9 6572.4 6723.0 5347.8 5378.4 5396.2 5404.3 5422.9 4741.0 4753.8 4762.9 4767.4 4799.1 6271.0 6304.2 6343.5 6343.8 6377.2 6647.6 6651.6 6752.5 6816.9 6847.5 6345.3 6357.8 6367.3 6370.8 6378.9 5919.6 5990.4 6004.2 6016.8 6016.8 5956.0 6787.6 6887.8 6902.7 7006.2 6557.2 6658.1 6730.5 6828.3 6835.9 6909.1 6992.0 7019.8 7051.8 7066.4 6677.2 6701.7 6703.0 6704.9 6719.2 6545.3 6765.9 6773.3 6807.8 6812.1 6376.6 6401.9 6509.7 6534.2 6604.4 6524.9 6554.4 6556.4 6556.5 6575.1 6249.1 6358.6 6371.5 6399.8 6424.9 6309.3 6359.3 6366.8 6580.1 6582.0 6319.1 6363.4 6398.8 6406.3 6411.7 05:02:03 INFO - PID 1642 | 05:02:03 INFO - PID 1642 | [#1] ext.html Cycles:180 Average:45318.99 Median:178444.00 stddev:84469.53 (47.3%) stddev-sans-first:84640.02 05:02:03 INFO - PID 1642 | Values: 689.7 813.7 1057.7 1092.8 1096.3 28056.7 37030.6 37377.4 37484.6 37737.0 39762.0 40169.8 40198.6 40220.0 40316.6 8384.7 8542.0 8548.2 8552.1 8554.0 6098.8 6235.7 6243.3 6256.2 7945.2 6420.7 7585.8 7591.7 7592.6 7606.4 7521.3 7554.7 7568.1 7572.5 7589.6 5983.4 6136.0 8415.8 8467.9 8492.4 27269.3 27613.9 27694.9 36376.5 37851.1 3414.2 3453.3 3463.6 3469.6 3473.9 29837.9 29882.0 29914.7 29931.0 30049.0 3103.0 3125.6 3130.6 3147.6 3150.8 226317.0 292609.0 292763.0 293888.0 294337.0 39496.0 49366.0 49510.3 49586.0 49727.0 41183.6 41197.8 49384.0 49645.3 50412.7 14172.6 14253.8 14261.6 14263.2 14296.8 11664.5 11686.5 11686.7 11702.8 11719.2 12238.8 12246.6 12291.0 12294.9 12381.9 4709.5 5113.7 5475.3 5665.3 5671.3 871.6 953.8 972.5 999.5 1011.8 21894.5 23149.4 23196.2 23212.2 23489.6 1047.5 1069.8 1075.5 1108.6 1116.8 8869.6 10829.8 11258.7 11842.1 11846.3 351488.0 351974.0 352335.0 353197.0 353942.0 41427.8 51660.0 51675.0 51765.0 51818.4 1429.4 1475.2 1516.5 1518.6 1523.3 22655.8 22748.8 22803.7 22833.5 22856.7 36691.3 36722.6 36738.8 36779.8 36817.8 321888.0 322322.0 323237.4 323705.0 324024.0 26078.9 26274.7 30656.2 31948.0 32864.0 39757.6 39782.4 39961.6 40646.2 41145.2 26658.5 27159.5 27545.7 29016.6 29138.9 21995.8 22901.9 28991.4 29177.0 29249.0 34413.0 34420.8 34472.3 34517.5 34647.3 25806.5 30130.7 30156.7 30338.4 30345.8 18632.8 20950.7 21537.9 23634.8 23944.3 05:02:03 INFO - PID 1642 | 05:02:03 INFO - PID 1642 | [#2] jquery.html Cycles:180 Average:41186.89 Median:22536.38 stddev:119245.61 (529.1%) stddev-sans-first:119540.74 05:02:03 INFO - PID 1642 | Values: 370.6 431.5 436.0 443.3 454.0 19962.3 21587.2 22303.3 22515.5 22557.2 22015.3 23305.9 23332.7 23373.4 23701.8 6203.5 6242.4 6452.7 6488.9 6496.4 6107.3 6360.2 6362.4 6380.4 6384.0 6247.3 6258.2 6323.9 6330.1 6341.1 6170.6 6308.1 6314.4 6332.2 6350.1 5403.7 5596.7 5649.4 5664.5 5667.8 27272.5 27397.3 27428.7 27554.6 27802.0 2188.3 2235.1 2244.2 2245.2 2247.7 17444.3 17896.7 18196.3 18268.6 18271.5 2065.6 2098.2 2142.4 2150.8 2163.4 146290.1 147192.3 147754.0 148617.0 151906.0 11964.8 12517.0 12542.2 12551.6 12619.9 16708.2 16721.0 16725.8 16760.4 16766.5 8718.1 8944.8 8974.9 9067.6 9086.0 8550.9 8553.4 8581.0 8739.0 8757.6 6234.8 7825.3 7836.8 7854.6 7863.1 2132.6 2149.2 2160.9 2168.2 2171.3 934.7 954.2 954.4 960.5 966.2 18297.2 19288.7 19613.9 21029.6 21211.8 827.5 972.6 984.7 1021.3 1021.9 10470.1 10793.9 10898.8 10907.2 10940.3 696110.0 700431.0 712799.0 723562.0 729600.0 122699.8 141315.0 162727.0 166664.0 167990.2 1189.9 1207.2 1237.6 1238.8 1242.4 19617.7 19905.7 21436.1 21791.0 22266.3 61777.7 63509.7 63786.4 64199.0 64210.4 87136.6 88328.0 89522.0 89676.6 90425.0 8695.3 8734.9 8872.0 8880.9 9343.9 12941.8 13661.8 14446.6 14876.4 15030.3 11979.8 12118.3 12220.3 12289.1 12332.6 9809.2 11039.1 11311.7 11432.4 11661.9 12159.9 12352.4 12395.1 12414.1 12428.9 8652.8 8680.8 8923.7 8993.2 9247.1 11847.9 11998.4 12162.6 12248.3 12258.4 05:02:03 INFO - PID 1642 | 05:02:03 INFO - PID 1642 | [#3] mootools.html Cycles:180 Average:7135.91 Median:2533.97 stddev:4517.75 (178.3%) stddev-sans-first:4509.42 05:02:03 INFO - PID 1642 | Values: 1338.6 1400.6 1420.3 1425.3 1428.5 11401.5 11946.7 11949.4 11985.5 12010.9 11318.7 11586.8 11669.8 11713.8 11729.6 2482.6 2517.2 2531.3 2535.0 2545.2 2153.2 2448.3 2469.6 2516.7 2521.0 2403.1 2504.3 2506.5 2508.3 2515.0 2493.7 2502.0 2511.9 2533.1 2534.8 2376.7 2417.6 2425.4 2427.4 2493.2 11632.8 11740.5 11748.4 11753.8 11773.4 6475.4 6748.9 6749.3 6753.2 6760.4 3871.2 4265.7 4281.0 4372.9 4379.1 1212.7 1228.6 1282.0 1287.4 1289.7 14997.7 15374.8 15434.9 16145.2 16474.3 5415.5 5577.1 5581.7 5581.9 5583.9 13233.7 13603.8 13615.3 13622.7 13632.3 6455.2 6504.2 6597.2 6602.7 6914.0 5973.7 6063.4 6123.8 6210.5 6236.2 4609.6 4670.6 4689.4 4714.6 4765.8 1451.2 1456.0 1457.5 1460.5 1480.9 744.3 765.6 783.2 784.9 795.8 5179.1 5925.4 5993.9 6118.7 6157.6 560.5 572.1 588.0 591.9 593.3 3874.8 4162.7 4173.6 4239.9 4308.5 11601.8 15209.8 15215.3 15232.8 15271.6 14717.9 15058.5 15158.4 15163.1 15167.3 8795.6 10855.0 10871.9 10880.2 10885.2 6340.7 6510.5 6551.2 6635.7 6646.4 13157.6 13542.4 13587.4 13615.4 13634.3 12240.8 12519.7 12526.4 13107.3 13780.3 9178.2 9499.1 9499.3 9508.3 9512.5 10270.6 10546.4 10665.9 10674.9 10676.4 8825.4 9068.6 9077.4 9134.0 9158.1 8772.0 8775.0 8879.8 8913.6 8915.9 7822.5 7989.4 7998.4 7999.8 8013.8 5625.7 5662.9 5833.5 5902.0 5933.4 5918.3 6091.1 6196.4 6196.6 6216.8 05:02:03 INFO - PID 1642 | 05:02:03 INFO - PID 1642 | [#4] prototype.html Cycles:180 Average:5075.23 Median:5755.53 stddev:1591.32 (27.6%) stddev-sans-first:1555.90 05:02:03 INFO - PID 1642 | Values: 358.0 382.8 389.5 405.5 407.3 4446.6 5805.8 5928.9 5976.4 6126.0 5707.9 5734.7 5764.8 5915.7 5922.9 4505.8 4514.0 4518.9 4539.2 4540.1 3981.8 4161.3 4356.2 4399.4 4539.7 3697.0 4093.0 4169.9 4226.6 4312.2 4194.8 4281.8 4295.0 4302.4 4315.2 3125.2 3697.8 3715.3 3732.1 3732.2 4184.6 5474.4 5738.4 5749.3 5761.7 5078.5 5083.5 5153.1 5162.6 5170.7 5166.3 5665.0 6049.9 6225.5 6249.8 4030.9 4241.4 4247.0 4253.0 4285.1 6450.2 6629.8 6639.6 6652.9 6657.9 3827.8 4118.9 4322.8 4328.7 4329.3 3842.0 4246.5 4343.5 4365.2 4374.2 4016.5 4486.4 5066.3 5113.3 5129.0 5774.7 5966.0 5991.6 6151.9 6262.8 1427.5 1458.9 1484.2 1498.6 1500.9 962.6 985.4 1002.9 1007.8 1008.8 5698.2 5946.7 5959.8 5994.6 6031.7 6444.2 6458.9 6473.7 6479.6 6481.9 5020.7 5099.5 5857.2 5917.2 5937.8 3057.9 3362.9 3379.4 3387.2 3396.4 5838.5 6492.9 6627.5 6680.4 6705.6 6629.2 6636.7 6648.0 6648.3 6649.3 5639.0 6266.1 6386.5 6690.7 6719.0 5678.7 6441.8 6447.9 6478.9 6538.4 6090.8 6134.5 6340.9 6345.6 6411.7 4930.6 5612.7 6674.4 6745.6 6777.3 4020.9 4083.1 4773.4 4776.0 4784.2 6034.3 6203.8 6594.5 6605.8 6656.8 6293.5 6313.9 6322.9 6355.6 6359.3 5384.7 5711.4 5776.4 6252.2 6283.2 5904.8 6161.6 6190.8 6203.3 6246.3 6298.1 6311.2 6317.6 6336.8 6377.7 5999.3 6112.8 6192.9 6196.1 6196.9 05:02:03 INFO - PID 1642 | 05:02:03 INFO - PID 1642 | [#5] yui.html Cycles:180 Average:20634.36 Median:20542.38 stddev:29952.51 (145.8%) stddev-sans-first:29999.20 05:02:03 INFO - PID 1642 | Values: 717.0 749.3 792.4 813.2 833.8 16166.8 16263.5 16756.7 16937.0 16976.2 14699.6 15295.2 15342.5 15397.7 15653.8 928.2 948.5 951.6 955.0 955.1 935.0 994.9 1000.0 1003.3 1004.3 884.4 1063.0 1063.3 1065.5 1066.8 1052.6 1054.3 1054.6 1054.7 1056.5 785.1 787.1 787.2 787.8 788.3 15603.2 15864.4 15878.6 16762.7 16801.9 14595.7 14753.5 14789.0 14824.6 14898.7 12772.3 12840.4 12968.4 12990.2 13125.8 3306.6 3365.7 3367.8 3376.5 3379.6 118747.4 119279.0 119454.0 121771.0 122364.3 11456.9 11546.9 11612.8 11949.4 12031.8 24108.5 25104.2 25167.9 25703.1 25826.7 7763.8 7798.2 7861.1 7882.8 7913.5 4098.9 4155.7 4168.2 4219.7 4252.3 4196.1 4238.0 4282.8 4288.2 4335.0 855.4 879.1 884.7 885.7 885.9 603.6 618.5 631.9 633.1 656.0 9431.5 9820.5 9862.6 10021.6 10217.5 596.2 613.6 627.3 633.8 647.4 4416.5 4722.8 5096.3 5132.9 5145.3 100158.0 102478.0 104530.5 104557.5 106264.5 89441.0 89707.0 90471.5 91585.2 91725.0 43365.3 68662.7 77100.6 77514.6 78441.6 10527.5 10750.1 10804.8 10982.1 11054.8 37870.2 38631.8 38891.0 39137.0 39744.6 51644.5 61379.5 67653.0 67853.0 69137.7 13667.9 13688.2 13906.9 14004.9 14146.2 14515.3 14544.7 14849.0 15001.0 15221.0 13819.6 13972.4 13982.9 14014.2 14626.9 13338.3 13546.5 13946.2 13974.9 13978.5 13500.3 13555.3 13628.3 13669.8 13697.8 8818.7 9853.0 10233.3 10750.3 10824.7 10098.5 11126.4 11198.4 11249.8 11385.4 05:02:03 INFO - PID 1642 | -------- Summary: end -------- 05:02:03 INFO - PID 1642 | 05:02:04 INFO - TEST-INFO | 1642: exit 0 05:02:04 INFO - TEST-OK | dromaeo_css | took 1121763ms 05:02:04 INFO - TEST-START | kraken 05:02:04 INFO - operating with platform_type : mac_ 05:02:04 INFO - Initialising browser for kraken test... 05:02:04 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpXfPw4Y/profile http://localhost:49243/getInfo.html) 05:02:07 INFO - PID 1653 | __metrics Screen width/height:1600/1200 05:02:07 INFO - PID 1653 | colorDepth:24 05:02:07 INFO - PID 1653 | Browser inner width/height: 1024/689 05:02:07 INFO - PID 1653 | __metrics 05:02:07 INFO - PID 1653 | 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" 05:02:07 INFO - PID 1653 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:02:08 INFO - TEST-INFO | 1653: exit 0 05:02:08 INFO - Browser initialized. 05:02:08 INFO - Running cycle 1/1 for kraken test... 05:02:08 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpXfPw4Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:02:20 INFO - PID 1655 | RSS: Main: 236941312 05:02:20 INFO - PID 1655 | 05:02:23 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 05:02:24 INFO - PID 1655 | RSS: Main: 291913728 05:02:24 INFO - PID 1655 | 05:02:27 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 05:02:27 INFO - PID 1655 | RSS: Main: 292245504 05:02:27 INFO - PID 1655 | 05:02:31 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 05:02:31 INFO - PID 1655 | RSS: Main: 384909312 05:02:31 INFO - PID 1655 | 05:02:34 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 05:02:34 INFO - PID 1655 | RSS: Main: 290263040 05:02:34 INFO - PID 1655 | 05:02:36 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:02:37 INFO - PID 1655 | RSS: Main: 291811328 05:02:37 INFO - PID 1655 | 05:02:40 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 05:02:41 INFO - PID 1655 | RSS: Main: 334462976 05:02:41 INFO - PID 1655 | 05:02:44 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 05:02:45 INFO - PID 1655 | RSS: Main: 348884992 05:02:45 INFO - PID 1655 | 05:02:48 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 05:02:49 INFO - PID 1655 | RSS: Main: 356200448 05:02:49 INFO - PID 1655 | 05:02:50 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:02:51 INFO - PID 1655 | RSS: Main: 309202944 05:02:51 INFO - PID 1655 | 05:02:53 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:02:54 INFO - PID 1655 | RSS: Main: 311615488 05:02:54 INFO - PID 1655 | 05:02:56 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:02:57 INFO - PID 1655 | RSS: Main: 313585664 05:02:57 INFO - PID 1655 | 05:03:00 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:03:00 INFO - PID 1655 | RSS: Main: 330440704 05:03:00 INFO - PID 1655 | 05:03:04 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:03:05 INFO - PID 1655 | RSS: Main: 313630720 05:03:05 INFO - PID 1655 | 05:03:06 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 05:03:07 INFO - PID 1655 | RSS: Main: 379510784 05:03:07 INFO - PID 1655 | 05:03:07 INFO - PID 1655 | __start_tp_report 05:03:07 INFO - PID 1655 | _x_x_mozilla_page_load 05:03:07 INFO - PID 1655 | _x_x_mozilla_page_load_details 05:03:07 INFO - PID 1655 | |i|pagename|runs| 05:03:07 INFO - PID 1655 | |0;ai-astar;113;125;123;124;121;123;129;175;124;122 05:03:07 INFO - PID 1655 | |1;audio-beat-detection;156;116;117;162;116;118;118;120;146;116 05:03:07 INFO - PID 1655 | |2;audio-dft;213;220;219;214;210;213;214;217;211;215 05:03:07 INFO - PID 1655 | |3;audio-fft;83;66;67;98;91;66;63;63;86;83 05:03:07 INFO - PID 1655 | |4;audio-oscillator;96;76;100;110;115;100;91;74;75;92 05:03:07 INFO - PID 1655 | |5;imaging-gaussian-blur;93;93;113;126;92;94;94;92;117;140 05:03:07 INFO - PID 1655 | |6;imaging-darkroom;101;101;98;99;99;100;101;100;99;98 05:03:07 INFO - PID 1655 | |7;imaging-desaturate;102;102;102;102;100;103;130;157;102;101 05:03:07 INFO - PID 1655 | |8;json-parse-financial;54;50;52;51;51;53;51;52;51;51 05:03:07 INFO - PID 1655 | |9;json-stringify-tinderbox;58;70;84;91;60;93;100;95;73;65 05:03:07 INFO - PID 1655 | |10;stanford-crypto-aes;89;92;93;91;92;93;95;93;91;93 05:03:07 INFO - PID 1655 | |11;stanford-crypto-ccm;153;156;169;170;176;155;150;152;188;163 05:03:07 INFO - PID 1655 | |12;stanford-crypto-pbkdf2;203;208;211;261;236;268;219;208;204;203 05:03:07 INFO - PID 1655 | |13;stanford-crypto-sha256-iterative;84;76;74;73;71;72;76;74;73;74 05:03:07 INFO - PID 1655 | __end_tp_report 05:03:07 INFO - PID 1655 | __start_cc_report 05:03:07 INFO - PID 1655 | _x_x_mozilla_cycle_collect,2134 05:03:07 INFO - PID 1655 | __end_cc_report 05:03:07 INFO - PID 1655 | __startTimestamp1491566587229__endTimestamp 05:03:07 INFO - PID 1655 | 05:03:07 INFO - PID 1655 | ------- Summary: start ------- 05:03:07 INFO - PID 1655 | Number of tests: 14 05:03:07 INFO - PID 1655 | 05:03:07 INFO - PID 1655 | [#0] ai-astar Cycles:10 Average:127.90 Median:124.00 stddev:17.03 (13.7%) stddev-sans-first:17.19 05:03:07 INFO - PID 1655 | Values: 113.0 125.0 123.0 124.0 121.0 123.0 129.0 175.0 124.0 122.0 05:03:07 INFO - PID 1655 | 05:03:07 INFO - PID 1655 | [#1] audio-beat-detection Cycles:10 Average:128.50 Median:119.00 stddev:18.49 (15.5%) stddev-sans-first:16.73 05:03:07 INFO - PID 1655 | Values: 156.0 116.0 117.0 162.0 116.0 118.0 118.0 120.0 146.0 116.0 05:03:07 INFO - PID 1655 | 05:03:07 INFO - PID 1655 | [#2] audio-dft Cycles:10 Average:214.60 Median:214.50 stddev:3.24 (1.5%) stddev-sans-first:3.38 05:03:07 INFO - PID 1655 | Values: 213.0 220.0 219.0 214.0 210.0 213.0 214.0 217.0 211.0 215.0 05:03:07 INFO - PID 1655 | 05:03:07 INFO - PID 1655 | [#3] audio-fft Cycles:10 Average:76.60 Median:83.00 stddev:13.01 (15.7%) stddev-sans-first:13.59 05:03:07 INFO - PID 1655 | Values: 83.0 66.0 67.0 98.0 91.0 66.0 63.0 63.0 86.0 83.0 05:03:07 INFO - PID 1655 | 05:03:07 INFO - PID 1655 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:75.50 stddev:14.37 (19.0%) stddev-sans-first:15.20 05:03:07 INFO - PID 1655 | Values: 96.0 76.0 100.0 110.0 115.0 100.0 91.0 74.0 75.0 92.0 05:03:07 INFO - PID 1655 | 05:03:07 INFO - PID 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:105.40 Median:92.50 stddev:17.45 (18.9%) stddev-sans-first:17.92 05:03:07 INFO - PID 1655 | Values: 93.0 93.0 113.0 126.0 92.0 94.0 94.0 92.0 117.0 140.0 05:03:07 INFO - PID 1655 | 05:03:07 INFO - PID 1655 | [#6] imaging-darkroom Cycles:10 Average:99.60 Median:98.00 stddev:1.17 (1.2%) stddev-sans-first:1.13 05:03:07 INFO - PID 1655 | Values: 101.0 101.0 98.0 99.0 99.0 100.0 101.0 100.0 99.0 98.0 05:03:07 INFO - PID 1655 | 05:03:07 INFO - PID 1655 | [#7] imaging-desaturate Cycles:10 Average:110.10 Median:102.00 stddev:18.73 (18.4%) stddev-sans-first:19.64 05:03:07 INFO - PID 1655 | Values: 102.0 102.0 102.0 102.0 100.0 103.0 130.0 157.0 102.0 101.0 05:03:07 INFO - PID 1655 | 05:03:07 INFO - PID 1655 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:51.50 stddev:1.17 (2.3%) stddev-sans-first:0.87 05:03:07 INFO - PID 1655 | Values: 54.0 50.0 52.0 51.0 51.0 53.0 51.0 52.0 51.0 51.0 05:03:07 INFO - PID 1655 | 05:03:07 INFO - PID 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:78.90 Median:78.50 stddev:15.55 (19.8%) stddev-sans-first:14.54 05:03:07 INFO - PID 1655 | Values: 58.0 70.0 84.0 91.0 60.0 93.0 100.0 95.0 73.0 65.0 05:03:07 INFO - PID 1655 | 05:03:07 INFO - PID 1655 | [#10] stanford-crypto-aes Cycles:10 Average:92.20 Median:93.00 stddev:1.62 (1.7%) stddev-sans-first:1.24 05:03:07 INFO - PID 1655 | Values: 89.0 92.0 93.0 91.0 92.0 93.0 95.0 93.0 91.0 93.0 05:03:07 INFO - PID 1655 | 05:03:07 INFO - PID 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:163.20 Median:166.00 stddev:12.39 (7.5%) stddev-sans-first:12.58 05:03:07 INFO - PID 1655 | Values: 153.0 156.0 169.0 170.0 176.0 155.0 150.0 152.0 188.0 163.0 05:03:07 INFO - PID 1655 | 05:03:07 INFO - PID 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:222.10 Median:215.00 stddev:24.50 (11.4%) stddev-sans-first:24.99 05:03:07 INFO - PID 1655 | Values: 203.0 208.0 211.0 261.0 236.0 268.0 219.0 208.0 204.0 203.0 05:03:07 INFO - PID 1655 | 05:03:07 INFO - PID 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.70 Median:74.00 stddev:3.62 (4.9%) stddev-sans-first:1.66 05:03:07 INFO - PID 1655 | Values: 84.0 76.0 74.0 73.0 71.0 72.0 76.0 74.0 73.0 74.0 05:03:07 INFO - PID 1655 | -------- Summary: end -------- 05:03:07 INFO - PID 1655 | 05:03:08 INFO - TEST-INFO | 1655: exit 0 05:03:08 INFO - TEST-OK | kraken | took 63844ms 05:03:08 INFO - SUITE-END | took 1185s 05:03:08 INFO - Completed test suite (00:19:45) 05:03:08 INFO - javascript benchmark 05:03:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7700.256803165608, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3551.7868927864324, 3568.9107772305674, 3582.7898838873866, 3586.211033572613, 3613.8012409317494, 6103.307364981957, 6192.50459963203, 6259.593126446778, 6262.0293854452575, 6278.623282603047, 6168.0, 6207.286162091361, 6250.000000000001, 6251.218597675291, 6264.373562643734, 5258.553022993031, 5426.647267927592, 5434.375046869602, 5438.510534051935, 5456.508914197741, 4549.272116461367, 5496.0, 5525.226468294442, 5536.944630553703, 5602.747876345554, 5367.409584945653, 5439.184122381675, 5446.836594902159, 5449.0, 5502.80740174094, 5450.018996580614, 5464.453554644504, 5469.234307196995, 5473.480019398151, 5475.178723191553, 5333.386660534049, 5409.486098820645, 5412.079946409081, 5413.810516631938, 5429.212764149216, 5411.83764487066, 6088.4520393164385, 6222.844428889269, 6260.060990851363, 6265.530085243625, 6534.77128300512, 6536.444402225769, 6540.901886471706, 6544.312847151028, 6553.574017688835, 6742.359475849787, 6787.117674702306, 6800.4219641330055, 6855.07456493372, 6861.2795656455855, 6337.873242535124, 6349.428551430301, 6354.015127655221, 6366.586171898812, 6423.903641445382, 6669.566478178903, 6974.093367862146, 6974.58152510851, 6976.51164418496, 6994.650267486707, 6447.1618689571, 6476.579022363531, 6513.706883190173, 6577.83555411109, 6614.239362473281, 6784.253732089466, 6798.388145066869, 6811.352921472452, 6814.557053791487, 6818.420434263143, 6619.204343200284, 6720.260771315151, 6727.327267273234, 6727.663616819237, 6733.9326606734285, 5422.566194704415, 6516.0, 6518.902216466757, 6572.441342485942, 6722.957941519072, 5347.839564813062, 5378.354597448331, 5396.217548455452, 5404.297441332602, 5422.8915421691345, 4740.976295118571, 4753.786079626425, 4762.928556071662, 4767.356406885096, 4799.112164249625, 6271.0, 6304.18045654062, 6343.460805831463, 6343.777967771106, 6377.17096777416, 6647.567908085959, 6651.600903945779, 6752.459803215829, 6816.931830681729, 6847.452203823682, 6345.302016778151, 6357.809265722036, 6367.299597044322, 6370.77702280418, 6378.936210637927, 5919.6152250103605, 5990.371011043778, 6004.219451471281, 6016.759329626853, 6016.819495415145, 5955.970220148872, 6787.592744435349, 6887.793366199022, 6902.654867256718, 7006.159260888522, 6557.245916719638, 6658.067870498231, 6730.528862979544, 6828.283030281749, 6835.863282734417, 6909.1018167637885, 6992.0, 7019.824504387227, 7051.823704407226, 7066.399356054793, 6677.165354330708, 6701.698423571049, 6702.966485167543, 6704.899426508704, 6719.160104986877, 6545.345465453416, 6765.86468270622, 6773.322667733188, 6807.795766126826, 6812.114425124702, 6376.585521941059, 6401.93598064032, 6509.7396104155305, 6534.150560427114, 6604.4056034955165, 6524.902126468011, 6554.410103090745, 6556.377144171296, 6556.508261880283, 6575.079488871657, 6249.093881387264, 6358.618482891041, 6371.458426033839, 6399.776007839703, 6424.903626445701, 6309.305976342507, 6359.332270111571, 6366.840828979312, 6580.1116849224745, 6582.0, 6319.115323854756, 6363.395477429637, 6398.840028999126, 6406.327335629878, 6411.679416029273], "value": 6127.497204310384, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.6689588997281, 813.6745301879249, 1057.693268952004, 1092.836074588811, 1096.309325125171, 28056.71943280569, 37030.62969370306, 37377.43933840991, 37484.62515374846, 37737.0, 39762.0, 40169.79915100428, 40198.59801401985, 40220.0, 40316.596834031654, 8384.70653527125, 8541.95729021354, 8548.187922147386, 8552.102029286929, 8554.0, 6098.756049758004, 6235.659333243374, 6243.313235544087, 6256.249250089995, 7945.245201705829, 6420.711068001951, 7585.848283034336, 7591.696332146707, 7592.582407967559, 7606.42951778616, 7521.285477879593, 7554.660040298199, 7568.053993250871, 7572.469927105105, 7589.582572958485, 5983.431574000463, 6135.9693201534155, 8415.831683366298, 8467.915320846774, 8492.405531612789, 27269.318267043283, 27613.857921311763, 27694.892204312004, 36376.45435318472, 37851.053723656856, 3414.2488652496413, 3453.2920751245933, 3463.619001909788, 3469.60099588548, 3473.8610455581747, 29837.850810745807, 29882.0, 29914.70085299141, 29931.0, 30049.0, 3102.9506494025286, 3125.5934829326893, 3130.6086739157604, 3147.590813194293, 3150.763692723055, 226317.0, 292609.0, 292763.0, 293888.0, 294337.0, 39496.0, 49366.0, 49510.257346139835, 49586.0, 49727.0, 41183.58816411858, 41197.79401102975, 49384.012319754125, 49645.269510176564, 50412.747936260086, 14172.574822755334, 14253.78619320711, 14261.572152835432, 14263.215523146326, 14296.785548216785, 11664.533418663328, 11686.532538698357, 11686.70783230426, 11702.76594468106, 11719.179657423898, 12238.81641775374, 12246.632601021984, 12291.0, 12294.877051229374, 12381.938090309492, 4709.481956984729, 5113.744312784346, 5475.260839786578, 5665.3201615806365, 5671.291088613923, 871.6097823970756, 953.7997020625746, 972.5137431284357, 999.5452069308448, 1011.8330475471465, 21894.45263868384, 23149.421264468187, 23196.23796372302, 23212.18757343485, 23489.647655285185, 1047.4553232319151, 1069.7967386196754, 1075.5482697267166, 1108.6119858049617, 1116.832475128737, 8869.556522173865, 10829.783404331869, 11258.66224013281, 11842.11184161174, 11846.348450835114, 351488.0, 351974.0, 352335.0, 353197.0, 353942.0, 41427.7928610355, 51660.0, 51675.0, 51765.0, 51818.44544663666, 1429.4425174182077, 1475.2181343887758, 1516.4843953056013, 1518.5899807052035, 1523.3221216558748, 22655.773442266025, 22748.772512274667, 22803.657945131166, 22833.543329133656, 22856.657150143095, 36691.266174675824, 36722.63277367192, 36738.8163059183, 36779.81610091932, 36817.815910921345, 321888.0, 322322.0, 323237.38381307945, 323705.0, 324024.0, 26078.86960565185, 26274.73725262723, 30656.233594160323, 31948.041558753273, 32864.0, 39757.60242397539, 39782.40870365153, 39961.60038399695, 40646.1870762589, 41145.17709645731, 26658.466830663667, 27159.456810863277, 27545.724542755117, 29016.56475152832, 29138.854305728335, 21995.780042199374, 22901.885490573106, 28991.42017159687, 29176.978805741695, 29249.0, 34413.0, 34420.79527216536, 34472.310553789284, 34517.48223776595, 34647.30705385929, 25806.483870322114, 30130.69869301279, 30156.69843301539, 30338.393232134793, 30345.848270758506, 18632.81367186365, 20950.685739714223, 21537.892310538347, 23634.818259086634, 23944.28167154988], "value": 16563.733733690082, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.5701386391786, 431.5404094639207, 435.98474053408137, 443.26860679878195, 454.00119736579535, 19962.30131945384, 21587.244446444376, 22303.330900072982, 22515.54968900621, 22557.210497632586, 22015.33953981379, 23305.92146374382, 23332.65001024986, 23373.415664608394, 23701.76298237017, 6203.472704820096, 6242.4069713377385, 6452.677366131698, 6488.902666460007, 6496.415322620963, 6107.267127944653, 6360.204974378203, 6362.427381535661, 6380.393862583047, 6384.042393640944, 6247.250329960389, 6258.249010118792, 6323.93676063238, 6330.0504924261495, 6341.112244285804, 6170.598911070766, 6308.053791931201, 6314.368563143695, 6332.240131184241, 6350.110984462132, 5403.7027963462, 5596.748146333384, 5649.406812284733, 5664.546836253131, 5667.801626943037, 27272.454550909068, 27397.31506712348, 27428.725712742817, 27554.5866811998, 27802.0, 2188.2559929623844, 2235.1394713035434, 2244.2033078257145, 2245.1805091141778, 2247.685324054634, 17444.30222791087, 17896.731549026776, 18196.27214911402, 18268.63462730751, 18271.451856444328, 2065.555905480329, 2098.1607357057146, 2142.4108370198164, 2150.7526634437086, 2163.3618082665494, 146290.0741985165, 147192.26403868018, 147754.0, 148617.0, 151906.0, 11964.76070478603, 12517.0, 12542.1847579907, 12551.560695375618, 12619.936900315439, 16708.24812883423, 16721.0, 16725.83274167267, 16760.413385531447, 16766.497005089866, 8718.08460111679, 8944.776380590538, 8974.910250897537, 9067.591958361889, 9086.045965173695, 8550.914490855137, 8553.401261911606, 8581.0, 8739.0, 8757.56212189388, 6234.844128896814, 7825.334846538108, 7836.804079897935, 7854.567998760009, 7863.135055144044, 2132.637451633226, 2149.204794226115, 2160.902759375832, 2168.241115609524, 2171.283476452767, 934.705432975334, 954.2318433660831, 954.3510412919143, 960.519740129935, 966.1594412860716, 18297.176627051813, 19288.710669339973, 19613.901930490258, 21029.579408412053, 21211.788101971717, 827.4662842466576, 972.6255391674256, 984.670135504614, 1021.341234903483, 1021.8569400283966, 10470.110040646478, 10793.892061079447, 10898.836517452244, 10907.236493445384, 10940.343579385262, 696110.0, 700431.0, 712799.0, 723562.0, 729600.0, 122699.77905081703, 141315.0, 162727.0, 166664.0, 167990.16004919898, 1189.8810118988206, 1207.1791181996152, 1237.6348977051791, 1238.8451443569554, 1242.3850194153952, 19617.70573441428, 19905.701414478506, 21436.142554297654, 21791.0, 22266.332010039725, 61777.691111544154, 63509.68245158745, 63786.40533986502, 64199.0, 64210.357896420435, 87136.56431717801, 88328.0, 89522.0, 89676.5516172415, 90425.0, 8695.347848911231, 8734.90362313053, 8872.0, 8880.911190888008, 9343.906560934303, 12941.805872911726, 13661.79507307411, 14446.638834029234, 14876.404943802127, 15030.323635436212, 11979.820302695642, 12118.272903625812, 12220.327881966221, 12289.07831912628, 12332.643409224798, 9809.166220871306, 11039.061679757311, 11311.660650180507, 11432.428378581204, 11661.941690291495, 12159.878401215874, 12352.3823808811, 12395.132340736423, 12414.131010829155, 12428.875711242772, 8652.8367908023, 8680.782980425287, 8923.73228803137, 8993.235574975939, 9247.0752924707, 11847.940760296144, 11998.40007999579, 12162.574309899112, 12248.265104093784, 12258.448369823558], "value": 10725.504154424878, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.5917295224956, 1400.5588239704493, 1420.3040510150024, 1425.2517428350109, 1428.528585566763, 11401.54393824247, 11946.701332466693, 11949.402529873494, 11985.460654270557, 12010.939945300272, 11318.717032074203, 11586.768264634702, 11669.766604667902, 11713.824292635618, 11729.592448906144, 2482.615194644833, 2517.2070797698757, 2531.253280282321, 2534.974650253492, 2545.172818833877, 2153.214076861942, 2448.2532827487607, 2469.64190192422, 2516.672832531768, 2521.0, 2403.098837935774, 2504.3113143885394, 2506.4987002599555, 2508.3352911478473, 2514.9874250628723, 2493.7132229793624, 2502.0492212959143, 2511.949761004779, 2533.1134103063873, 2534.835235709673, 2376.738558758535, 2417.5890098683267, 2425.3936515871032, 2427.368884090132, 2493.1772515069983, 11632.825507617392, 11740.530378784924, 11748.412579370997, 11753.764924701458, 11773.352465614387, 6475.417212450902, 6748.932510674879, 6749.291324410915, 6753.189617245913, 6760.42536384408, 3871.2451072040963, 4265.7227280227, 4281.0, 4372.934405983913, 4379.1022840317655, 1212.721074152941, 1228.6068458093414, 1281.9615411537668, 1287.4335292471283, 1289.7033682253134, 14997.700045999129, 15374.769378459332, 15434.922825385913, 16145.192740363053, 16474.341026358932, 5415.539679127318, 5577.1355439906065, 5581.748821303051, 5581.888362232733, 5583.916241256385, 13233.669158271121, 13603.795943060863, 13615.31923403826, 13622.727545449035, 13632.318384080756, 6455.193100862392, 6504.1869766279215, 6597.241317248482, 6602.669866506655, 6913.965430172918, 5973.731182096816, 6063.393660633989, 6123.846903827351, 6210.534209934273, 6236.18929539157, 4609.562091601292, 4670.579647831712, 4689.413823272091, 4714.622830173578, 4765.8093676252565, 1451.1800832529586, 1455.9563213103625, 1457.453454954392, 1460.4669295707204, 1480.8667219950257, 744.3077937518052, 765.5712800831552, 783.169839969634, 784.901887264092, 795.7612123249073, 5179.119549676564, 5925.4370834770625, 5993.880122397528, 6118.663473509, 6157.599756015845, 560.4591569135804, 572.058963005853, 588.0385569593745, 591.9171316015761, 593.27916581353, 3874.825632846472, 4162.729422587522, 4173.64524015456, 4239.894002649959, 4308.5045219799495, 11601.76796464066, 15209.771853421986, 15215.31531081104, 15232.771508427382, 15271.563898123055, 14717.92641036788, 15058.54824355271, 15158.393664253306, 15163.09021458716, 15167.317470713844, 8795.648174072965, 10855.0, 10871.945640271748, 10880.183986201067, 10885.18361122919, 6340.71466784005, 6510.502584405518, 6551.246606640298, 6635.668216589248, 6646.401823835878, 13157.60527184186, 13542.390592423562, 13587.388567514683, 13615.387307570985, 13634.250116243702, 12240.816387754368, 12519.687007824878, 12526.436310366238, 13107.279099649611, 13780.310984450536, 9178.219851312713, 9499.050094990445, 9499.335046546952, 9508.28687848428, 9512.524373781145, 10270.6405275815, 10546.36721796664, 10665.933406659273, 10674.8932510677, 10676.412797296223, 8825.426347287663, 9068.591913363782, 9077.409968352036, 9134.040925702971, 9158.129977652112, 8771.956140219258, 8774.99087604908, 8879.822403552022, 8913.55432228373, 8915.910840891507, 7822.491538050009, 7989.360851132012, 7998.440109192534, 7999.840003199787, 8013.8397232056195, 5625.718714064362, 5662.915056274242, 5833.504152147115, 5901.9933222704485, 5933.3769954154195, 5918.319393269829, 6091.1472393864005, 6196.411340922605, 6196.597221180609, 6216.813495594958], "value": 5342.547691675659, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.983327350325, 382.8468612554979, 389.53645162256913, 405.4911086586334, 407.3055440473992, 4446.577575130365, 5805.767769289234, 5928.88142237155, 5976.402359764022, 6126.019836826109, 5707.857303567413, 5734.741936612852, 5764.849308497885, 5915.746339513272, 5922.851928701784, 4505.819767209307, 4514.0, 4518.927129551904, 4539.160255352754, 4540.069285796404, 3981.825361518359, 4161.271777438951, 4356.194104090738, 4399.362092496586, 4539.659525535581, 3696.981515092421, 4093.0, 4169.873364584068, 4226.562968590679, 4312.202242585132, 4194.832206711728, 4281.752080157911, 4294.978525107385, 4302.397664326997, 4315.223259813232, 3125.1874512626655, 3697.7596456230526, 3715.3126671565847, 3732.1416074302792, 3732.216234590739, 4184.581541845791, 5474.39781624021, 5738.42615738427, 5749.310082790092, 5761.740721667535, 5078.5175408336145, 5083.466236045199, 5153.149730294497, 5162.6128040397125, 5170.741462926839, 5166.276721259027, 5665.0, 6049.909251361233, 6225.501959843202, 6249.781257656005, 4030.8992275193064, 4241.384999175102, 4246.978765106154, 4253.0, 4285.1429714057, 6450.161479007746, 6629.801105966829, 6639.568428052209, 6652.866942661168, 6657.866842663119, 3827.7894715790344, 4118.897027574335, 4322.805473753689, 4328.7402755834755, 4329.307310830315, 3841.961580384216, 4246.4691913510815, 4343.500497442771, 4365.192439398721, 4374.234508960919, 4016.457778199964, 4486.416765820422, 5066.341375621219, 5113.309703190096, 5129.0, 5774.711264436762, 5966.0454327307425, 5991.58058935879, 6151.8926593212755, 6262.812115636538, 1427.5217802036434, 1458.8905832062637, 1484.1911158418689, 1498.6403263216966, 1500.9174495402858, 962.6438217859437, 985.3841349156777, 1002.9318775504065, 1007.7732510185297, 1008.7730260691433, 5698.230738850285, 5946.70266486674, 5959.761609535657, 5994.610350327215, 6031.668258245751, 6444.2266927968, 6458.870822583522, 6473.676316184172, 6479.643619600873, 6481.870362592722, 5020.723860187652, 5099.515546023122, 5857.179994800731, 5917.201177840936, 5937.7921772737745, 3057.908262752121, 3362.915927101793, 3379.442392005341, 3387.187075101958, 3396.371671240779, 5838.474537291664, 6492.9284937196735, 6627.475680593394, 6680.392588002424, 6705.631190284484, 6629.171353580802, 6636.668166591651, 6648.0, 6648.33516648341, 6649.335066493312, 5638.971805140948, 6266.091416744638, 6386.457151142205, 6690.698918548677, 6718.966405167846, 5678.716064196857, 6441.808265470903, 6447.935520644921, 6478.870422591616, 6538.444232240313, 6090.756369745161, 6134.539909506894, 6340.904886426615, 6345.619262844244, 6411.711472983634, 4930.580900623344, 5612.719364031864, 6674.365935236145, 6745.628990405575, 6777.254502004677, 4020.8592699255387, 4083.1221287423346, 4773.355596994361, 4776.0, 4784.162771515041, 6034.336223015377, 6203.844903877439, 6594.505412094208, 6605.834854128685, 6656.83357916056, 6293.465055470337, 6313.936860631335, 6322.8735425290315, 6355.5551111421755, 6359.300476947439, 5384.730763461889, 5711.371749107512, 5776.3717508534355, 6252.187215662117, 6283.183186185949, 5904.822855314347, 6161.599496032743, 6190.783322583688, 6203.286622038523, 6246.250449946036, 6298.149749783904, 6311.2426508819235, 6317.6209427434505, 6336.809895703136, 6377.74489020434, 5999.340072592098, 6112.755489780537, 6192.876142477216, 6196.132541444112, 6196.938030619816], "value": 4582.911915173638, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.9856602867943, 749.306891125709, 792.3502727763237, 813.1502579804104, 833.8332333533294, 16166.83833161668, 16263.512094637164, 16756.664866702675, 16937.0, 16976.236069376875, 14699.559013229593, 15295.2352382381, 15342.539723808275, 15397.69204615907, 15653.84346156538, 928.18783564381, 948.5209968965697, 951.6241084771546, 955.0258736089185, 955.126059655418, 935.036911980661, 994.8855881573603, 999.9600015999351, 1003.282652903174, 1004.2769206171545, 884.3676771108657, 1063.0485715284815, 1063.346042184055, 1065.5151905882806, 1066.7546464313173, 1052.6263176572322, 1054.3094273251033, 1054.5781687325054, 1054.699410667956, 1056.5456853552969, 785.1324286663269, 787.1341524323255, 787.1616728184465, 787.8030492376906, 788.2826627768703, 15603.219839008118, 15864.444744434004, 15878.603034924105, 16762.74855877163, 16801.915990420093, 14595.70808583833, 14753.483628073072, 14789.0, 14824.629384265372, 14898.702025959421, 12772.297523636196, 12840.422181001877, 12968.35158242084, 12990.22058676473, 13125.803112953314, 3306.6197387300285, 3365.663433656615, 3367.7979321240805, 3376.544166537535, 3379.6282408935, 118747.406262969, 119279.0, 119454.0, 121771.0, 122364.26996515277, 11456.94271528637, 11546.94226528862, 11612.825807612893, 11949.402529873472, 12031.75936481283, 24108.517829643308, 25104.246872593852, 25167.874160629446, 25703.10039148621, 25826.741732582435, 7763.767086987399, 7798.181190974866, 7861.056673199253, 7882.763517094496, 7913.507693688026, 4098.856540021085, 4155.688323375759, 4168.2080404723, 4219.662427005894, 4252.255855225385, 4196.118815048813, 4238.004069043834, 4282.828686852553, 4288.206681763883, 4335.0, 855.4012191465998, 879.134052957836, 884.7168905950034, 885.7387070814125, 885.9158379953894, 603.6378173096107, 618.4557589321369, 631.8767840271195, 633.1357696743911, 656.0069657451544, 9431.48126853016, 9820.459874706818, 9862.556184971694, 10021.599136034623, 10217.540210690537, 596.2008370699524, 613.5613036678797, 627.3162253144095, 633.8288662061218, 647.439964430764, 4416.492103408085, 4722.834700785456, 5096.286519887219, 5132.870768430939, 5145.288729510241, 100157.99842001486, 102478.0, 104530.47734761277, 104557.49867514567, 106264.46867765766, 89441.0, 89707.0, 90471.54764226137, 91585.1682966337, 91725.0, 43365.30972404307, 68662.65668671725, 77100.61449692716, 77514.6124269375, 78441.60779196068, 10527.473626318806, 10750.139988801033, 10804.837927431252, 10982.121430285399, 11054.834177487182, 37870.16456188194, 38631.80684096674, 38891.0, 39137.0, 39744.60255397409, 51644.48355516397, 61379.46551336074, 67653.0, 67853.0, 69137.65431172813, 13667.931660341636, 13688.178709277476, 13906.930465347608, 14004.859951400764, 14146.22195779242, 14515.274236287933, 14544.709105818036, 14849.0, 15001.0, 15221.0, 13819.585412437644, 13972.37124329428, 13982.860171398155, 14014.159150451005, 14626.85373146255, 13338.26639534835, 13546.458141674222, 13946.232957187452, 13974.930125349309, 13978.510752123628, 13500.32498375097, 13555.254461004739, 13628.31858407056, 13669.794953075512, 13697.794533081813, 8818.691345802867, 9853.0, 10233.334833236113, 10750.301230419998, 10824.729381765519, 10098.495075246356, 11126.388048657402, 11198.429264858194, 11249.831252531383, 11385.430728463709], "value": 7820.805678322901, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1638.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 125.0, 123.0, 124.0, 121.0, 123.0, 129.0, 175.0, 124.0, 122.0], "value": 127.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 116.0, 117.0, 162.0, 116.0, 118.0, 118.0, 120.0, 146.0, 116.0], "value": 128.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [213.0, 220.0, 219.0, 214.0, 210.0, 213.0, 214.0, 217.0, 211.0, 215.0], "value": 214.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 66.0, 67.0, 98.0, 91.0, 66.0, 63.0, 63.0, 86.0, 83.0], "value": 76.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 76.0, 100.0, 110.0, 115.0, 100.0, 91.0, 74.0, 75.0, 92.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 113.0, 126.0, 92.0, 94.0, 94.0, 92.0, 117.0, 140.0], "value": 105.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 101.0, 98.0, 99.0, 99.0, 100.0, 101.0, 100.0, 99.0, 98.0], "value": 99.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 102.0, 102.0, 102.0, 100.0, 103.0, 130.0, 157.0, 102.0, 101.0], "value": 110.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 50.0, 52.0, 51.0, 51.0, 53.0, 51.0, 52.0, 51.0, 51.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 70.0, 84.0, 91.0, 60.0, 93.0, 100.0, 95.0, 73.0, 65.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 93.0, 91.0, 92.0, 93.0, 95.0, 93.0, 91.0, 93.0], "value": 92.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 156.0, 169.0, 170.0, 176.0, 155.0, 150.0, 152.0, 188.0, 163.0], "value": 163.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 208.0, 211.0, 261.0, 236.0, 268.0, 219.0, 208.0, 204.0, 203.0], "value": 222.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 76.0, 74.0, 73.0, 71.0, 72.0, 76.0, 74.0, 73.0, 74.0], "value": 74.7, "unit": "score"}]}]} 05:03:08 INFO - Return code: 0 05:03:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:03:08 ERROR - # TBPL SUCCESS # 05:03:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:03:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:03:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:03:08 INFO - 2017-04-07 05:03:08.534 screenresolution[1659:9848] starting screenresolution argv=screenresolution get 05:03:08 INFO - 2017-04-07 05:03:08.537 screenresolution[1659:9848] Display 0: 1600x1200x32@60 05:03:08 INFO - 2017-04-07 05:03:08.544 screenresolution[1660:9851] starting screenresolution argv=screenresolution list 05:03:08 INFO - Available Modes on Display 0 05:03:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:03:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:03:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:03:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:03:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:03:08 INFO - Intel Iris: 05:03:08 INFO - Chipset Model: Intel Iris 05:03:08 INFO - Type: GPU 05:03:08 INFO - Bus: Built-In 05:03:08 INFO - VRAM (Dynamic, Max): 1536 MB 05:03:08 INFO - Vendor: Intel (0x8086) 05:03:08 INFO - Device ID: 0x0a2e 05:03:08 INFO - Revision ID: 0x0009 05:03:08 INFO - Displays: 05:03:08 INFO - Display: 05:03:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:03:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:03:08 INFO - Display Serial Number: 1600x1200 60 05:03:08 INFO - Main Display: Yes 05:03:08 INFO - Mirror: Off 05:03:08 INFO - Online: Yes 05:03:08 INFO - Rotation: Supported 05:03:08 INFO - Return code: 0 05:03:08 INFO - Running post-action listener: _resource_record_post_action 05:03:08 INFO - [mozharness: 2017-04-07 12:03:08.792088Z] Finished run-tests step (success) 05:03:08 INFO - Running post-run listener: _resource_record_post_run 05:03:08 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 39490560; Write bytes: 519700992; Read time: 385; Write time: 1633 05:03:08 INFO - TinderboxPrint: CPU usage
53.5% 05:03:08 INFO - TinderboxPrint: I/O read bytes / time
39,490,560 / 385 05:03:08 INFO - TinderboxPrint: I/O write bytes / time
519,700,992 / 1,633 05:03:08 INFO - TinderboxPrint: CPU idle
2,244.4 (46.5%) 05:03:08 INFO - TinderboxPrint: CPU system
961.7 (19.9%) 05:03:08 INFO - TinderboxPrint: CPU user
1,619.5 (33.6%) 05:03:08 INFO - TinderboxPrint: Swap in / out
246,423,552 / 0 05:03:08 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 206993920; Write bytes: 204867072; Read time: 16061; Write time: 394 05:03:08 INFO - run-tests - Wall time: 1187s; CPU: 53.0%; Read bytes: 37364736; Write bytes: 307633152; Read time: 361; Write time: 1209 05:03:09 INFO - Running post-run listener: _upload_blobber_files 05:03:09 INFO - Blob upload gear active. 05:03:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:03:09 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 05:03:09 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'] 05:03:09 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 05:03:09 INFO - (blobuploader) - INFO - Open directory for files ... 05:03:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:03:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:03:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:11 INFO - (blobuploader) - INFO - Done attempting. 05:03:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:03:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:03:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:12 INFO - (blobuploader) - INFO - Done attempting. 05:03:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:03:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:03:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:13 INFO - (blobuploader) - INFO - Done attempting. 05:03:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:03:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:03:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:16 INFO - (blobuploader) - INFO - Done attempting. 05:03:16 INFO - (blobuploader) - INFO - Iteration through files over. 05:03:16 INFO - Return code: 0 05:03:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:03:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:03:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6efc816eeacbdd713f7cbfd6ed366115f645b404d91ffcd42c3987cda51fa83e1c4e70f4709ae1a4e89c95b180565cb98b2dd9e6bc25aff6df123161eeec278", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d297361574d97b42f5cc6e2a1522ad94ad96cea620ef3c29de1726dca8a546306201acae8c398daee25fe5d9598e96309402fbc7015117315689c7f7b3ea746", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d04a7fba9e4073a5501f5dfc96acbe5971c1526fc4d76e5bc59e5ee4f000b0c07679fa8a957010d150f853a8b20780c85d3531e87334198444f826d2c24a0ba", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdf11880ab212c4752803af0187bf74493166dd4208c299529ed7c55e8f8542ed5b8c53d13024db5cb416a1635dded4a077f7ba9bc6e06b2d383942b17bdb78e"} 05:03:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:03:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:03:16 INFO - Contents: 05:03:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6efc816eeacbdd713f7cbfd6ed366115f645b404d91ffcd42c3987cda51fa83e1c4e70f4709ae1a4e89c95b180565cb98b2dd9e6bc25aff6df123161eeec278", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d297361574d97b42f5cc6e2a1522ad94ad96cea620ef3c29de1726dca8a546306201acae8c398daee25fe5d9598e96309402fbc7015117315689c7f7b3ea746", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d04a7fba9e4073a5501f5dfc96acbe5971c1526fc4d76e5bc59e5ee4f000b0c07679fa8a957010d150f853a8b20780c85d3531e87334198444f826d2c24a0ba", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdf11880ab212c4752803af0187bf74493166dd4208c299529ed7c55e8f8542ed5b8c53d13024db5cb416a1635dded4a077f7ba9bc6e06b2d383942b17bdb78e"} 05:03:16 INFO - Running post-run listener: copy_logs_to_upload_dir 05:03:16 INFO - Copying logs to upload dir... 05:03:16 INFO - mkdir: /builds/slave/test/build/upload/logs 05:03:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1291.580063 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2017-04-07 05:03:16.518279) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-07 05:03:16.521590) ========= 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.fS9m2vcJHL/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.jl4NZQiwMN/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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/e6efc816eeacbdd713f7cbfd6ed366115f645b404d91ffcd42c3987cda51fa83e1c4e70f4709ae1a4e89c95b180565cb98b2dd9e6bc25aff6df123161eeec278", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d297361574d97b42f5cc6e2a1522ad94ad96cea620ef3c29de1726dca8a546306201acae8c398daee25fe5d9598e96309402fbc7015117315689c7f7b3ea746", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d04a7fba9e4073a5501f5dfc96acbe5971c1526fc4d76e5bc59e5ee4f000b0c07679fa8a957010d150f853a8b20780c85d3531e87334198444f826d2c24a0ba", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdf11880ab212c4752803af0187bf74493166dd4208c299529ed7c55e8f8542ed5b8c53d13024db5cb416a1635dded4a077f7ba9bc6e06b2d383942b17bdb78e"} build_url:https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010879 build_url: 'https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/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/e6efc816eeacbdd713f7cbfd6ed366115f645b404d91ffcd42c3987cda51fa83e1c4e70f4709ae1a4e89c95b180565cb98b2dd9e6bc25aff6df123161eeec278", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d297361574d97b42f5cc6e2a1522ad94ad96cea620ef3c29de1726dca8a546306201acae8c398daee25fe5d9598e96309402fbc7015117315689c7f7b3ea746", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d04a7fba9e4073a5501f5dfc96acbe5971c1526fc4d76e5bc59e5ee4f000b0c07679fa8a957010d150f853a8b20780c85d3531e87334198444f826d2c24a0ba", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdf11880ab212c4752803af0187bf74493166dd4208c299529ed7c55e8f8542ed5b8c53d13024db5cb416a1635dded4a077f7ba9bc6e06b2d383942b17bdb78e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-07 05:03:16.555421) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 05:03:16.555713) ========= 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.fS9m2vcJHL/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.jl4NZQiwMN/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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.005261 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 05:03:16.603620) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-07 05:03:16.603903) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-07 05:03:16.604206) ========= ========= Total master_lag: 0.17 =========