builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0252 starttime: 1492025131.66 results: success (0) buildid: 20170412105209 builduid: cf634f8262a14955b6d6a9c373814204 revision: bc086e9044e6537d18d385f417248cdb4c14c3af ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-12 12:25:31.662011) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-12 12:25:31.662451) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-12 12:25:31.662724) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-12 12:25:31.688050) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 12:25:31.688433) ========= 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.V1chTFqXn8/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.9E8Yt8U098/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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-12 12:25:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.93M=0.001s 2017-04-12 12:25:32 (7.93 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.359858 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 12:25:32.071886) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 12:25:32.072195) ========= 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.V1chTFqXn8/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.9E8Yt8U098/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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.021182 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 12:25:32.121147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 12:25:32.121538) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bc086e9044e6537d18d385f417248cdb4c14c3af --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 bc086e9044e6537d18d385f417248cdb4c14c3af --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.V1chTFqXn8/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.9E8Yt8U098/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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-12 12:25:32,200 truncating revision to first 12 chars 2017-04-12 12:25:32,201 Setting DEBUG logging. 2017-04-12 12:25:32,201 attempt 1/10 2017-04-12 12:25:32,201 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bc086e9044e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-12 12:25:32,880 unpacking tar archive at: mozilla-central-bc086e9044e6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.948103 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 12:25:33.093514) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-12 12:25:33.093836) ========= script_repo_revision: bc086e9044e6537d18d385f417248cdb4c14c3af ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-12 12:25:33.094214) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-12 12:25:33.094494) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-12 12:25:33.114665) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-04-12 12:25:33.115035) ========= /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.V1chTFqXn8/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.9E8Yt8U098/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 12:25:33 INFO - MultiFileLogger online at 20170412 12:25:33 in /builds/slave/test 12:25:33 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 12:25:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:25:33 INFO - {'append_to_log': False, 12:25:33 INFO - 'base_work_dir': '/builds/slave/test', 12:25:33 INFO - 'blob_upload_branch': 'Firefox', 12:25:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:25:33 INFO - 'branch': 'Firefox', 12:25:33 INFO - 'buildbot_json_path': 'buildprops.json', 12:25:33 INFO - 'config_files': ('talos/mac_config.py',), 12:25:33 INFO - 'default_actions': ('clobber', 12:25:33 INFO - 'read-buildbot-config', 12:25:33 INFO - 'download-and-extract', 12:25:33 INFO - 'populate-webroot', 12:25:33 INFO - 'create-virtualenv', 12:25:33 INFO - 'install', 12:25:33 INFO - 'run-tests'), 12:25:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:25:33 INFO - 'download_minidump_stackwalk': True, 12:25:33 INFO - 'download_symbols': 'ondemand', 12:25:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:25:33 INFO - 'tooltool.py': '/tools/tooltool.py', 12:25:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:25:33 INFO - '/tools/misc-python/virtualenv.py')}, 12:25:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:25:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:25:33 INFO - 'gecko_profile': False, 12:25:33 INFO - 'gecko_profile_interval': 0, 12:25:33 INFO - 'installer_path': 'installer.exe', 12:25:33 INFO - 'log_level': 'info', 12:25:33 INFO - 'log_name': 'talos', 12:25:33 INFO - 'log_to_console': True, 12:25:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:25:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:25:33 INFO - 'opt_config_files': (), 12:25:33 INFO - 'pip_index': False, 12:25:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:25:33 INFO - 'cmd': ('bash', 12:25:33 INFO - '-c', 12:25:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:25:33 INFO - 'enabled': True, 12:25:33 INFO - 'halt_on_failure': False, 12:25:33 INFO - 'name': 'check_screen_resolution'},), 12:25:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:25:33 INFO - 'cmd': ('bash', 12:25:33 INFO - '-c', 12:25:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:25:33 INFO - 'enabled': True, 12:25:33 INFO - 'halt_on_failure': False, 12:25:33 INFO - 'name': 'check_screen_resolution'},), 12:25:33 INFO - 'run_cmd_checks_enabled': True, 12:25:33 INFO - 'suite': 'dromaeojs', 12:25:33 INFO - 'system_bits': '32', 12:25:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:25:33 INFO - 'title': 't-yosemite-r7-0252', 12:25:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:25:33 INFO - 'use_talos_json': True, 12:25:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:25:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:25:33 INFO - 'work_dir': 'build'} 12:25:33 INFO - [mozharness: 2017-04-12 19:25:33.309349Z] Running clobber step. 12:25:33 INFO - Running pre-action listener: _resource_record_pre_action 12:25:33 INFO - Running main action method: clobber 12:25:33 INFO - rmtree: /builds/slave/test/build 12:25:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:25:35 INFO - Running post-action listener: _resource_record_post_action 12:25:35 INFO - [mozharness: 2017-04-12 19:25:35.072277Z] Finished clobber step (success) 12:25:35 INFO - [mozharness: 2017-04-12 19:25:35.072475Z] Running read-buildbot-config step. 12:25:35 INFO - Running pre-action listener: _resource_record_pre_action 12:25:35 INFO - Running main action method: read_buildbot_config 12:25:35 INFO - Using buildbot properties: 12:25:35 INFO - { 12:25:35 INFO - "project": "", 12:25:35 INFO - "product": "firefox", 12:25:35 INFO - "script_repo_revision": "production", 12:25:35 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 12:25:35 INFO - "repository": "", 12:25:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 12:25:35 INFO - "buildid": "20170412105209", 12:25:35 INFO - "pgo_build": "False", 12:25:35 INFO - "basedir": "/builds/slave/test", 12:25:35 INFO - "buildnumber": 5, 12:25:35 INFO - "slavename": "t-yosemite-r7-0252", 12:25:35 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 12:25:35 INFO - "platform": "yosemite_r7", 12:25:35 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 12:25:35 INFO - "branch": "mozilla-central", 12:25:35 INFO - "repo_path": "mozilla-central", 12:25:35 INFO - "revision": "bc086e9044e6537d18d385f417248cdb4c14c3af", 12:25:35 INFO - "stage_platform": "macosx64", 12:25:35 INFO - "builduid": "cf634f8262a14955b6d6a9c373814204", 12:25:35 INFO - "slavebuilddir": "test" 12:25:35 INFO - } 12:25:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/SyJLc0NPTFyk6yPLuOPEJA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 12:25:35 INFO - Running post-action listener: _resource_record_post_action 12:25:35 INFO - [mozharness: 2017-04-12 19:25:35.078119Z] Finished read-buildbot-config step (success) 12:25:35 INFO - [mozharness: 2017-04-12 19:25:35.078275Z] Running download-and-extract step. 12:25:35 INFO - Running pre-action listener: _resource_record_pre_action 12:25:35 INFO - Running main action method: download_and_extract 12:25:35 INFO - mkdir: /builds/slave/test/build/tests 12:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:25:35 INFO - trying https://queue.taskcluster.net/v1/task/SyJLc0NPTFyk6yPLuOPEJA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 12:25:35 INFO - Downloading https://queue.taskcluster.net/v1/task/SyJLc0NPTFyk6yPLuOPEJA/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 12:25:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SyJLc0NPTFyk6yPLuOPEJA/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 12:25:36 INFO - Downloaded 1325 bytes. 12:25:36 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 12:25:36 INFO - Using the following test package requirements: 12:25:36 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:25:36 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 12:25:36 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 12:25:36 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:25:36 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 12:25:36 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:25:36 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 12:25:36 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:25:36 INFO - u'jsshell-mac.zip'], 12:25:36 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:25:36 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 12:25:36 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 12:25:36 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:25:36 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 12:25:36 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:25:36 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 12:25:36 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:25:36 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 12:25:36 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:25:36 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 12:25:36 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:25:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SyJLc0NPTFyk6yPLuOPEJA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 12:25:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SyJLc0NPTFyk6yPLuOPEJA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:25:36 INFO - Fetch https://queue.taskcluster.net/v1/task/SyJLc0NPTFyk6yPLuOPEJA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 12:25:37 INFO - Expected file size: 52595264 12:25:37 INFO - Obtained file size: 52595264 12:25:53 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 12:25:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SyJLc0NPTFyk6yPLuOPEJA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 12:25:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SyJLc0NPTFyk6yPLuOPEJA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:25:53 INFO - Fetch https://queue.taskcluster.net/v1/task/SyJLc0NPTFyk6yPLuOPEJA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 12:25:55 INFO - Expected file size: 52595264 12:25:55 INFO - Obtained file size: 52595264 12:26:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SyJLc0NPTFyk6yPLuOPEJA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 12:26:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SyJLc0NPTFyk6yPLuOPEJA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:26:11 INFO - Fetch https://queue.taskcluster.net/v1/task/SyJLc0NPTFyk6yPLuOPEJA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 12:26:12 INFO - Expected file size: 14405596 12:26:12 INFO - Obtained file size: 14405596 12:26:12 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')]} 12:26:12 INFO - trying https://queue.taskcluster.net/v1/task/SyJLc0NPTFyk6yPLuOPEJA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:26:12 INFO - Downloading https://queue.taskcluster.net/v1/task/SyJLc0NPTFyk6yPLuOPEJA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 12:26:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SyJLc0NPTFyk6yPLuOPEJA/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 12:26:14 INFO - Downloaded 70938854 bytes. 12:26:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SyJLc0NPTFyk6yPLuOPEJA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:26:14 INFO - mkdir: /builds/slave/test/properties 12:26:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:26:14 INFO - Writing to file /builds/slave/test/properties/build_url 12:26:14 INFO - Contents: 12:26:14 INFO - build_url:https://queue.taskcluster.net/v1/task/SyJLc0NPTFyk6yPLuOPEJA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:26:15 INFO - Running post-action listener: _resource_record_post_action 12:26:15 INFO - Running post-action listener: set_extra_try_arguments 12:26:15 INFO - [mozharness: 2017-04-12 19:26:15.247016Z] Finished download-and-extract step (success) 12:26:15 INFO - [mozharness: 2017-04-12 19:26:15.247139Z] Running populate-webroot step. 12:26:15 INFO - Running pre-action listener: _resource_record_pre_action 12:26:15 INFO - Running main action method: populate_webroot 12:26:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:26:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:26:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:26:15 INFO - '--tppagecycles', 12:26:15 INFO - '7'], 12:26:15 INFO - 'tests': ['tsvgm']}}, 12:26:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:26:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:26:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:26:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:26:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:26:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:26:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:26:15 INFO - 'talos_options': ['--disable-e10s'], 12:26:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:26:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:26:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:26:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:26:15 INFO - 'talos_options': ['--disable-e10s'], 12:26:15 INFO - 'tests': ['damp', 'tps']}, 12:26:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:26:15 INFO - 'tests': ['damp', 'tps']}, 12:26:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:26:15 INFO - 'tests': ['dromaeo_dom']}, 12:26:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:26:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:26:15 INFO - 'tests': ['basic_compositor_video']}, 12:26:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:26:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:26:15 INFO - 'tests': ['a11yr', 12:26:15 INFO - 'ts_paint', 12:26:15 INFO - 'tpaint', 12:26:15 INFO - 'sessionrestore', 12:26:15 INFO - 'sessionrestore_no_auto_restore', 12:26:15 INFO - 'tabpaint']}, 12:26:15 INFO - 'other-e10s': {'tests': ['a11yr', 12:26:15 INFO - 'ts_paint', 12:26:15 INFO - 'tpaint', 12:26:15 INFO - 'sessionrestore', 12:26:15 INFO - 'sessionrestore_no_auto_restore', 12:26:15 INFO - 'tabpaint']}, 12:26:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:26:15 INFO - 'ts_paint', 12:26:15 INFO - 'tpaint', 12:26:15 INFO - 'sessionrestore', 12:26:15 INFO - 'sessionrestore_no_auto_restore', 12:26:15 INFO - 'tabpaint']}, 12:26:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:26:15 INFO - 'ts_paint', 12:26:15 INFO - 'tpaint', 12:26:15 INFO - 'sessionrestore', 12:26:15 INFO - 'sessionrestore_no_auto_restore', 12:26:15 INFO - 'tabpaint']}, 12:26:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:26:15 INFO - 'tests': ['a11yr', 12:26:15 INFO - 'ts_paint', 12:26:15 INFO - 'tpaint', 12:26:15 INFO - 'sessionrestore', 12:26:15 INFO - 'sessionrestore_no_auto_restore', 12:26:15 INFO - 'tabpaint']}, 12:26:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:26:15 INFO - 'tests': ['a11yr', 12:26:15 INFO - 'ts_paint', 12:26:15 INFO - 'tpaint', 12:26:15 INFO - 'sessionrestore', 12:26:15 INFO - 'sessionrestore_no_auto_restore', 12:26:15 INFO - 'tabpaint']}, 12:26:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:26:15 INFO - 'tests': ['tsvgx', 12:26:15 INFO - 'tsvgr_opacity', 12:26:15 INFO - 'tart', 12:26:15 INFO - 'tscrollx', 12:26:15 INFO - 'cart', 12:26:15 INFO - 'tsvg_static']}, 12:26:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:26:15 INFO - 'tsvgr_opacity', 12:26:15 INFO - 'tart', 12:26:15 INFO - 'tscrollx', 12:26:15 INFO - 'cart', 12:26:15 INFO - 'tsvg_static']}, 12:26:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:26:15 INFO - 'talos_options': ['--disable-e10s'], 12:26:15 INFO - 'tests': ['tp5o']}, 12:26:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:26:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:26:15 INFO - 'talos_options': ['--disable-e10s', 12:26:15 INFO - '--xperf_path', 12:26:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:26:15 INFO - 'tests': ['tp5n']}, 12:26:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:26:15 INFO - 'talos_options': ['--xperf_path', 12:26:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:26:15 INFO - 'tests': ['tp5n']}}, 12:26:15 INFO - 'talos.zip': {'path': '', 12:26:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:26:15 INFO - Running post-action listener: _resource_record_post_action 12:26:15 INFO - [mozharness: 2017-04-12 19:26:15.265320Z] Finished populate-webroot step (success) 12:26:15 INFO - [mozharness: 2017-04-12 19:26:15.265439Z] Running create-virtualenv step. 12:26:15 INFO - Running pre-action listener: _resource_record_pre_action 12:26:15 INFO - Running main action method: create_virtualenv 12:26:15 INFO - Creating virtualenv /builds/slave/test/build/venv 12:26:15 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 12:26:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:26:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:26:15 INFO - Using real prefix '/tools/python27' 12:26:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:26:16 INFO - Installing distribute.............................................................................................................................................................................................done. 12:26:18 INFO - Installing pip.................done. 12:26:18 INFO - Return code: 0 12:26:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:26:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:26:19 INFO - Reading from file tmpfile_stdout 12:26:19 INFO - Output received: 12:26:19 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) 12:26:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:26:19 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')]} 12:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:19 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')]} 12:26:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:19 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 0x10f0d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f158f880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eeb1d30>, '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 0x10edd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eea6be8>, '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.V1chTFqXn8/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.9E8Yt8U098/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 12:26:19 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 12:26:19 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 12:26:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1chTFqXn8/Render', 12:26:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:26:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:26:19 INFO - 'HOME': '/Users/cltbld', 12:26:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:26:19 INFO - 'LOGNAME': 'cltbld', 12:26:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:19 INFO - 'MOZ_NO_REMOTE': '1', 12:26:19 INFO - 'NO_EM_RESTART': '1', 12:26:19 INFO - 'PAGER': '/bin/cat', 12:26:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:26:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:19 INFO - 'PWD': '/builds/slave/test', 12:26:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:26:19 INFO - 'SHELL': '/bin/bash', 12:26:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9E8Yt8U098/Listeners', 12:26:19 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 12:26:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:26:19 INFO - 'USER': 'cltbld', 12:26:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:26:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:26:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:19 INFO - 'XPC_FLAGS': '0x0', 12:26:19 INFO - 'XPC_SERVICE_NAME': '0', 12:26:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:26:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:19 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 12:26:19 INFO - Cleaning up... 12:26:19 INFO - Return code: 0 12:26:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:26:19 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')]} 12:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:19 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')]} 12:26:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:19 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 0x10f0d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f158f880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eeb1d30>, '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 0x10edd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eea6be8>, '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.V1chTFqXn8/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.9E8Yt8U098/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 12:26:19 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 12:26:19 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 12:26:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1chTFqXn8/Render', 12:26:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:26:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:26:19 INFO - 'HOME': '/Users/cltbld', 12:26:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:26:19 INFO - 'LOGNAME': 'cltbld', 12:26:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:19 INFO - 'MOZ_NO_REMOTE': '1', 12:26:19 INFO - 'NO_EM_RESTART': '1', 12:26:19 INFO - 'PAGER': '/bin/cat', 12:26:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:26:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:19 INFO - 'PWD': '/builds/slave/test', 12:26:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:26:19 INFO - 'SHELL': '/bin/bash', 12:26:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9E8Yt8U098/Listeners', 12:26:19 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 12:26:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:26:19 INFO - 'USER': 'cltbld', 12:26:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:26:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:26:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:19 INFO - 'XPC_FLAGS': '0x0', 12:26:19 INFO - 'XPC_SERVICE_NAME': '0', 12:26:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:26:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:19 INFO - Downloading/unpacking psutil>=3.1.1 12:26:19 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 12:26:19 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 12:26:19 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 12:26:19 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 12:26:19 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 12:26:19 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 12:26:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:26:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:26:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:26:23 INFO - Installing collected packages: psutil 12:26:23 INFO - Running setup.py install for psutil 12:26:23 INFO - building 'psutil._psutil_osx' extension 12:26:23 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 12:26:23 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 12:26:23 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 12:26:23 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 12:26:23 INFO - building 'psutil._psutil_posix' extension 12:26:23 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 12:26:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:26:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:26:23 INFO - ^ 12:26:24 INFO - 1 warning generated. 12:26:24 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 12:26:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:26:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:26:24 INFO - Successfully installed psutil 12:26:24 INFO - Cleaning up... 12:26:24 INFO - Return code: 0 12:26:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:26:24 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')]} 12:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:24 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')]} 12:26:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:24 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 0x10f0d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f158f880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eeb1d30>, '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 0x10edd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eea6be8>, '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.V1chTFqXn8/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.9E8Yt8U098/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 12:26:24 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 12:26:24 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 12:26:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1chTFqXn8/Render', 12:26:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:26:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:26:24 INFO - 'HOME': '/Users/cltbld', 12:26:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:26:24 INFO - 'LOGNAME': 'cltbld', 12:26:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:24 INFO - 'MOZ_NO_REMOTE': '1', 12:26:24 INFO - 'NO_EM_RESTART': '1', 12:26:24 INFO - 'PAGER': '/bin/cat', 12:26:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:26:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:24 INFO - 'PWD': '/builds/slave/test', 12:26:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:26:24 INFO - 'SHELL': '/bin/bash', 12:26:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9E8Yt8U098/Listeners', 12:26:24 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 12:26:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:26:24 INFO - 'USER': 'cltbld', 12:26:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:26:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:26:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:24 INFO - 'XPC_FLAGS': '0x0', 12:26:24 INFO - 'XPC_SERVICE_NAME': '0', 12:26:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:26:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:26:24 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 12:26:24 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 12:26:24 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 12:26:24 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 12:26:24 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 12:26:24 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 12:26:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:26:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:26:27 INFO - Installing collected packages: mozsystemmonitor 12:26:27 INFO - Running setup.py install for mozsystemmonitor 12:26:27 INFO - Successfully installed mozsystemmonitor 12:26:27 INFO - Cleaning up... 12:26:27 INFO - Return code: 0 12:26:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:26:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:28 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 0x10f0d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f158f880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eeb1d30>, '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 0x10edd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eea6be8>, '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.V1chTFqXn8/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.9E8Yt8U098/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 12:26:28 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 12:26:28 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 12:26:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1chTFqXn8/Render', 12:26:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:26:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:26:28 INFO - 'HOME': '/Users/cltbld', 12:26:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:26:28 INFO - 'LOGNAME': 'cltbld', 12:26:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:28 INFO - 'MOZ_NO_REMOTE': '1', 12:26:28 INFO - 'NO_EM_RESTART': '1', 12:26:28 INFO - 'PAGER': '/bin/cat', 12:26:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:26:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:28 INFO - 'PWD': '/builds/slave/test', 12:26:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:26:28 INFO - 'SHELL': '/bin/bash', 12:26:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9E8Yt8U098/Listeners', 12:26:28 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 12:26:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:26:28 INFO - 'USER': 'cltbld', 12:26:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:26:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:26:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:28 INFO - 'XPC_FLAGS': '0x0', 12:26:28 INFO - 'XPC_SERVICE_NAME': '0', 12:26:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:26:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:28 INFO - Downloading/unpacking jsonschema==2.5.1 12:26:28 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 12:26:28 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 12:26:28 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 12:26:28 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 12:26:28 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 12:26:28 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 12:26:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:26:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:26:31 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 12:26:31 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 12:26:31 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 12:26:31 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 12:26:31 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 12:26:31 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 12:26:32 INFO - Downloading functools32-3.2.3-2.tar.gz 12:26:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:26:32 INFO - warning: no files found matching '*.txt' 12:26:32 INFO - no previously-included directories found matching 'build' 12:26:32 INFO - no previously-included directories found matching 'dist' 12:26:32 INFO - no previously-included directories found matching '.git*' 12:26:32 INFO - Installing collected packages: jsonschema, functools32 12:26:32 INFO - Running setup.py install for functools32 12:26:32 INFO - warning: no files found matching '*.txt' 12:26:32 INFO - no previously-included directories found matching 'build' 12:26:32 INFO - no previously-included directories found matching 'dist' 12:26:32 INFO - no previously-included directories found matching '.git*' 12:26:32 INFO - Successfully installed jsonschema functools32 12:26:32 INFO - Cleaning up... 12:26:32 INFO - Return code: 0 12:26:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:26:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:32 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 0x10f0d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f158f880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eeb1d30>, '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 0x10edd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eea6be8>, '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.V1chTFqXn8/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.9E8Yt8U098/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 12:26:32 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 12:26:32 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 12:26:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1chTFqXn8/Render', 12:26:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:26:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:26:32 INFO - 'HOME': '/Users/cltbld', 12:26:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:26:32 INFO - 'LOGNAME': 'cltbld', 12:26:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:32 INFO - 'MOZ_NO_REMOTE': '1', 12:26:32 INFO - 'NO_EM_RESTART': '1', 12:26:32 INFO - 'PAGER': '/bin/cat', 12:26:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:26:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:32 INFO - 'PWD': '/builds/slave/test', 12:26:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:26:32 INFO - 'SHELL': '/bin/bash', 12:26:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9E8Yt8U098/Listeners', 12:26:32 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 12:26:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:26:32 INFO - 'USER': 'cltbld', 12:26:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:26:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:26:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:32 INFO - 'XPC_FLAGS': '0x0', 12:26:32 INFO - 'XPC_SERVICE_NAME': '0', 12:26:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:26:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:26:32 INFO - Cleaning up... 12:26:33 INFO - Return code: 0 12:26:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:26: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')]} 12:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26: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')]} 12:26:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26: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', '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 0x10f0d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f158f880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eeb1d30>, '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 0x10edd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eea6be8>, '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.V1chTFqXn8/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.9E8Yt8U098/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 12:26: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:26: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 blobuploader==1.2.4 12:26:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1chTFqXn8/Render', 12:26:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:26:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:26:33 INFO - 'HOME': '/Users/cltbld', 12:26:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:26:33 INFO - 'LOGNAME': 'cltbld', 12:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:33 INFO - 'MOZ_NO_REMOTE': '1', 12:26:33 INFO - 'NO_EM_RESTART': '1', 12:26:33 INFO - 'PAGER': '/bin/cat', 12:26:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:33 INFO - 'PWD': '/builds/slave/test', 12:26:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:26:33 INFO - 'SHELL': '/bin/bash', 12:26:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9E8Yt8U098/Listeners', 12:26:33 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 12:26:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:26:33 INFO - 'USER': 'cltbld', 12:26:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:26:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:33 INFO - 'XPC_FLAGS': '0x0', 12:26:33 INFO - 'XPC_SERVICE_NAME': '0', 12:26:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:26:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:33 INFO - Downloading/unpacking blobuploader==1.2.4 12:26: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 12:26: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 12:26: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 12:26: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 12:26: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 12:26: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 12:26:35 INFO - Downloading blobuploader-1.2.4.tar.gz 12:26:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:26:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:26:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:26:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:26:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:26:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:26:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:26:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:26:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:26:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:26:36 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 12:26:36 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 12:26:36 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 12:26:36 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 12:26:36 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 12:26:36 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 12:26:37 INFO - Downloading docopt-0.6.1.tar.gz 12:26:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:26:37 INFO - Installing collected packages: blobuploader, requests, docopt 12:26:37 INFO - Running setup.py install for blobuploader 12:26:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:26:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:26:37 INFO - Running setup.py install for requests 12:26:37 INFO - Running setup.py install for docopt 12:26:38 INFO - Successfully installed blobuploader requests docopt 12:26:38 INFO - Cleaning up... 12:26:38 INFO - Return code: 0 12:26:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:26: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')]} 12:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26: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')]} 12:26:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:38 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 0x10f0d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f158f880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eeb1d30>, '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 0x10edd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eea6be8>, '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.V1chTFqXn8/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.9E8Yt8U098/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 12:26:38 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 12:26:38 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 12:26:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1chTFqXn8/Render', 12:26:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:26:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:26:38 INFO - 'HOME': '/Users/cltbld', 12:26:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:26:38 INFO - 'LOGNAME': 'cltbld', 12:26:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:38 INFO - 'MOZ_NO_REMOTE': '1', 12:26:38 INFO - 'NO_EM_RESTART': '1', 12:26:38 INFO - 'PAGER': '/bin/cat', 12:26:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:26:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:38 INFO - 'PWD': '/builds/slave/test', 12:26:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:26:38 INFO - 'SHELL': '/bin/bash', 12:26:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9E8Yt8U098/Listeners', 12:26:38 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 12:26:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:26:38 INFO - 'USER': 'cltbld', 12:26:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:26:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:26:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:38 INFO - 'XPC_FLAGS': '0x0', 12:26:38 INFO - 'XPC_SERVICE_NAME': '0', 12:26:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:26:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:26:38 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-N61cjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:26:38 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-6ODH8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:26:38 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-3uAYFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:26:38 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-C0dW1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:26:38 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-_RNtY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:26:38 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-4DxF2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:26:38 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-jHahKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:26:39 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-51spt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:26:39 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-kDYi6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:26:39 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-W_z0n6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:26:39 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-BEZroL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:26:39 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-zfHenJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:26:39 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-g0ihUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:26:39 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-BOQjKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:26:39 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-M4ErNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:26:39 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-nuBlDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:26:40 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-xITY0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:26:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:26:40 INFO - Running setup.py install for manifestparser 12:26:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:26:40 INFO - Running setup.py install for mozcrash 12:26:40 INFO - Running setup.py install for mozdebug 12:26:40 INFO - Running setup.py install for mozdevice 12:26:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:26:40 INFO - Running setup.py install for mozfile 12:26:40 INFO - Running setup.py install for mozhttpd 12:26:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:26:40 INFO - Running setup.py install for mozinfo 12:26:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:26:41 INFO - Running setup.py install for mozInstall 12:26:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:26:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:26:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:26:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:26:41 INFO - Running setup.py install for mozleak 12:26:41 INFO - Running setup.py install for mozlog 12:26:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:26:41 INFO - Running setup.py install for moznetwork 12:26:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:26:41 INFO - Running setup.py install for mozprocess 12:26:41 INFO - Running setup.py install for mozprofile 12:26:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:26:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:26:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:26:42 INFO - Running setup.py install for mozrunner 12:26:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:26:42 INFO - Running setup.py install for mozscreenshot 12:26:42 INFO - Running setup.py install for moztest 12:26:42 INFO - Running setup.py install for mozversion 12:26:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:26:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:26:42 INFO - Cleaning up... 12:26:42 INFO - Return code: 0 12:26:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:26: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')]} 12:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26: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')]} 12:26:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:42 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 0x10f0d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f158f880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eeb1d30>, '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 0x10edd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eea6be8>, '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.V1chTFqXn8/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.9E8Yt8U098/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 12:26:42 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 12:26:42 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 12:26:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1chTFqXn8/Render', 12:26:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:26:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:26:42 INFO - 'HOME': '/Users/cltbld', 12:26:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:26:42 INFO - 'LOGNAME': 'cltbld', 12:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:42 INFO - 'MOZ_NO_REMOTE': '1', 12:26:42 INFO - 'NO_EM_RESTART': '1', 12:26:42 INFO - 'PAGER': '/bin/cat', 12:26:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:42 INFO - 'PWD': '/builds/slave/test', 12:26:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:26:42 INFO - 'SHELL': '/bin/bash', 12:26:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9E8Yt8U098/Listeners', 12:26:42 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 12:26:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:26:42 INFO - 'USER': 'cltbld', 12:26:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:26:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:42 INFO - 'XPC_FLAGS': '0x0', 12:26:42 INFO - 'XPC_SERVICE_NAME': '0', 12:26:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:26:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:26:42 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-KK0dDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:26:43 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)) 12:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:26:43 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-ZSCI7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:26:43 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)) 12:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:26:43 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-_UbzPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:26:43 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)) 12:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:26:43 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-QonFV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:26:43 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)) 12:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:26:43 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-zdWlI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:26:43 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)) 12:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:26:43 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-l8Olyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:26:43 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)) 12:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:26:43 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-As1Rq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:26:43 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)) 12:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:26:43 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-SNOIpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:26:43 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)) 12:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:26:43 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-In4AUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:26:43 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)) 12:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:26:43 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-D1ByIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:26:44 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)) 12:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:26:44 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-kU8cCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:26:44 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)) 12:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:26:44 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-kVu5GL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:26:44 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)) 12:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:26:44 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-NPhhIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:26:44 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)) 12:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:26:44 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-QTHReO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:26:44 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)) 12:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:26:44 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-1Zteil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:26:44 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)) 12:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:26:44 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-jpXDuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:26:44 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)) 12:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:26:44 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-xsnx16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:26:44 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)) 12:26:44 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)) 12:26:44 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)) 12:26:44 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)) 12:26:44 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)) 12:26:44 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)) 12:26:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:26:44 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 12:26:44 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 12:26:44 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 12:26:44 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 12:26:44 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 12:26:44 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 12:26:47 INFO - Downloading blessings-1.6.tar.gz 12:26:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:26:47 INFO - Installing collected packages: blessings 12:26:47 INFO - Running setup.py install for blessings 12:26:47 INFO - Successfully installed blessings 12:26:47 INFO - Cleaning up... 12:26:47 INFO - Return code: 0 12:26:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:26:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:26:47 INFO - Reading from file tmpfile_stdout 12:26:47 INFO - Current package versions: 12:26:47 INFO - blessings == 1.6 12:26:47 INFO - blobuploader == 1.2.4 12:26:47 INFO - docopt == 0.6.1 12:26:47 INFO - functools32 == 3.2.3-2 12:26:47 INFO - jsonschema == 2.5.1 12:26:47 INFO - manifestparser == 1.1 12:26:47 INFO - mozInstall == 1.12 12:26:47 INFO - mozcrash == 1.0 12:26:47 INFO - mozdebug == 0.1 12:26:47 INFO - mozdevice == 0.50 12:26:47 INFO - mozfile == 1.2 12:26:47 INFO - mozhttpd == 0.7 12:26:47 INFO - mozinfo == 0.9 12:26:47 INFO - mozleak == 0.1 12:26:47 INFO - mozlog == 3.4 12:26:47 INFO - moznetwork == 0.27 12:26:47 INFO - mozprocess == 0.25 12:26:47 INFO - mozprofile == 0.28 12:26:47 INFO - mozrunner == 6.13 12:26:47 INFO - mozscreenshot == 0.1 12:26:47 INFO - mozsystemmonitor == 0.3 12:26:47 INFO - moztest == 0.8 12:26:47 INFO - mozversion == 1.4 12:26:47 INFO - psutil == 3.1.1 12:26:47 INFO - requests == 1.2.3 12:26:47 INFO - wsgiref == 0.1.2 12:26:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:26: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')]} 12:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26: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')]} 12:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:47 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 0x10f0d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f158f880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eeb1d30>, '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 0x10edd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eea6be8>, '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.V1chTFqXn8/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.9E8Yt8U098/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 12:26:47 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 12:26:47 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 12:26:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1chTFqXn8/Render', 12:26:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:26:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:26:47 INFO - 'HOME': '/Users/cltbld', 12:26:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:26:47 INFO - 'LOGNAME': 'cltbld', 12:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:47 INFO - 'MOZ_NO_REMOTE': '1', 12:26:47 INFO - 'NO_EM_RESTART': '1', 12:26:47 INFO - 'PAGER': '/bin/cat', 12:26:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:47 INFO - 'PWD': '/builds/slave/test', 12:26:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:26:47 INFO - 'SHELL': '/bin/bash', 12:26:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9E8Yt8U098/Listeners', 12:26:47 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 12:26:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:26:47 INFO - 'USER': 'cltbld', 12:26:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:26:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:47 INFO - 'XPC_FLAGS': '0x0', 12:26:47 INFO - 'XPC_SERVICE_NAME': '0', 12:26:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:48 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)) 12:26:48 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)) 12:26:48 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)) 12:26:48 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)) 12:26:48 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)) 12:26:48 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)) 12:26:48 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)) 12:26:48 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)) 12:26:48 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)) 12:26:48 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)) 12:26:48 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)) 12:26:48 INFO - Cleaning up... 12:26:48 INFO - Return code: 0 12:26:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:48 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 0x10f0d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f158f880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eeb1d30>, '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 0x10edd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eea6be8>, '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.V1chTFqXn8/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.9E8Yt8U098/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 12:26:48 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 12:26:48 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 12:26:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1chTFqXn8/Render', 12:26:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:26:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:26:48 INFO - 'HOME': '/Users/cltbld', 12:26:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:26:48 INFO - 'LOGNAME': 'cltbld', 12:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:48 INFO - 'MOZ_NO_REMOTE': '1', 12:26:48 INFO - 'NO_EM_RESTART': '1', 12:26:48 INFO - 'PAGER': '/bin/cat', 12:26:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:48 INFO - 'PWD': '/builds/slave/test', 12:26:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:26:48 INFO - 'SHELL': '/bin/bash', 12:26:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9E8Yt8U098/Listeners', 12:26:48 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 12:26:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:26:48 INFO - 'USER': 'cltbld', 12:26:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:26:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:48 INFO - 'XPC_FLAGS': '0x0', 12:26:48 INFO - 'XPC_SERVICE_NAME': '0', 12:26:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:26:48 INFO - Cleaning up... 12:26:48 INFO - Return code: 0 12:26:48 INFO - Running post-action listener: _resource_record_post_action 12:26:48 INFO - Running post-action listener: _start_resource_monitoring 12:26:48 INFO - Starting resource monitoring. 12:26:48 INFO - [mozharness: 2017-04-12 19:26:48.517693Z] Finished create-virtualenv step (success) 12:26:48 INFO - [mozharness: 2017-04-12 19:26:48.518685Z] Running install step. 12:26:48 INFO - Running pre-action listener: _resource_record_pre_action 12:26:48 INFO - Running main action method: install 12:26:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:26:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:26:48 INFO - Reading from file tmpfile_stdout 12:26:48 INFO - Detecting whether we're running mozinstall >=1.0... 12:26:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:26:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:26:48 INFO - Reading from file tmpfile_stdout 12:26:48 INFO - Output received: 12:26:48 INFO - Usage: mozinstall [options] installer 12:26:48 INFO - Options: 12:26:48 INFO - -h, --help show this help message and exit 12:26:48 INFO - -d DEST, --destination=DEST 12:26:48 INFO - Directory to install application into. [default: 12:26:48 INFO - "/builds/slave/test"] 12:26:48 INFO - --app=APP Application being installed. [default: firefox] 12:26:48 INFO - mkdir: /builds/slave/test/build/application 12:26:48 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'] 12:26:48 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 12:27:09 INFO - Reading from file tmpfile_stdout 12:27:09 INFO - Output received: 12:27:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:27:09 INFO - Running post-action listener: _resource_record_post_action 12:27:09 INFO - [mozharness: 2017-04-12 19:27:09.094946Z] Finished install step (success) 12:27:09 INFO - [mozharness: 2017-04-12 19:27:09.095059Z] Running run-tests step. 12:27:09 INFO - Running pre-action listener: _resource_record_pre_action 12:27:09 INFO - Running main action method: run_tests 12:27:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:27:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:27:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:27:09 INFO - 2017-04-12 12:27:09.110 screenresolution[2399:30954] starting screenresolution argv=screenresolution get 12:27:09 INFO - 2017-04-12 12:27:09.113 screenresolution[2399:30954] Display 0: 1600x1200x32@60 12:27:09 INFO - 2017-04-12 12:27:09.118 screenresolution[2400:30957] starting screenresolution argv=screenresolution list 12:27:09 INFO - Available Modes on Display 0 12:27:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:27:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:27:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:27:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:27:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:27:09 INFO - Intel Iris: 12:27:09 INFO - Chipset Model: Intel Iris 12:27:09 INFO - Type: GPU 12:27:09 INFO - Bus: Built-In 12:27:09 INFO - VRAM (Dynamic, Max): 1536 MB 12:27:09 INFO - Vendor: Intel (0x8086) 12:27:09 INFO - Device ID: 0x0a2e 12:27:09 INFO - Revision ID: 0x0009 12:27:09 INFO - Displays: 12:27:09 INFO - Display: 12:27:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:27:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:27:09 INFO - Display Serial Number: 1600x1200 60 12:27:09 INFO - Main Display: Yes 12:27:09 INFO - Mirror: Off 12:27:09 INFO - Online: Yes 12:27:09 INFO - Rotation: Supported 12:27:09 INFO - Return code: 0 12:27:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:27:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:27:09 INFO - Python 2.7.3 12:27:09 INFO - Return code: 0 12:27:09 INFO - grabbing minidump binary from tooltool 12:27:09 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')]} 12:27:09 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 0x10eeb1d30>, '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 0x10edd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eea6be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:27:09 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 12:27:09 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 12:27:09 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 12:27:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:27:09 INFO - Return code: 0 12:27:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:27:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:27:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:27:09 INFO - ENV: RUST_BACKTRACE is now 1 12:27:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:27:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:27:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SyJLc0NPTFyk6yPLuOPEJA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0252', '--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 12:27:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SyJLc0NPTFyk6yPLuOPEJA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0252 --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 12:27:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1chTFqXn8/Render', 12:27:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:27:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:27:09 INFO - 'HOME': '/Users/cltbld', 12:27:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:27:09 INFO - 'LOGNAME': 'cltbld', 12:27:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:27:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:09 INFO - 'MOZ_NO_REMOTE': '1', 12:27:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:27:09 INFO - 'NO_EM_RESTART': '1', 12:27:09 INFO - 'PAGER': '/bin/cat', 12:27:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:09 INFO - 'PWD': '/builds/slave/test', 12:27:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:27:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:27:09 INFO - 'RUST_BACKTRACE': '1', 12:27:09 INFO - 'SHELL': '/bin/bash', 12:27:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9E8Yt8U098/Listeners', 12:27:09 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 12:27:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:27:09 INFO - 'USER': 'cltbld', 12:27:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:27:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:09 INFO - 'XPC_FLAGS': '0x0', 12:27:09 INFO - 'XPC_SERVICE_NAME': '0', 12:27:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:27:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SyJLc0NPTFyk6yPLuOPEJA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0252', '--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 12:27:09 INFO - mozversion application_buildid: 20170412105209 12:27:09 INFO - mozversion application_changeset: bc086e9044e6537d18d385f417248cdb4c14c3af 12:27:09 INFO - mozversion application_display_name: Nightly 12:27:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:27:09 INFO - mozversion application_name: Firefox 12:27:09 INFO - mozversion application_remotingname: firefox 12:27:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:27:09 INFO - mozversion application_vendor: Mozilla 12:27:09 INFO - mozversion application_version: 55.0a1 12:27:09 INFO - mozversion platform_buildid: 20170412105209 12:27:09 INFO - mozversion platform_changeset: bc086e9044e6537d18d385f417248cdb4c14c3af 12:27:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:27:09 INFO - mozversion platform_version: 55.0a1 12:27:09 INFO - using testdate: 1492025229 12:27:09 INFO - actual date: 1492025229 12:27:09 INFO - starting webserver on 'localhost:58069' 12:27:09 INFO - SUITE-START | Running 2 tests 12:27:09 INFO - TEST-START | dromaeo_css 12:27:09 INFO - operating with platform_type : mac_ 12:27:09 INFO - Initialising browser for dromaeo_css test... 12:27:09 INFO - TEST-INFO | started process 2410 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmp1dzeM9/profile http://localhost:58069/getInfo.html) 12:27:12 INFO - PID 2410 | __metrics Screen width/height:1600/1200 12:27:12 INFO - PID 2410 | colorDepth:24 12:27:12 INFO - PID 2410 | Browser inner width/height: 1024/689 12:27:12 INFO - PID 2410 | __metrics 12:27:12 INFO - PID 2410 | 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" 12:27:12 INFO - PID 2410 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:27:13 INFO - TEST-INFO | 2410: exit 0 12:27:13 INFO - Browser initialized. 12:27:13 INFO - Running cycle 1/1 for dromaeo_css test... 12:27:13 INFO - TEST-INFO | started process 2412 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmp1dzeM9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:27:25 INFO - PID 2412 | RSS: Main: 238956544 12:27:25 INFO - PID 2412 | 12:30:31 INFO - PID 2412 | Cycle 1(1): loaded http://localhost:58069/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58069/tests/dromaeo/cssquery-ext.html) 12:30:32 INFO - PID 2412 | RSS: Main: 382324736 12:30:32 INFO - PID 2412 | 12:32:15 INFO - PID 2412 | ************************* 12:32:15 INFO - PID 2412 | A coding exception was thrown and uncaught in a Task. 12:32:15 INFO - PID 2412 | 12:32:15 ERROR - PID 2412 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:32:15 INFO - PID 2412 | Full stack: 12:32:15 INFO - PID 2412 | ************************* 12:32:15 INFO - PID 2412 | ************************* 12:32:15 INFO - PID 2412 | A coding exception was thrown and uncaught in a Task. 12:32:15 INFO - PID 2412 | 12:32:15 ERROR - PID 2412 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:32:15 INFO - PID 2412 | Full stack: 12:32:15 INFO - PID 2412 | ************************* 12:32:15 INFO - PID 2412 | ************************* 12:32:15 INFO - PID 2412 | A coding exception was thrown and uncaught in a Task. 12:32:15 INFO - PID 2412 | 12:32:15 ERROR - PID 2412 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:32:15 INFO - PID 2412 | Full stack: 12:32:15 INFO - PID 2412 | ************************* 12:32:15 INFO - PID 2412 | ************************* 12:32:15 INFO - PID 2412 | A coding exception was thrown and uncaught in a Task. 12:32:15 INFO - PID 2412 | 12:32:15 ERROR - PID 2412 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:32:15 INFO - PID 2412 | Full stack: 12:32:15 INFO - PID 2412 | ************************* 12:33:35 INFO - PID 2412 | Cycle 1(1): loaded http://localhost:58069/tests/dromaeo/cssquery-ext.html (next: http://localhost:58069/tests/dromaeo/cssquery-jquery.html) 12:33:35 INFO - PID 2412 | RSS: Main: 375402496 12:33:35 INFO - PID 2412 | 12:36:38 INFO - PID 2412 | Cycle 1(1): loaded http://localhost:58069/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58069/tests/dromaeo/cssquery-mootools.html) 12:36:38 INFO - PID 2412 | RSS: Main: 332763136 12:36:38 INFO - PID 2412 | 12:39:41 INFO - PID 2412 | Cycle 1(1): loaded http://localhost:58069/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58069/tests/dromaeo/cssquery-prototype.html) 12:39:41 INFO - PID 2412 | RSS: Main: 337235968 12:39:41 INFO - PID 2412 | 12:42:45 INFO - PID 2412 | Cycle 1(1): loaded http://localhost:58069/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58069/tests/dromaeo/cssquery-yui.html) 12:42:46 INFO - PID 2412 | RSS: Main: 341204992 12:42:46 INFO - PID 2412 | 12:45:48 INFO - PID 2412 | Cycle 1(1): loaded http://localhost:58069/tests/dromaeo/cssquery-yui.html (next: http://localhost:58069/tests/dromaeo/cssquery-dojo.html) 12:45:48 INFO - PID 2412 | RSS: Main: 375336960 12:45:48 INFO - PID 2412 | 12:45:48 INFO - PID 2412 | __start_tp_report 12:45:48 INFO - PID 2412 | _x_x_mozilla_page_load 12:45:48 INFO - PID 2412 | _x_x_mozilla_page_load_details 12:45:48 INFO - PID 2412 | |i|pagename|runs| 12:45:48 INFO - PID 2412 | |0;dojo.html;3224.9677503224966;3461.5846098468187;3465.6361082086364;3505.7370697197716;3549.662782035707;6029.577929544934;6115.6967227388295;6121.66330851803;6135.815925522242;6141.815745527636;6043.829069578778;6088.786892458754;6125.57121001529;6126.192588752531;6146.600470969383;4891.339669144673;5181.818636347729;5276.683398996053;5310.256564081032;5419.430959749228;5341.626086173969;5356.9732151339385;5364;5373.435789242132;5407.783688652449;5168.173092305232;5236.29310043147;5257.237700533401;5260.842174734764;5286.920696189561;5244.895102097937;5250.553702935217;5253.658512196733;5272.710000949946;5274.683518988873;5167;5223.112070947948;5228.163493840967;5240.292560504321;5244.842654720364;5847.181394604716;5860.677662728548;5873.676947767871;5873.706314684248;5896.557758168155;6357;6361.809145725636;6364.077208804697;6367.968160159169;6380.744770209186;6314.71583778731;6514.315996820361;6585.835354116138;6597.703103360361;6599.637019963948;6195.070739389128;6212.4408803207925;6221.377862213788;6222.719977601018;6238.313785483593;5602.943970560324;6683.298253683391;6695.430888374445;6698.832529186712;6708.496862735315;6249.812505624838;6336.714847831859;6337.366263373626;6346.4605508532295;6347.174867267226;5334.946650533522;6390;6396.200474940632;6406.23125224976;6412.551121421456;6311.1795466589965;6332.620042797447;6349.14286571307;6374.681265936684;6399;6302.739766397824;6439.839004024843;6444.838879027968;6451.0645956337;6455.2576453708425;5246.23929530216;5247.2653828464045;5253.106971814801;5267.499587539178;5296.947030529723;4562.771861406916;4562.84030058953;4614.469336026333;4635.072985402933;4663.953360466419;5076.568491678248;6197.845053873689;6209.844753881189;6220.502359811204;6225.937740622536;6458.2895881453005;6478.963365861534;6486.189226346707;6491.091247225392;6491.8701625967215;6021;6031.607945483617;6217.191765070512;6235.095911092866;6246.250449946036;5627.549796016309;5720.799772008043;5738.942610573841;5773.653580785082;5779.959607270732;6651.135352404253;6719.899201512079;6727.058211850247;6727.226368967631;6735.6968936397;6488.994205898093;6496.187976502937;6540.934590654223;6571.474282057328;6576.145101136822;6409.4231519163495;6487.416132547904;6501.447376972821;6600.174978127734;6667.033280174251;6407.455366293917;6417.486601071996;6431.163948686641;6439.549231553746;6440.967795160994;6424;6498.3826536478955;6510.0885875976455;6515.576487528296;6547.541672083099;6211.65835879031;6213.5339849512375;6273.153124328157;6308.747650093945;6355.396237357444;6270.529710271839;6277.591956522994;6280.277768056732;6280.560360774702;6297.937020629735;5232.5552328052545;6161.168242287234;6177.042558403455;6219.036049412348;6274.749010039547;6250.156228909039;6261.718222680081;6293.748250069946;6304.243490781136;6327.905081423874;6244.968775156095;6269.216347956505;6269.592476489013;6283.37166283368;6300.527460440577 12:45:48 INFO - PID 2412 | |1;ext.html;609.7530500147441;709.2234003765877;765.9119201291851;1137.6302701621976;1158.4844744088884;27165.91336346546;27758.444831103367;27773.861130694317;36252.19351968045;36726;38649.22701545968;39046;39088.41367379484;39095.60904390955;39118.02204944878;8437.873431898526;8600.956995215016;8638.956805215965;8640.39517233794;8648.913510864904;6138.416850399227;6293.244810622732;6297.08692239625;8494.915050849475;8633.611487483047;6280.654563998978;6320.083587879754;6322.336154703758;8506.574671266442;8677.739667809945;8670.046294907555;8718.782030449258;8729.039805621376;8732.825343493094;8734.69428569997;8406.28546573542;8494.830103397959;8499.702510412106;8502.447340922881;8512.233898949124;25664;26073.95704171831;35666.108347291265;36710.8164459176;36982;3591.6408359163875;3604.4953706481115;3616.945745813815;3619.7647152934974;3624.5650521937537;30318.69681303181;30426.391472170653;30435.23911902198;30452.086437406913;30476.390472190655;2682.141714651312;2945.882164713409;3169.1760142362923;3186.681331866818;3187.553742476055;262961;266201;268362;269779;269813;47991.52008479871;48124.75937620289;48143.79640509015;48163.27755083676;48229.7942551432;50566.494335056916;50651.24023139656;50729.74635126875;50809.74595127001;50854.491455085714;14196.716065678835;14296.714065718628;14362.552987283187;14371.425142994163;14417.207053612152;11733.35466549348;11734.354610496333;11737.589184378507;11746.530138794353;11802.996745276747;10124.240681948882;12592.559260426024;12760.489580416865;12772.808407873888;12901.483940642456;3966.9685881670976;4271.337942618837;4648.3259927310355;4784.904301913943;5363.892722145535;1014.2757312568516;1020.1430798129459;1026.4200726589454;1048.3762161513887;1060.5704689600725;18108.818911810977;24171.75828241695;24184.87907560451;24362.390940226636;24503.142390016263;1104.1222228328497;1115.5147510832815;1160.442987366069;1160.5357856857156;1169.6607983684805;12298.385080745928;12465.688357790947;12475.93762031184;12478.876901078946;12502.937485312515;326926;327024;327190;327256;327447;53496;53520.73239633777;53668;53681.46318536765;53751.73124134433;1489.2404873514586;1497.161589509878;1545.489988303857;1553.6038310231045;1557.1435710359258;18977.14929195689;21827.563448731253;22577.984815390955;23749.64375534334;23917.880410597834;38207.04482387962;38348;38485;38500.614993850824;38519.0370240735;288601;288918;289229;289964;290494.547527261;30222.524409693167;31454;34283.314333713686;34446.48330275098;34451.655483445844;42629.786851065546;43659.78170109129;43759.34360984652;43898.90252743707;44119.77940110279;28957.710422896344;29007.274818129714;29906.551401728557;30201.244968875955;30484.390312194075;26329.473410532064;29712.96004639827;30044.948426804956;30159.396812064075;30177.300926361724;35449.645503544634;35924.82037589795;36036.91889243327;36124.45813312855;36202.63797362098;26580.40517568952;28970.855145724137;30667.53998690066;30770.53844192294;31094.22264443407;18962.810371896656;19970;21867.07331050963;22591.20930767415;23666.17168399098 12:45:48 INFO - PID 2412 | |2;jquery.html;388.7317750751979;421.93887245850055;434.259587403477;441.1683975705795;452.9614982726468;17456.476305710832;18346.633067338644;21190.470238244034;22851.31446056621;22895.656565151538;23321.76678233217;23441.827908604588;24035.75964240357;24292.75707242927;24359.269221923325;6130;6134.294556126036;6262.9686851565675;6313.28525760166;6335;6261.812145635638;6284;6386.201724784379;6393.808185754435;6394.61632302061;5067.265246539249;6259.467945224661;6322.272938612073;6323;6329.588576742497;6041.335453100155;6271.278802937675;6308.463780578656;6309.810705678837;6317.557770956035;4761.666683332168;5655.491005809456;5660.207570940031;5660.264165658479;5663.518600918886;27180.728192718216;27644.72355276462;28420.85789571039;28449.57325640117;28667.85666071677;2242.159190303636;2295.1966811615966;2295.885205739706;2296.8621882686925;2298.839081264312;17678.292868285254;18645.813541864678;18655;18700;18868.905655471634;1747.9038652874087;2137.647288197461;2149.269248455517;2150.967735483969;2180.760116387196;158982;160140;160865;161969;163406.18296908558;10515.52680129396;11236.438178091063;11783.646490605295;12316.692082698004;12612.684682883002;14300.356483958247;15473.5357939262;16710.415135470445;16715.16424178786;16856.241469133918;7671.654775535114;8879.866801997976;9141.634334626673;9146.95426522863;9240.065209913028;7005.92994070063;7205;8826.955865220632;9016.8647470288;9018.59416326267;7806.414518911104;7935.880961785578;7990.960045199737;8005.359571234288;8047.919520804717;2175.7497887742798;2197;2199.7030400895997;2206.1285792112026;2348.3659411959015;948.6158105967095;964.1370972979145;965.2712202287369;1003.5433877585681;1003.6637726361605;18628.97540635278;19080.71378929317;20296.289629862884;20909.222716069;20962.951852407317;888.294711824121;972.9610815567439;987.3730181334761;988.3427520698799;1021.3106153346462;9271.397359171768;10880.183986200907;10903.781924361469;10952.452377381258;11061.612843550438;601757;630119;647270;659487;660561.3943860596;153480.2325988363;156423;156727.21636391745;157398;158788;1152.9884701153048;1160.7678464307173;1185.51986445488;1189.1735244005506;1235.1971218707731;21527.246546370803;21569.813660248838;22504.88747556252;22889.427764306027;22959.311220663407;60916.39083609107;64691.67654161699;65703.67148164229;65829;66255.66872165608;62973.05540416989;89649;90100.5494972521;91148;93808.53095734477;8881.111888811325;8953.32850036263;9082.682106126254;9106.499142547224;9163.633454661738;13865.930670346585;14448.638784030483;14461.638459038608;14889.627759306104;15041.924790376415;10355.689329320132;11767.470463828977;12193.012711885645;12245.632631021084;12337.568185113478;9327.440353578808;9771.560279787569;10458.738531536772;11475.426228688699;11581.652550423501;11817.468213930566;12328.445219965302;12467.75064498723;12502.562410315959;12587.496500139892;8838.425502342327;8850.867236991578;9158.584926828105;9319.673811416567;9366.859497107413;9940.403575785476;11122.944385278022;11708.414579270831;12210.633680989584;12246.632601021984 12:45:48 INFO - PID 2412 | |3;mootools.html;1298.6493646715387;1363.6522686714889;1415.2852809331287;1455.3160014793048;1460.1750011243653;11015.449227538622;11475.713107172303;11485.368304743226;11492.540298388076;11504.25222360546;11116.277441966267;11193.27243729157;11486.885131148685;11503.48234329455;11518.884811151886;2475.6410320503514;2525.5075260324243;2526.343150780801;2527.178666933254;2527.734587868266;2424.2242482405636;2432.282476669378;2467.4078221226955;2468.025130073629;2472.8269021168526;2419.8911049002836;2520.206135067457;2520.773130418262;2523.066465407802;2525.4822761333976;2449.2774631483753;2470.3947532854386;2472.950540989179;2502.912398066059;2503.0113105323294;2448.09420514409;2467.0748469324003;2481.813863960192;2488.1913378151994;2490.7882829959476;11542.480588373543;11618.94190529042;11638.6508404748;11643.76712465746;11652.533898644044;6411.3588641135975;6661.63361015144;6667.899981500282;6671.33286671329;6677.265500794909;3982.26328129297;4132.648724858391;4181.560936101726;4233.576642335773;4334.371516130175;1211.7031327324773;1239.770642431144;1290.9612711618665;1294.4757373263844;1296.002078399627;14060.789088163685;14482.1310721356;14483.493077742229;15952;16120;5310.628256022042;5417.024935511646;5613.887722245532;5614.803481878114;5627.071533197059;12021.819672704916;12041.096917731205;12057.095717821023;12057.733937936566;12063.457144428521;6484.124643173205;6484.1894763154605;6487.026945958144;6493.415592596689;6495.382938620918;5965.642061476326;6062.696865156725;6150.538709596798;6157.815265542041;6235.875282494325;3606.4590311453494;4191.392248124066;4322.0491491871735;4335.804888780012;4371.497277813029;1108.8780234174235;1229.2685851918095;1265.5760320292804;1287.9549215777404;1292.360281660584;700.2542292458515;742.2132539508139;774.2567135549823;814.4909431605247;835.6490274084899;4251.383549385322;6087.512998960073;6306.211723534559;6334.904976425358;6412.134361861089;540.2625416306713;595.6902410746387;614.2567493333117;615.5937081526171;627.0281064350239;4088.691618681993;4210.389493523422;4284.031167391073;4291.742495450283;4325.52419233884;14173.71652566943;14906.180160091082;14906.180160091299;14932.178730169728;14941.477048303257;14655.120692758468;14828.258587070603;14848.554543363716;14867.702645947236;14871;10251.231157663206;10566.735831604117;10829.458527073772;10853.24027318096;10861.1854110942;5716.54267658578;5969.3732158122775;6973.895391569232;7146.749863754952;7163.713451462092;12155.635330940086;12325.876741232472;12699.047571431995;12719.87280127187;12734.981201503671;13517.662058448224;13618.387172577455;13796.241206733726;13827.51603693866;13847;8375.45559538628;8540.957295213484;8550.615222315135;8554.700585479479;8564.871526927225;10453.738656533647;10472.162227021972;10546.314489558154;10560.894391055992;10566.31318964265;8908.331875109263;8944.150305720947;8962.238209751984;8988.505632190292;9009.909900900908;8580.785480363042;8727.476351418682;8742.38803283764;8827.646894124164;8837.027926928162;7930.841383172419;8107.918920810716;8108.83782324362;8115.83768324642;8122.472039317426;5924.733386997509;5954.523638109027;6074.514038876968;6135.509159267337;6173.506119510518;5990.34106248321;6096.776606087731;6157.322694503511;6287.622742635456;6313.810585682437 12:45:48 INFO - PID 2412 | |4;prototype.html;318.51903625525455;398.99401508977354;402.84691817109496;409.59654740081;410.7761270107791;5304.761285742141;5546.696526316317;5688.63023903446;5869.9706501467535;5886.793962211324;5063.746632748428;5176.171812509999;5279.049771041211;5649.830505084844;5657.4159235414045;3645.2345007548447;3980.840766369349;4189.835381497627;4389.275769498045;4470.597646211841;3873.3028054950096;4297.484301883763;4457.88855278619;4508.526604706508;4515.345274935133;3377.966220337802;4111.992561822358;4173.8330466781445;4485.52901945296;4495.527969563198;4002.837049468549;4036.1725846201457;4282.528921818597;4304.418903448041;4325.675574331937;3734.9626503734885;3741.30785804627;3756.6619004289746;3762.3851423260844;3765.4163604641326;4607.884802879921;5646.571974051157;5660.028669753408;5670.051573181963;5713.942920559668;4618.699784513996;4788.832390866338;5026.170681837492;5028.823991160292;5076.720780357079;6115.266168059861;6127;6129.62870421271;6130;6151.046587778901;4087.8773636790943;4209.6000879916355;4226.746395216266;4233.491980962273;4234.17433600448;5756.740946657411;6124.663143527104;6203.658798766066;6302.149209856702;6306.558540902093;3296.538484612156;4178.770167640748;4266.506722647111;4280.72175308604;4285.228658841376;3621.764585301947;3672.412414013745;4294.914101717948;4363.807069587181;4369.650427965755;4522.4573051234065;4734.342979957057;4822;5065.138926382524;5086.338775959101;5331.480528049565;5865.882682346414;6153.7230824613;6157.476614487729;6160.784372547029;1279.366713476835;1452.7724073158165;1454.8763355114934;1481.5185064853965;1483.1842486632308;955.3264948211634;981.6956743409565;988.7280997725683;992.7220378294089;999.2355847776457;4694.43666759991;5100.566451851634;5809.5352371811;5816.069428891357;5826.970865145647;5519.972400138054;5757.942420575824;6372.55392122547;6380.617162970237;6392.39272269143;4840.75796210188;5091.363579552556;5510.256115424447;5769.192313076089;5841.620294680833;3268.9019329420157;3316.922000349896;3317.3531161423775;3323.5347051412823;3335.5830521184853;4930.077269864755;5181.326427564468;6216.222972128484;6259.874802503924;6522;5146.408163061221;5708;6400.551961362753;6440.61356318613;6464.22429308486;6395.2645445773405;6481.902771458432;6505.707243173973;6509.804705858832;6529.608223506605;4885.14364541472;5537.307836520435;5788.160716695971;5866.2960444746905;6020.638761674313;5617.297837770278;5845.298564172156;6236.781712640036;6246.562740608114;6264.467520260829;5954.583179177589;6112.388761123852;6224.906626400698;6355.474686075401;6506.674666266573;4001.4998125234347;4233.91532169361;4244.432118568345;4254.680898932655;4257.91484170321;4903;5391.649542779707;6107.755689772359;6303.5902666328375;6389.456896163878;4749.525047495223;5653.858653533694;5763.991301522301;5955.796355348549;6143.139960405636;6011.325828581503;6125.081237814185;6141.40323515898;6151.231096112986;6156.538259630456;4431.689781715249;4986.32684587576;5236.921446178234;5370.475876338115;6064.696765161636;5334.519448456486;5578.916316255179;5969.671668058125;6117.938820611737;6156.846078848064;5316.171800571647;5952.791652292149;5986.191864098291;6015.338312785678;6029.487493563096 12:45:48 INFO - PID 2412 | |5;yui.html;698.6820996446618;835.2691395029349;847.9618417171223;850.0946491986034;858.2618947704974;13562.796558051637;17852.642947141067;18612.627747445043;18638.813611863876;18657.440276791684;17163.74254386182;17583.29666813326;17736.733948990775;17775.466735997907;17785;914.3964983111165;951.0394501553446;954.1698722111772;954.2652157838495;956.2159029595734;652.1782553981993;673.3233100733755;675.6790524500872;676.6853413162878;677.0352248046538;997.3643225110824;1050.8844027157006;1054.2409465185056;1056.3397876327294;1056.561526966312;1037.5590374091018;1038.5170895533538;1041.7864337810731;1041.8020576090519;1042.3902017319801;747.1482509938675;752.0711920777835;752.1650967426152;752.6011214056504;753.3558807219857;16733.66532669352;17085;17148.485545433658;17177.742333865;17381.217845196996;13846.515371961934;16052.438164664181;16283.91858040714;16388.26252818614;16495.670086598202;13919.652008699763;14270.357833897395;14461.566153015427;15700.921495392564;15804;3532.1522834519787;3539.7876127432437;3542.433210686278;3544.432890737495;3550.14796448853;98438.50780746122;108420;110341.89658103477;110405;110668;11274.774504509864;11649.534018639159;13456.730865382833;13742.244176570184;13785.448582056806;19350.709739353922;23719.051237950633;24303.75696243015;24465.143719969714;25135.62296565553;8846.46921184731;8846.601902914384;9067.501287429122;9083.182513573678;9097.681581144629;4772.236442169236;4929.088118698052;4933.260010998379;4933.555979961749;4944.085344211332;4247.957520424818;4259.829606815754;4270.35944608305;4382.408374869416;4393.560643935645;912.9406588571721;926.0831776541175;929.6235024814961;933.0809152984305;934.7149119518476;640.4556127291858;663.1213641924469;670.276101810044;673.9191297044387;700.5236439221277;10016.899831001743;10814.567417303377;11274.605388811353;11382.373969431761;11535.942320288344;645.4449173710605;649.95775274607;653.3368630839701;668.4017804065335;685.2873012067494;4264.786760661955;5471.50756431923;5530.115181570929;5599.048161812501;5639.915401268984;82159;109061.90938090676;111251.44374278077;111375;113749.62563641676;97832.53251201237;98659.50670246602;99003.50498247462;100571.49714251382;100750.48874266892;63878;85949;87661.93183238684;88763.78090547658;90280;8923.330750193632;9674.274429417681;10408.687739367831;10931.890681093088;11010.39442830652;41932.79033604812;42408;42840.28638854411;42883.571164287954;42899.142017160106;42481.787591061846;56666.15000774909;56945.29164125083;57894.13158802537;58395.12407313809;13854.30728463593;14141.222232777296;14169.787453188004;14209;14223.146611203361;15551.14468704187;15598.98606590568;15834.287457064229;15872.047677139408;15910.920445397698;14342.139471631735;14372.993890427988;14495.78256326135;14654.267286635839;14656.340464678902;13032.283224422748;13049.478020879058;13064.80402793978;13185.40665670028;13269.33653317311;14257.287135643384;14315.427382904567;14467.059641123293;16075.35698572044;17099.145042747565;11573.942130289295;11729.706757331134;11944.581939632419;12293.815592766294;12428.37858107109;12609.180403273758;13702.177869327872;13772.311384430537;13796.034277600873;13814.309284535933 12:45:48 INFO - PID 2412 | __end_tp_report 12:45:48 INFO - PID 2412 | __start_cc_report 12:45:48 INFO - PID 2412 | _x_x_mozilla_cycle_collect,1472 12:45:48 INFO - PID 2412 | __end_cc_report 12:45:48 INFO - PID 2412 | __startTimestamp1492026348759__endTimestamp 12:45:48 INFO - PID 2412 | 12:45:48 INFO - PID 2412 | ------- Summary: start ------- 12:45:48 INFO - PID 2412 | Number of tests: 6 12:45:48 INFO - PID 2412 | 12:45:48 INFO - PID 2412 | [#0] dojo.html Cycles:165 Average:5962.18 Median:6244.97 stddev:695.62 (11.1%) stddev-sans-first:663.79 12:45:48 INFO - PID 2412 | Values: 3225.0 3461.6 3465.6 3505.7 3549.7 6029.6 6115.7 6121.7 6135.8 6141.8 6043.8 6088.8 6125.6 6126.2 6146.6 4891.3 5181.8 5276.7 5310.3 5419.4 5341.6 5357.0 5364.0 5373.4 5407.8 5168.2 5236.3 5257.2 5260.8 5286.9 5244.9 5250.6 5253.7 5272.7 5274.7 5167.0 5223.1 5228.2 5240.3 5244.8 5847.2 5860.7 5873.7 5873.7 5896.6 6357.0 6361.8 6364.1 6368.0 6380.7 6314.7 6514.3 6585.8 6597.7 6599.6 6195.1 6212.4 6221.4 6222.7 6238.3 5602.9 6683.3 6695.4 6698.8 6708.5 6249.8 6336.7 6337.4 6346.5 6347.2 5334.9 6390.0 6396.2 6406.2 6412.6 6311.2 6332.6 6349.1 6374.7 6399.0 6302.7 6439.8 6444.8 6451.1 6455.3 5246.2 5247.3 5253.1 5267.5 5296.9 4562.8 4562.8 4614.5 4635.1 4664.0 5076.6 6197.8 6209.8 6220.5 6225.9 6458.3 6479.0 6486.2 6491.1 6491.9 6021.0 6031.6 6217.2 6235.1 6246.3 5627.5 5720.8 5738.9 5773.7 5780.0 6651.1 6719.9 6727.1 6727.2 6735.7 6489.0 6496.2 6540.9 6571.5 6576.1 6409.4 6487.4 6501.4 6600.2 6667.0 6407.5 6417.5 6431.2 6439.5 6441.0 6424.0 6498.4 6510.1 6515.6 6547.5 6211.7 6213.5 6273.2 6308.7 6355.4 6270.5 6277.6 6280.3 6280.6 6297.9 5232.6 6161.2 6177.0 6219.0 6274.7 6250.2 6261.7 6293.7 6304.2 6327.9 6245.0 6269.2 6269.6 6283.4 6300.5 12:45:48 INFO - PID 2412 | 12:45:48 INFO - PID 2412 | [#1] ext.html Cycles:180 Average:43952.93 Median:17311.59 stddev:77668.87 (448.7%) stddev-sans-first:77818.57 12:45:48 INFO - PID 2412 | Values: 609.8 709.2 765.9 1137.6 1158.5 27165.9 27758.4 27773.9 36252.2 36726.0 38649.2 39046.0 39088.4 39095.6 39118.0 8437.9 8601.0 8639.0 8640.4 8648.9 6138.4 6293.2 6297.1 8494.9 8633.6 6280.7 6320.1 6322.3 8506.6 8677.7 8670.0 8718.8 8729.0 8732.8 8734.7 8406.3 8494.8 8499.7 8502.4 8512.2 25664.0 26074.0 35666.1 36710.8 36982.0 3591.6 3604.5 3616.9 3619.8 3624.6 30318.7 30426.4 30435.2 30452.1 30476.4 2682.1 2945.9 3169.2 3186.7 3187.6 262961.0 266201.0 268362.0 269779.0 269813.0 47991.5 48124.8 48143.8 48163.3 48229.8 50566.5 50651.2 50729.7 50809.7 50854.5 14196.7 14296.7 14362.6 14371.4 14417.2 11733.4 11734.4 11737.6 11746.5 11803.0 10124.2 12592.6 12760.5 12772.8 12901.5 3967.0 4271.3 4648.3 4784.9 5363.9 1014.3 1020.1 1026.4 1048.4 1060.6 18108.8 24171.8 24184.9 24362.4 24503.1 1104.1 1115.5 1160.4 1160.5 1169.7 12298.4 12465.7 12475.9 12478.9 12502.9 326926.0 327024.0 327190.0 327256.0 327447.0 53496.0 53520.7 53668.0 53681.5 53751.7 1489.2 1497.2 1545.5 1553.6 1557.1 18977.1 21827.6 22578.0 23749.6 23917.9 38207.0 38348.0 38485.0 38500.6 38519.0 288601.0 288918.0 289229.0 289964.0 290494.5 30222.5 31454.0 34283.3 34446.5 34451.7 42629.8 43659.8 43759.3 43898.9 44119.8 28957.7 29007.3 29906.6 30201.2 30484.4 26329.5 29713.0 30044.9 30159.4 30177.3 35449.6 35924.8 36036.9 36124.5 36202.6 26580.4 28970.9 30667.5 30770.5 31094.2 18962.8 19970.0 21867.1 22591.2 23666.2 12:45:48 INFO - PID 2412 | 12:45:48 INFO - PID 2412 | [#2] jquery.html Cycles:180 Average:39543.69 Median:13192.06 stddev:108382.85 (821.6%) stddev-sans-first:108647.01 12:45:48 INFO - PID 2412 | Values: 388.7 421.9 434.3 441.2 453.0 17456.5 18346.6 21190.5 22851.3 22895.7 23321.8 23441.8 24035.8 24292.8 24359.3 6130.0 6134.3 6263.0 6313.3 6335.0 6261.8 6284.0 6386.2 6393.8 6394.6 5067.3 6259.5 6322.3 6323.0 6329.6 6041.3 6271.3 6308.5 6309.8 6317.6 4761.7 5655.5 5660.2 5660.3 5663.5 27180.7 27644.7 28420.9 28449.6 28667.9 2242.2 2295.2 2295.9 2296.9 2298.8 17678.3 18645.8 18655.0 18700.0 18868.9 1747.9 2137.6 2149.3 2151.0 2180.8 158982.0 160140.0 160865.0 161969.0 163406.2 10515.5 11236.4 11783.6 12316.7 12612.7 14300.4 15473.5 16710.4 16715.2 16856.2 7671.7 8879.9 9141.6 9147.0 9240.1 7005.9 7205.0 8827.0 9016.9 9018.6 7806.4 7935.9 7991.0 8005.4 8047.9 2175.7 2197.0 2199.7 2206.1 2348.4 948.6 964.1 965.3 1003.5 1003.7 18629.0 19080.7 20296.3 20909.2 20963.0 888.3 973.0 987.4 988.3 1021.3 9271.4 10880.2 10903.8 10952.5 11061.6 601757.0 630119.0 647270.0 659487.0 660561.4 153480.2 156423.0 156727.2 157398.0 158788.0 1153.0 1160.8 1185.5 1189.2 1235.2 21527.2 21569.8 22504.9 22889.4 22959.3 60916.4 64691.7 65703.7 65829.0 66255.7 62973.1 89649.0 90100.5 91148.0 93808.5 8881.1 8953.3 9082.7 9106.5 9163.6 13865.9 14448.6 14461.6 14889.6 15041.9 10355.7 11767.5 12193.0 12245.6 12337.6 9327.4 9771.6 10458.7 11475.4 11581.7 11817.5 12328.4 12467.8 12502.6 12587.5 8838.4 8850.9 9158.6 9319.7 9366.9 9940.4 11122.9 11708.4 12210.6 12246.6 12:45:48 INFO - PID 2412 | 12:45:48 INFO - PID 2412 | [#3] mootools.html Cycles:180 Average:7013.42 Median:2525.49 stddev:4404.01 (174.4%) stddev-sans-first:4395.42 12:45:48 INFO - PID 2412 | Values: 1298.6 1363.7 1415.3 1455.3 1460.2 11015.4 11475.7 11485.4 11492.5 11504.3 11116.3 11193.3 11486.9 11503.5 11518.9 2475.6 2525.5 2526.3 2527.2 2527.7 2424.2 2432.3 2467.4 2468.0 2472.8 2419.9 2520.2 2520.8 2523.1 2525.5 2449.3 2470.4 2473.0 2502.9 2503.0 2448.1 2467.1 2481.8 2488.2 2490.8 11542.5 11618.9 11638.7 11643.8 11652.5 6411.4 6661.6 6667.9 6671.3 6677.3 3982.3 4132.6 4181.6 4233.6 4334.4 1211.7 1239.8 1291.0 1294.5 1296.0 14060.8 14482.1 14483.5 15952.0 16120.0 5310.6 5417.0 5613.9 5614.8 5627.1 12021.8 12041.1 12057.1 12057.7 12063.5 6484.1 6484.2 6487.0 6493.4 6495.4 5965.6 6062.7 6150.5 6157.8 6235.9 3606.5 4191.4 4322.0 4335.8 4371.5 1108.9 1229.3 1265.6 1288.0 1292.4 700.3 742.2 774.3 814.5 835.6 4251.4 6087.5 6306.2 6334.9 6412.1 540.3 595.7 614.3 615.6 627.0 4088.7 4210.4 4284.0 4291.7 4325.5 14173.7 14906.2 14906.2 14932.2 14941.5 14655.1 14828.3 14848.6 14867.7 14871.0 10251.2 10566.7 10829.5 10853.2 10861.2 5716.5 5969.4 6973.9 7146.7 7163.7 12155.6 12325.9 12699.0 12719.9 12735.0 13517.7 13618.4 13796.2 13827.5 13847.0 8375.5 8541.0 8550.6 8554.7 8564.9 10453.7 10472.2 10546.3 10560.9 10566.3 8908.3 8944.2 8962.2 8988.5 9009.9 8580.8 8727.5 8742.4 8827.6 8837.0 7930.8 8107.9 8108.8 8115.8 8122.5 5924.7 5954.5 6074.5 6135.5 6173.5 5990.3 6096.8 6157.3 6287.6 6313.8 12:45:48 INFO - PID 2412 | 12:45:48 INFO - PID 2412 | [#4] prototype.html Cycles:180 Average:4869.18 Median:5352.50 stddev:1492.62 (27.9%) stddev-sans-first:1457.20 12:45:48 INFO - PID 2412 | Values: 318.5 399.0 402.8 409.6 410.8 5304.8 5546.7 5688.6 5870.0 5886.8 5063.7 5176.2 5279.0 5649.8 5657.4 3645.2 3980.8 4189.8 4389.3 4470.6 3873.3 4297.5 4457.9 4508.5 4515.3 3378.0 4112.0 4173.8 4485.5 4495.5 4002.8 4036.2 4282.5 4304.4 4325.7 3735.0 3741.3 3756.7 3762.4 3765.4 4607.9 5646.6 5660.0 5670.1 5713.9 4618.7 4788.8 5026.2 5028.8 5076.7 6115.3 6127.0 6129.6 6130.0 6151.0 4087.9 4209.6 4226.7 4233.5 4234.2 5756.7 6124.7 6203.7 6302.1 6306.6 3296.5 4178.8 4266.5 4280.7 4285.2 3621.8 3672.4 4294.9 4363.8 4369.7 4522.5 4734.3 4822.0 5065.1 5086.3 5331.5 5865.9 6153.7 6157.5 6160.8 1279.4 1452.8 1454.9 1481.5 1483.2 955.3 981.7 988.7 992.7 999.2 4694.4 5100.6 5809.5 5816.1 5827.0 5520.0 5757.9 6372.6 6380.6 6392.4 4840.8 5091.4 5510.3 5769.2 5841.6 3268.9 3316.9 3317.4 3323.5 3335.6 4930.1 5181.3 6216.2 6259.9 6522.0 5146.4 5708.0 6400.6 6440.6 6464.2 6395.3 6481.9 6505.7 6509.8 6529.6 4885.1 5537.3 5788.2 5866.3 6020.6 5617.3 5845.3 6236.8 6246.6 6264.5 5954.6 6112.4 6224.9 6355.5 6506.7 4001.5 4233.9 4244.4 4254.7 4257.9 4903.0 5391.6 6107.8 6303.6 6389.5 4749.5 5653.9 5764.0 5955.8 6143.1 6011.3 6125.1 6141.4 6151.2 6156.5 4431.7 4986.3 5236.9 5370.5 6064.7 5334.5 5578.9 5969.7 6117.9 6156.8 5316.2 5952.8 5986.2 6015.3 6029.5 12:45:48 INFO - PID 2412 | 12:45:48 INFO - PID 2412 | [#5] yui.html Cycles:180 Average:21276.48 Median:18648.13 stddev:29992.59 (160.8%) stddev-sans-first:30036.92 12:45:48 INFO - PID 2412 | Values: 698.7 835.3 848.0 850.1 858.3 13562.8 17852.6 18612.6 18638.8 18657.4 17163.7 17583.3 17736.7 17775.5 17785.0 914.4 951.0 954.2 954.3 956.2 652.2 673.3 675.7 676.7 677.0 997.4 1050.9 1054.2 1056.3 1056.6 1037.6 1038.5 1041.8 1041.8 1042.4 747.1 752.1 752.2 752.6 753.4 16733.7 17085.0 17148.5 17177.7 17381.2 13846.5 16052.4 16283.9 16388.3 16495.7 13919.7 14270.4 14461.6 15700.9 15804.0 3532.2 3539.8 3542.4 3544.4 3550.1 98438.5 108420.0 110341.9 110405.0 110668.0 11274.8 11649.5 13456.7 13742.2 13785.4 19350.7 23719.1 24303.8 24465.1 25135.6 8846.5 8846.6 9067.5 9083.2 9097.7 4772.2 4929.1 4933.3 4933.6 4944.1 4248.0 4259.8 4270.4 4382.4 4393.6 912.9 926.1 929.6 933.1 934.7 640.5 663.1 670.3 673.9 700.5 10016.9 10814.6 11274.6 11382.4 11535.9 645.4 650.0 653.3 668.4 685.3 4264.8 5471.5 5530.1 5599.0 5639.9 82159.0 109061.9 111251.4 111375.0 113749.6 97832.5 98659.5 99003.5 100571.5 100750.5 63878.0 85949.0 87661.9 88763.8 90280.0 8923.3 9674.3 10408.7 10931.9 11010.4 41932.8 42408.0 42840.3 42883.6 42899.1 42481.8 56666.2 56945.3 57894.1 58395.1 13854.3 14141.2 14169.8 14209.0 14223.1 15551.1 15599.0 15834.3 15872.0 15910.9 14342.1 14373.0 14495.8 14654.3 14656.3 13032.3 13049.5 13064.8 13185.4 13269.3 14257.3 14315.4 14467.1 16075.4 17099.1 11573.9 11729.7 11944.6 12293.8 12428.4 12609.2 13702.2 13772.3 13796.0 13814.3 12:45:48 INFO - PID 2412 | -------- Summary: end -------- 12:45:48 INFO - PID 2412 | 12:45:49 INFO - TEST-INFO | 2412: exit 0 12:45:49 INFO - TEST-OK | dromaeo_css | took 1119743ms 12:45:49 INFO - TEST-START | kraken 12:45:49 INFO - operating with platform_type : mac_ 12:45:49 INFO - Initialising browser for kraken test... 12:45:49 INFO - TEST-INFO | started process 2416 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmpIUikIu/profile http://localhost:58069/getInfo.html) 12:45:52 INFO - PID 2416 | __metrics Screen width/height:1600/1200 12:45:52 INFO - PID 2416 | colorDepth:24 12:45:52 INFO - PID 2416 | Browser inner width/height: 1024/689 12:45:52 INFO - PID 2416 | __metrics 12:45:52 INFO - PID 2416 | 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" 12:45:52 INFO - PID 2416 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:45:53 INFO - TEST-INFO | 2416: exit 0 12:45:53 INFO - Browser initialized. 12:45:53 INFO - Running cycle 1/1 for kraken test... 12:45:53 INFO - TEST-INFO | started process 2417 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmpIUikIu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:46:05 INFO - PID 2417 | RSS: Main: 238821376 12:46:05 INFO - PID 2417 | 12:46:08 INFO - PID 2417 | Cycle 1(1): loaded http://localhost:58069/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58069/tests/kraken/driver.html?testName=audio-beat-detection) 12:46:09 INFO - PID 2417 | RSS: Main: 291696640 12:46:09 INFO - PID 2417 | 12:46:12 INFO - PID 2417 | Cycle 1(1): loaded http://localhost:58069/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58069/tests/kraken/driver.html?testName=audio-dft) 12:46:12 INFO - PID 2417 | RSS: Main: 292560896 12:46:12 INFO - PID 2417 | 12:46:16 INFO - PID 2417 | Cycle 1(1): loaded http://localhost:58069/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58069/tests/kraken/driver.html?testName=audio-fft) 12:46:17 INFO - PID 2417 | RSS: Main: 386605056 12:46:17 INFO - PID 2417 | 12:46:19 INFO - PID 2417 | Cycle 1(1): loaded http://localhost:58069/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58069/tests/kraken/driver.html?testName=audio-oscillator) 12:46:19 INFO - PID 2417 | RSS: Main: 290283520 12:46:19 INFO - PID 2417 | 12:46:21 INFO - PID 2417 | Cycle 1(1): loaded http://localhost:58069/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58069/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:46:22 INFO - PID 2417 | RSS: Main: 292605952 12:46:22 INFO - PID 2417 | 12:46:25 INFO - PID 2417 | Cycle 1(1): loaded http://localhost:58069/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58069/tests/kraken/driver.html?testName=imaging-darkroom) 12:46:26 INFO - PID 2417 | RSS: Main: 334024704 12:46:26 INFO - PID 2417 | 12:46:29 INFO - PID 2417 | Cycle 1(1): loaded http://localhost:58069/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58069/tests/kraken/driver.html?testName=imaging-desaturate) 12:46:30 INFO - PID 2417 | RSS: Main: 345829376 12:46:30 INFO - PID 2417 | 12:46:33 INFO - PID 2417 | Cycle 1(1): loaded http://localhost:58069/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58069/tests/kraken/driver.html?testName=json-parse-financial) 12:46:34 INFO - PID 2417 | RSS: Main: 349831168 12:46:34 INFO - PID 2417 | 12:46:36 INFO - PID 2417 | Cycle 1(1): loaded http://localhost:58069/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58069/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:46:36 INFO - PID 2417 | RSS: Main: 310460416 12:46:36 INFO - PID 2417 | 12:46:38 INFO - PID 2417 | Cycle 1(1): loaded http://localhost:58069/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58069/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:46:39 INFO - PID 2417 | RSS: Main: 315052032 12:46:39 INFO - PID 2417 | 12:46:41 INFO - PID 2417 | Cycle 1(1): loaded http://localhost:58069/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58069/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:46:42 INFO - PID 2417 | RSS: Main: 318029824 12:46:42 INFO - PID 2417 | 12:46:45 INFO - PID 2417 | Cycle 1(1): loaded http://localhost:58069/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58069/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:46:46 INFO - PID 2417 | RSS: Main: 327671808 12:46:46 INFO - PID 2417 | 12:46:49 INFO - PID 2417 | Cycle 1(1): loaded http://localhost:58069/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58069/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:46:50 INFO - PID 2417 | RSS: Main: 315805696 12:46:50 INFO - PID 2417 | 12:46:52 INFO - PID 2417 | Cycle 1(1): loaded http://localhost:58069/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58069/tests/kraken/driver.html?testName=ai-astar) 12:46:52 INFO - PID 2417 | RSS: Main: 383066112 12:46:52 INFO - PID 2417 | 12:46:52 INFO - PID 2417 | __start_tp_report 12:46:52 INFO - PID 2417 | _x_x_mozilla_page_load 12:46:52 INFO - PID 2417 | _x_x_mozilla_page_load_details 12:46:52 INFO - PID 2417 | |i|pagename|runs| 12:46:52 INFO - PID 2417 | |0;ai-astar;111;122;122;124;122;124;124;122;121;123 12:46:52 INFO - PID 2417 | |1;audio-beat-detection;144;115;120;158;119;131;117;111;140;118 12:46:52 INFO - PID 2417 | |2;audio-dft;210;210;244;224;210;210;209;214;213;211 12:46:52 INFO - PID 2417 | |3;audio-fft;85;66;64;107;67;65;65;67;87;68 12:46:52 INFO - PID 2417 | |4;audio-oscillator;92;75;97;75;74;75;93;73;73;90 12:46:52 INFO - PID 2417 | |5;imaging-gaussian-blur;93;91;95;93;100;139;106;138;140;94 12:46:52 INFO - PID 2417 | |6;imaging-darkroom;102;101;102;103;147;156;102;104;100;102 12:46:52 INFO - PID 2417 | |7;imaging-desaturate;102;135;153;123;102;101;100;132;165;101 12:46:52 INFO - PID 2417 | |8;json-parse-financial;52;51;51;51;51;51;52;54;51;51 12:46:52 INFO - PID 2417 | |9;json-stringify-tinderbox;58;67;65;72;65;63;63;64;63;62 12:46:52 INFO - PID 2417 | |10;stanford-crypto-aes;90;92;91;93;87;96;91;90;90;91 12:46:52 INFO - PID 2417 | |11;stanford-crypto-ccm;172;177;173;153;152;151;154;151;244;151 12:46:52 INFO - PID 2417 | |12;stanford-crypto-pbkdf2;199;202;220;216;213;208;209;217;214;213 12:46:52 INFO - PID 2417 | |13;stanford-crypto-sha256-iterative;76;74;76;74;75;75;76;74;76;75 12:46:52 INFO - PID 2417 | __end_tp_report 12:46:52 INFO - PID 2417 | __start_cc_report 12:46:52 INFO - PID 2417 | _x_x_mozilla_cycle_collect,2226 12:46:52 INFO - PID 2417 | __end_cc_report 12:46:52 INFO - PID 2417 | __startTimestamp1492026412296__endTimestamp 12:46:52 INFO - PID 2417 | 12:46:52 INFO - PID 2417 | ------- Summary: start ------- 12:46:52 INFO - PID 2417 | Number of tests: 14 12:46:52 INFO - PID 2417 | 12:46:52 INFO - PID 2417 | [#0] ai-astar Cycles:10 Average:121.50 Median:122.50 stddev:3.84 (3.1%) stddev-sans-first:1.12 12:46:52 INFO - PID 2417 | Values: 111.0 122.0 122.0 124.0 122.0 124.0 124.0 122.0 121.0 123.0 12:46:52 INFO - PID 2417 | 12:46:52 INFO - PID 2417 | [#1] audio-beat-detection Cycles:10 Average:127.30 Median:125.50 stddev:15.38 (12.3%) stddev-sans-first:15.08 12:46:52 INFO - PID 2417 | Values: 144.0 115.0 120.0 158.0 119.0 131.0 117.0 111.0 140.0 118.0 12:46:52 INFO - PID 2417 | 12:46:52 INFO - PID 2417 | [#2] audio-dft Cycles:10 Average:215.50 Median:212.00 stddev:10.94 (5.2%) stddev-sans-first:11.42 12:46:52 INFO - PID 2417 | Values: 210.0 210.0 244.0 224.0 210.0 210.0 209.0 214.0 213.0 211.0 12:46:52 INFO - PID 2417 | 12:46:52 INFO - PID 2417 | [#3] audio-fft Cycles:10 Average:74.10 Median:67.00 stddev:14.29 (21.3%) stddev-sans-first:14.61 12:46:52 INFO - PID 2417 | Values: 85.0 66.0 64.0 107.0 67.0 65.0 65.0 67.0 87.0 68.0 12:46:52 INFO - PID 2417 | 12:46:52 INFO - PID 2417 | [#4] audio-oscillator Cycles:10 Average:81.70 Median:82.50 stddev:9.90 (12.0%) stddev-sans-first:9.77 12:46:52 INFO - PID 2417 | Values: 92.0 75.0 97.0 75.0 74.0 75.0 93.0 73.0 73.0 90.0 12:46:52 INFO - PID 2417 | 12:46:52 INFO - PID 2417 | [#5] imaging-gaussian-blur Cycles:10 Average:108.90 Median:92.00 stddev:21.21 (23.1%) stddev-sans-first:21.70 12:46:52 INFO - PID 2417 | Values: 93.0 91.0 95.0 93.0 100.0 139.0 106.0 138.0 140.0 94.0 12:46:52 INFO - PID 2417 | 12:46:52 INFO - PID 2417 | [#6] imaging-darkroom Cycles:10 Average:111.90 Median:102.50 stddev:21.01 (20.5%) stddev-sans-first:21.97 12:46:52 INFO - PID 2417 | Values: 102.0 101.0 102.0 103.0 147.0 156.0 102.0 104.0 100.0 102.0 12:46:52 INFO - PID 2417 | 12:46:52 INFO - PID 2417 | [#7] imaging-desaturate Cycles:10 Average:121.40 Median:127.50 stddev:24.13 (18.9%) stddev-sans-first:24.56 12:46:52 INFO - PID 2417 | Values: 102.0 135.0 153.0 123.0 102.0 101.0 100.0 132.0 165.0 101.0 12:46:52 INFO - PID 2417 | 12:46:52 INFO - PID 2417 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:51.00 stddev:0.97 (1.9%) stddev-sans-first:1.01 12:46:52 INFO - PID 2417 | Values: 52.0 51.0 51.0 51.0 51.0 51.0 52.0 54.0 51.0 51.0 12:46:52 INFO - PID 2417 | 12:46:52 INFO - PID 2417 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.50 stddev:3.61 (5.6%) stddev-sans-first:3.06 12:46:52 INFO - PID 2417 | Values: 58.0 67.0 65.0 72.0 65.0 63.0 63.0 64.0 63.0 62.0 12:46:52 INFO - PID 2417 | 12:46:52 INFO - PID 2417 | [#10] stanford-crypto-aes Cycles:10 Average:91.10 Median:91.00 stddev:2.33 (2.6%) stddev-sans-first:2.44 12:46:52 INFO - PID 2417 | Values: 90.0 92.0 91.0 93.0 87.0 96.0 91.0 90.0 90.0 91.0 12:46:52 INFO - PID 2417 | 12:46:52 INFO - PID 2417 | [#11] stanford-crypto-ccm Cycles:10 Average:167.80 Median:163.00 stddev:28.75 (17.6%) stddev-sans-first:30.46 12:46:52 INFO - PID 2417 | Values: 172.0 177.0 173.0 153.0 152.0 151.0 154.0 151.0 244.0 151.0 12:46:52 INFO - PID 2417 | 12:46:52 INFO - PID 2417 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:211.10 Median:213.50 stddev:6.64 (3.1%) stddev-sans-first:5.41 12:46:52 INFO - PID 2417 | Values: 199.0 202.0 220.0 216.0 213.0 208.0 209.0 217.0 214.0 213.0 12:46:52 INFO - PID 2417 | 12:46:52 INFO - PID 2417 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.10 Median:75.50 stddev:0.88 (1.2%) stddev-sans-first:0.87 12:46:52 INFO - PID 2417 | Values: 76.0 74.0 76.0 74.0 75.0 75.0 76.0 74.0 76.0 75.0 12:46:52 INFO - PID 2417 | -------- Summary: end -------- 12:46:52 INFO - PID 2417 | 12:46:53 INFO - TEST-INFO | 2417: exit 0 12:46:53 INFO - TEST-OK | kraken | took 64137ms 12:46:53 INFO - SUITE-END | took 1183s 12:46:53 INFO - Completed test suite (00:19:44) 12:46:53 INFO - javascript benchmark 12:46:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7655.66749235144, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3224.9677503224966, 3461.5846098468187, 3465.6361082086364, 3505.7370697197716, 3549.662782035707, 6029.577929544934, 6115.6967227388295, 6121.66330851803, 6135.815925522242, 6141.815745527636, 6043.829069578778, 6088.786892458754, 6125.57121001529, 6126.192588752531, 6146.600470969383, 4891.339669144673, 5181.818636347729, 5276.683398996053, 5310.256564081032, 5419.430959749228, 5341.626086173969, 5356.9732151339385, 5364.0, 5373.435789242132, 5407.783688652449, 5168.173092305232, 5236.29310043147, 5257.237700533401, 5260.842174734764, 5286.920696189561, 5244.895102097937, 5250.553702935217, 5253.658512196733, 5272.710000949946, 5274.683518988873, 5167.0, 5223.112070947948, 5228.163493840967, 5240.292560504321, 5244.842654720364, 5847.181394604716, 5860.677662728548, 5873.676947767871, 5873.706314684248, 5896.557758168155, 6357.0, 6361.809145725636, 6364.077208804697, 6367.968160159169, 6380.744770209186, 6314.71583778731, 6514.315996820361, 6585.835354116138, 6597.703103360361, 6599.637019963948, 6195.070739389128, 6212.4408803207925, 6221.377862213788, 6222.719977601018, 6238.313785483593, 5602.943970560324, 6683.298253683391, 6695.430888374445, 6698.832529186712, 6708.496862735315, 6249.812505624838, 6336.714847831859, 6337.366263373626, 6346.4605508532295, 6347.174867267226, 5334.946650533522, 6390.0, 6396.200474940632, 6406.23125224976, 6412.551121421456, 6311.1795466589965, 6332.620042797447, 6349.14286571307, 6374.681265936684, 6399.0, 6302.739766397824, 6439.839004024843, 6444.838879027968, 6451.0645956337, 6455.2576453708425, 5246.23929530216, 5247.2653828464045, 5253.106971814801, 5267.499587539178, 5296.947030529723, 4562.771861406916, 4562.84030058953, 4614.469336026333, 4635.072985402933, 4663.953360466419, 5076.568491678248, 6197.845053873689, 6209.844753881189, 6220.502359811204, 6225.937740622536, 6458.2895881453005, 6478.963365861534, 6486.189226346707, 6491.091247225392, 6491.8701625967215, 6021.0, 6031.607945483617, 6217.191765070512, 6235.095911092866, 6246.250449946036, 5627.549796016309, 5720.799772008043, 5738.942610573841, 5773.653580785082, 5779.959607270732, 6651.135352404253, 6719.899201512079, 6727.058211850247, 6727.226368967631, 6735.6968936397, 6488.994205898093, 6496.187976502937, 6540.934590654223, 6571.474282057328, 6576.145101136822, 6409.4231519163495, 6487.416132547904, 6501.447376972821, 6600.174978127734, 6667.033280174251, 6407.455366293917, 6417.486601071996, 6431.163948686641, 6439.549231553746, 6440.967795160994, 6424.0, 6498.3826536478955, 6510.0885875976455, 6515.576487528296, 6547.541672083099, 6211.65835879031, 6213.5339849512375, 6273.153124328157, 6308.747650093945, 6355.396237357444, 6270.529710271839, 6277.591956522994, 6280.277768056732, 6280.560360774702, 6297.937020629735, 5232.5552328052545, 6161.168242287234, 6177.042558403455, 6219.036049412348, 6274.749010039547, 6250.156228909039, 6261.718222680081, 6293.748250069946, 6304.243490781136, 6327.905081423874, 6244.968775156095, 6269.216347956505, 6269.592476489013, 6283.37166283368, 6300.527460440577], "value": 5916.403233452459, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.7530500147441, 709.2234003765877, 765.9119201291851, 1137.6302701621976, 1158.4844744088884, 27165.91336346546, 27758.444831103367, 27773.861130694317, 36252.19351968045, 36726.0, 38649.22701545968, 39046.0, 39088.41367379484, 39095.60904390955, 39118.02204944878, 8437.873431898526, 8600.956995215016, 8638.956805215965, 8640.39517233794, 8648.913510864904, 6138.416850399227, 6293.244810622732, 6297.08692239625, 8494.915050849475, 8633.611487483047, 6280.654563998978, 6320.083587879754, 6322.336154703758, 8506.574671266442, 8677.739667809945, 8670.046294907555, 8718.782030449258, 8729.039805621376, 8732.825343493094, 8734.69428569997, 8406.28546573542, 8494.830103397959, 8499.702510412106, 8502.447340922881, 8512.233898949124, 25664.0, 26073.95704171831, 35666.108347291265, 36710.8164459176, 36982.0, 3591.6408359163875, 3604.4953706481115, 3616.945745813815, 3619.7647152934974, 3624.5650521937537, 30318.69681303181, 30426.391472170653, 30435.23911902198, 30452.086437406913, 30476.390472190655, 2682.141714651312, 2945.882164713409, 3169.1760142362923, 3186.681331866818, 3187.553742476055, 262961.0, 266201.0, 268362.0, 269779.0, 269813.0, 47991.52008479871, 48124.75937620289, 48143.79640509015, 48163.27755083676, 48229.7942551432, 50566.494335056916, 50651.24023139656, 50729.74635126875, 50809.74595127001, 50854.491455085714, 14196.716065678835, 14296.714065718628, 14362.552987283187, 14371.425142994163, 14417.207053612152, 11733.35466549348, 11734.354610496333, 11737.589184378507, 11746.530138794353, 11802.996745276747, 10124.240681948882, 12592.559260426024, 12760.489580416865, 12772.808407873888, 12901.483940642456, 3966.9685881670976, 4271.337942618837, 4648.3259927310355, 4784.904301913943, 5363.892722145535, 1014.2757312568516, 1020.1430798129459, 1026.4200726589454, 1048.3762161513887, 1060.5704689600725, 18108.818911810977, 24171.75828241695, 24184.87907560451, 24362.390940226636, 24503.142390016263, 1104.1222228328497, 1115.5147510832815, 1160.442987366069, 1160.5357856857156, 1169.6607983684805, 12298.385080745928, 12465.688357790947, 12475.93762031184, 12478.876901078946, 12502.937485312515, 326926.0, 327024.0, 327190.0, 327256.0, 327447.0, 53496.0, 53520.73239633777, 53668.0, 53681.46318536765, 53751.73124134433, 1489.2404873514586, 1497.161589509878, 1545.489988303857, 1553.6038310231045, 1557.1435710359258, 18977.14929195689, 21827.563448731253, 22577.984815390955, 23749.64375534334, 23917.880410597834, 38207.04482387962, 38348.0, 38485.0, 38500.614993850824, 38519.0370240735, 288601.0, 288918.0, 289229.0, 289964.0, 290494.547527261, 30222.524409693167, 31454.0, 34283.314333713686, 34446.48330275098, 34451.655483445844, 42629.786851065546, 43659.78170109129, 43759.34360984652, 43898.90252743707, 44119.77940110279, 28957.710422896344, 29007.274818129714, 29906.551401728557, 30201.244968875955, 30484.390312194075, 26329.473410532064, 29712.96004639827, 30044.948426804956, 30159.396812064075, 30177.300926361724, 35449.645503544634, 35924.82037589795, 36036.91889243327, 36124.45813312855, 36202.63797362098, 26580.40517568952, 28970.855145724137, 30667.53998690066, 30770.53844192294, 31094.22264443407, 18962.810371896656, 19970.0, 21867.07331050963, 22591.20930767415, 23666.17168399098], "value": 16868.98620896486, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.7317750751979, 421.93887245850055, 434.259587403477, 441.1683975705795, 452.9614982726468, 17456.476305710832, 18346.633067338644, 21190.470238244034, 22851.31446056621, 22895.656565151538, 23321.76678233217, 23441.827908604588, 24035.75964240357, 24292.75707242927, 24359.269221923325, 6130.0, 6134.294556126036, 6262.9686851565675, 6313.28525760166, 6335.0, 6261.812145635638, 6284.0, 6386.201724784379, 6393.808185754435, 6394.61632302061, 5067.265246539249, 6259.467945224661, 6322.272938612073, 6323.0, 6329.588576742497, 6041.335453100155, 6271.278802937675, 6308.463780578656, 6309.810705678837, 6317.557770956035, 4761.666683332168, 5655.491005809456, 5660.207570940031, 5660.264165658479, 5663.518600918886, 27180.728192718216, 27644.72355276462, 28420.85789571039, 28449.57325640117, 28667.85666071677, 2242.159190303636, 2295.1966811615966, 2295.885205739706, 2296.8621882686925, 2298.839081264312, 17678.292868285254, 18645.813541864678, 18655.0, 18700.0, 18868.905655471634, 1747.9038652874087, 2137.647288197461, 2149.269248455517, 2150.967735483969, 2180.760116387196, 158982.0, 160140.0, 160865.0, 161969.0, 163406.18296908558, 10515.52680129396, 11236.438178091063, 11783.646490605295, 12316.692082698004, 12612.684682883002, 14300.356483958247, 15473.5357939262, 16710.415135470445, 16715.16424178786, 16856.241469133918, 7671.654775535114, 8879.866801997976, 9141.634334626673, 9146.95426522863, 9240.065209913028, 7005.92994070063, 7205.0, 8826.955865220632, 9016.8647470288, 9018.59416326267, 7806.414518911104, 7935.880961785578, 7990.960045199737, 8005.359571234288, 8047.919520804717, 2175.7497887742798, 2197.0, 2199.7030400895997, 2206.1285792112026, 2348.3659411959015, 948.6158105967095, 964.1370972979145, 965.2712202287369, 1003.5433877585681, 1003.6637726361605, 18628.97540635278, 19080.71378929317, 20296.289629862884, 20909.222716069, 20962.951852407317, 888.294711824121, 972.9610815567439, 987.3730181334761, 988.3427520698799, 1021.3106153346462, 9271.397359171768, 10880.183986200907, 10903.781924361469, 10952.452377381258, 11061.612843550438, 601757.0, 630119.0, 647270.0, 659487.0, 660561.3943860596, 153480.2325988363, 156423.0, 156727.21636391745, 157398.0, 158788.0, 1152.9884701153048, 1160.7678464307173, 1185.51986445488, 1189.1735244005506, 1235.1971218707731, 21527.246546370803, 21569.813660248838, 22504.88747556252, 22889.427764306027, 22959.311220663407, 60916.39083609107, 64691.67654161699, 65703.67148164229, 65829.0, 66255.66872165608, 62973.05540416989, 89649.0, 90100.5494972521, 91148.0, 93808.53095734477, 8881.111888811325, 8953.32850036263, 9082.682106126254, 9106.499142547224, 9163.633454661738, 13865.930670346585, 14448.638784030483, 14461.638459038608, 14889.627759306104, 15041.924790376415, 10355.689329320132, 11767.470463828977, 12193.012711885645, 12245.632631021084, 12337.568185113478, 9327.440353578808, 9771.560279787569, 10458.738531536772, 11475.426228688699, 11581.652550423501, 11817.468213930566, 12328.445219965302, 12467.75064498723, 12502.562410315959, 12587.496500139892, 8838.425502342327, 8850.867236991578, 9158.584926828105, 9319.673811416567, 9366.859497107413, 9940.403575785476, 11122.944385278022, 11708.414579270831, 12210.633680989584, 12246.632601021984], "value": 10666.189953586665, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1298.6493646715387, 1363.6522686714889, 1415.2852809331287, 1455.3160014793048, 1460.1750011243653, 11015.449227538622, 11475.713107172303, 11485.368304743226, 11492.540298388076, 11504.25222360546, 11116.277441966267, 11193.27243729157, 11486.885131148685, 11503.48234329455, 11518.884811151886, 2475.6410320503514, 2525.5075260324243, 2526.343150780801, 2527.178666933254, 2527.734587868266, 2424.2242482405636, 2432.282476669378, 2467.4078221226955, 2468.025130073629, 2472.8269021168526, 2419.8911049002836, 2520.206135067457, 2520.773130418262, 2523.066465407802, 2525.4822761333976, 2449.2774631483753, 2470.3947532854386, 2472.950540989179, 2502.912398066059, 2503.0113105323294, 2448.09420514409, 2467.0748469324003, 2481.813863960192, 2488.1913378151994, 2490.7882829959476, 11542.480588373543, 11618.94190529042, 11638.6508404748, 11643.76712465746, 11652.533898644044, 6411.3588641135975, 6661.63361015144, 6667.899981500282, 6671.33286671329, 6677.265500794909, 3982.26328129297, 4132.648724858391, 4181.560936101726, 4233.576642335773, 4334.371516130175, 1211.7031327324773, 1239.770642431144, 1290.9612711618665, 1294.4757373263844, 1296.002078399627, 14060.789088163685, 14482.1310721356, 14483.493077742229, 15952.0, 16120.0, 5310.628256022042, 5417.024935511646, 5613.887722245532, 5614.803481878114, 5627.071533197059, 12021.819672704916, 12041.096917731205, 12057.095717821023, 12057.733937936566, 12063.457144428521, 6484.124643173205, 6484.1894763154605, 6487.026945958144, 6493.415592596689, 6495.382938620918, 5965.642061476326, 6062.696865156725, 6150.538709596798, 6157.815265542041, 6235.875282494325, 3606.4590311453494, 4191.392248124066, 4322.0491491871735, 4335.804888780012, 4371.497277813029, 1108.8780234174235, 1229.2685851918095, 1265.5760320292804, 1287.9549215777404, 1292.360281660584, 700.2542292458515, 742.2132539508139, 774.2567135549823, 814.4909431605247, 835.6490274084899, 4251.383549385322, 6087.512998960073, 6306.211723534559, 6334.904976425358, 6412.134361861089, 540.2625416306713, 595.6902410746387, 614.2567493333117, 615.5937081526171, 627.0281064350239, 4088.691618681993, 4210.389493523422, 4284.031167391073, 4291.742495450283, 4325.52419233884, 14173.71652566943, 14906.180160091082, 14906.180160091299, 14932.178730169728, 14941.477048303257, 14655.120692758468, 14828.258587070603, 14848.554543363716, 14867.702645947236, 14871.0, 10251.231157663206, 10566.735831604117, 10829.458527073772, 10853.24027318096, 10861.1854110942, 5716.54267658578, 5969.3732158122775, 6973.895391569232, 7146.749863754952, 7163.713451462092, 12155.635330940086, 12325.876741232472, 12699.047571431995, 12719.87280127187, 12734.981201503671, 13517.662058448224, 13618.387172577455, 13796.241206733726, 13827.51603693866, 13847.0, 8375.45559538628, 8540.957295213484, 8550.615222315135, 8554.700585479479, 8564.871526927225, 10453.738656533647, 10472.162227021972, 10546.314489558154, 10560.894391055992, 10566.31318964265, 8908.331875109263, 8944.150305720947, 8962.238209751984, 8988.505632190292, 9009.909900900908, 8580.785480363042, 8727.476351418682, 8742.38803283764, 8827.646894124164, 8837.027926928162, 7930.841383172419, 8107.918920810716, 8108.83782324362, 8115.83768324642, 8122.472039317426, 5924.733386997509, 5954.523638109027, 6074.514038876968, 6135.509159267337, 6173.506119510518, 5990.34106248321, 6096.776606087731, 6157.322694503511, 6287.622742635456, 6313.810585682437], "value": 5263.47454291671, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.51903625525455, 398.99401508977354, 402.84691817109496, 409.59654740081, 410.7761270107791, 5304.761285742141, 5546.696526316317, 5688.63023903446, 5869.9706501467535, 5886.793962211324, 5063.746632748428, 5176.171812509999, 5279.049771041211, 5649.830505084844, 5657.4159235414045, 3645.2345007548447, 3980.840766369349, 4189.835381497627, 4389.275769498045, 4470.597646211841, 3873.3028054950096, 4297.484301883763, 4457.88855278619, 4508.526604706508, 4515.345274935133, 3377.966220337802, 4111.992561822358, 4173.8330466781445, 4485.52901945296, 4495.527969563198, 4002.837049468549, 4036.1725846201457, 4282.528921818597, 4304.418903448041, 4325.675574331937, 3734.9626503734885, 3741.30785804627, 3756.6619004289746, 3762.3851423260844, 3765.4163604641326, 4607.884802879921, 5646.571974051157, 5660.028669753408, 5670.051573181963, 5713.942920559668, 4618.699784513996, 4788.832390866338, 5026.170681837492, 5028.823991160292, 5076.720780357079, 6115.266168059861, 6127.0, 6129.62870421271, 6130.0, 6151.046587778901, 4087.8773636790943, 4209.6000879916355, 4226.746395216266, 4233.491980962273, 4234.17433600448, 5756.740946657411, 6124.663143527104, 6203.658798766066, 6302.149209856702, 6306.558540902093, 3296.538484612156, 4178.770167640748, 4266.506722647111, 4280.72175308604, 4285.228658841376, 3621.764585301947, 3672.412414013745, 4294.914101717948, 4363.807069587181, 4369.650427965755, 4522.4573051234065, 4734.342979957057, 4822.0, 5065.138926382524, 5086.338775959101, 5331.480528049565, 5865.882682346414, 6153.7230824613, 6157.476614487729, 6160.784372547029, 1279.366713476835, 1452.7724073158165, 1454.8763355114934, 1481.5185064853965, 1483.1842486632308, 955.3264948211634, 981.6956743409565, 988.7280997725683, 992.7220378294089, 999.2355847776457, 4694.43666759991, 5100.566451851634, 5809.5352371811, 5816.069428891357, 5826.970865145647, 5519.972400138054, 5757.942420575824, 6372.55392122547, 6380.617162970237, 6392.39272269143, 4840.75796210188, 5091.363579552556, 5510.256115424447, 5769.192313076089, 5841.620294680833, 3268.9019329420157, 3316.922000349896, 3317.3531161423775, 3323.5347051412823, 3335.5830521184853, 4930.077269864755, 5181.326427564468, 6216.222972128484, 6259.874802503924, 6522.0, 5146.408163061221, 5708.0, 6400.551961362753, 6440.61356318613, 6464.22429308486, 6395.2645445773405, 6481.902771458432, 6505.707243173973, 6509.804705858832, 6529.608223506605, 4885.14364541472, 5537.307836520435, 5788.160716695971, 5866.2960444746905, 6020.638761674313, 5617.297837770278, 5845.298564172156, 6236.781712640036, 6246.562740608114, 6264.467520260829, 5954.583179177589, 6112.388761123852, 6224.906626400698, 6355.474686075401, 6506.674666266573, 4001.4998125234347, 4233.91532169361, 4244.432118568345, 4254.680898932655, 4257.91484170321, 4903.0, 5391.649542779707, 6107.755689772359, 6303.5902666328375, 6389.456896163878, 4749.525047495223, 5653.858653533694, 5763.991301522301, 5955.796355348549, 6143.139960405636, 6011.325828581503, 6125.081237814185, 6141.40323515898, 6151.231096112986, 6156.538259630456, 4431.689781715249, 4986.32684587576, 5236.921446178234, 5370.475876338115, 6064.696765161636, 5334.519448456486, 5578.916316255179, 5969.671668058125, 6117.938820611737, 6156.846078848064, 5316.171800571647, 5952.791652292149, 5986.191864098291, 6015.338312785678, 6029.487493563096], "value": 4416.861073930357, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.6820996446618, 835.2691395029349, 847.9618417171223, 850.0946491986034, 858.2618947704974, 13562.796558051637, 17852.642947141067, 18612.627747445043, 18638.813611863876, 18657.440276791684, 17163.74254386182, 17583.29666813326, 17736.733948990775, 17775.466735997907, 17785.0, 914.3964983111165, 951.0394501553446, 954.1698722111772, 954.2652157838495, 956.2159029595734, 652.1782553981993, 673.3233100733755, 675.6790524500872, 676.6853413162878, 677.0352248046538, 997.3643225110824, 1050.8844027157006, 1054.2409465185056, 1056.3397876327294, 1056.561526966312, 1037.5590374091018, 1038.5170895533538, 1041.7864337810731, 1041.8020576090519, 1042.3902017319801, 747.1482509938675, 752.0711920777835, 752.1650967426152, 752.6011214056504, 753.3558807219857, 16733.66532669352, 17085.0, 17148.485545433658, 17177.742333865, 17381.217845196996, 13846.515371961934, 16052.438164664181, 16283.91858040714, 16388.26252818614, 16495.670086598202, 13919.652008699763, 14270.357833897395, 14461.566153015427, 15700.921495392564, 15804.0, 3532.1522834519787, 3539.7876127432437, 3542.433210686278, 3544.432890737495, 3550.14796448853, 98438.50780746122, 108420.0, 110341.89658103477, 110405.0, 110668.0, 11274.774504509864, 11649.534018639159, 13456.730865382833, 13742.244176570184, 13785.448582056806, 19350.709739353922, 23719.051237950633, 24303.75696243015, 24465.143719969714, 25135.62296565553, 8846.46921184731, 8846.601902914384, 9067.501287429122, 9083.182513573678, 9097.681581144629, 4772.236442169236, 4929.088118698052, 4933.260010998379, 4933.555979961749, 4944.085344211332, 4247.957520424818, 4259.829606815754, 4270.35944608305, 4382.408374869416, 4393.560643935645, 912.9406588571721, 926.0831776541175, 929.6235024814961, 933.0809152984305, 934.7149119518476, 640.4556127291858, 663.1213641924469, 670.276101810044, 673.9191297044387, 700.5236439221277, 10016.899831001743, 10814.567417303377, 11274.605388811353, 11382.373969431761, 11535.942320288344, 645.4449173710605, 649.95775274607, 653.3368630839701, 668.4017804065335, 685.2873012067494, 4264.786760661955, 5471.50756431923, 5530.115181570929, 5599.048161812501, 5639.915401268984, 82159.0, 109061.90938090676, 111251.44374278077, 111375.0, 113749.62563641676, 97832.53251201237, 98659.50670246602, 99003.50498247462, 100571.49714251382, 100750.48874266892, 63878.0, 85949.0, 87661.93183238684, 88763.78090547658, 90280.0, 8923.330750193632, 9674.274429417681, 10408.687739367831, 10931.890681093088, 11010.39442830652, 41932.79033604812, 42408.0, 42840.28638854411, 42883.571164287954, 42899.142017160106, 42481.787591061846, 56666.15000774909, 56945.29164125083, 57894.13158802537, 58395.12407313809, 13854.30728463593, 14141.222232777296, 14169.787453188004, 14209.0, 14223.146611203361, 15551.14468704187, 15598.98606590568, 15834.287457064229, 15872.047677139408, 15910.920445397698, 14342.139471631735, 14372.993890427988, 14495.78256326135, 14654.267286635839, 14656.340464678902, 13032.283224422748, 13049.478020879058, 13064.80402793978, 13185.40665670028, 13269.33653317311, 14257.287135643384, 14315.427382904567, 14467.059641123293, 16075.35698572044, 17099.145042747565, 11573.942130289295, 11729.706757331134, 11944.581939632419, 12293.815592766294, 12428.37858107109, 12609.180403273758, 13702.177869327872, 13772.311384430537, 13796.034277600873, 13814.309284535933], "value": 8134.340188561865, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1623.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 122.0, 122.0, 124.0, 122.0, 124.0, 124.0, 122.0, 121.0, 123.0], "value": 121.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 115.0, 120.0, 158.0, 119.0, 131.0, 117.0, 111.0, 140.0, 118.0], "value": 127.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [210.0, 210.0, 244.0, 224.0, 210.0, 210.0, 209.0, 214.0, 213.0, 211.0], "value": 215.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 66.0, 64.0, 107.0, 67.0, 65.0, 65.0, 67.0, 87.0, 68.0], "value": 74.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 75.0, 97.0, 75.0, 74.0, 75.0, 93.0, 73.0, 73.0, 90.0], "value": 81.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 95.0, 93.0, 100.0, 139.0, 106.0, 138.0, 140.0, 94.0], "value": 108.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 101.0, 102.0, 103.0, 147.0, 156.0, 102.0, 104.0, 100.0, 102.0], "value": 111.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 135.0, 153.0, 123.0, 102.0, 101.0, 100.0, 132.0, 165.0, 101.0], "value": 121.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 51.0, 51.0, 51.0, 52.0, 54.0, 51.0, 51.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 67.0, 65.0, 72.0, 65.0, 63.0, 63.0, 64.0, 63.0, 62.0], "value": 64.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 92.0, 91.0, 93.0, 87.0, 96.0, 91.0, 90.0, 90.0, 91.0], "value": 91.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 177.0, 173.0, 153.0, 152.0, 151.0, 154.0, 151.0, 244.0, 151.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 202.0, 220.0, 216.0, 213.0, 208.0, 209.0, 217.0, 214.0, 213.0], "value": 211.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 74.0, 75.0, 75.0, 76.0, 74.0, 76.0, 75.0], "value": 75.1, "unit": "score"}]}]} 12:46:54 INFO - Return code: 0 12:46:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:46:54 ERROR - # TBPL SUCCESS # 12:46:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:46:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:46:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:46:54 INFO - 2017-04-12 12:46:54.100 screenresolution[2421:33038] starting screenresolution argv=screenresolution get 12:46:54 INFO - 2017-04-12 12:46:54.102 screenresolution[2421:33038] Display 0: 1600x1200x32@60 12:46:54 INFO - 2017-04-12 12:46:54.108 screenresolution[2422:33041] starting screenresolution argv=screenresolution list 12:46:54 INFO - Available Modes on Display 0 12:46:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:46:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:46:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:46:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:46:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:46:54 INFO - Intel Iris: 12:46:54 INFO - Chipset Model: Intel Iris 12:46:54 INFO - Type: GPU 12:46:54 INFO - Bus: Built-In 12:46:54 INFO - VRAM (Dynamic, Max): 1536 MB 12:46:54 INFO - Vendor: Intel (0x8086) 12:46:54 INFO - Device ID: 0x0a2e 12:46:54 INFO - Revision ID: 0x0009 12:46:54 INFO - Displays: 12:46:54 INFO - Display: 12:46:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:46:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:46:54 INFO - Display Serial Number: 1600x1200 60 12:46:54 INFO - Main Display: Yes 12:46:54 INFO - Mirror: Off 12:46:54 INFO - Online: Yes 12:46:54 INFO - Rotation: Supported 12:46:54 INFO - Return code: 0 12:46:54 INFO - Running post-action listener: _resource_record_post_action 12:46:54 INFO - [mozharness: 2017-04-12 19:46:54.343249Z] Finished run-tests step (success) 12:46:54 INFO - Running post-run listener: _resource_record_post_run 12:46:54 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 684032; Write bytes: 519245824; Read time: 6; Write time: 1613 12:46:54 INFO - TinderboxPrint: CPU usage
53.3% 12:46:54 INFO - TinderboxPrint: I/O read bytes / time
684,032 / 6 12:46:54 INFO - TinderboxPrint: I/O write bytes / time
519,245,824 / 1,613 12:46:54 INFO - TinderboxPrint: CPU idle
2,253.5 (46.7%) 12:46:54 INFO - TinderboxPrint: CPU system
959.9 (19.9%) 12:46:54 INFO - TinderboxPrint: CPU user
1,608.4 (33.4%) 12:46:54 INFO - TinderboxPrint: Swap in / out
208,015,360 / 0 12:46:54 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203188736; Write bytes: 204318208; Read time: 16090; Write time: 443 12:46:54 INFO - run-tests - Wall time: 1185s; CPU: 53.0%; Read bytes: 684032; Write bytes: 308136448; Read time: 6; Write time: 1141 12:46:54 INFO - Running post-run listener: _upload_blobber_files 12:46:54 INFO - Blob upload gear active. 12:46:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:46:54 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 12:46:54 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'] 12:46:54 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 12:46:55 INFO - (blobuploader) - INFO - Open directory for files ... 12:46:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:46:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:46:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:46:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:46:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:46:56 INFO - (blobuploader) - INFO - Done attempting. 12:46:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:46:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:46:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:46:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:46:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:46:57 INFO - (blobuploader) - INFO - Done attempting. 12:46:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:46:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:46:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:46:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:46:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:46:57 INFO - (blobuploader) - INFO - Done attempting. 12:46:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:46:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:46:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:47:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:47:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:47:00 INFO - (blobuploader) - INFO - Done attempting. 12:47:00 INFO - (blobuploader) - INFO - Iteration through files over. 12:47:00 INFO - Return code: 0 12:47:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:47:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:47:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7493c45eb6e997e21d28e0d273eafe800ffffe790ae1804b124effe2d0ececd97410cc5d4689e713084364931f96c6dbedf3c743fc3667f449817107cd55268e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90ce9a0d8335ea7b7b3c873770017aac768aa1598a623efad297ac21c4fd12cf063b4e8eeb7f4f859b05b358f64792b071e00285b19e5589addf36253137237d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb9b3dd429362c1d10f94b900996fc7f0633c87ffed5917596cbe0c5b777fed957933e55570e73f7a108821879e2ce1091368c3e1dbf99fcf3e2b000e6ea0d92", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e25e74a01449fa88334c00c7cc3e65d0b375af24f4ca190036841b5473deedf06d626be5a88a03b73062bb95bd15d4a015d333f5125525394e1536063144d999"} 12:47:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:47:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:47:00 INFO - Contents: 12:47:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7493c45eb6e997e21d28e0d273eafe800ffffe790ae1804b124effe2d0ececd97410cc5d4689e713084364931f96c6dbedf3c743fc3667f449817107cd55268e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90ce9a0d8335ea7b7b3c873770017aac768aa1598a623efad297ac21c4fd12cf063b4e8eeb7f4f859b05b358f64792b071e00285b19e5589addf36253137237d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb9b3dd429362c1d10f94b900996fc7f0633c87ffed5917596cbe0c5b777fed957933e55570e73f7a108821879e2ce1091368c3e1dbf99fcf3e2b000e6ea0d92", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e25e74a01449fa88334c00c7cc3e65d0b375af24f4ca190036841b5473deedf06d626be5a88a03b73062bb95bd15d4a015d333f5125525394e1536063144d999"} 12:47:00 INFO - Running post-run listener: copy_logs_to_upload_dir 12:47:00 INFO - Copying logs to upload dir... 12:47:00 INFO - mkdir: /builds/slave/test/build/upload/logs 12:47:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.907273 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-04-12 12:47:01.062150) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-12 12:47:01.065858) ========= 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.V1chTFqXn8/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.9E8Yt8U098/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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/7493c45eb6e997e21d28e0d273eafe800ffffe790ae1804b124effe2d0ececd97410cc5d4689e713084364931f96c6dbedf3c743fc3667f449817107cd55268e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90ce9a0d8335ea7b7b3c873770017aac768aa1598a623efad297ac21c4fd12cf063b4e8eeb7f4f859b05b358f64792b071e00285b19e5589addf36253137237d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb9b3dd429362c1d10f94b900996fc7f0633c87ffed5917596cbe0c5b777fed957933e55570e73f7a108821879e2ce1091368c3e1dbf99fcf3e2b000e6ea0d92", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e25e74a01449fa88334c00c7cc3e65d0b375af24f4ca190036841b5473deedf06d626be5a88a03b73062bb95bd15d4a015d333f5125525394e1536063144d999"} build_url:https://queue.taskcluster.net/v1/task/SyJLc0NPTFyk6yPLuOPEJA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011478 build_url: 'https://queue.taskcluster.net/v1/task/SyJLc0NPTFyk6yPLuOPEJA/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/7493c45eb6e997e21d28e0d273eafe800ffffe790ae1804b124effe2d0ececd97410cc5d4689e713084364931f96c6dbedf3c743fc3667f449817107cd55268e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90ce9a0d8335ea7b7b3c873770017aac768aa1598a623efad297ac21c4fd12cf063b4e8eeb7f4f859b05b358f64792b071e00285b19e5589addf36253137237d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb9b3dd429362c1d10f94b900996fc7f0633c87ffed5917596cbe0c5b777fed957933e55570e73f7a108821879e2ce1091368c3e1dbf99fcf3e2b000e6ea0d92", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e25e74a01449fa88334c00c7cc3e65d0b375af24f4ca190036841b5473deedf06d626be5a88a03b73062bb95bd15d4a015d333f5125525394e1536063144d999"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-12 12:47:01.101100) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 12:47:01.101459) ========= 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.V1chTFqXn8/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.9E8Yt8U098/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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.005230 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 12:47:01.150468) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-12 12:47:01.150807) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-12 12:47:01.151166) ========= ========= Total master_lag: 0.18 =========