builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0312 starttime: 1481561309.1 results: success (0) buildid: 20161212080751 builduid: d1479deae8fb4ab4a901510c1943dbce revision: 4ee7b6591cf4128098225651e734dbf04eef57bb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-12 08:48:29.104186) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-12 08:48:29.104596) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-12 08:48:29.104889) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-12 08:48:29.130240) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 08:48:29.130590) ========= 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.ImuR1OfRW4/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.ANYfmiSGvw/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 --2016-12-12 08:48:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.94M=0.001s 2016-12-12 08:48:29 (7.94 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.490088 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 08:48:29.653716) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 08:48:29.654042) ========= 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.ImuR1OfRW4/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.ANYfmiSGvw/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.019670 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 08:48:29.702404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-12 08:48:29.702727) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4ee7b6591cf4128098225651e734dbf04eef57bb --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 4ee7b6591cf4128098225651e734dbf04eef57bb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ImuR1OfRW4/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.ANYfmiSGvw/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 2016-12-12 08:48:29,779 truncating revision to first 12 chars 2016-12-12 08:48:29,779 Setting DEBUG logging. 2016-12-12 08:48:29,779 attempt 1/10 2016-12-12 08:48:29,779 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4ee7b6591cf4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-12 08:48:31,033 unpacking tar archive at: mozilla-central-4ee7b6591cf4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.500779 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-12 08:48:31.226968) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-12 08:48:31.227293) ========= script_repo_revision: 4ee7b6591cf4128098225651e734dbf04eef57bb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-12 08:48:31.227682) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-12 08:48:31.227968) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-12 08:48:31.247569) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-12-12 08:48:31.247891) ========= /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.ImuR1OfRW4/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.ANYfmiSGvw/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 08:48:31 INFO - MultiFileLogger online at 20161212 08:48:31 in /builds/slave/test 08:48:31 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 08:48:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:48:31 INFO - {'append_to_log': False, 08:48:31 INFO - 'base_work_dir': '/builds/slave/test', 08:48:31 INFO - 'blob_upload_branch': 'Firefox', 08:48:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:48:31 INFO - 'branch': 'Firefox', 08:48:31 INFO - 'buildbot_json_path': 'buildprops.json', 08:48:31 INFO - 'config_files': ('talos/mac_config.py',), 08:48:31 INFO - 'default_actions': ('clobber', 08:48:31 INFO - 'read-buildbot-config', 08:48:31 INFO - 'download-and-extract', 08:48:31 INFO - 'populate-webroot', 08:48:31 INFO - 'create-virtualenv', 08:48:31 INFO - 'install', 08:48:31 INFO - 'run-tests'), 08:48:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:48:31 INFO - 'download_minidump_stackwalk': True, 08:48:31 INFO - 'download_symbols': 'ondemand', 08:48:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:48:31 INFO - 'tooltool.py': '/tools/tooltool.py', 08:48:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:48:31 INFO - '/tools/misc-python/virtualenv.py')}, 08:48:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:48:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:48:31 INFO - 'installer_path': 'installer.exe', 08:48:31 INFO - 'log_level': 'info', 08:48:31 INFO - 'log_name': 'talos', 08:48:31 INFO - 'log_to_console': True, 08:48:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:48:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:48:31 INFO - 'opt_config_files': (), 08:48:31 INFO - 'pip_index': False, 08:48:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:48:31 INFO - 'cmd': ('bash', 08:48:31 INFO - '-c', 08:48:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:48:31 INFO - 'enabled': True, 08:48:31 INFO - 'halt_on_failure': False, 08:48:31 INFO - 'name': 'check_screen_resolution'},), 08:48:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:48:31 INFO - 'cmd': ('bash', 08:48:31 INFO - '-c', 08:48:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:48:31 INFO - 'enabled': True, 08:48:31 INFO - 'halt_on_failure': False, 08:48:31 INFO - 'name': 'check_screen_resolution'},), 08:48:31 INFO - 'run_cmd_checks_enabled': True, 08:48:31 INFO - 'sps_profile': False, 08:48:31 INFO - 'sps_profile_interval': 0, 08:48:31 INFO - 'suite': 'dromaeojs', 08:48:31 INFO - 'system_bits': '32', 08:48:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:48:31 INFO - 'title': 't-yosemite-r7-0312', 08:48:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:48:31 INFO - 'use_talos_json': True, 08:48:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:48:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:48:31 INFO - 'work_dir': 'build'} 08:48:31 INFO - [mozharness: 2016-12-12 16:48:31.441433Z] Running clobber step. 08:48:31 INFO - Running pre-action listener: _resource_record_pre_action 08:48:31 INFO - Running main action method: clobber 08:48:31 INFO - rmtree: /builds/slave/test/build 08:48:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:48:33 INFO - Running post-action listener: _resource_record_post_action 08:48:33 INFO - [mozharness: 2016-12-12 16:48:33.012313Z] Finished clobber step (success) 08:48:33 INFO - [mozharness: 2016-12-12 16:48:33.012438Z] Running read-buildbot-config step. 08:48:33 INFO - Running pre-action listener: _resource_record_pre_action 08:48:33 INFO - Running main action method: read_buildbot_config 08:48:33 INFO - Using buildbot properties: 08:48:33 INFO - { 08:48:33 INFO - "project": "", 08:48:33 INFO - "product": "firefox", 08:48:33 INFO - "script_repo_revision": "production", 08:48:33 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:48:33 INFO - "repository": "", 08:48:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:48:33 INFO - "buildid": "20161212080751", 08:48:33 INFO - "pgo_build": "False", 08:48:33 INFO - "basedir": "/builds/slave/test", 08:48:33 INFO - "buildnumber": 5, 08:48:33 INFO - "slavename": "t-yosemite-r7-0312", 08:48:33 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 08:48:33 INFO - "platform": "yosemite_r7", 08:48:33 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:48:33 INFO - "branch": "mozilla-central", 08:48:33 INFO - "repo_path": "mozilla-central", 08:48:33 INFO - "revision": "4ee7b6591cf4128098225651e734dbf04eef57bb", 08:48:33 INFO - "stage_platform": "macosx64", 08:48:33 INFO - "builduid": "d1479deae8fb4ab4a901510c1943dbce", 08:48:33 INFO - "slavebuilddir": "test" 08:48:33 INFO - } 08:48:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z85-jjRSSJ-nxp4Vdrrqkw/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg. 08:48:33 INFO - Running post-action listener: _resource_record_post_action 08:48:33 INFO - [mozharness: 2016-12-12 16:48:33.015785Z] Finished read-buildbot-config step (success) 08:48:33 INFO - [mozharness: 2016-12-12 16:48:33.015912Z] Running download-and-extract step. 08:48:33 INFO - Running pre-action listener: _resource_record_pre_action 08:48:33 INFO - Running main action method: download_and_extract 08:48:33 INFO - mkdir: /builds/slave/test/build/tests 08:48: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')]} 08:48:33 INFO - trying https://queue.taskcluster.net/v1/task/Z85-jjRSSJ-nxp4Vdrrqkw/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json 08:48:33 INFO - Downloading https://queue.taskcluster.net/v1/task/Z85-jjRSSJ-nxp4Vdrrqkw/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 08:48:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z85-jjRSSJ-nxp4Vdrrqkw/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json'}, attempt #1 08:48:34 INFO - Downloaded 1235 bytes. 08:48:34 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 08:48:34 INFO - Using the following test package requirements: 08:48:34 INFO - {u'common': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 08:48:34 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:48:34 INFO - u'firefox-53.0a1.en-US.mac64.cppunittest.tests.zip'], 08:48:34 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:48:34 INFO - u'firefox-53.0a1.en-US.mac64.gtest.tests.zip'], 08:48:34 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:48:34 INFO - u'jsshell-mac64.zip'], 08:48:34 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:48:34 INFO - u'firefox-53.0a1.en-US.mac64.mochitest.tests.zip'], 08:48:34 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 08:48:34 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:48:34 INFO - u'firefox-53.0a1.en-US.mac64.reftest.tests.zip'], 08:48:34 INFO - u'talos': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:48:34 INFO - u'firefox-53.0a1.en-US.mac64.talos.tests.zip'], 08:48:34 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:48:34 INFO - u'firefox-53.0a1.en-US.mac64.web-platform.tests.zip'], 08:48:34 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:48:34 INFO - u'firefox-53.0a1.en-US.mac64.xpcshell.tests.zip']} 08:48:34 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip'] for test suite category: common 08:48:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z85-jjRSSJ-nxp4Vdrrqkw/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 08:48:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z85-jjRSSJ-nxp4Vdrrqkw/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 08:48:34 INFO - Fetch https://queue.taskcluster.net/v1/task/Z85-jjRSSJ-nxp4Vdrrqkw/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 08:48:35 INFO - Expected file size: 16289308 08:48:35 INFO - Obtained file size: 16289308 08:48:41 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip', u'firefox-53.0a1.en-US.mac64.talos.tests.zip'] for test suite category: talos 08:48:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z85-jjRSSJ-nxp4Vdrrqkw/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 08:48:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z85-jjRSSJ-nxp4Vdrrqkw/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 08:48:41 INFO - Fetch https://queue.taskcluster.net/v1/task/Z85-jjRSSJ-nxp4Vdrrqkw/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 08:48:42 INFO - Expected file size: 16289308 08:48:42 INFO - Obtained file size: 16289308 08:48:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z85-jjRSSJ-nxp4Vdrrqkw/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip 08:48:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z85-jjRSSJ-nxp4Vdrrqkw/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip'}, attempt #1 08:48:48 INFO - Fetch https://queue.taskcluster.net/v1/task/Z85-jjRSSJ-nxp4Vdrrqkw/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip into memory 08:48:49 INFO - Expected file size: 14409734 08:48:49 INFO - Obtained file size: 14409734 08:48:50 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')]} 08:48:50 INFO - trying https://queue.taskcluster.net/v1/task/Z85-jjRSSJ-nxp4Vdrrqkw/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 08:48:50 INFO - Downloading https://queue.taskcluster.net/v1/task/Z85-jjRSSJ-nxp4Vdrrqkw/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg 08:48:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z85-jjRSSJ-nxp4Vdrrqkw/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg'}, attempt #1 08:48:52 INFO - Downloaded 69674838 bytes. 08:48:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z85-jjRSSJ-nxp4Vdrrqkw/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 08:48:52 INFO - mkdir: /builds/slave/test/properties 08:48:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:48:52 INFO - Writing to file /builds/slave/test/properties/build_url 08:48:52 INFO - Contents: 08:48:52 INFO - build_url:https://queue.taskcluster.net/v1/task/Z85-jjRSSJ-nxp4Vdrrqkw/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 08:48:53 INFO - Running post-action listener: _resource_record_post_action 08:48:53 INFO - Running post-action listener: set_extra_try_arguments 08:48:53 INFO - [mozharness: 2016-12-12 16:48:53.296278Z] Finished download-and-extract step (success) 08:48:53 INFO - [mozharness: 2016-12-12 16:48:53.296391Z] Running populate-webroot step. 08:48:53 INFO - Running pre-action listener: _resource_record_pre_action 08:48:53 INFO - Running main action method: populate_webroot 08:48:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:48:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:48:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:48:53 INFO - '--tppagecycles', 08:48:53 INFO - '7'], 08:48:53 INFO - 'tests': ['tsvgm']}}, 08:48:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:48:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:48:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:48:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:48:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:48:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:48:53 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:48:53 INFO - 'talos_options': ['--disable-e10s'], 08:48:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:48:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:48:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:48:53 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:48:53 INFO - 'talos_options': ['--disable-e10s'], 08:48:53 INFO - 'tests': ['damp', 'tps']}, 08:48:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:48:53 INFO - 'tests': ['damp', 'tps']}, 08:48:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:48:53 INFO - 'tests': ['dromaeo_dom']}, 08:48:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:48:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:48:53 INFO - 'tests': ['basic_compositor_video']}, 08:48:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:48:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:48:53 INFO - 'tests': ['a11yr', 08:48:53 INFO - 'ts_paint', 08:48:53 INFO - 'tpaint', 08:48:53 INFO - 'sessionrestore', 08:48:53 INFO - 'sessionrestore_no_auto_restore', 08:48:53 INFO - 'tabpaint']}, 08:48:53 INFO - 'other-e10s': {'tests': ['a11yr', 08:48:53 INFO - 'ts_paint', 08:48:53 INFO - 'tpaint', 08:48:53 INFO - 'sessionrestore', 08:48:53 INFO - 'sessionrestore_no_auto_restore', 08:48:53 INFO - 'tabpaint']}, 08:48:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:48:53 INFO - 'ts_paint', 08:48:53 INFO - 'tpaint', 08:48:53 INFO - 'sessionrestore', 08:48:53 INFO - 'sessionrestore_no_auto_restore', 08:48:53 INFO - 'tabpaint']}, 08:48:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:48:53 INFO - 'ts_paint', 08:48:53 INFO - 'tpaint', 08:48:53 INFO - 'sessionrestore', 08:48:53 INFO - 'sessionrestore_no_auto_restore', 08:48:53 INFO - 'tabpaint']}, 08:48:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:48:53 INFO - 'tests': ['a11yr', 08:48:53 INFO - 'ts_paint', 08:48:53 INFO - 'tpaint', 08:48:53 INFO - 'sessionrestore', 08:48:53 INFO - 'sessionrestore_no_auto_restore', 08:48:53 INFO - 'tabpaint']}, 08:48:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:48:53 INFO - 'tests': ['a11yr', 08:48:53 INFO - 'ts_paint', 08:48:53 INFO - 'tpaint', 08:48:53 INFO - 'sessionrestore', 08:48:53 INFO - 'sessionrestore_no_auto_restore', 08:48:53 INFO - 'tabpaint']}, 08:48:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:48:53 INFO - 'tests': ['tsvgx', 08:48:53 INFO - 'tsvgr_opacity', 08:48:53 INFO - 'tart', 08:48:53 INFO - 'tscrollx', 08:48:53 INFO - 'cart', 08:48:53 INFO - 'tsvg_static']}, 08:48:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:48:53 INFO - 'tsvgr_opacity', 08:48:53 INFO - 'tart', 08:48:53 INFO - 'tscrollx', 08:48:53 INFO - 'cart', 08:48:53 INFO - 'tsvg_static']}, 08:48:53 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:48:53 INFO - 'talos_options': ['--disable-e10s'], 08:48:53 INFO - 'tests': ['tp5o']}, 08:48:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:48:53 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:48:53 INFO - 'talos_options': ['--disable-e10s', 08:48:53 INFO - '--xperf_path', 08:48:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:48:53 INFO - 'tests': ['tp5n']}, 08:48:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:48:53 INFO - 'talos_options': ['--xperf_path', 08:48:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:48:53 INFO - 'tests': ['tp5n']}}, 08:48:53 INFO - 'talos.zip': {'path': '', 08:48:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:48:53 INFO - Running post-action listener: _resource_record_post_action 08:48:53 INFO - [mozharness: 2016-12-12 16:48:53.315142Z] Finished populate-webroot step (success) 08:48:53 INFO - [mozharness: 2016-12-12 16:48:53.315238Z] Running create-virtualenv step. 08:48:53 INFO - Running pre-action listener: _resource_record_pre_action 08:48:53 INFO - Running main action method: create_virtualenv 08:48:53 INFO - Creating virtualenv /builds/slave/test/build/venv 08:48:53 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 08:48:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:48:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:48:53 INFO - Using real prefix '/tools/python27' 08:48:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:48:54 INFO - Installing distribute.............................................................................................................................................................................................done. 08:48:57 INFO - Installing pip.................done. 08:48:57 INFO - Return code: 0 08:48:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:48:57 INFO - Reading from file tmpfile_stdout 08:48:57 INFO - Output received: 08:48:57 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) 08:48:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:57 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 0x1068e33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106859570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fcad49f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066f8d30>, '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 0x10655fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066f0b20>, '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.ImuR1OfRW4/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.ANYfmiSGvw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 08:48:57 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 08:48:57 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 08:48:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ImuR1OfRW4/Render', 08:48:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:57 INFO - 'HOME': '/Users/cltbld', 08:48:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:57 INFO - 'LOGNAME': 'cltbld', 08:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:57 INFO - 'MOZ_NO_REMOTE': '1', 08:48:57 INFO - 'NO_EM_RESTART': '1', 08:48:57 INFO - 'PAGER': '/bin/cat', 08:48:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:57 INFO - 'PWD': '/builds/slave/test', 08:48:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:57 INFO - 'SHELL': '/bin/bash', 08:48:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ANYfmiSGvw/Listeners', 08:48:57 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 08:48:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:57 INFO - 'USER': 'cltbld', 08:48:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:57 INFO - 'XPC_FLAGS': '0x0', 08:48:57 INFO - 'XPC_SERVICE_NAME': '0', 08:48:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:57 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 08:48:57 INFO - Cleaning up... 08:48:57 INFO - Return code: 0 08:48:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:57 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 0x1068e33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106859570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fcad49f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066f8d30>, '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 0x10655fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066f0b20>, '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.ImuR1OfRW4/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.ANYfmiSGvw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 08:48:57 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 08:48:57 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 08:48:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ImuR1OfRW4/Render', 08:48:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:57 INFO - 'HOME': '/Users/cltbld', 08:48:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:57 INFO - 'LOGNAME': 'cltbld', 08:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:57 INFO - 'MOZ_NO_REMOTE': '1', 08:48:57 INFO - 'NO_EM_RESTART': '1', 08:48:57 INFO - 'PAGER': '/bin/cat', 08:48:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:57 INFO - 'PWD': '/builds/slave/test', 08:48:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:57 INFO - 'SHELL': '/bin/bash', 08:48:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ANYfmiSGvw/Listeners', 08:48:57 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 08:48:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:57 INFO - 'USER': 'cltbld', 08:48:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:57 INFO - 'XPC_FLAGS': '0x0', 08:48:57 INFO - 'XPC_SERVICE_NAME': '0', 08:48:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:57 INFO - Downloading/unpacking psutil>=3.1.1 08:48:57 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 08:48:57 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 08:48:57 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 08:48:57 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 08:48:57 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 08:48:57 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 08:49:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:49:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:49:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:49:01 INFO - Installing collected packages: psutil 08:49:01 INFO - Running setup.py install for psutil 08:49:02 INFO - building 'psutil._psutil_osx' extension 08:49:02 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 08:49:02 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 08:49:02 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 08:49:02 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 08:49:02 INFO - building 'psutil._psutil_posix' extension 08:49:02 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 08:49:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:49:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:49:02 INFO - ^ 08:49:02 INFO - 1 warning generated. 08:49:02 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 08:49:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:49:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:49:02 INFO - Successfully installed psutil 08:49:02 INFO - Cleaning up... 08:49:02 INFO - Return code: 0 08:49:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1068e33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106859570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fcad49f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066f8d30>, '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 0x10655fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066f0b20>, '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.ImuR1OfRW4/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.ANYfmiSGvw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 08:49:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:49:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:49:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ImuR1OfRW4/Render', 08:49:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:02 INFO - 'HOME': '/Users/cltbld', 08:49:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:02 INFO - 'LOGNAME': 'cltbld', 08:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:02 INFO - 'MOZ_NO_REMOTE': '1', 08:49:02 INFO - 'NO_EM_RESTART': '1', 08:49:02 INFO - 'PAGER': '/bin/cat', 08:49:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:02 INFO - 'PWD': '/builds/slave/test', 08:49:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:02 INFO - 'SHELL': '/bin/bash', 08:49:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ANYfmiSGvw/Listeners', 08:49:02 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 08:49:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:02 INFO - 'USER': 'cltbld', 08:49:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:02 INFO - 'XPC_FLAGS': '0x0', 08:49:02 INFO - 'XPC_SERVICE_NAME': '0', 08:49:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:49:03 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 08:49:03 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 08:49:03 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 08:49:03 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 08:49:03 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 08:49:03 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 08:49:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:49:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:49:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:49:05 INFO - Installing collected packages: mozsystemmonitor 08:49:05 INFO - Running setup.py install for mozsystemmonitor 08:49:06 INFO - Successfully installed mozsystemmonitor 08:49:06 INFO - Cleaning up... 08:49:06 INFO - Return code: 0 08:49:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:06 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 0x1068e33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106859570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fcad49f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066f8d30>, '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 0x10655fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066f0b20>, '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.ImuR1OfRW4/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.ANYfmiSGvw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 08:49:06 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 08:49:06 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 08:49:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ImuR1OfRW4/Render', 08:49:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:06 INFO - 'HOME': '/Users/cltbld', 08:49:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:06 INFO - 'LOGNAME': 'cltbld', 08:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:06 INFO - 'MOZ_NO_REMOTE': '1', 08:49:06 INFO - 'NO_EM_RESTART': '1', 08:49:06 INFO - 'PAGER': '/bin/cat', 08:49:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:06 INFO - 'PWD': '/builds/slave/test', 08:49:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:06 INFO - 'SHELL': '/bin/bash', 08:49:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ANYfmiSGvw/Listeners', 08:49:06 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 08:49:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:06 INFO - 'USER': 'cltbld', 08:49:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:06 INFO - 'XPC_FLAGS': '0x0', 08:49:06 INFO - 'XPC_SERVICE_NAME': '0', 08:49:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:06 INFO - Downloading/unpacking jsonschema==2.5.1 08:49:06 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 08:49:06 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 08:49:06 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 08:49:06 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 08:49:06 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 08:49:06 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 08:49:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:49:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:49:08 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 08:49:08 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 08:49:08 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 08:49:08 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 08:49:08 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 08:49:08 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 08:49:09 INFO - Downloading functools32-3.2.3-2.tar.gz 08:49:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:49:09 INFO - warning: no files found matching '*.txt' 08:49:09 INFO - no previously-included directories found matching 'build' 08:49:09 INFO - no previously-included directories found matching 'dist' 08:49:09 INFO - no previously-included directories found matching '.git*' 08:49:09 INFO - Installing collected packages: jsonschema, functools32 08:49:09 INFO - Running setup.py install for functools32 08:49:09 INFO - warning: no files found matching '*.txt' 08:49:09 INFO - no previously-included directories found matching 'build' 08:49:09 INFO - no previously-included directories found matching 'dist' 08:49:09 INFO - no previously-included directories found matching '.git*' 08:49:09 INFO - Successfully installed jsonschema functools32 08:49:09 INFO - Cleaning up... 08:49:09 INFO - Return code: 0 08:49:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:49: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')]} 08:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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')]} 08:49:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:09 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 0x1068e33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106859570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fcad49f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066f8d30>, '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 0x10655fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066f0b20>, '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.ImuR1OfRW4/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.ANYfmiSGvw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 08:49:09 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 08:49:09 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 08:49:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ImuR1OfRW4/Render', 08:49:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:09 INFO - 'HOME': '/Users/cltbld', 08:49:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:09 INFO - 'LOGNAME': 'cltbld', 08:49:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:09 INFO - 'MOZ_NO_REMOTE': '1', 08:49:09 INFO - 'NO_EM_RESTART': '1', 08:49:09 INFO - 'PAGER': '/bin/cat', 08:49:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:09 INFO - 'PWD': '/builds/slave/test', 08:49:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:09 INFO - 'SHELL': '/bin/bash', 08:49:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ANYfmiSGvw/Listeners', 08:49:09 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 08:49:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:09 INFO - 'USER': 'cltbld', 08:49:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:09 INFO - 'XPC_FLAGS': '0x0', 08:49:09 INFO - 'XPC_SERVICE_NAME': '0', 08:49:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:49:10 INFO - Cleaning up... 08:49:10 INFO - Return code: 0 08:49:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1068e33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106859570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fcad49f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066f8d30>, '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 0x10655fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066f0b20>, '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.ImuR1OfRW4/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.ANYfmiSGvw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 08:49:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:49:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:49:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ImuR1OfRW4/Render', 08:49:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:10 INFO - 'HOME': '/Users/cltbld', 08:49:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:10 INFO - 'LOGNAME': 'cltbld', 08:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:10 INFO - 'MOZ_NO_REMOTE': '1', 08:49:10 INFO - 'NO_EM_RESTART': '1', 08:49:10 INFO - 'PAGER': '/bin/cat', 08:49:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:10 INFO - 'PWD': '/builds/slave/test', 08:49:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:10 INFO - 'SHELL': '/bin/bash', 08:49:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ANYfmiSGvw/Listeners', 08:49:10 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 08:49:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:10 INFO - 'USER': 'cltbld', 08:49:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:10 INFO - 'XPC_FLAGS': '0x0', 08:49:10 INFO - 'XPC_SERVICE_NAME': '0', 08:49:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:10 INFO - Downloading/unpacking blobuploader==1.2.4 08:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:12 INFO - Downloading blobuploader-1.2.4.tar.gz 08:49:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:49:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:49:12 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 08:49:12 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 08:49:12 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 08:49:12 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 08:49:12 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 08:49:12 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 08:49:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:49:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:49:13 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 08:49:13 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 08:49:13 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 08:49:13 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 08:49:13 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 08:49:13 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 08:49:14 INFO - Downloading docopt-0.6.1.tar.gz 08:49:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:49:14 INFO - Installing collected packages: blobuploader, requests, docopt 08:49:14 INFO - Running setup.py install for blobuploader 08:49:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:49:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:49:14 INFO - Running setup.py install for requests 08:49:14 INFO - Running setup.py install for docopt 08:49:14 INFO - Successfully installed blobuploader requests docopt 08:49:14 INFO - Cleaning up... 08:49:15 INFO - Return code: 0 08:49:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49:15 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')]} 08:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:15 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')]} 08:49:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:15 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 0x1068e33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106859570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fcad49f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066f8d30>, '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 0x10655fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066f0b20>, '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.ImuR1OfRW4/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.ANYfmiSGvw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 08:49:15 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 08:49:15 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 08:49:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ImuR1OfRW4/Render', 08:49:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:15 INFO - 'HOME': '/Users/cltbld', 08:49:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:15 INFO - 'LOGNAME': 'cltbld', 08:49:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:15 INFO - 'MOZ_NO_REMOTE': '1', 08:49:15 INFO - 'NO_EM_RESTART': '1', 08:49:15 INFO - 'PAGER': '/bin/cat', 08:49:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:15 INFO - 'PWD': '/builds/slave/test', 08:49:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:15 INFO - 'SHELL': '/bin/bash', 08:49:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ANYfmiSGvw/Listeners', 08:49:15 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 08:49:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:15 INFO - 'USER': 'cltbld', 08:49:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:15 INFO - 'XPC_FLAGS': '0x0', 08:49:15 INFO - 'XPC_SERVICE_NAME': '0', 08:49:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:49:15 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-xHN4gj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:49:15 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-QpTHBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:49:15 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-UGXKJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:49:15 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-NlgAZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:49:15 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-cWluPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:49:15 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-hvgBAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:49:15 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-ax1Lca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:49:16 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-BXlIQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:49:16 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-a9MfLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:49:16 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-bE6zAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:49:16 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-PfFIDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:49:16 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-hWfYjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:49:16 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Yoo8Kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:49:16 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-SSlgLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:16 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-K3YPdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:49:16 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-5MdQCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:49:16 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-sXSrV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:49:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:49:17 INFO - Running setup.py install for manifestparser 08:49:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:49:17 INFO - Running setup.py install for mozcrash 08:49:17 INFO - Running setup.py install for mozdebug 08:49:17 INFO - Running setup.py install for mozdevice 08:49:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:49:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:49:17 INFO - Running setup.py install for mozfile 08:49:17 INFO - Running setup.py install for mozhttpd 08:49:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:49:17 INFO - Running setup.py install for mozinfo 08:49:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:49:18 INFO - Running setup.py install for mozInstall 08:49:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:49:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:49:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:49:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:49:18 INFO - Running setup.py install for mozleak 08:49:18 INFO - Running setup.py install for mozlog 08:49:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:49:18 INFO - Running setup.py install for moznetwork 08:49:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:49:18 INFO - Running setup.py install for mozprocess 08:49:18 INFO - Running setup.py install for mozprofile 08:49:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:49:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:49:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:49:19 INFO - Running setup.py install for mozrunner 08:49:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:49:19 INFO - Running setup.py install for mozscreenshot 08:49:19 INFO - Running setup.py install for moztest 08:49:19 INFO - Running setup.py install for mozversion 08:49:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:49:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:49:19 INFO - Cleaning up... 08:49:19 INFO - Return code: 0 08:49:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49: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')]} 08:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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')]} 08:49:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:19 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 0x1068e33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106859570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fcad49f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066f8d30>, '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 0x10655fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066f0b20>, '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.ImuR1OfRW4/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.ANYfmiSGvw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 08:49:19 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 08:49:19 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 08:49:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ImuR1OfRW4/Render', 08:49:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:19 INFO - 'HOME': '/Users/cltbld', 08:49:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:19 INFO - 'LOGNAME': 'cltbld', 08:49:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:19 INFO - 'MOZ_NO_REMOTE': '1', 08:49:19 INFO - 'NO_EM_RESTART': '1', 08:49:19 INFO - 'PAGER': '/bin/cat', 08:49:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:19 INFO - 'PWD': '/builds/slave/test', 08:49:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:19 INFO - 'SHELL': '/bin/bash', 08:49:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ANYfmiSGvw/Listeners', 08:49:19 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 08:49:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:19 INFO - 'USER': 'cltbld', 08:49:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:19 INFO - 'XPC_FLAGS': '0x0', 08:49:19 INFO - 'XPC_SERVICE_NAME': '0', 08:49:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:49:19 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-yuUnv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:49:20 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)) 08:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:49:20 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-tQolEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:49:20 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)) 08:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:49:20 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-knrO52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:49:20 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)) 08:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:49:20 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-E9JmPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:49:20 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-HcQc6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:49:20 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)) 08:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:49:20 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-HmPndf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:49:20 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)) 08:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:49:20 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-K3pIpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:49:20 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)) 08:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:49:20 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-3QHwSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:49:20 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)) 08:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:49:20 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-zUlsEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:49:20 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)) 08:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:49:20 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Z9M9Pc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:49:20 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)) 08:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:49:20 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Owt1Kf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:49:21 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)) 08:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:49:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-9UwkK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:49:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 08:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:49:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-1Ku_fo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:49:21 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)) 08:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:49:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-P1BiGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:49:21 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)) 08:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-W_ZsL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:21 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)) 08:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:49:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-PPBT_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:49:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 08:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:49:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-EsEcS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:49:21 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)) 08:49:21 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)) 08:49:21 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)) 08:49:21 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)) 08:49:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:49:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:49:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:24 INFO - Downloading blessings-1.6.tar.gz 08:49:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:49:24 INFO - Installing collected packages: blessings 08:49:24 INFO - Running setup.py install for blessings 08:49:24 INFO - Successfully installed blessings 08:49:24 INFO - Cleaning up... 08:49:24 INFO - Return code: 0 08:49:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:49:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:49:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:49:24 INFO - Reading from file tmpfile_stdout 08:49:24 INFO - Current package versions: 08:49:24 INFO - blessings == 1.6 08:49:24 INFO - blobuploader == 1.2.4 08:49:24 INFO - docopt == 0.6.1 08:49:24 INFO - functools32 == 3.2.3-2 08:49:24 INFO - jsonschema == 2.5.1 08:49:24 INFO - manifestparser == 1.1 08:49:24 INFO - mozInstall == 1.12 08:49:24 INFO - mozcrash == 1.0 08:49:24 INFO - mozdebug == 0.1 08:49:24 INFO - mozdevice == 0.49 08:49:24 INFO - mozfile == 1.2 08:49:24 INFO - mozhttpd == 0.7 08:49:24 INFO - mozinfo == 0.9 08:49:24 INFO - mozleak == 0.1 08:49:24 INFO - mozlog == 3.4 08:49:24 INFO - moznetwork == 0.27 08:49:24 INFO - mozprocess == 0.23 08:49:24 INFO - mozprofile == 0.28 08:49:24 INFO - mozrunner == 6.13 08:49:24 INFO - mozscreenshot == 0.1 08:49:24 INFO - mozsystemmonitor == 0.3 08:49:24 INFO - moztest == 0.7 08:49:24 INFO - mozversion == 1.4 08:49:24 INFO - psutil == 3.1.1 08:49:24 INFO - requests == 1.2.3 08:49:24 INFO - wsgiref == 0.1.2 08:49:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49: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')]} 08:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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')]} 08:49:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:24 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 0x1068e33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106859570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fcad49f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066f8d30>, '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 0x10655fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066f0b20>, '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.ImuR1OfRW4/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.ANYfmiSGvw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 08:49:24 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 08:49:24 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 08:49:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ImuR1OfRW4/Render', 08:49:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:24 INFO - 'HOME': '/Users/cltbld', 08:49:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:24 INFO - 'LOGNAME': 'cltbld', 08:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:24 INFO - 'MOZ_NO_REMOTE': '1', 08:49:24 INFO - 'NO_EM_RESTART': '1', 08:49:24 INFO - 'PAGER': '/bin/cat', 08:49:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:24 INFO - 'PWD': '/builds/slave/test', 08:49:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:24 INFO - 'SHELL': '/bin/bash', 08:49:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ANYfmiSGvw/Listeners', 08:49:24 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 08:49:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:24 INFO - 'USER': 'cltbld', 08:49:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:24 INFO - 'XPC_FLAGS': '0x0', 08:49:24 INFO - 'XPC_SERVICE_NAME': '0', 08:49:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:25 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)) 08:49:25 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)) 08:49:25 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)) 08:49:25 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)) 08:49:25 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)) 08:49:25 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)) 08:49:25 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)) 08:49:25 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)) 08:49:25 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)) 08:49:25 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)) 08:49:25 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)) 08:49:25 INFO - Cleaning up... 08:49:25 INFO - Return code: 0 08:49:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:49:25 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')]} 08:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:25 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')]} 08:49:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:25 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 0x1068e33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106859570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fcad49f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066f8d30>, '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 0x10655fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066f0b20>, '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.ImuR1OfRW4/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.ANYfmiSGvw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 08:49:25 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 08:49:25 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 08:49:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ImuR1OfRW4/Render', 08:49:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:25 INFO - 'HOME': '/Users/cltbld', 08:49:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:25 INFO - 'LOGNAME': 'cltbld', 08:49:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:25 INFO - 'MOZ_NO_REMOTE': '1', 08:49:25 INFO - 'NO_EM_RESTART': '1', 08:49:25 INFO - 'PAGER': '/bin/cat', 08:49:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:25 INFO - 'PWD': '/builds/slave/test', 08:49:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:25 INFO - 'SHELL': '/bin/bash', 08:49:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ANYfmiSGvw/Listeners', 08:49:25 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 08:49:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:25 INFO - 'USER': 'cltbld', 08:49:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:25 INFO - 'XPC_FLAGS': '0x0', 08:49:25 INFO - 'XPC_SERVICE_NAME': '0', 08:49:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:49:25 INFO - Cleaning up... 08:49:25 INFO - Return code: 0 08:49:25 INFO - Running post-action listener: _resource_record_post_action 08:49:25 INFO - Running post-action listener: _start_resource_monitoring 08:49:25 INFO - Starting resource monitoring. 08:49:25 INFO - [mozharness: 2016-12-12 16:49:25.514175Z] Finished create-virtualenv step (success) 08:49:25 INFO - [mozharness: 2016-12-12 16:49:25.515022Z] Running install step. 08:49:25 INFO - Running pre-action listener: _resource_record_pre_action 08:49:25 INFO - Running main action method: install 08:49:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:49:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:49:25 INFO - Reading from file tmpfile_stdout 08:49:25 INFO - Detecting whether we're running mozinstall >=1.0... 08:49:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:49:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:49:25 INFO - Reading from file tmpfile_stdout 08:49:25 INFO - Output received: 08:49:25 INFO - Usage: mozinstall [options] installer 08:49:25 INFO - Options: 08:49:25 INFO - -h, --help show this help message and exit 08:49:25 INFO - -d DEST, --destination=DEST 08:49:25 INFO - Directory to install application into. [default: 08:49:25 INFO - "/builds/slave/test"] 08:49:25 INFO - --app=APP Application being installed. [default: firefox] 08:49:25 INFO - mkdir: /builds/slave/test/build/application 08:49:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg', '--destination', '/builds/slave/test/build/application'] 08:49:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg --destination /builds/slave/test/build/application 08:49:47 INFO - Reading from file tmpfile_stdout 08:49:47 INFO - Output received: 08:49:47 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:49:47 INFO - Running post-action listener: _resource_record_post_action 08:49:47 INFO - [mozharness: 2016-12-12 16:49:47.627788Z] Finished install step (success) 08:49:47 INFO - [mozharness: 2016-12-12 16:49:47.627919Z] Running run-tests step. 08:49:47 INFO - Running pre-action listener: _resource_record_pre_action 08:49:47 INFO - Running main action method: run_tests 08:49:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:49:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:49:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:49:47 INFO - 2016-12-12 08:49:47.642 screenresolution[2191:29301] starting screenresolution argv=screenresolution get 08:49:47 INFO - 2016-12-12 08:49:47.645 screenresolution[2191:29301] Display 0: 1600x1200x32@60 08:49:47 INFO - 2016-12-12 08:49:47.650 screenresolution[2192:29304] starting screenresolution argv=screenresolution list 08:49:47 INFO - Available Modes on Display 0 08:49:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:49:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:49:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:49:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:49:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:49:47 INFO - Intel Iris: 08:49:47 INFO - Chipset Model: Intel Iris 08:49:47 INFO - Type: GPU 08:49:47 INFO - Bus: Built-In 08:49:47 INFO - VRAM (Dynamic, Max): 1536 MB 08:49:47 INFO - Vendor: Intel (0x8086) 08:49:47 INFO - Device ID: 0x0a2e 08:49:47 INFO - Revision ID: 0x0009 08:49:47 INFO - Displays: 08:49:47 INFO - Display: 08:49:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:49:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:49:47 INFO - Display Serial Number: 1600x1200 60 08:49:47 INFO - Main Display: Yes 08:49:47 INFO - Mirror: Off 08:49:47 INFO - Online: Yes 08:49:47 INFO - Rotation: Supported 08:49:47 INFO - Return code: 0 08:49:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:49:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:49:47 INFO - Python 2.7.3 08:49:47 INFO - Return code: 0 08:49:47 INFO - grabbing minidump binary from tooltool 08:49: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')]} 08:49:47 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 0x1066f8d30>, '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 0x10655fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066f0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:49:47 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 08:49:47 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 08:49:47 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 08:49:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:49:48 INFO - Return code: 0 08:49:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:49:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:49:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:49:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:49:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:49:48 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/Z85-jjRSSJ-nxp4Vdrrqkw/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--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 08:49:48 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/Z85-jjRSSJ-nxp4Vdrrqkw/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip --title t-yosemite-r7-0312 --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 08:49:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ImuR1OfRW4/Render', 08:49:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:48 INFO - 'HOME': '/Users/cltbld', 08:49:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:48 INFO - 'LOGNAME': 'cltbld', 08:49:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:49:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:48 INFO - 'MOZ_NO_REMOTE': '1', 08:49:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:49:48 INFO - 'NO_EM_RESTART': '1', 08:49:48 INFO - 'PAGER': '/bin/cat', 08:49:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:48 INFO - 'PWD': '/builds/slave/test', 08:49:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:49:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:48 INFO - 'SHELL': '/bin/bash', 08:49:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ANYfmiSGvw/Listeners', 08:49:48 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 08:49:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:48 INFO - 'USER': 'cltbld', 08:49:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:48 INFO - 'XPC_FLAGS': '0x0', 08:49:48 INFO - 'XPC_SERVICE_NAME': '0', 08:49:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:48 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/Z85-jjRSSJ-nxp4Vdrrqkw/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--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 08:49:48 INFO - mozversion application_buildid: 20161212080751 08:49:48 INFO - mozversion application_changeset: 4ee7b6591cf4128098225651e734dbf04eef57bb 08:49:48 INFO - mozversion application_display_name: Nightly 08:49:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:49:48 INFO - mozversion application_name: Firefox 08:49:48 INFO - mozversion application_remotingname: firefox 08:49:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:49:48 INFO - mozversion application_vendor: Mozilla 08:49:48 INFO - mozversion application_version: 53.0a1 08:49:48 INFO - mozversion platform_buildid: 20161212080751 08:49:48 INFO - mozversion platform_changeset: 4ee7b6591cf4128098225651e734dbf04eef57bb 08:49:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:49:48 INFO - mozversion platform_version: 53.0a1 08:49:48 INFO - using testdate: 1481561388 08:49:48 INFO - actual date: 1481561388 08:49:48 INFO - starting webserver on 'localhost:56030' 08:49:48 INFO - SUITE-START | Running 2 tests 08:49:48 INFO - TEST-START | dromaeo_css 08:49:48 INFO - operating with platform_type : mac_ 08:49:48 INFO - Initialising browser for dromaeo_css test... 08:49:48 INFO - TEST-INFO | started process 2202 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpoI5IvN/profile http://localhost:56030/getInfo.html) 08:49:50 INFO - PROCESS | 2202 | __metrics Screen width/height:1600/1200 08:49:50 INFO - PROCESS | 2202 | colorDepth:24 08:49:50 INFO - PROCESS | 2202 | Browser inner width/height: 1024/689 08:49:50 INFO - PROCESS | 2202 | __metrics 08:49:50 INFO - PROCESS | 2202 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:49:50 INFO - PROCESS | 2202 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:49:51 INFO - TEST-INFO | 2202: exit 0 08:49:51 INFO - Browser initialized. 08:49:51 INFO - Running cycle 1/1 for dromaeo_css test... 08:49:51 INFO - TEST-INFO | started process 2204 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpoI5IvN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:50:03 INFO - PROCESS | 2204 | RSS: Main: 236892160 08:50:03 INFO - PROCESS | 2204 | 08:50:54 INFO - PROCESS | 2204 | 1481561454676 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:53:07 INFO - PROCESS | 2204 | Cycle 1(1): loaded http://localhost:56030/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56030/tests/dromaeo/cssquery-ext.html) 08:53:08 INFO - PROCESS | 2204 | RSS: Main: 399503360 08:53:08 INFO - PROCESS | 2204 | 08:56:11 INFO - PROCESS | 2204 | Cycle 1(1): loaded http://localhost:56030/tests/dromaeo/cssquery-ext.html (next: http://localhost:56030/tests/dromaeo/cssquery-jquery.html) 08:56:12 INFO - PROCESS | 2204 | RSS: Main: 381583360 08:56:12 INFO - PROCESS | 2204 | 08:59:14 INFO - PROCESS | 2204 | Cycle 1(1): loaded http://localhost:56030/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56030/tests/dromaeo/cssquery-mootools.html) 08:59:15 INFO - PROCESS | 2204 | RSS: Main: 368553984 08:59:15 INFO - PROCESS | 2204 | 09:02:18 INFO - PROCESS | 2204 | Cycle 1(1): loaded http://localhost:56030/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56030/tests/dromaeo/cssquery-prototype.html) 09:02:18 INFO - PROCESS | 2204 | RSS: Main: 353906688 09:02:18 INFO - PROCESS | 2204 | 09:05:22 INFO - PROCESS | 2204 | Cycle 1(1): loaded http://localhost:56030/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56030/tests/dromaeo/cssquery-yui.html) 09:05:22 INFO - PROCESS | 2204 | RSS: Main: 331751424 09:05:22 INFO - PROCESS | 2204 | 09:08:25 INFO - PROCESS | 2204 | Cycle 1(1): loaded http://localhost:56030/tests/dromaeo/cssquery-yui.html (next: http://localhost:56030/tests/dromaeo/cssquery-dojo.html) 09:08:26 INFO - PROCESS | 2204 | RSS: Main: 469446656 09:08:26 INFO - PROCESS | 2204 | 09:08:26 INFO - PROCESS | 2204 | __start_tp_report 09:08:26 INFO - PROCESS | 2204 | _x_x_mozilla_page_load 09:08:26 INFO - PROCESS | 2204 | _x_x_mozilla_page_load_details 09:08:26 INFO - PROCESS | 2204 | |i|pagename|runs| 09:08:26 INFO - PROCESS | 2204 | |0;dojo.html;3293.901182964512;3299.4720844664853;3301.7523685723577;3339.0650617827;3341.4486609709397;5519.558435325174;5585.301837270341;5608.719564021798;5657.886842263152;5663.263775709157;5570.721463926798;5609;5616.691081990489;5622.803201887935;5637.633553818999;5113.974430127844;5141.408737995141;5145.459726728695;5148.922766158511;5163.81926632568;5205.687658740469;5209.895802083956;5210.635255532115;5212.270282160482;5215.765290561933;5125.871853203681;5172;5172.327597412331;5191.662541934781;5211.765470553834;5202.297689811865;5211.1922651989;5216.374035115772;5216.713080780555;5225.477452254782;5033.84898453047;5055.266986287004;5115.488451154892;5155.458676838915;5161.354830646169;5524.226608274845;5597.076482380402;5600.5519558435635;5605.047141985872;5639.661620302754;6141.508679305645;6149.2620885494025;6154.107654390134;6166.352532984017;6167.568270221086;6063.575549711522;6109.01788465936;6186.474149697281;6246.781362652286;6251.12484252205;5665;5703.7148142592705;5708.97145514274;5718.285214348207;5723.914141287884;6267.96866015667;6273.780417685359;6278.497720182374;6282.717277722513;6289.96855015722;5861.120831875168;5980.222571065734;6051.848703782441;6069.757209711651;6072.392760723892;5005.874853128628;6075.5747097703625;6112.047575716935;6117.082437634391;6117.3402608778015;6105.48103411215;6112.419320164578;6116.694165291718;6127.403330890726;6140.3552626974415;6116.558005275416;6141.683490914946;6145.893739126911;6168;6172.321044685081;4789.425268967746;4851.442084160296;4852.708837469763;4860.975695121501;4861.781219845116;4360.607545320936;4388.2320593896575;4397.890052748643;4414.536473670219;4416.470023597125;5706;5762.654240745569;5785.247917770663;5788.363280039192;5810.012297909366;6154.5076393888385;6209.2548894133;6225.937740622627;6227.159333489921;6240.563160578807;5601.29983752031;5652;5661.575381846378;5695.800646977336;5755.625884317506;5353.384360798558;5356.009138309425;5386.434424385383;5400.21696853954;5414.187871819258;6274.121622972696;6287.96856015717;6295.937040629627;6301.936980630135;6307.211598550181;6056.57603967718;6141;6142.723577439116;6173.104899789595;6235.688215589112;6228.065790131516;6233.158523599256;6246.8125956219565;6247.5001999839;6255.093011513396;6109.829807539466;6116.487945662287;6119.593952096689;6125.05232106189;6127.922628246602;6107.755689772359;6143.941779503916;6166.290876549254;6210.503159747119;6226.719797609209;5814.273215848019;5879.853003674943;5937.435943585352;5967.940320596738;6004;6005.069214271794;6021.458068773832;6036.154938308729;6036.758529658764;6052.455279024909;5784.82645520635;5878.500327472213;5884.764609415575;5894.823155305347;5896.380880007709;5803.7968671096305;5864.208331875313;5933.436323549256;5939;5954.910676339945;5822.73797679097;5869.06095024811;5877.500412464989;5908;5921.792737254175 09:08:26 INFO - PROCESS | 2204 | |1;ext.html;470.33447671544764;481.94457637371715;487.54901715912774;492.78071258290066;493.66924160812255;30656.693433065662;39653.60346396535;40905;40919;41001.58998410015;42299.78850105753;42529.36205956913;42648;42655.78672106635;42707.78646106765;9366.625334986593;9593.273210822084;9605.135537801596;9605.75985600362;9624.181944534723;8495.830083398328;8731.476111433334;11223.857319950426;11477.426128693574;11503.48234329453;11326.71683207918;11381.975622194042;11399.145064120225;11422.086233101332;11453.484593193327;8526.360522960802;11263.943680281587;11357.772844543062;11364.579427571554;11381.601643942506;8130.796730081736;8136.633851476698;8149.755507334789;8566.957165214197;11037.724056898562;38357.80821095876;39929;39940.60059399398;39969.200615987516;40138.598614013776;3307.1236122427576;3415.1291420687567;3491.0574144980965;3528.7353448491467;3755.286495565834;22757.43106422336;24109.879450602635;26374.340641483923;28052;28963;3206;3233.4826427771677;3249.545063691085;3292.5390445337434;3341.381844358777;493059;495422;496515;497780.9999999964;499994;52627.210591841154;52954.47045529573;53059.73470132625;53161.468385316424;54078.918421631344;55535.44464555303;55766.72116639391;55805.72097139488;55849.298084230155;55979;14699.632509187142;15104.471343502924;15130.319135638923;15148.848511514963;15154.318055687521;10614.0447359738;10904.727381815359;11815.291082535075;11900.88099119015;11922.940385298018;14563.417463301561;16486.258118384703;16900.985940843588;16908.746368804477;17393.304267829146;6732.259451460335;6733.93266067333;7144.464165187632;7210.278972102853;7239.348458638748;745.7464462082918;832.3382910586099;956.3687965942584;965.7633879699378;991.5389343955095;29338.559921601194;29380.853095734383;29389.706102939126;29868.70131298703;30107.69892301093;914.8170365926841;1051.4374809476892;1095.3592148593002;1102.7188067042853;1107.3577325151393;14946.850531494763;15064.849351506344;15076.773848392282;15106.622334441727;15310.923445382701;634097;635868;635974;636202;636459;57966.4203357961;58689;58749.82500350055;58774.412255876894;58852.99749521253;1344.9529266475627;1386.1475192756382;1396.1832328088183;1400.2228763036612;1409.8942579306593;27060.72939270582;28933.226017706842;29099.833552430915;29676.406471870872;29875.850620746758;49159.75420122877;49726.751366242934;50012.49987500079;50029.496165498254;50047.748806280135;576759;578313;578811;579088;579388.1030594988;25505.362365941;25675.35811604725;25873.22380328593;26029;26046.479070418107;43353.91615209645;43454.34818477662;44154.337684935395;44325.55674443343;44691;36682;37234.62765372312;37849.24301514009;38213.23573528458;38291.42562861615;36594.45108323431;36823.317668232965;37917.86246412612;38044;38236.61763382442;34166.1963812156;35015;37376.252474950896;37541.43687844739;37648.24703505969;29358;31507.684923150475;31616;31691.683083168875;31709;23341.88329058344;23436.531269374856;23968.161114360915;24079.27762167138;24154.516909661357 09:08:26 INFO - PROCESS | 2204 | |2;jquery.html;359.2975732443074;374.6777771116839;375.81209395302346;387.27386150966936;404.5267037566047;14493.855061449382;14827.332770025349;16409.17954102293;19585.314513992013;20393.980300984927;19337.4198774037;20186;20247.39257822264;20269.898650506762;20306.390808275777;5238.166641675402;5247.081760691874;5494.890102197954;5508.531774799147;5515.972420137894;5238.345206849144;5309.601779866525;5369.301990741198;5378.623496355257;5387.218853266274;3859.5754467008746;4093.283675356801;5373.462653734615;5753.769849206048;6047.879042419171;5835;6095.603785753934;6107.816765497042;6128.17269668598;6128.295246046717;5826;5879.911801322984;5881.3530511643685;5885.941140588582;5888.5289176865745;13097.672558186026;13113.737725245443;13130.277834719087;13264.40310186044;13345.399457024458;2001.35956493922;2105.26315789474;2234.4525591230254;2276.8747718875456;2921.810082344662;9660.95169524148;9743.512824358824;9791.412515249107;10281.588736450532;10305.742356441075;1770.283035370677;1785.0806834480254;1821.6903126468533;1822.7903791064066;1855.7773067231883;94280.05719942781;104895.47552262266;107762.3835642466;108548;124848;10635.52140153695;11063.502142403611;11125.554977800797;11273.098152147808;11466.598669046543;14541.200233987232;14566.563003109924;14579;14582.562523124323;14596.708065838837;8052.798680032929;8288.875666865002;8336;8423.368247381472;8526.829463410697;6722.327767223239;6941.409980151642;8125.228103330174;8195.42632015765;8436.789080273042;3797.5632802227547;4484.955150448519;4487.214737420938;4490.842820501267;4491.461024676994;1882.3882238272615;1922.826945574905;1927.9299988506514;1931.642646110474;1960.7941166177345;817.595290331278;876.6668665906915;903.2072771568772;976.1263669016332;998.9600415983425;17356.305747769948;20794.79205207959;21382.465438364165;21389.78610213909;21432.249871254433;921.9124183202586;922.3497434308796;928.1090153452761;937.7936853892132;964.3972517176765;10631.07984551514;10648.627298044532;11125.388103654215;11245.156613253876;11324.6036388726;480431;559246;562751;564687;568623;125124;125741;127586.72413275934;129004;130057;833.7123692326259;927.1192367251003;941.6798288582052;964.1226483899758;968.0561452583815;14134.374546927234;18684.3460478888;18952.147153378406;18999.43001709951;19089.85365707829;49925;53870.19194712161;54111;54121.72939135279;54682;53943;77176.61411692905;80100.59949700447;80317;80459;7772.261635144652;7857.096433909945;7955.403344749283;8013.759587212393;8274.710385136492;9660.75848103803;11879.940600297288;12263.325517096646;12685.746285074432;12860.871391286342;10276.22928280397;10302.484875756032;10469.79597346315;10635.521401537104;10895.455227238765;9786.902130978599;10666.253362264568;10804.325329573929;10895.836562451728;10956.56173753041;9778.559964801743;10569.788604228026;10620.044196022394;11237.775244495228;11454.370009649549;7959.442839001214;7993.240642138988;8006.799830004296;8050.604940053536;8144.796380090545;8119.147489513516;10556.366618002945;10707.839382409426;11059.889401105886;11217.383043932661 09:08:26 INFO - PROCESS | 2204 | |3;mootools.html;1232.8643849176592;1355.4984655677401;1504.6388866671996;1615.612253059266;1848.667239896819;7437.25627437256;7452.254774522545;7846.8038299042555;8334.333253339733;8364.539950302731;8222.712205072823;8325.708600198994;8326.042505111915;8338.166183381658;8340.708075217368;2059.4233614587865;2297.437127903662;2340.9297721068397;2341.379534423371;2342.7188737351544;2137.551114266006;2248.955020899581;2312.3409828198965;2319.6404557293645;2322.686437330964;2252.324302709189;2263.4567703751145;2265.8413911026237;2270.8410411271216;2274.9772502275014;2284.9885750571225;2314.409825494488;2315.0855412112205;2323.8257130715265;2335.9182428614918;2302.2172461363048;2345.2143531916827;2348.2016114521143;2350.4241460842204;2352.259038402915;8185.467944583643;8388.622511986976;8396.328293736486;8399.874001889977;8417.747467575982;5026.737967914453;5193.610479214036;5202.687838729688;5216.713080780555;5219.112750832368;3347.196672798535;3399.065257054305;3479.2171761353748;3577.499150118985;3581.534400527915;937.8698668104985;1021.2493817044541;1071.3822128585814;1085.582050910405;1095.2606990281608;10219;10560.524776385004;10734.892651073467;10750.569977200903;10756.623518176904;4299.161663475655;4356.976110614003;4403.867883963486;4427.955720442755;4538.568835960578;8547;8554.61504232311;8555.572221388906;8577.571121443903;8587.82824343522;5072.82245121419;5076.593872490192;5082.983403319351;5085.466026067284;5105.617078719111;4193.370994350872;4244.278472659656;4393.472783266028;4702.52974702527;4789.353437285922;3385.153711572107;3446.827658617059;3448.620651728308;3449.1549570355423;3547.1486843157454;1107.164091111222;1140.7376303450253;1141.9714507137387;1143.108375467137;1143.1597775634903;827.068794365152;855.4396870050127;882.92495137914;904.2946501728662;919.8160367926441;5372.62391632582;5488.286522752017;5498.45015498447;5699.430056994267;5795.33353664334;729.7664747280925;813.8484045076151;911.562450023979;926.1248120526038;944.6552008516979;3577.2487777567003;3582.98208508961;3740.653364788728;3860.2665493556133;3909.139989202371;9554.665586704432;9855.11303982645;10027.749306267402;10049.59801607942;10064.094231519199;10010.299279050396;10046.547905344278;10046.74883127913;10050.145737612238;10054.899451005542;7423.62881855905;7682.769516914502;7708.152103268636;7868.803279918048;7900.209979002054;5418.566514678895;5469.371022332482;5506.201600767947;5549.195366671891;5700.686462244616;9226.584803683985;9254.444733316022;9279.67521136757;9285.860712089188;9306.953465232631;8912.197902188835;9294.070592940652;9337.299702522203;9432;9437.386569872937;7009.719611215494;7166.498345115792;7170.103737032871;7177.389921856492;7182.209956904632;7590.696372145052;7648.808779780327;7740.92259077402;7749.186335434698;7830.686772529035;7090.113735783028;7119.216886142417;7151.32062454066;7163.391111755559;7209.0988626421695;6781.491388145811;6821.079154314104;6956.895646565406;6969.2682268361095;7021.929780702332;6140.662263575367;6204.503639708722;6485.286618472059;6686.498512611476;6699.698513566998;4660.650451216105;4801.279808028824;4809.398825146856;4857.878553036061;4931.580815630711;4705.576498115186;4803.135435621622;4915.459299476983;4928.112939670894;4999.750012499288 09:08:26 INFO - PROCESS | 2204 | |4;prototype.html;354.7800363774459;362.10740524606837;366.18523784579304;375.1427987049592;378.443687778965;4498.392716983206;5271.630985830993;5296.629235953485;5336.466353364662;5342.999999999995;4794.921142742881;4935.802567897289;4939.333190019346;5164.870878228046;5183.792648294064;3975.8927768282856;4018.4976877890263;4049.817758200888;4052.4731784868072;4059.573744756802;3638.8362523686496;4098.918021639565;4113.526944401402;4128.938065929014;4179.6447301979215;4004.359302511599;4103.384492326145;4105.967546064688;4109.6712263019035;4135.855245066423;4091.284025295561;4102.220578090169;4123.020949944043;4138.8344466221315;4151.626353628173;3493.47597860323;3621.4830692668606;3640.1809592841664;3650.817459127033;3668.816559172031;4332.545082766295;4981.427135879384;4986.681193245158;5094.184930411154;5162.92255616166;4224.45082139323;4502.41468609082;4681.88295292617;4748.857534273978;4791.904161916742;4810.7113573185725;5484.424135465799;5572.247746554204;5585.413531579166;5601;3410;3748.9437658435145;3987.8604248851443;4030.5364883038533;4043.6158564936286;5160.136124450928;5261.553072904943;5587.664740115606;5793.754342816314;5880;3557.3952428087287;4132.669386449077;4143.97928010358;4144.41978123063;4176.535843852142;3598.946015809765;3673.412254039341;4206.348016057516;4210.915781684349;4211.862797044842;3969.4442778011103;4176.665866730655;4518.661100417482;4760.738159401266;4763.809447622126;4860.455474131698;5154.479428568581;5528.143137813645;5569.582281328917;5570.97214513933;1188.7458731038664;1283.307014212315;1303.6154334471353;1338.6921008168176;1374.1548947397478;747.3535391885979;855.1576696953496;911.1890417528405;919.3794188922451;968.2496065549255;4167.624913757776;4531.56950089741;4898.926516102261;4931.16170251051;4947.901041979212;4658.627309815207;5235.732877704659;5437.537809286176;5456.3358175756775;5526.281583394133;4425.911481770411;4524.9090606033715;4876.95123048765;4904.645770030405;4937.963027764138;2480.875956202183;2653.349929267303;2653.5405526960094;2846.316883947879;2860.7244704812874;4907.484714105039;5081.2632168335385;5136.332276803992;5360.686631775162;5589.972050139804;5423.3491980962535;5889.293284805851;5964.194833697396;5968.432998865101;5985.850353741192;4837.685550439211;5241.711705856214;5348.839534813962;5792.565557583198;5962.284525856925;5583.972080139573;5709.457601527848;5743.741531631003;5771.336296325976;5893.557983151367;5712.5429965601825;5722.971385143048;5723.971380143073;5732.885342293047;5749.7575945380495;5923.9491661793345;5933.258342707161;5960.552958528041;5972.70136493165;5983.192269043623;3422.9657703422645;3431.262278610111;3792.1088544192644;3830.8659196927974;3856.2094770572526;5251.214587040272;5384.0427285944015;5758.596898217084;5763.7982670606325;5788.82633520995;5398.6283647770715;5627.634203776742;5630.915536267041;5651.378348381757;5658.236138121301;5519;5553.8333849984565;5608.579356548356;5643.1311436107635;5656.095024796013;4299.656027517729;4595.287730401793;4877.561019508261;5051.156327940202;5476.534494567847;4563.817447302071;4704.647151463585;5074.5686616637995;5173.379194496684;5601.834963245753;4675.368825208553;5462.317210348707;5472.945270547243;5487.917681234864;5497.917531236954 09:08:26 INFO - PROCESS | 2204 | |5;yui.html;733.7358550921667;738.641758747008;742.116880911715;777.9105402878668;812.1147948735884;15371.154586497738;15993.360265589363;15997.520074397758;16004.839951600481;16019;14447.92776036121;14602.634934126652;14612.785187258813;14626.414943402278;14687.77968330476;701.8596280743847;725.7351066860584;868.179570306061;879.2526352600287;895.4806212396827;897.107378158733;899.4738078224246;900.7838118851494;903.408267584733;908.9272858171363;964.6912987843892;964.7202311329706;965;966.1739212972913;970.2432102959702;960.4285450157146;961.0629636104812;961.4567769210408;965.4110992294694;966.0436168193509;551.9917201241984;568.3918207517958;689.3038031588083;712.6436781609195;714.4534431160166;12254.20347677407;14746.410143594243;14770.26148692561;14774.704505909822;14796.778048329285;13356.79964800519;13466.528671496548;13519.52681656147;13526.59420217395;13558.186508809504;10706.710445922494;12291.754164916652;12436;12486.188397754207;12754.489820407172;4351.129774045204;4444.28891377378;4459.264221403465;4475.865724028285;4493.41585593874;98782;115546.42226788896;117329.4133529327;119102;119378;10177.338472999232;10741.409222492837;10772.784544309226;10796.298240614335;11155.442227888736;17999.460016199537;21498.677519837216;21511.462213444476;21529.784702152778;21547.522034965867;7571.734989275349;7644.273793989562;7679.500832445873;7748.535087894745;7765.3011228988535;4048.6558642515715;4206.317473010759;4218.767967761742;4222.1766755483;4282.957170428318;3384.272381438003;3422.6577342265573;3454.464557993515;3503.2292895562937;3507.3686736387695;635.5551114220065;641.4611726150056;649.376598465469;651.33238430609;659.1990731261541;448.52008351064046;525.0732457213022;578.8292453726161;579.7912751409489;588.9263842019748;8347.332213422911;8473.618687159093;8916.15296546827;8935.955320223356;8948.373613847098;527.3671594087111;592.9584929055011;627.4227710506345;630.9242890853127;633.6039975015615;4209.221294060609;4271.700980931367;4384.539623339567;4485.484169320504;4535.501094879561;104596.264597664;108694;112314;112801;114733.4263328678;91558.8798504069;91761.54119229494;94154;94695.73869175903;99504.5024774886;67363.66318168378;68292.658536707;68697.65651171713;71869.28130718836;72454.2754572458;9381.249500040118;9857.457839818879;9878.85181722289;9889;10090.293679442368;45430.09139817119;46080;46779.29831052605;48907;50758.984820304126;55132.44867551273;55391;65454.09119300437;70213.29786702068;71044.28955710583;12639.145060756557;12697.003551051115;12864.485420583445;13395.397207125508;13412.396442160321;14326.57020289393;14400.99193056476;14448.855511444752;14785.630359241106;15038.924805375904;13155.60533184006;13273.933630331787;13352;13640.79538806899;13664.726705466033;13531.391087401287;13622.182669039494;13625.79561306601;13827.101238419471;13871;13078.346082695636;13152.539661111816;13154.289118347742;13274.402651880882;13283.317311027902;10986.945065274942;11336.6032188873;11479.942600286946;11551.537938482366;11684.591039313584;8233.670653173805;10633.574657013942;11250.42460087515;11520;11549.711257218636 09:08:26 INFO - PROCESS | 2204 | __end_tp_report 09:08:26 INFO - PROCESS | 2204 | __start_cc_report 09:08:26 INFO - PROCESS | 2204 | _x_x_mozilla_cycle_collect,1753 09:08:26 INFO - PROCESS | 2204 | __end_cc_report 09:08:26 INFO - PROCESS | 2204 | __startTimestamp1481562506007__endTimestamp 09:08:26 INFO - PROCESS | 2204 | 09:08:26 INFO - PROCESS | 2204 | ------- Summary: start ------- 09:08:26 INFO - PROCESS | 2204 | Number of tests: 6 09:08:26 INFO - PROCESS | 2204 | 09:08:26 INFO - PROCESS | 2204 | [#0] dojo.html Cycles:165 Average:5675.62 Median:5869.06 stddev:627.89 (10.7%) stddev-sans-first:601.38 09:08:26 INFO - PROCESS | 2204 | Values: 3293.9 3299.5 3301.8 3339.1 3341.4 5519.6 5585.3 5608.7 5657.9 5663.3 5570.7 5609.0 5616.7 5622.8 5637.6 5114.0 5141.4 5145.5 5148.9 5163.8 5205.7 5209.9 5210.6 5212.3 5215.8 5125.9 5172.0 5172.3 5191.7 5211.8 5202.3 5211.2 5216.4 5216.7 5225.5 5033.8 5055.3 5115.5 5155.5 5161.4 5524.2 5597.1 5600.6 5605.0 5639.7 6141.5 6149.3 6154.1 6166.4 6167.6 6063.6 6109.0 6186.5 6246.8 6251.1 5665.0 5703.7 5709.0 5718.3 5723.9 6268.0 6273.8 6278.5 6282.7 6290.0 5861.1 5980.2 6051.8 6069.8 6072.4 5005.9 6075.6 6112.0 6117.1 6117.3 6105.5 6112.4 6116.7 6127.4 6140.4 6116.6 6141.7 6145.9 6168.0 6172.3 4789.4 4851.4 4852.7 4861.0 4861.8 4360.6 4388.2 4397.9 4414.5 4416.5 5706.0 5762.7 5785.2 5788.4 5810.0 6154.5 6209.3 6225.9 6227.2 6240.6 5601.3 5652.0 5661.6 5695.8 5755.6 5353.4 5356.0 5386.4 5400.2 5414.2 6274.1 6288.0 6295.9 6301.9 6307.2 6056.6 6141.0 6142.7 6173.1 6235.7 6228.1 6233.2 6246.8 6247.5 6255.1 6109.8 6116.5 6119.6 6125.1 6127.9 6107.8 6143.9 6166.3 6210.5 6226.7 5814.3 5879.9 5937.4 5967.9 6004.0 6005.1 6021.5 6036.2 6036.8 6052.5 5784.8 5878.5 5884.8 5894.8 5896.4 5803.8 5864.2 5933.4 5939.0 5954.9 5822.7 5869.1 5877.5 5908.0 5921.8 09:08:26 INFO - PROCESS | 2204 | 09:08:26 INFO - PROCESS | 2204 | [#1] ext.html Cycles:180 Average:69343.06 Median:20701.77 stddev:153282.24 (740.4%) stddev-sans-first:153625.01 09:08:26 INFO - PROCESS | 2204 | Values: 470.3 481.9 487.5 492.8 493.7 30656.7 39653.6 40905.0 40919.0 41001.6 42299.8 42529.4 42648.0 42655.8 42707.8 9366.6 9593.3 9605.1 9605.8 9624.2 8495.8 8731.5 11223.9 11477.4 11503.5 11326.7 11382.0 11399.1 11422.1 11453.5 8526.4 11263.9 11357.8 11364.6 11381.6 8130.8 8136.6 8149.8 8567.0 11037.7 38357.8 39929.0 39940.6 39969.2 40138.6 3307.1 3415.1 3491.1 3528.7 3755.3 22757.4 24109.9 26374.3 28052.0 28963.0 3206.0 3233.5 3249.5 3292.5 3341.4 493059.0 495422.0 496515.0 497781.0 499994.0 52627.2 52954.5 53059.7 53161.5 54078.9 55535.4 55766.7 55805.7 55849.3 55979.0 14699.6 15104.5 15130.3 15148.8 15154.3 10614.0 10904.7 11815.3 11900.9 11922.9 14563.4 16486.3 16901.0 16908.7 17393.3 6732.3 6733.9 7144.5 7210.3 7239.3 745.7 832.3 956.4 965.8 991.5 29338.6 29380.9 29389.7 29868.7 30107.7 914.8 1051.4 1095.4 1102.7 1107.4 14946.9 15064.8 15076.8 15106.6 15310.9 634097.0 635868.0 635974.0 636202.0 636459.0 57966.4 58689.0 58749.8 58774.4 58853.0 1345.0 1386.1 1396.2 1400.2 1409.9 27060.7 28933.2 29099.8 29676.4 29875.9 49159.8 49726.8 50012.5 50029.5 50047.7 576759.0 578313.0 578811.0 579088.0 579388.1 25505.4 25675.4 25873.2 26029.0 26046.5 43353.9 43454.3 44154.3 44325.6 44691.0 36682.0 37234.6 37849.2 38213.2 38291.4 36594.5 36823.3 37917.9 38044.0 38236.6 34166.2 35015.0 37376.3 37541.4 37648.2 29358.0 31507.7 31616.0 31691.7 31709.0 23341.9 23436.5 23968.2 24079.3 24154.5 09:08:26 INFO - PROCESS | 2204 | 09:08:26 INFO - PROCESS | 2204 | [#2] jquery.html Cycles:180 Average:32590.95 Median:3828.57 stddev:91845.73 (2399.0%) stddev-sans-first:92071.49 09:08:26 INFO - PROCESS | 2204 | Values: 359.3 374.7 375.8 387.3 404.5 14493.9 14827.3 16409.2 19585.3 20394.0 19337.4 20186.0 20247.4 20269.9 20306.4 5238.2 5247.1 5494.9 5508.5 5516.0 5238.3 5309.6 5369.3 5378.6 5387.2 3859.6 4093.3 5373.5 5753.8 6047.9 5835.0 6095.6 6107.8 6128.2 6128.3 5826.0 5879.9 5881.4 5885.9 5888.5 13097.7 13113.7 13130.3 13264.4 13345.4 2001.4 2105.3 2234.5 2276.9 2921.8 9661.0 9743.5 9791.4 10281.6 10305.7 1770.3 1785.1 1821.7 1822.8 1855.8 94280.1 104895.5 107762.4 108548.0 124848.0 10635.5 11063.5 11125.6 11273.1 11466.6 14541.2 14566.6 14579.0 14582.6 14596.7 8052.8 8288.9 8336.0 8423.4 8526.8 6722.3 6941.4 8125.2 8195.4 8436.8 3797.6 4485.0 4487.2 4490.8 4491.5 1882.4 1922.8 1927.9 1931.6 1960.8 817.6 876.7 903.2 976.1 999.0 17356.3 20794.8 21382.5 21389.8 21432.2 921.9 922.3 928.1 937.8 964.4 10631.1 10648.6 11125.4 11245.2 11324.6 480431.0 559246.0 562751.0 564687.0 568623.0 125124.0 125741.0 127586.7 129004.0 130057.0 833.7 927.1 941.7 964.1 968.1 14134.4 18684.3 18952.1 18999.4 19089.9 49925.0 53870.2 54111.0 54121.7 54682.0 53943.0 77176.6 80100.6 80317.0 80459.0 7772.3 7857.1 7955.4 8013.8 8274.7 9660.8 11879.9 12263.3 12685.7 12860.9 10276.2 10302.5 10469.8 10635.5 10895.5 9786.9 10666.3 10804.3 10895.8 10956.6 9778.6 10569.8 10620.0 11237.8 11454.4 7959.4 7993.2 8006.8 8050.6 8144.8 8119.1 10556.4 10707.8 11059.9 11217.4 09:08:26 INFO - PROCESS | 2204 | 09:08:26 INFO - PROCESS | 2204 | [#3] mootools.html Cycles:180 Average:5354.75 Median:5084.22 stddev:2931.68 (57.7%) stddev-sans-first:2923.53 09:08:26 INFO - PROCESS | 2204 | Values: 1232.9 1355.5 1504.6 1615.6 1848.7 7437.3 7452.3 7846.8 8334.3 8364.5 8222.7 8325.7 8326.0 8338.2 8340.7 2059.4 2297.4 2340.9 2341.4 2342.7 2137.6 2249.0 2312.3 2319.6 2322.7 2252.3 2263.5 2265.8 2270.8 2275.0 2285.0 2314.4 2315.1 2323.8 2335.9 2302.2 2345.2 2348.2 2350.4 2352.3 8185.5 8388.6 8396.3 8399.9 8417.7 5026.7 5193.6 5202.7 5216.7 5219.1 3347.2 3399.1 3479.2 3577.5 3581.5 937.9 1021.2 1071.4 1085.6 1095.3 10219.0 10560.5 10734.9 10750.6 10756.6 4299.2 4357.0 4403.9 4428.0 4538.6 8547.0 8554.6 8555.6 8577.6 8587.8 5072.8 5076.6 5083.0 5085.5 5105.6 4193.4 4244.3 4393.5 4702.5 4789.4 3385.2 3446.8 3448.6 3449.2 3547.1 1107.2 1140.7 1142.0 1143.1 1143.2 827.1 855.4 882.9 904.3 919.8 5372.6 5488.3 5498.5 5699.4 5795.3 729.8 813.8 911.6 926.1 944.7 3577.2 3583.0 3740.7 3860.3 3909.1 9554.7 9855.1 10027.7 10049.6 10064.1 10010.3 10046.5 10046.7 10050.1 10054.9 7423.6 7682.8 7708.2 7868.8 7900.2 5418.6 5469.4 5506.2 5549.2 5700.7 9226.6 9254.4 9279.7 9285.9 9307.0 8912.2 9294.1 9337.3 9432.0 9437.4 7009.7 7166.5 7170.1 7177.4 7182.2 7590.7 7648.8 7740.9 7749.2 7830.7 7090.1 7119.2 7151.3 7163.4 7209.1 6781.5 6821.1 6956.9 6969.3 7021.9 6140.7 6204.5 6485.3 6686.5 6699.7 4660.7 4801.3 4809.4 4857.9 4931.6 4705.6 4803.1 4915.5 4928.1 4999.8 09:08:26 INFO - PROCESS | 2204 | 09:08:26 INFO - PROCESS | 2204 | [#4] prototype.html Cycles:180 Average:4489.72 Median:4919.32 stddev:1356.57 (27.6%) stddev-sans-first:1324.40 09:08:26 INFO - PROCESS | 2204 | Values: 354.8 362.1 366.2 375.1 378.4 4498.4 5271.6 5296.6 5336.5 5343.0 4794.9 4935.8 4939.3 5164.9 5183.8 3975.9 4018.5 4049.8 4052.5 4059.6 3638.8 4098.9 4113.5 4128.9 4179.6 4004.4 4103.4 4106.0 4109.7 4135.9 4091.3 4102.2 4123.0 4138.8 4151.6 3493.5 3621.5 3640.2 3650.8 3668.8 4332.5 4981.4 4986.7 5094.2 5162.9 4224.5 4502.4 4681.9 4748.9 4791.9 4810.7 5484.4 5572.2 5585.4 5601.0 3410.0 3748.9 3987.9 4030.5 4043.6 5160.1 5261.6 5587.7 5793.8 5880.0 3557.4 4132.7 4144.0 4144.4 4176.5 3598.9 3673.4 4206.3 4210.9 4211.9 3969.4 4176.7 4518.7 4760.7 4763.8 4860.5 5154.5 5528.1 5569.6 5571.0 1188.7 1283.3 1303.6 1338.7 1374.2 747.4 855.2 911.2 919.4 968.2 4167.6 4531.6 4898.9 4931.2 4947.9 4658.6 5235.7 5437.5 5456.3 5526.3 4425.9 4524.9 4877.0 4904.6 4938.0 2480.9 2653.3 2653.5 2846.3 2860.7 4907.5 5081.3 5136.3 5360.7 5590.0 5423.3 5889.3 5964.2 5968.4 5985.9 4837.7 5241.7 5348.8 5792.6 5962.3 5584.0 5709.5 5743.7 5771.3 5893.6 5712.5 5723.0 5724.0 5732.9 5749.8 5923.9 5933.3 5960.6 5972.7 5983.2 3423.0 3431.3 3792.1 3830.9 3856.2 5251.2 5384.0 5758.6 5763.8 5788.8 5398.6 5627.6 5630.9 5651.4 5658.2 5519.0 5553.8 5608.6 5643.1 5656.1 4299.7 4595.3 4877.6 5051.2 5476.5 4563.8 4704.6 5074.6 5173.4 5601.8 4675.4 5462.3 5472.9 5487.9 5497.9 09:08:26 INFO - PROCESS | 2204 | 09:08:26 INFO - PROCESS | 2204 | [#5] yui.html Cycles:180 Average:20587.93 Median:4317.04 stddev:30451.09 (705.4%) stddev-sans-first:30500.03 09:08:26 INFO - PROCESS | 2204 | Values: 733.7 738.6 742.1 777.9 812.1 15371.2 15993.4 15997.5 16004.8 16019.0 14447.9 14602.6 14612.8 14626.4 14687.8 701.9 725.7 868.2 879.3 895.5 897.1 899.5 900.8 903.4 908.9 964.7 964.7 965.0 966.2 970.2 960.4 961.1 961.5 965.4 966.0 552.0 568.4 689.3 712.6 714.5 12254.2 14746.4 14770.3 14774.7 14796.8 13356.8 13466.5 13519.5 13526.6 13558.2 10706.7 12291.8 12436.0 12486.2 12754.5 4351.1 4444.3 4459.3 4475.9 4493.4 98782.0 115546.4 117329.4 119102.0 119378.0 10177.3 10741.4 10772.8 10796.3 11155.4 17999.5 21498.7 21511.5 21529.8 21547.5 7571.7 7644.3 7679.5 7748.5 7765.3 4048.7 4206.3 4218.8 4222.2 4283.0 3384.3 3422.7 3454.5 3503.2 3507.4 635.6 641.5 649.4 651.3 659.2 448.5 525.1 578.8 579.8 588.9 8347.3 8473.6 8916.2 8936.0 8948.4 527.4 593.0 627.4 630.9 633.6 4209.2 4271.7 4384.5 4485.5 4535.5 104596.3 108694.0 112314.0 112801.0 114733.4 91558.9 91761.5 94154.0 94695.7 99504.5 67363.7 68292.7 68697.7 71869.3 72454.3 9381.2 9857.5 9878.9 9889.0 10090.3 45430.1 46080.0 46779.3 48907.0 50759.0 55132.4 55391.0 65454.1 70213.3 71044.3 12639.1 12697.0 12864.5 13395.4 13412.4 14326.6 14401.0 14448.9 14785.6 15038.9 13155.6 13273.9 13352.0 13640.8 13664.7 13531.4 13622.2 13625.8 13827.1 13871.0 13078.3 13152.5 13154.3 13274.4 13283.3 10986.9 11336.6 11479.9 11551.5 11684.6 8233.7 10633.6 11250.4 11520.0 11549.7 09:08:26 INFO - PROCESS | 2204 | -------- Summary: end -------- 09:08:26 INFO - PROCESS | 2204 | 09:08:26 INFO - TEST-INFO | 2204: exit 0 09:08:26 INFO - TEST-OK | dromaeo_css | took 1118417ms 09:08:26 INFO - TEST-START | kraken 09:08:26 INFO - operating with platform_type : mac_ 09:08:26 INFO - Initialising browser for kraken test... 09:08:26 INFO - TEST-INFO | started process 2210 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpAJeY4Y/profile http://localhost:56030/getInfo.html) 09:08:29 INFO - PROCESS | 2210 | __metrics Screen width/height:1600/1200 09:08:29 INFO - PROCESS | 2210 | colorDepth:24 09:08:29 INFO - PROCESS | 2210 | Browser inner width/height: 1024/689 09:08:29 INFO - PROCESS | 2210 | __metrics 09:08:29 INFO - PROCESS | 2210 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:08:29 INFO - PROCESS | 2210 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:08:30 INFO - TEST-INFO | 2210: exit 0 09:08:30 INFO - Browser initialized. 09:08:30 INFO - Running cycle 1/1 for kraken test... 09:08:30 INFO - TEST-INFO | started process 2211 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpAJeY4Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:08:41 INFO - PROCESS | 2211 | RSS: Main: 237039616 09:08:41 INFO - PROCESS | 2211 | 09:08:44 INFO - PROCESS | 2211 | Cycle 1(1): loaded http://localhost:56030/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56030/tests/kraken/driver.html?testName=audio-beat-detection) 09:08:45 INFO - PROCESS | 2211 | RSS: Main: 289759232 09:08:45 INFO - PROCESS | 2211 | 09:08:48 INFO - PROCESS | 2211 | Cycle 1(1): loaded http://localhost:56030/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56030/tests/kraken/driver.html?testName=audio-dft) 09:08:48 INFO - PROCESS | 2211 | RSS: Main: 291131392 09:08:48 INFO - PROCESS | 2211 | 09:08:52 INFO - PROCESS | 2211 | Cycle 1(1): loaded http://localhost:56030/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56030/tests/kraken/driver.html?testName=audio-fft) 09:08:52 INFO - PROCESS | 2211 | RSS: Main: 382967808 09:08:52 INFO - PROCESS | 2211 | 09:08:54 INFO - PROCESS | 2211 | Cycle 1(1): loaded http://localhost:56030/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56030/tests/kraken/driver.html?testName=audio-oscillator) 09:08:55 INFO - PROCESS | 2211 | RSS: Main: 285782016 09:08:55 INFO - PROCESS | 2211 | 09:08:57 INFO - PROCESS | 2211 | Cycle 1(1): loaded http://localhost:56030/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56030/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:08:58 INFO - PROCESS | 2211 | RSS: Main: 289239040 09:08:58 INFO - PROCESS | 2211 | 09:09:01 INFO - PROCESS | 2211 | Cycle 1(1): loaded http://localhost:56030/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56030/tests/kraken/driver.html?testName=imaging-darkroom) 09:09:01 INFO - PROCESS | 2211 | RSS: Main: 331694080 09:09:01 INFO - PROCESS | 2211 | 09:09:04 INFO - PROCESS | 2211 | Cycle 1(1): loaded http://localhost:56030/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56030/tests/kraken/driver.html?testName=imaging-desaturate) 09:09:05 INFO - PROCESS | 2211 | RSS: Main: 332533760 09:09:05 INFO - PROCESS | 2211 | 09:09:08 INFO - PROCESS | 2211 | Cycle 1(1): loaded http://localhost:56030/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56030/tests/kraken/driver.html?testName=json-parse-financial) 09:09:08 INFO - PROCESS | 2211 | RSS: Main: 330412032 09:09:08 INFO - PROCESS | 2211 | 09:09:10 INFO - PROCESS | 2211 | Cycle 1(1): loaded http://localhost:56030/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56030/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:09:11 INFO - PROCESS | 2211 | RSS: Main: 306049024 09:09:11 INFO - PROCESS | 2211 | 09:09:13 INFO - PROCESS | 2211 | Cycle 1(1): loaded http://localhost:56030/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56030/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:09:13 INFO - PROCESS | 2211 | RSS: Main: 309624832 09:09:13 INFO - PROCESS | 2211 | 09:09:15 INFO - PROCESS | 2211 | Cycle 1(1): loaded http://localhost:56030/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56030/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:09:16 INFO - PROCESS | 2211 | RSS: Main: 311590912 09:09:16 INFO - PROCESS | 2211 | 09:09:19 INFO - PROCESS | 2211 | Cycle 1(1): loaded http://localhost:56030/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56030/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:09:20 INFO - PROCESS | 2211 | RSS: Main: 329441280 09:09:20 INFO - PROCESS | 2211 | 09:09:23 INFO - PROCESS | 2211 | Cycle 1(1): loaded http://localhost:56030/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56030/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:09:23 INFO - PROCESS | 2211 | RSS: Main: 323497984 09:09:23 INFO - PROCESS | 2211 | 09:09:25 INFO - PROCESS | 2211 | Cycle 1(1): loaded http://localhost:56030/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56030/tests/kraken/driver.html?testName=ai-astar) 09:09:25 INFO - PROCESS | 2211 | RSS: Main: 367448064 09:09:25 INFO - PROCESS | 2211 | 09:09:25 INFO - PROCESS | 2211 | __start_tp_report 09:09:25 INFO - PROCESS | 2211 | _x_x_mozilla_page_load 09:09:25 INFO - PROCESS | 2211 | _x_x_mozilla_page_load_details 09:09:25 INFO - PROCESS | 2211 | |i|pagename|runs| 09:09:25 INFO - PROCESS | 2211 | |0;ai-astar;113;114;113;112;113;114;114;112;113;114 09:09:25 INFO - PROCESS | 2211 | |1;audio-beat-detection;148;109;111;150;115;128;144;113;131;112 09:09:25 INFO - PROCESS | 2211 | |2;audio-dft;185;181;180;185;183;185;181;182;229;211 09:09:25 INFO - PROCESS | 2211 | |3;audio-fft;81;59;60;87;61;57;60;68;97;81 09:09:25 INFO - PROCESS | 2211 | |4;audio-oscillator;90;70;85;69;68;73;113;100;68;84 09:09:25 INFO - PROCESS | 2211 | |5;imaging-gaussian-blur;109;110;108;110;107;110;107;111;107;110 09:09:25 INFO - PROCESS | 2211 | |6;imaging-darkroom;96;96;96;103;96;95;93;96;95;95 09:09:25 INFO - PROCESS | 2211 | |7;imaging-desaturate;87;87;86;86;88;87;107;138;94;87 09:09:25 INFO - PROCESS | 2211 | |8;json-parse-financial;53;53;52;53;54;55;55;54;55;55 09:09:25 INFO - PROCESS | 2211 | |9;json-stringify-tinderbox;64;76;65;76;72;69;71;70;71;73 09:09:25 INFO - PROCESS | 2211 | |10;stanford-crypto-aes;90;89;88;87;88;94;80;90;107;114 09:09:25 INFO - PROCESS | 2211 | |11;stanford-crypto-ccm;152;149;153;151;148;149;147;147;197;149 09:09:25 INFO - PROCESS | 2211 | |12;stanford-crypto-pbkdf2;175;168;179;182;175;176;175;173;174;173 09:09:25 INFO - PROCESS | 2211 | |13;stanford-crypto-sha256-iterative;69;77;84;84;87;75;67;66;67;66 09:09:25 INFO - PROCESS | 2211 | __end_tp_report 09:09:25 INFO - PROCESS | 2211 | __start_cc_report 09:09:25 INFO - PROCESS | 2211 | _x_x_mozilla_cycle_collect,2013 09:09:25 INFO - PROCESS | 2211 | __end_cc_report 09:09:25 INFO - PROCESS | 2211 | __startTimestamp1481562565983__endTimestamp 09:09:25 INFO - PROCESS | 2211 | 09:09:25 INFO - PROCESS | 2211 | ------- Summary: start ------- 09:09:25 INFO - PROCESS | 2211 | Number of tests: 14 09:09:25 INFO - PROCESS | 2211 | 09:09:25 INFO - PROCESS | 2211 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.50 stddev:0.79 (0.7%) stddev-sans-first:0.83 09:09:25 INFO - PROCESS | 2211 | Values: 113.0 114.0 113.0 112.0 113.0 114.0 114.0 112.0 113.0 114.0 09:09:25 INFO - PROCESS | 2211 | 09:09:25 INFO - PROCESS | 2211 | [#1] audio-beat-detection Cycles:10 Average:126.10 Median:129.50 stddev:16.37 (12.6%) stddev-sans-first:15.33 09:09:25 INFO - PROCESS | 2211 | Values: 148.0 109.0 111.0 150.0 115.0 128.0 144.0 113.0 131.0 112.0 09:09:25 INFO - PROCESS | 2211 | 09:09:25 INFO - PROCESS | 2211 | [#2] audio-dft Cycles:10 Average:190.20 Median:185.00 stddev:16.37 (8.8%) stddev-sans-first:17.25 09:09:25 INFO - PROCESS | 2211 | Values: 185.0 181.0 180.0 185.0 183.0 185.0 181.0 182.0 229.0 211.0 09:09:25 INFO - PROCESS | 2211 | 09:09:25 INFO - PROCESS | 2211 | [#3] audio-fft Cycles:10 Average:71.10 Median:74.50 stddev:14.23 (19.1%) stddev-sans-first:14.64 09:09:25 INFO - PROCESS | 2211 | Values: 81.0 59.0 60.0 87.0 61.0 57.0 60.0 68.0 97.0 81.0 09:09:25 INFO - PROCESS | 2211 | 09:09:25 INFO - PROCESS | 2211 | [#4] audio-oscillator Cycles:10 Average:82.00 Median:71.50 stddev:15.45 (21.6%) stddev-sans-first:16.11 09:09:25 INFO - PROCESS | 2211 | Values: 90.0 70.0 85.0 69.0 68.0 73.0 113.0 100.0 68.0 84.0 09:09:25 INFO - PROCESS | 2211 | 09:09:25 INFO - PROCESS | 2211 | [#5] imaging-gaussian-blur Cycles:10 Average:108.90 Median:110.00 stddev:1.52 (1.4%) stddev-sans-first:1.62 09:09:25 INFO - PROCESS | 2211 | Values: 109.0 110.0 108.0 110.0 107.0 110.0 107.0 111.0 107.0 110.0 09:09:25 INFO - PROCESS | 2211 | 09:09:25 INFO - PROCESS | 2211 | [#6] imaging-darkroom Cycles:10 Average:96.10 Median:96.00 stddev:2.60 (2.7%) stddev-sans-first:2.76 09:09:25 INFO - PROCESS | 2211 | Values: 96.0 96.0 96.0 103.0 96.0 95.0 93.0 96.0 95.0 95.0 09:09:25 INFO - PROCESS | 2211 | 09:09:25 INFO - PROCESS | 2211 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:87.00 stddev:16.53 (19.0%) stddev-sans-first:17.30 09:09:25 INFO - PROCESS | 2211 | Values: 87.0 87.0 86.0 86.0 88.0 87.0 107.0 138.0 94.0 87.0 09:09:25 INFO - PROCESS | 2211 | 09:09:25 INFO - PROCESS | 2211 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.50 stddev:1.10 (2.0%) stddev-sans-first:1.12 09:09:25 INFO - PROCESS | 2211 | Values: 53.0 53.0 52.0 53.0 54.0 55.0 55.0 54.0 55.0 55.0 09:09:25 INFO - PROCESS | 2211 | 09:09:25 INFO - PROCESS | 2211 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:71.50 stddev:4.00 (5.6%) stddev-sans-first:3.43 09:09:25 INFO - PROCESS | 2211 | Values: 64.0 76.0 65.0 76.0 72.0 69.0 71.0 70.0 71.0 73.0 09:09:25 INFO - PROCESS | 2211 | 09:09:25 INFO - PROCESS | 2211 | [#10] stanford-crypto-aes Cycles:10 Average:92.70 Median:88.50 stddev:10.14 (11.5%) stddev-sans-first:10.71 09:09:25 INFO - PROCESS | 2211 | Values: 90.0 89.0 88.0 87.0 88.0 94.0 80.0 90.0 107.0 114.0 09:09:25 INFO - PROCESS | 2211 | 09:09:25 INFO - PROCESS | 2211 | [#11] stanford-crypto-ccm Cycles:10 Average:154.20 Median:150.00 stddev:15.17 (10.1%) stddev-sans-first:16.07 09:09:25 INFO - PROCESS | 2211 | Values: 152.0 149.0 153.0 151.0 148.0 149.0 147.0 147.0 197.0 149.0 09:09:25 INFO - PROCESS | 2211 | 09:09:26 INFO - PROCESS | 2211 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.00 Median:175.00 stddev:3.71 (2.1%) stddev-sans-first:3.94 09:09:26 INFO - PROCESS | 2211 | Values: 175.0 168.0 179.0 182.0 175.0 176.0 175.0 173.0 174.0 173.0 09:09:26 INFO - PROCESS | 2211 | 09:09:26 INFO - PROCESS | 2211 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.20 Median:76.00 stddev:8.36 (11.0%) stddev-sans-first:8.66 09:09:26 INFO - PROCESS | 2211 | Values: 69.0 77.0 84.0 84.0 87.0 75.0 67.0 66.0 67.0 66.0 09:09:26 INFO - PROCESS | 2211 | -------- Summary: end -------- 09:09:26 INFO - PROCESS | 2211 | 09:09:26 INFO - TEST-INFO | 2211: exit 0 09:09:26 INFO - TEST-OK | kraken | took 60237ms 09:09:26 INFO - SUITE-END | took 1178s 09:09:27 INFO - Completed test suite (00:19:38) 09:09:27 INFO - javascript benchmark 09:09:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3293.901182964512, 3299.4720844664853, 3301.7523685723577, 3339.0650617827, 3341.4486609709397, 5519.558435325174, 5585.301837270341, 5608.719564021798, 5657.886842263152, 5663.263775709157, 5570.721463926798, 5609.0, 5616.691081990489, 5622.803201887935, 5637.633553818999, 5113.974430127844, 5141.408737995141, 5145.459726728695, 5148.922766158511, 5163.81926632568, 5205.687658740469, 5209.895802083956, 5210.635255532115, 5212.270282160482, 5215.765290561933, 5125.871853203681, 5172.0, 5172.327597412331, 5191.662541934781, 5211.765470553834, 5202.297689811865, 5211.1922651989, 5216.374035115772, 5216.713080780555, 5225.477452254782, 5033.84898453047, 5055.266986287004, 5115.488451154892, 5155.458676838915, 5161.354830646169, 5524.226608274845, 5597.076482380402, 5600.5519558435635, 5605.047141985872, 5639.661620302754, 6141.508679305645, 6149.2620885494025, 6154.107654390134, 6166.352532984017, 6167.568270221086, 6063.575549711522, 6109.01788465936, 6186.474149697281, 6246.781362652286, 6251.12484252205, 5665.0, 5703.7148142592705, 5708.97145514274, 5718.285214348207, 5723.914141287884, 6267.96866015667, 6273.780417685359, 6278.497720182374, 6282.717277722513, 6289.96855015722, 5861.120831875168, 5980.222571065734, 6051.848703782441, 6069.757209711651, 6072.392760723892, 5005.874853128628, 6075.5747097703625, 6112.047575716935, 6117.082437634391, 6117.3402608778015, 6105.48103411215, 6112.419320164578, 6116.694165291718, 6127.403330890726, 6140.3552626974415, 6116.558005275416, 6141.683490914946, 6145.893739126911, 6168.0, 6172.321044685081, 4789.425268967746, 4851.442084160296, 4852.708837469763, 4860.975695121501, 4861.781219845116, 4360.607545320936, 4388.2320593896575, 4397.890052748643, 4414.536473670219, 4416.470023597125, 5706.0, 5762.654240745569, 5785.247917770663, 5788.363280039192, 5810.012297909366, 6154.5076393888385, 6209.2548894133, 6225.937740622627, 6227.159333489921, 6240.563160578807, 5601.29983752031, 5652.0, 5661.575381846378, 5695.800646977336, 5755.625884317506, 5353.384360798558, 5356.009138309425, 5386.434424385383, 5400.21696853954, 5414.187871819258, 6274.121622972696, 6287.96856015717, 6295.937040629627, 6301.936980630135, 6307.211598550181, 6056.57603967718, 6141.0, 6142.723577439116, 6173.104899789595, 6235.688215589112, 6228.065790131516, 6233.158523599256, 6246.8125956219565, 6247.5001999839, 6255.093011513396, 6109.829807539466, 6116.487945662287, 6119.593952096689, 6125.05232106189, 6127.922628246602, 6107.755689772359, 6143.941779503916, 6166.290876549254, 6210.503159747119, 6226.719797609209, 5814.273215848019, 5879.853003674943, 5937.435943585352, 5967.940320596738, 6004.0, 6005.069214271794, 6021.458068773832, 6036.154938308729, 6036.758529658764, 6052.455279024909, 5784.82645520635, 5878.500327472213, 5884.764609415575, 5894.823155305347, 5896.380880007709, 5803.7968671096305, 5864.208331875313, 5933.436323549256, 5939.0, 5954.910676339945, 5822.73797679097, 5869.06095024811, 5877.500412464989, 5908.0, 5921.792737254175], "value": 5635.083931905118, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.33447671544764, 481.94457637371715, 487.54901715912774, 492.78071258290066, 493.66924160812255, 30656.693433065662, 39653.60346396535, 40905.0, 40919.0, 41001.58998410015, 42299.78850105753, 42529.36205956913, 42648.0, 42655.78672106635, 42707.78646106765, 9366.625334986593, 9593.273210822084, 9605.135537801596, 9605.75985600362, 9624.181944534723, 8495.830083398328, 8731.476111433334, 11223.857319950426, 11477.426128693574, 11503.48234329453, 11326.71683207918, 11381.975622194042, 11399.145064120225, 11422.086233101332, 11453.484593193327, 8526.360522960802, 11263.943680281587, 11357.772844543062, 11364.579427571554, 11381.601643942506, 8130.796730081736, 8136.633851476698, 8149.755507334789, 8566.957165214197, 11037.724056898562, 38357.80821095876, 39929.0, 39940.60059399398, 39969.200615987516, 40138.598614013776, 3307.1236122427576, 3415.1291420687567, 3491.0574144980965, 3528.7353448491467, 3755.286495565834, 22757.43106422336, 24109.879450602635, 26374.340641483923, 28052.0, 28963.0, 3206.0, 3233.4826427771677, 3249.545063691085, 3292.5390445337434, 3341.381844358777, 493059.0, 495422.0, 496515.0, 497780.9999999964, 499994.0, 52627.210591841154, 52954.47045529573, 53059.73470132625, 53161.468385316424, 54078.918421631344, 55535.44464555303, 55766.72116639391, 55805.72097139488, 55849.298084230155, 55979.0, 14699.632509187142, 15104.471343502924, 15130.319135638923, 15148.848511514963, 15154.318055687521, 10614.0447359738, 10904.727381815359, 11815.291082535075, 11900.88099119015, 11922.940385298018, 14563.417463301561, 16486.258118384703, 16900.985940843588, 16908.746368804477, 17393.304267829146, 6732.259451460335, 6733.93266067333, 7144.464165187632, 7210.278972102853, 7239.348458638748, 745.7464462082918, 832.3382910586099, 956.3687965942584, 965.7633879699378, 991.5389343955095, 29338.559921601194, 29380.853095734383, 29389.706102939126, 29868.70131298703, 30107.69892301093, 914.8170365926841, 1051.4374809476892, 1095.3592148593002, 1102.7188067042853, 1107.3577325151393, 14946.850531494763, 15064.849351506344, 15076.773848392282, 15106.622334441727, 15310.923445382701, 634097.0, 635868.0, 635974.0, 636202.0, 636459.0, 57966.4203357961, 58689.0, 58749.82500350055, 58774.412255876894, 58852.99749521253, 1344.9529266475627, 1386.1475192756382, 1396.1832328088183, 1400.2228763036612, 1409.8942579306593, 27060.72939270582, 28933.226017706842, 29099.833552430915, 29676.406471870872, 29875.850620746758, 49159.75420122877, 49726.751366242934, 50012.49987500079, 50029.496165498254, 50047.748806280135, 576759.0, 578313.0, 578811.0, 579088.0, 579388.1030594988, 25505.362365941, 25675.35811604725, 25873.22380328593, 26029.0, 26046.479070418107, 43353.91615209645, 43454.34818477662, 44154.337684935395, 44325.55674443343, 44691.0, 36682.0, 37234.62765372312, 37849.24301514009, 38213.23573528458, 38291.42562861615, 36594.45108323431, 36823.317668232965, 37917.86246412612, 38044.0, 38236.61763382442, 34166.1963812156, 35015.0, 37376.252474950896, 37541.43687844739, 37648.24703505969, 29358.0, 31507.684923150475, 31616.0, 31691.683083168875, 31709.0, 23341.88329058344, 23436.531269374856, 23968.161114360915, 24079.27762167138, 24154.516909661357], "value": 19406.84215089926, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.2975732443074, 374.6777771116839, 375.81209395302346, 387.27386150966936, 404.5267037566047, 14493.855061449382, 14827.332770025349, 16409.17954102293, 19585.314513992013, 20393.980300984927, 19337.4198774037, 20186.0, 20247.39257822264, 20269.898650506762, 20306.390808275777, 5238.166641675402, 5247.081760691874, 5494.890102197954, 5508.531774799147, 5515.972420137894, 5238.345206849144, 5309.601779866525, 5369.301990741198, 5378.623496355257, 5387.218853266274, 3859.5754467008746, 4093.283675356801, 5373.462653734615, 5753.769849206048, 6047.879042419171, 5835.0, 6095.603785753934, 6107.816765497042, 6128.17269668598, 6128.295246046717, 5826.0, 5879.911801322984, 5881.3530511643685, 5885.941140588582, 5888.5289176865745, 13097.672558186026, 13113.737725245443, 13130.277834719087, 13264.40310186044, 13345.399457024458, 2001.35956493922, 2105.26315789474, 2234.4525591230254, 2276.8747718875456, 2921.810082344662, 9660.95169524148, 9743.512824358824, 9791.412515249107, 10281.588736450532, 10305.742356441075, 1770.283035370677, 1785.0806834480254, 1821.6903126468533, 1822.7903791064066, 1855.7773067231883, 94280.05719942781, 104895.47552262266, 107762.3835642466, 108548.0, 124848.0, 10635.52140153695, 11063.502142403611, 11125.554977800797, 11273.098152147808, 11466.598669046543, 14541.200233987232, 14566.563003109924, 14579.0, 14582.562523124323, 14596.708065838837, 8052.798680032929, 8288.875666865002, 8336.0, 8423.368247381472, 8526.829463410697, 6722.327767223239, 6941.409980151642, 8125.228103330174, 8195.42632015765, 8436.789080273042, 3797.5632802227547, 4484.955150448519, 4487.214737420938, 4490.842820501267, 4491.461024676994, 1882.3882238272615, 1922.826945574905, 1927.9299988506514, 1931.642646110474, 1960.7941166177345, 817.595290331278, 876.6668665906915, 903.2072771568772, 976.1263669016332, 998.9600415983425, 17356.305747769948, 20794.79205207959, 21382.465438364165, 21389.78610213909, 21432.249871254433, 921.9124183202586, 922.3497434308796, 928.1090153452761, 937.7936853892132, 964.3972517176765, 10631.07984551514, 10648.627298044532, 11125.388103654215, 11245.156613253876, 11324.6036388726, 480431.0, 559246.0, 562751.0, 564687.0, 568623.0, 125124.0, 125741.0, 127586.72413275934, 129004.0, 130057.0, 833.7123692326259, 927.1192367251003, 941.6798288582052, 964.1226483899758, 968.0561452583815, 14134.374546927234, 18684.3460478888, 18952.147153378406, 18999.43001709951, 19089.85365707829, 49925.0, 53870.19194712161, 54111.0, 54121.72939135279, 54682.0, 53943.0, 77176.61411692905, 80100.59949700447, 80317.0, 80459.0, 7772.261635144652, 7857.096433909945, 7955.403344749283, 8013.759587212393, 8274.710385136492, 9660.75848103803, 11879.940600297288, 12263.325517096646, 12685.746285074432, 12860.871391286342, 10276.22928280397, 10302.484875756032, 10469.79597346315, 10635.521401537104, 10895.455227238765, 9786.902130978599, 10666.253362264568, 10804.325329573929, 10895.836562451728, 10956.56173753041, 9778.559964801743, 10569.788604228026, 10620.044196022394, 11237.775244495228, 11454.370009649549, 7959.442839001214, 7993.240642138988, 8006.799830004296, 8050.604940053536, 8144.796380090545, 8119.147489513516, 10556.366618002945, 10707.839382409426, 11059.889401105886, 11217.383043932661], "value": 9065.002526007445, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1232.8643849176592, 1355.4984655677401, 1504.6388866671996, 1615.612253059266, 1848.667239896819, 7437.25627437256, 7452.254774522545, 7846.8038299042555, 8334.333253339733, 8364.539950302731, 8222.712205072823, 8325.708600198994, 8326.042505111915, 8338.166183381658, 8340.708075217368, 2059.4233614587865, 2297.437127903662, 2340.9297721068397, 2341.379534423371, 2342.7188737351544, 2137.551114266006, 2248.955020899581, 2312.3409828198965, 2319.6404557293645, 2322.686437330964, 2252.324302709189, 2263.4567703751145, 2265.8413911026237, 2270.8410411271216, 2274.9772502275014, 2284.9885750571225, 2314.409825494488, 2315.0855412112205, 2323.8257130715265, 2335.9182428614918, 2302.2172461363048, 2345.2143531916827, 2348.2016114521143, 2350.4241460842204, 2352.259038402915, 8185.467944583643, 8388.622511986976, 8396.328293736486, 8399.874001889977, 8417.747467575982, 5026.737967914453, 5193.610479214036, 5202.687838729688, 5216.713080780555, 5219.112750832368, 3347.196672798535, 3399.065257054305, 3479.2171761353748, 3577.499150118985, 3581.534400527915, 937.8698668104985, 1021.2493817044541, 1071.3822128585814, 1085.582050910405, 1095.2606990281608, 10219.0, 10560.524776385004, 10734.892651073467, 10750.569977200903, 10756.623518176904, 4299.161663475655, 4356.976110614003, 4403.867883963486, 4427.955720442755, 4538.568835960578, 8547.0, 8554.61504232311, 8555.572221388906, 8577.571121443903, 8587.82824343522, 5072.82245121419, 5076.593872490192, 5082.983403319351, 5085.466026067284, 5105.617078719111, 4193.370994350872, 4244.278472659656, 4393.472783266028, 4702.52974702527, 4789.353437285922, 3385.153711572107, 3446.827658617059, 3448.620651728308, 3449.1549570355423, 3547.1486843157454, 1107.164091111222, 1140.7376303450253, 1141.9714507137387, 1143.108375467137, 1143.1597775634903, 827.068794365152, 855.4396870050127, 882.92495137914, 904.2946501728662, 919.8160367926441, 5372.62391632582, 5488.286522752017, 5498.45015498447, 5699.430056994267, 5795.33353664334, 729.7664747280925, 813.8484045076151, 911.562450023979, 926.1248120526038, 944.6552008516979, 3577.2487777567003, 3582.98208508961, 3740.653364788728, 3860.2665493556133, 3909.139989202371, 9554.665586704432, 9855.11303982645, 10027.749306267402, 10049.59801607942, 10064.094231519199, 10010.299279050396, 10046.547905344278, 10046.74883127913, 10050.145737612238, 10054.899451005542, 7423.62881855905, 7682.769516914502, 7708.152103268636, 7868.803279918048, 7900.209979002054, 5418.566514678895, 5469.371022332482, 5506.201600767947, 5549.195366671891, 5700.686462244616, 9226.584803683985, 9254.444733316022, 9279.67521136757, 9285.860712089188, 9306.953465232631, 8912.197902188835, 9294.070592940652, 9337.299702522203, 9432.0, 9437.386569872937, 7009.719611215494, 7166.498345115792, 7170.103737032871, 7177.389921856492, 7182.209956904632, 7590.696372145052, 7648.808779780327, 7740.92259077402, 7749.186335434698, 7830.686772529035, 7090.113735783028, 7119.216886142417, 7151.32062454066, 7163.391111755559, 7209.0988626421695, 6781.491388145811, 6821.079154314104, 6956.895646565406, 6969.2682268361095, 7021.929780702332, 6140.662263575367, 6204.503639708722, 6485.286618472059, 6686.498512611476, 6699.698513566998, 4660.650451216105, 4801.279808028824, 4809.398825146856, 4857.878553036061, 4931.580815630711, 4705.576498115186, 4803.135435621622, 4915.459299476983, 4928.112939670894, 4999.750012499288], "value": 4331.956182886432, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.7800363774459, 362.10740524606837, 366.18523784579304, 375.1427987049592, 378.443687778965, 4498.392716983206, 5271.630985830993, 5296.629235953485, 5336.466353364662, 5342.999999999995, 4794.921142742881, 4935.802567897289, 4939.333190019346, 5164.870878228046, 5183.792648294064, 3975.8927768282856, 4018.4976877890263, 4049.817758200888, 4052.4731784868072, 4059.573744756802, 3638.8362523686496, 4098.918021639565, 4113.526944401402, 4128.938065929014, 4179.6447301979215, 4004.359302511599, 4103.384492326145, 4105.967546064688, 4109.6712263019035, 4135.855245066423, 4091.284025295561, 4102.220578090169, 4123.020949944043, 4138.8344466221315, 4151.626353628173, 3493.47597860323, 3621.4830692668606, 3640.1809592841664, 3650.817459127033, 3668.816559172031, 4332.545082766295, 4981.427135879384, 4986.681193245158, 5094.184930411154, 5162.92255616166, 4224.45082139323, 4502.41468609082, 4681.88295292617, 4748.857534273978, 4791.904161916742, 4810.7113573185725, 5484.424135465799, 5572.247746554204, 5585.413531579166, 5601.0, 3410.0, 3748.9437658435145, 3987.8604248851443, 4030.5364883038533, 4043.6158564936286, 5160.136124450928, 5261.553072904943, 5587.664740115606, 5793.754342816314, 5880.0, 3557.3952428087287, 4132.669386449077, 4143.97928010358, 4144.41978123063, 4176.535843852142, 3598.946015809765, 3673.412254039341, 4206.348016057516, 4210.915781684349, 4211.862797044842, 3969.4442778011103, 4176.665866730655, 4518.661100417482, 4760.738159401266, 4763.809447622126, 4860.455474131698, 5154.479428568581, 5528.143137813645, 5569.582281328917, 5570.97214513933, 1188.7458731038664, 1283.307014212315, 1303.6154334471353, 1338.6921008168176, 1374.1548947397478, 747.3535391885979, 855.1576696953496, 911.1890417528405, 919.3794188922451, 968.2496065549255, 4167.624913757776, 4531.56950089741, 4898.926516102261, 4931.16170251051, 4947.901041979212, 4658.627309815207, 5235.732877704659, 5437.537809286176, 5456.3358175756775, 5526.281583394133, 4425.911481770411, 4524.9090606033715, 4876.95123048765, 4904.645770030405, 4937.963027764138, 2480.875956202183, 2653.349929267303, 2653.5405526960094, 2846.316883947879, 2860.7244704812874, 4907.484714105039, 5081.2632168335385, 5136.332276803992, 5360.686631775162, 5589.972050139804, 5423.3491980962535, 5889.293284805851, 5964.194833697396, 5968.432998865101, 5985.850353741192, 4837.685550439211, 5241.711705856214, 5348.839534813962, 5792.565557583198, 5962.284525856925, 5583.972080139573, 5709.457601527848, 5743.741531631003, 5771.336296325976, 5893.557983151367, 5712.5429965601825, 5722.971385143048, 5723.971380143073, 5732.885342293047, 5749.7575945380495, 5923.9491661793345, 5933.258342707161, 5960.552958528041, 5972.70136493165, 5983.192269043623, 3422.9657703422645, 3431.262278610111, 3792.1088544192644, 3830.8659196927974, 3856.2094770572526, 5251.214587040272, 5384.0427285944015, 5758.596898217084, 5763.7982670606325, 5788.82633520995, 5398.6283647770715, 5627.634203776742, 5630.915536267041, 5651.378348381757, 5658.236138121301, 5519.0, 5553.8333849984565, 5608.579356548356, 5643.1311436107635, 5656.095024796013, 4299.656027517729, 4595.287730401793, 4877.561019508261, 5051.156327940202, 5476.534494567847, 4563.817447302071, 4704.647151463585, 5074.5686616637995, 5173.379194496684, 5601.834963245753, 4675.368825208553, 5462.317210348707, 5472.945270547243, 5487.917681234864, 5497.917531236954], "value": 4072.9174427501357, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.7358550921667, 738.641758747008, 742.116880911715, 777.9105402878668, 812.1147948735884, 15371.154586497738, 15993.360265589363, 15997.520074397758, 16004.839951600481, 16019.0, 14447.92776036121, 14602.634934126652, 14612.785187258813, 14626.414943402278, 14687.77968330476, 701.8596280743847, 725.7351066860584, 868.179570306061, 879.2526352600287, 895.4806212396827, 897.107378158733, 899.4738078224246, 900.7838118851494, 903.408267584733, 908.9272858171363, 964.6912987843892, 964.7202311329706, 965.0, 966.1739212972913, 970.2432102959702, 960.4285450157146, 961.0629636104812, 961.4567769210408, 965.4110992294694, 966.0436168193509, 551.9917201241984, 568.3918207517958, 689.3038031588083, 712.6436781609195, 714.4534431160166, 12254.20347677407, 14746.410143594243, 14770.26148692561, 14774.704505909822, 14796.778048329285, 13356.79964800519, 13466.528671496548, 13519.52681656147, 13526.59420217395, 13558.186508809504, 10706.710445922494, 12291.754164916652, 12436.0, 12486.188397754207, 12754.489820407172, 4351.129774045204, 4444.28891377378, 4459.264221403465, 4475.865724028285, 4493.41585593874, 98782.0, 115546.42226788896, 117329.4133529327, 119102.0, 119378.0, 10177.338472999232, 10741.409222492837, 10772.784544309226, 10796.298240614335, 11155.442227888736, 17999.460016199537, 21498.677519837216, 21511.462213444476, 21529.784702152778, 21547.522034965867, 7571.734989275349, 7644.273793989562, 7679.500832445873, 7748.535087894745, 7765.3011228988535, 4048.6558642515715, 4206.317473010759, 4218.767967761742, 4222.1766755483, 4282.957170428318, 3384.272381438003, 3422.6577342265573, 3454.464557993515, 3503.2292895562937, 3507.3686736387695, 635.5551114220065, 641.4611726150056, 649.376598465469, 651.33238430609, 659.1990731261541, 448.52008351064046, 525.0732457213022, 578.8292453726161, 579.7912751409489, 588.9263842019748, 8347.332213422911, 8473.618687159093, 8916.15296546827, 8935.955320223356, 8948.373613847098, 527.3671594087111, 592.9584929055011, 627.4227710506345, 630.9242890853127, 633.6039975015615, 4209.221294060609, 4271.700980931367, 4384.539623339567, 4485.484169320504, 4535.501094879561, 104596.264597664, 108694.0, 112314.0, 112801.0, 114733.4263328678, 91558.8798504069, 91761.54119229494, 94154.0, 94695.73869175903, 99504.5024774886, 67363.66318168378, 68292.658536707, 68697.65651171713, 71869.28130718836, 72454.2754572458, 9381.249500040118, 9857.457839818879, 9878.85181722289, 9889.0, 10090.293679442368, 45430.09139817119, 46080.0, 46779.29831052605, 48907.0, 50758.984820304126, 55132.44867551273, 55391.0, 65454.09119300437, 70213.29786702068, 71044.28955710583, 12639.145060756557, 12697.003551051115, 12864.485420583445, 13395.397207125508, 13412.396442160321, 14326.57020289393, 14400.99193056476, 14448.855511444752, 14785.630359241106, 15038.924805375904, 13155.60533184006, 13273.933630331787, 13352.0, 13640.79538806899, 13664.726705466033, 13531.391087401287, 13622.182669039494, 13625.79561306601, 13827.101238419471, 13871.0, 13078.346082695636, 13152.539661111816, 13154.289118347742, 13274.402651880882, 13283.317311027902, 10986.945065274942, 11336.6032188873, 11479.942600286946, 11551.537938482366, 11684.591039313584, 8233.670653173805, 10633.574657013942, 11250.42460087515, 11520.0, 11549.711257218636], "value": 7429.5665982979735, "unit": "score"}], "name": "dromaeo_css", "value": 7117.112241171479, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 112.0, 113.0, 114.0, 114.0, 112.0, 113.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 109.0, 111.0, 150.0, 115.0, 128.0, 144.0, 113.0, 131.0, 112.0], "value": 126.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 181.0, 180.0, 185.0, 183.0, 185.0, 181.0, 182.0, 229.0, 211.0], "value": 190.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 60.0, 87.0, 61.0, 57.0, 60.0, 68.0, 97.0, 81.0], "value": 71.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 85.0, 69.0, 68.0, 73.0, 113.0, 100.0, 68.0, 84.0], "value": 82.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 108.0, 110.0, 107.0, 110.0, 107.0, 111.0, 107.0, 110.0], "value": 108.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 103.0, 96.0, 95.0, 93.0, 96.0, 95.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 86.0, 86.0, 88.0, 87.0, 107.0, 138.0, 94.0, 87.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 53.0, 54.0, 55.0, 55.0, 54.0, 55.0, 55.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 76.0, 65.0, 76.0, 72.0, 69.0, 71.0, 70.0, 71.0, 73.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 88.0, 87.0, 88.0, 94.0, 80.0, 90.0, 107.0, 114.0], "value": 92.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 149.0, 153.0, 151.0, 148.0, 149.0, 147.0, 147.0, 197.0, 149.0], "value": 154.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 168.0, 179.0, 182.0, 175.0, 176.0, 175.0, 173.0, 174.0, 173.0], "value": 175.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 77.0, 84.0, 84.0, 87.0, 75.0, 67.0, 66.0, 67.0, 66.0], "value": 74.2, "unit": "score"}], "name": "kraken", "value": 1503.0000000000002, "alertThreshold": 2.0}]} 09:09:27 INFO - Return code: 0 09:09:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:09:27 INFO - # TBPL SUCCESS # 09:09:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:09:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:09:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:09:27 INFO - 2016-12-12 09:09:27.309 screenresolution[2215:31637] starting screenresolution argv=screenresolution get 09:09:27 INFO - 2016-12-12 09:09:27.312 screenresolution[2215:31637] Display 0: 1600x1200x32@60 09:09:27 INFO - 2016-12-12 09:09:27.318 screenresolution[2216:31640] starting screenresolution argv=screenresolution list 09:09:27 INFO - Available Modes on Display 0 09:09:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:09:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:09:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:09:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:09:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:09:27 INFO - Intel Iris: 09:09:27 INFO - Chipset Model: Intel Iris 09:09:27 INFO - Type: GPU 09:09:27 INFO - Bus: Built-In 09:09:27 INFO - VRAM (Dynamic, Max): 1536 MB 09:09:27 INFO - Vendor: Intel (0x8086) 09:09:27 INFO - Device ID: 0x0a2e 09:09:27 INFO - Revision ID: 0x0009 09:09:27 INFO - Displays: 09:09:27 INFO - Display: 09:09:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:09:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:09:27 INFO - Display Serial Number: 1600x1200 60 09:09:27 INFO - Main Display: Yes 09:09:27 INFO - Mirror: Off 09:09:27 INFO - Online: Yes 09:09:27 INFO - Rotation: Supported 09:09:27 INFO - Return code: 0 09:09:27 INFO - Running post-action listener: _resource_record_post_action 09:09:27 INFO - [mozharness: 2016-12-12 17:09:27.553282Z] Finished run-tests step (success) 09:09:27 INFO - Running post-run listener: _resource_record_post_run 09:09:27 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 663552; Write bytes: 553762816; Read time: 11; Write time: 1705 09:09:27 INFO - TinderboxPrint: CPU usage
53.8% 09:09:27 INFO - TinderboxPrint: I/O read bytes / time
663,552 / 11 09:09:27 INFO - TinderboxPrint: I/O write bytes / time
553,762,816 / 1,705 09:09:27 INFO - TinderboxPrint: CPU idle
2,218.4 (46.2%) 09:09:27 INFO - TinderboxPrint: CPU system
961.0 (20.0%) 09:09:27 INFO - TinderboxPrint: CPU user
1,626.1 (33.8%) 09:09:27 INFO - TinderboxPrint: Swap in / out
249,413,632 / 0 09:09:27 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 250149376; Write bytes: 251303424; Read time: 17919; Write time: 557 09:09:27 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 581632; Write bytes: 301013504; Read time: 8; Write time: 1138 09:09:28 INFO - Running post-run listener: _upload_blobber_files 09:09:28 INFO - Blob upload gear active. 09:09:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:09:28 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 09:09:28 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'] 09:09:28 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 09:09:28 INFO - (blobuploader) - INFO - Open directory for files ... 09:09:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:09:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:09:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:29 INFO - (blobuploader) - INFO - Done attempting. 09:09:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:09:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:09:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:30 INFO - (blobuploader) - INFO - Done attempting. 09:09:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:09:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:09:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:33 INFO - (blobuploader) - INFO - Done attempting. 09:09:33 INFO - (blobuploader) - INFO - Iteration through files over. 09:09:33 INFO - Return code: 0 09:09:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:09:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:09:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0637fe33635a0380a60846f007b3b80139ea774ebf64dbb01802b316c8b34816d7d5262568b023a88661bb356dbb684e95ffee08e81c16cb3372e3d6791dd6e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b02bdc859e2a0302ef0c0d04e361c7bcc7b24d4fb533f05f0ade9d09ea00fad45acd4c7be604628af7d406013a260eb2edf73fdb5775321903dc52eab8d046b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd077c98011cd2a210515475b9001783e46d62f41c68e50e8af26de4de221860cf089a4e111dd525bf048d8dbde0a69ab0fccecdb9a4ce7d9363a732ac2f8755"} 09:09:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:09:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:09:33 INFO - Contents: 09:09:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0637fe33635a0380a60846f007b3b80139ea774ebf64dbb01802b316c8b34816d7d5262568b023a88661bb356dbb684e95ffee08e81c16cb3372e3d6791dd6e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b02bdc859e2a0302ef0c0d04e361c7bcc7b24d4fb533f05f0ade9d09ea00fad45acd4c7be604628af7d406013a260eb2edf73fdb5775321903dc52eab8d046b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd077c98011cd2a210515475b9001783e46d62f41c68e50e8af26de4de221860cf089a4e111dd525bf048d8dbde0a69ab0fccecdb9a4ce7d9363a732ac2f8755"} 09:09:33 INFO - Running post-run listener: copy_logs_to_upload_dir 09:09:33 INFO - Copying logs to upload dir... 09:09:33 INFO - mkdir: /builds/slave/test/build/upload/logs 09:09:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.222523 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-12-12 09:09:33.513246) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-12 09:09:33.516359) ========= 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.ImuR1OfRW4/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.ANYfmiSGvw/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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/e0637fe33635a0380a60846f007b3b80139ea774ebf64dbb01802b316c8b34816d7d5262568b023a88661bb356dbb684e95ffee08e81c16cb3372e3d6791dd6e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b02bdc859e2a0302ef0c0d04e361c7bcc7b24d4fb533f05f0ade9d09ea00fad45acd4c7be604628af7d406013a260eb2edf73fdb5775321903dc52eab8d046b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd077c98011cd2a210515475b9001783e46d62f41c68e50e8af26de4de221860cf089a4e111dd525bf048d8dbde0a69ab0fccecdb9a4ce7d9363a732ac2f8755"} build_url:https://queue.taskcluster.net/v1/task/Z85-jjRSSJ-nxp4Vdrrqkw/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg program finished with exit code 0 elapsedTime=0.011124 build_url: 'https://queue.taskcluster.net/v1/task/Z85-jjRSSJ-nxp4Vdrrqkw/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0637fe33635a0380a60846f007b3b80139ea774ebf64dbb01802b316c8b34816d7d5262568b023a88661bb356dbb684e95ffee08e81c16cb3372e3d6791dd6e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b02bdc859e2a0302ef0c0d04e361c7bcc7b24d4fb533f05f0ade9d09ea00fad45acd4c7be604628af7d406013a260eb2edf73fdb5775321903dc52eab8d046b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd077c98011cd2a210515475b9001783e46d62f41c68e50e8af26de4de221860cf089a4e111dd525bf048d8dbde0a69ab0fccecdb9a4ce7d9363a732ac2f8755"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-12 09:09:33.550474) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 09:09:33.550817) ========= 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.ImuR1OfRW4/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.ANYfmiSGvw/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.005278 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 09:09:33.599854) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-12 09:09:33.600254) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-12 09:09:33.600591) ========= ========= Total master_lag: 0.19 =========