builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0018 starttime: 1484581457.19 results: success (0) buildid: 20170116064321 builduid: 8af65f3c979b4b5b935c3db11ab96d3b revision: 7884f9ed756bad6e9d73b8a5adb82d0773daae08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 07:44:17.190418) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 07:44:17.190983) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 07:44:17.191263) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 07:44:17.300100) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 07:44:17.300466) ========= 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.408MIkmEV1/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.1G5cc0PzLo/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-16 07:44:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 147M=0s 2017-01-16 07:44:17 (147 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.529141 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 07:44:17.853616) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 07:44:17.853924) ========= 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.408MIkmEV1/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.1G5cc0PzLo/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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.026112 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 07:44:17.902308) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 07:44:17.902614) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7884f9ed756bad6e9d73b8a5adb82d0773daae08 --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 7884f9ed756bad6e9d73b8a5adb82d0773daae08 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.408MIkmEV1/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.1G5cc0PzLo/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-16 07:44:18,005 truncating revision to first 12 chars 2017-01-16 07:44:18,006 Setting DEBUG logging. 2017-01-16 07:44:18,006 attempt 1/10 2017-01-16 07:44:18,006 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7884f9ed756b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-16 07:44:18,655 unpacking tar archive at: mozilla-central-7884f9ed756b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.954959 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 07:44:18.880014) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 07:44:18.880278) ========= script_repo_revision: 7884f9ed756bad6e9d73b8a5adb82d0773daae08 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 07:44:18.880624) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 07:44:18.880884) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 07:44:18.900317) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-01-16 07:44:18.900603) ========= /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.408MIkmEV1/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.1G5cc0PzLo/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 07:44:19 INFO - MultiFileLogger online at 20170116 07:44:19 in /builds/slave/test 07:44:19 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 07:44:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:44:19 INFO - {'append_to_log': False, 07:44:19 INFO - 'base_work_dir': '/builds/slave/test', 07:44:19 INFO - 'blob_upload_branch': 'Firefox', 07:44:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:44:19 INFO - 'branch': 'Firefox', 07:44:19 INFO - 'buildbot_json_path': 'buildprops.json', 07:44:19 INFO - 'config_files': ('talos/mac_config.py',), 07:44:19 INFO - 'default_actions': ('clobber', 07:44:19 INFO - 'read-buildbot-config', 07:44:19 INFO - 'download-and-extract', 07:44:19 INFO - 'populate-webroot', 07:44:19 INFO - 'create-virtualenv', 07:44:19 INFO - 'install', 07:44:19 INFO - 'run-tests'), 07:44:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:44:19 INFO - 'download_minidump_stackwalk': True, 07:44:19 INFO - 'download_symbols': 'ondemand', 07:44:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:44:19 INFO - 'tooltool.py': '/tools/tooltool.py', 07:44:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:44:19 INFO - '/tools/misc-python/virtualenv.py')}, 07:44:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:44:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:44:19 INFO - 'installer_path': 'installer.exe', 07:44:19 INFO - 'log_level': 'info', 07:44:19 INFO - 'log_name': 'talos', 07:44:19 INFO - 'log_to_console': True, 07:44:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:44:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:44:19 INFO - 'opt_config_files': (), 07:44:19 INFO - 'pip_index': False, 07:44:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:44:19 INFO - 'cmd': ('bash', 07:44:19 INFO - '-c', 07:44:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:44:19 INFO - 'enabled': True, 07:44:19 INFO - 'halt_on_failure': False, 07:44:19 INFO - 'name': 'check_screen_resolution'},), 07:44:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:44:19 INFO - 'cmd': ('bash', 07:44:19 INFO - '-c', 07:44:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:44:19 INFO - 'enabled': True, 07:44:19 INFO - 'halt_on_failure': False, 07:44:19 INFO - 'name': 'check_screen_resolution'},), 07:44:19 INFO - 'run_cmd_checks_enabled': True, 07:44:19 INFO - 'sps_profile': False, 07:44:19 INFO - 'sps_profile_interval': 0, 07:44:19 INFO - 'suite': 'dromaeojs', 07:44:19 INFO - 'system_bits': '32', 07:44:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:44:19 INFO - 'title': 't-yosemite-r7-0018', 07:44:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:44:19 INFO - 'use_talos_json': True, 07:44:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:44:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:44:19 INFO - 'work_dir': 'build'} 07:44:19 INFO - [mozharness: 2017-01-16 15:44:19.110818Z] Running clobber step. 07:44:19 INFO - Running pre-action listener: _resource_record_pre_action 07:44:19 INFO - Running main action method: clobber 07:44:19 INFO - rmtree: /builds/slave/test/build 07:44:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:44:21 INFO - Running post-action listener: _resource_record_post_action 07:44:21 INFO - [mozharness: 2017-01-16 15:44:21.654437Z] Finished clobber step (success) 07:44:21 INFO - [mozharness: 2017-01-16 15:44:21.654569Z] Running read-buildbot-config step. 07:44:21 INFO - Running pre-action listener: _resource_record_pre_action 07:44:21 INFO - Running main action method: read_buildbot_config 07:44:21 INFO - Using buildbot properties: 07:44:21 INFO - { 07:44:21 INFO - "project": "", 07:44:21 INFO - "product": "firefox", 07:44:21 INFO - "script_repo_revision": "production", 07:44:21 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 07:44:21 INFO - "repository": "", 07:44:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 07:44:21 INFO - "buildid": "20170116064321", 07:44:21 INFO - "pgo_build": "False", 07:44:21 INFO - "basedir": "/builds/slave/test", 07:44:21 INFO - "buildnumber": 14, 07:44:21 INFO - "slavename": "t-yosemite-r7-0018", 07:44:21 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 07:44:21 INFO - "platform": "yosemite_r7", 07:44:21 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:44:21 INFO - "branch": "mozilla-central", 07:44:21 INFO - "repo_path": "mozilla-central", 07:44:21 INFO - "revision": "7884f9ed756bad6e9d73b8a5adb82d0773daae08", 07:44:21 INFO - "stage_platform": "macosx64", 07:44:21 INFO - "builduid": "8af65f3c979b4b5b935c3db11ab96d3b", 07:44:21 INFO - "slavebuilddir": "test" 07:44:21 INFO - } 07:44:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/D5ajY2KpSnOU1N1npK-Ntg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 07:44:21 INFO - Running post-action listener: _resource_record_post_action 07:44:21 INFO - [mozharness: 2017-01-16 15:44:21.657836Z] Finished read-buildbot-config step (success) 07:44:21 INFO - [mozharness: 2017-01-16 15:44:21.657923Z] Running download-and-extract step. 07:44:21 INFO - Running pre-action listener: _resource_record_pre_action 07:44:21 INFO - Running main action method: download_and_extract 07:44:21 INFO - mkdir: /builds/slave/test/build/tests 07:44:21 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')]} 07:44:21 INFO - trying https://queue.taskcluster.net/v1/task/D5ajY2KpSnOU1N1npK-Ntg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 07:44:21 INFO - Downloading https://queue.taskcluster.net/v1/task/D5ajY2KpSnOU1N1npK-Ntg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:44:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D5ajY2KpSnOU1N1npK-Ntg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 07:44:22 INFO - Downloaded 1199 bytes. 07:44:22 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:44:22 INFO - Using the following test package requirements: 07:44:22 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:44:22 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:44:22 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 07:44:22 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:44:22 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 07:44:22 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:44:22 INFO - u'jsshell-mac.zip'], 07:44:22 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:44:22 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 07:44:22 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:44:22 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:44:22 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 07:44:22 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:44:22 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 07:44:22 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:44:22 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 07:44:22 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:44:22 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 07:44:22 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:44:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D5ajY2KpSnOU1N1npK-Ntg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:44:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D5ajY2KpSnOU1N1npK-Ntg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:44:22 INFO - Fetch https://queue.taskcluster.net/v1/task/D5ajY2KpSnOU1N1npK-Ntg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:44:23 INFO - Expected file size: 16324410 07:44:23 INFO - Obtained file size: 16324410 07:44:30 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:44:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D5ajY2KpSnOU1N1npK-Ntg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:44:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D5ajY2KpSnOU1N1npK-Ntg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:44:30 INFO - Fetch https://queue.taskcluster.net/v1/task/D5ajY2KpSnOU1N1npK-Ntg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:44:31 INFO - Expected file size: 16324410 07:44:31 INFO - Obtained file size: 16324410 07:44:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D5ajY2KpSnOU1N1npK-Ntg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 07:44:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D5ajY2KpSnOU1N1npK-Ntg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:44:37 INFO - Fetch https://queue.taskcluster.net/v1/task/D5ajY2KpSnOU1N1npK-Ntg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 07:44:39 INFO - Expected file size: 14403463 07:44:39 INFO - Obtained file size: 14403463 07:44:39 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')]} 07:44:39 INFO - trying https://queue.taskcluster.net/v1/task/D5ajY2KpSnOU1N1npK-Ntg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:44:39 INFO - Downloading https://queue.taskcluster.net/v1/task/D5ajY2KpSnOU1N1npK-Ntg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 07:44:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D5ajY2KpSnOU1N1npK-Ntg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 07:44:41 INFO - Downloaded 70136756 bytes. 07:44:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D5ajY2KpSnOU1N1npK-Ntg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:44:41 INFO - mkdir: /builds/slave/test/properties 07:44:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:44:41 INFO - Writing to file /builds/slave/test/properties/build_url 07:44:41 INFO - Contents: 07:44:41 INFO - build_url:https://queue.taskcluster.net/v1/task/D5ajY2KpSnOU1N1npK-Ntg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:44:42 INFO - Running post-action listener: _resource_record_post_action 07:44:42 INFO - Running post-action listener: set_extra_try_arguments 07:44:42 INFO - [mozharness: 2017-01-16 15:44:42.316896Z] Finished download-and-extract step (success) 07:44:42 INFO - [mozharness: 2017-01-16 15:44:42.317020Z] Running populate-webroot step. 07:44:42 INFO - Running pre-action listener: _resource_record_pre_action 07:44:42 INFO - Running main action method: populate_webroot 07:44:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:44:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:44:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:44:42 INFO - '--tppagecycles', 07:44:42 INFO - '7'], 07:44:42 INFO - 'tests': ['tsvgm']}}, 07:44:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:44:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:44:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:44:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:44:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:44:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:44:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:44:42 INFO - 'talos_options': ['--disable-e10s'], 07:44:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:44:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:44:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:44:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:44:42 INFO - 'talos_options': ['--disable-e10s'], 07:44:42 INFO - 'tests': ['damp', 'tps']}, 07:44:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:44:42 INFO - 'tests': ['damp', 'tps']}, 07:44:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:44:42 INFO - 'tests': ['dromaeo_dom']}, 07:44:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:44:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:44:42 INFO - 'tests': ['basic_compositor_video']}, 07:44:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:44:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:44:42 INFO - 'tests': ['a11yr', 07:44:42 INFO - 'ts_paint', 07:44:42 INFO - 'tpaint', 07:44:42 INFO - 'sessionrestore', 07:44:42 INFO - 'sessionrestore_no_auto_restore', 07:44:42 INFO - 'tabpaint']}, 07:44:42 INFO - 'other-e10s': {'tests': ['a11yr', 07:44:42 INFO - 'ts_paint', 07:44:42 INFO - 'tpaint', 07:44:42 INFO - 'sessionrestore', 07:44:42 INFO - 'sessionrestore_no_auto_restore', 07:44:42 INFO - 'tabpaint']}, 07:44:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:44:42 INFO - 'ts_paint', 07:44:42 INFO - 'tpaint', 07:44:42 INFO - 'sessionrestore', 07:44:42 INFO - 'sessionrestore_no_auto_restore', 07:44:42 INFO - 'tabpaint']}, 07:44:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:44:42 INFO - 'ts_paint', 07:44:42 INFO - 'tpaint', 07:44:42 INFO - 'sessionrestore', 07:44:42 INFO - 'sessionrestore_no_auto_restore', 07:44:42 INFO - 'tabpaint']}, 07:44:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:44:42 INFO - 'tests': ['a11yr', 07:44:42 INFO - 'ts_paint', 07:44:42 INFO - 'tpaint', 07:44:42 INFO - 'sessionrestore', 07:44:42 INFO - 'sessionrestore_no_auto_restore', 07:44:42 INFO - 'tabpaint']}, 07:44:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:44:42 INFO - 'tests': ['a11yr', 07:44:42 INFO - 'ts_paint', 07:44:42 INFO - 'tpaint', 07:44:42 INFO - 'sessionrestore', 07:44:42 INFO - 'sessionrestore_no_auto_restore', 07:44:42 INFO - 'tabpaint']}, 07:44:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:44:42 INFO - 'tests': ['tsvgx', 07:44:42 INFO - 'tsvgr_opacity', 07:44:42 INFO - 'tart', 07:44:42 INFO - 'tscrollx', 07:44:42 INFO - 'cart', 07:44:42 INFO - 'tsvg_static']}, 07:44:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:44:42 INFO - 'tsvgr_opacity', 07:44:42 INFO - 'tart', 07:44:42 INFO - 'tscrollx', 07:44:42 INFO - 'cart', 07:44:42 INFO - 'tsvg_static']}, 07:44:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:44:42 INFO - 'talos_options': ['--disable-e10s'], 07:44:42 INFO - 'tests': ['tp5o']}, 07:44:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:44:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:44:42 INFO - 'talos_options': ['--disable-e10s', 07:44:42 INFO - '--xperf_path', 07:44:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:44:42 INFO - 'tests': ['tp5n']}, 07:44:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:44:42 INFO - 'talos_options': ['--xperf_path', 07:44:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:44:42 INFO - 'tests': ['tp5n']}}, 07:44:42 INFO - 'talos.zip': {'path': '', 07:44:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:44:42 INFO - Running post-action listener: _resource_record_post_action 07:44:42 INFO - [mozharness: 2017-01-16 15:44:42.335315Z] Finished populate-webroot step (success) 07:44:42 INFO - [mozharness: 2017-01-16 15:44:42.335433Z] Running create-virtualenv step. 07:44:42 INFO - Running pre-action listener: _resource_record_pre_action 07:44:42 INFO - Running main action method: create_virtualenv 07:44:42 INFO - Creating virtualenv /builds/slave/test/build/venv 07:44:42 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 07:44:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:44:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:44:42 INFO - Using real prefix '/tools/python27' 07:44:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:44:43 INFO - Installing distribute.............................................................................................................................................................................................done. 07:44:46 INFO - Installing pip.................done. 07:44:46 INFO - Return code: 0 07:44:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:44:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:44:46 INFO - Reading from file tmpfile_stdout 07:44:46 INFO - Output received: 07:44:46 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) 07:44:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fe9ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe9d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2785dbb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc78d30>, '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 0x10fb9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6dbe8>, '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.408MIkmEV1/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.1G5cc0PzLo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 07:44:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:44:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:44:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.408MIkmEV1/Render', 07:44:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:44:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:44:46 INFO - 'HOME': '/Users/cltbld', 07:44:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:44:46 INFO - 'LOGNAME': 'cltbld', 07:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:46 INFO - 'MOZ_NO_REMOTE': '1', 07:44:46 INFO - 'NO_EM_RESTART': '1', 07:44:46 INFO - 'PAGER': '/bin/cat', 07:44:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:46 INFO - 'PWD': '/builds/slave/test', 07:44:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:44:46 INFO - 'SHELL': '/bin/bash', 07:44:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1G5cc0PzLo/Listeners', 07:44:46 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 07:44:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:44:46 INFO - 'USER': 'cltbld', 07:44:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:44:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:46 INFO - 'XPC_FLAGS': '0x0', 07:44:46 INFO - 'XPC_SERVICE_NAME': '0', 07:44:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:44:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:46 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 07:44:46 INFO - Cleaning up... 07:44:46 INFO - Return code: 0 07:44:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fe9ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe9d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2785dbb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc78d30>, '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 0x10fb9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6dbe8>, '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.408MIkmEV1/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.1G5cc0PzLo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 07:44:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:44:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:44:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.408MIkmEV1/Render', 07:44:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:44:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:44:46 INFO - 'HOME': '/Users/cltbld', 07:44:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:44:46 INFO - 'LOGNAME': 'cltbld', 07:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:46 INFO - 'MOZ_NO_REMOTE': '1', 07:44:46 INFO - 'NO_EM_RESTART': '1', 07:44:46 INFO - 'PAGER': '/bin/cat', 07:44:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:46 INFO - 'PWD': '/builds/slave/test', 07:44:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:44:46 INFO - 'SHELL': '/bin/bash', 07:44:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1G5cc0PzLo/Listeners', 07:44:46 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 07:44:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:44:46 INFO - 'USER': 'cltbld', 07:44:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:44:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:46 INFO - 'XPC_FLAGS': '0x0', 07:44:46 INFO - 'XPC_SERVICE_NAME': '0', 07:44:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:44:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:46 INFO - Downloading/unpacking psutil>=3.1.1 07:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:44:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:44:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:44:50 INFO - Installing collected packages: psutil 07:44:50 INFO - Running setup.py install for psutil 07:44:50 INFO - building 'psutil._psutil_osx' extension 07:44:50 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 07:44:51 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 07:44:51 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 07:44:51 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 07:44:51 INFO - building 'psutil._psutil_posix' extension 07:44:51 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 07:44:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:44:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:44:51 INFO - ^ 07:44:51 INFO - 1 warning generated. 07:44:51 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 07:44:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:44:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:44:52 INFO - Successfully installed psutil 07:44:52 INFO - Cleaning up... 07:44:52 INFO - Return code: 0 07:44:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:44:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:52 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 0x10fe9ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe9d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2785dbb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc78d30>, '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 0x10fb9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6dbe8>, '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.408MIkmEV1/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.1G5cc0PzLo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 07:44:52 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 07:44:52 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 07:44:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.408MIkmEV1/Render', 07:44:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:44:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:44:52 INFO - 'HOME': '/Users/cltbld', 07:44:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:44:52 INFO - 'LOGNAME': 'cltbld', 07:44:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:52 INFO - 'MOZ_NO_REMOTE': '1', 07:44:52 INFO - 'NO_EM_RESTART': '1', 07:44:52 INFO - 'PAGER': '/bin/cat', 07:44:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:44:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:52 INFO - 'PWD': '/builds/slave/test', 07:44:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:44:52 INFO - 'SHELL': '/bin/bash', 07:44:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1G5cc0PzLo/Listeners', 07:44:52 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 07:44:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:44:52 INFO - 'USER': 'cltbld', 07:44:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:44:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:44:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:52 INFO - 'XPC_FLAGS': '0x0', 07:44:52 INFO - 'XPC_SERVICE_NAME': '0', 07:44:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:44:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:44:52 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 07:44:52 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 07:44:52 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 07:44:52 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 07:44:52 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 07:44:52 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 07:44:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:44:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:44:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:44:55 INFO - Installing collected packages: mozsystemmonitor 07:44:55 INFO - Running setup.py install for mozsystemmonitor 07:44:55 INFO - Successfully installed mozsystemmonitor 07:44:55 INFO - Cleaning up... 07:44:55 INFO - Return code: 0 07:44:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:44:55 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')]} 07:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:55 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')]} 07:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:55 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 0x10fe9ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe9d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2785dbb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc78d30>, '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 0x10fb9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6dbe8>, '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.408MIkmEV1/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.1G5cc0PzLo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 07:44:55 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 07:44:55 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 07:44:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.408MIkmEV1/Render', 07:44:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:44:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:44:55 INFO - 'HOME': '/Users/cltbld', 07:44:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:44:55 INFO - 'LOGNAME': 'cltbld', 07:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:55 INFO - 'MOZ_NO_REMOTE': '1', 07:44:55 INFO - 'NO_EM_RESTART': '1', 07:44:55 INFO - 'PAGER': '/bin/cat', 07:44:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:55 INFO - 'PWD': '/builds/slave/test', 07:44:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:44:55 INFO - 'SHELL': '/bin/bash', 07:44:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1G5cc0PzLo/Listeners', 07:44:55 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 07:44:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:44:55 INFO - 'USER': 'cltbld', 07:44:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:44:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:55 INFO - 'XPC_FLAGS': '0x0', 07:44:55 INFO - 'XPC_SERVICE_NAME': '0', 07:44:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:55 INFO - Downloading/unpacking jsonschema==2.5.1 07:44:55 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 07:44:55 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 07:44:55 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 07:44:55 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 07:44:55 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 07:44:55 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 07:44:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:44:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:58 INFO - Downloading functools32-3.2.3-2.tar.gz 07:44:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:44:58 INFO - warning: no files found matching '*.txt' 07:44:58 INFO - no previously-included directories found matching 'build' 07:44:58 INFO - no previously-included directories found matching 'dist' 07:44:58 INFO - no previously-included directories found matching '.git*' 07:44:58 INFO - Installing collected packages: jsonschema, functools32 07:44:58 INFO - Running setup.py install for functools32 07:44:58 INFO - warning: no files found matching '*.txt' 07:44:58 INFO - no previously-included directories found matching 'build' 07:44:58 INFO - no previously-included directories found matching 'dist' 07:44:58 INFO - no previously-included directories found matching '.git*' 07:44:58 INFO - Successfully installed jsonschema functools32 07:44:58 INFO - Cleaning up... 07:44:59 INFO - Return code: 0 07:44:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:44:59 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')]} 07:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:59 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')]} 07:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:59 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 0x10fe9ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe9d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2785dbb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc78d30>, '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 0x10fb9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6dbe8>, '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.408MIkmEV1/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.1G5cc0PzLo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 07:44:59 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 07:44:59 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 07:44:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.408MIkmEV1/Render', 07:44:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:44:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:44:59 INFO - 'HOME': '/Users/cltbld', 07:44:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:44:59 INFO - 'LOGNAME': 'cltbld', 07:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:59 INFO - 'MOZ_NO_REMOTE': '1', 07:44:59 INFO - 'NO_EM_RESTART': '1', 07:44:59 INFO - 'PAGER': '/bin/cat', 07:44:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:59 INFO - 'PWD': '/builds/slave/test', 07:44:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:44:59 INFO - 'SHELL': '/bin/bash', 07:44:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1G5cc0PzLo/Listeners', 07:44:59 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 07:44:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:44:59 INFO - 'USER': 'cltbld', 07:44:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:44:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:59 INFO - 'XPC_FLAGS': '0x0', 07:44:59 INFO - 'XPC_SERVICE_NAME': '0', 07:44:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:44:59 INFO - Cleaning up... 07:44:59 INFO - Return code: 0 07:44:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:44:59 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')]} 07:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:59 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')]} 07:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:59 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 0x10fe9ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe9d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2785dbb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc78d30>, '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 0x10fb9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6dbe8>, '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.408MIkmEV1/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.1G5cc0PzLo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 07:44:59 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 07:44:59 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 07:44:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.408MIkmEV1/Render', 07:44:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:44:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:44:59 INFO - 'HOME': '/Users/cltbld', 07:44:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:44:59 INFO - 'LOGNAME': 'cltbld', 07:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:59 INFO - 'MOZ_NO_REMOTE': '1', 07:44:59 INFO - 'NO_EM_RESTART': '1', 07:44:59 INFO - 'PAGER': '/bin/cat', 07:44:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:59 INFO - 'PWD': '/builds/slave/test', 07:44:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:44:59 INFO - 'SHELL': '/bin/bash', 07:44:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1G5cc0PzLo/Listeners', 07:44:59 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 07:44:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:44:59 INFO - 'USER': 'cltbld', 07:44:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:44:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:59 INFO - 'XPC_FLAGS': '0x0', 07:44:59 INFO - 'XPC_SERVICE_NAME': '0', 07:44:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:59 INFO - Downloading/unpacking blobuploader==1.2.4 07:44:59 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 07:44:59 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 07:44:59 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 07:44:59 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 07:44:59 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 07:44:59 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 07:45:02 INFO - Downloading blobuploader-1.2.4.tar.gz 07:45:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:45:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:45:02 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 07:45:02 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 07:45:02 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 07:45:02 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 07:45:02 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 07:45:02 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 07:45:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:45:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:45:02 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 07:45:02 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 07:45:02 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 07:45:02 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 07:45:02 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 07:45:02 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 07:45:03 INFO - Downloading docopt-0.6.1.tar.gz 07:45:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:45:03 INFO - Installing collected packages: blobuploader, requests, docopt 07:45:03 INFO - Running setup.py install for blobuploader 07:45:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:45:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:45:03 INFO - Running setup.py install for requests 07:45:04 INFO - Running setup.py install for docopt 07:45:04 INFO - Successfully installed blobuploader requests docopt 07:45:04 INFO - Cleaning up... 07:45:04 INFO - Return code: 0 07:45:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:45:04 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')]} 07:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:04 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')]} 07:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:04 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 0x10fe9ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe9d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2785dbb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc78d30>, '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 0x10fb9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6dbe8>, '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.408MIkmEV1/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.1G5cc0PzLo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 07:45:04 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 07:45:04 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 07:45:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.408MIkmEV1/Render', 07:45:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:45:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:45:04 INFO - 'HOME': '/Users/cltbld', 07:45:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:45:04 INFO - 'LOGNAME': 'cltbld', 07:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:04 INFO - 'MOZ_NO_REMOTE': '1', 07:45:04 INFO - 'NO_EM_RESTART': '1', 07:45:04 INFO - 'PAGER': '/bin/cat', 07:45:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:04 INFO - 'PWD': '/builds/slave/test', 07:45:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:45:04 INFO - 'SHELL': '/bin/bash', 07:45:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1G5cc0PzLo/Listeners', 07:45:04 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 07:45:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:45:04 INFO - 'USER': 'cltbld', 07:45:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:45:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:04 INFO - 'XPC_FLAGS': '0x0', 07:45:04 INFO - 'XPC_SERVICE_NAME': '0', 07:45:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:45:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:45:04 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-OPiVzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:45:04 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-ZDb9OS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:45:04 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-gg0skX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:45:04 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-sR9xyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:45:05 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-q5EOJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:45:05 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-8IxhpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:45:05 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-ZeySmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:45:05 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-_BGGSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:45:05 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-zIBJ1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:45:05 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-4l87FF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:45:05 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-TUqL6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:45:05 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-rYSFfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:45:05 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-nFvjEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:45:06 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-ywyWZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:45:06 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-DiFX9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:45:06 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-nL6CJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:45:06 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-7XOU6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:45:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:45:06 INFO - Running setup.py install for manifestparser 07:45:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:45:06 INFO - Running setup.py install for mozcrash 07:45:06 INFO - Running setup.py install for mozdebug 07:45:06 INFO - Running setup.py install for mozdevice 07:45:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:45:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:45:07 INFO - Running setup.py install for mozfile 07:45:07 INFO - Running setup.py install for mozhttpd 07:45:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:45:07 INFO - Running setup.py install for mozinfo 07:45:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:45:07 INFO - Running setup.py install for mozInstall 07:45:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:45:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:45:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:45:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:45:07 INFO - Running setup.py install for mozleak 07:45:07 INFO - Running setup.py install for mozlog 07:45:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:45:07 INFO - Running setup.py install for moznetwork 07:45:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:45:08 INFO - Running setup.py install for mozprocess 07:45:08 INFO - Running setup.py install for mozprofile 07:45:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:45:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:45:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:45:08 INFO - Running setup.py install for mozrunner 07:45:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:45:08 INFO - Running setup.py install for mozscreenshot 07:45:08 INFO - Running setup.py install for moztest 07:45:08 INFO - Running setup.py install for mozversion 07:45:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:45:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:45:08 INFO - Cleaning up... 07:45:09 INFO - Return code: 0 07:45:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:45: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')]} 07:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45: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')]} 07:45:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:09 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 0x10fe9ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe9d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2785dbb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc78d30>, '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 0x10fb9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6dbe8>, '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.408MIkmEV1/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.1G5cc0PzLo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 07:45:09 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 07:45:09 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 07:45:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.408MIkmEV1/Render', 07:45:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:45:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:45:09 INFO - 'HOME': '/Users/cltbld', 07:45:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:45:09 INFO - 'LOGNAME': 'cltbld', 07:45:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:09 INFO - 'MOZ_NO_REMOTE': '1', 07:45:09 INFO - 'NO_EM_RESTART': '1', 07:45:09 INFO - 'PAGER': '/bin/cat', 07:45:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:45:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:09 INFO - 'PWD': '/builds/slave/test', 07:45:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:45:09 INFO - 'SHELL': '/bin/bash', 07:45:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1G5cc0PzLo/Listeners', 07:45:09 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 07:45:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:45:09 INFO - 'USER': 'cltbld', 07:45:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:45:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:45:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:09 INFO - 'XPC_FLAGS': '0x0', 07:45:09 INFO - 'XPC_SERVICE_NAME': '0', 07:45:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:45:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:45:09 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-G3giSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:45:09 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)) 07:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:45:09 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-I4o63I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:45:09 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)) 07:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:45:09 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-ODASpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:45:09 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)) 07:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:45:09 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-0RK6_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:45:09 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)) 07:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:45:09 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-WE1vCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:45:09 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)) 07:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:45:09 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-LRrvZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:45:09 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)) 07:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:45:09 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-oK9Akl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:45:10 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)) 07:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:45:10 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-LfcweS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:45:10 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)) 07:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:45:10 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-fDIQpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:45:10 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)) 07:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:45:10 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-AMsMiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:45:10 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)) 07:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:45:10 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-zKqeXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:45:10 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)) 07:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:45:10 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-52lcvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:45:10 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-BmIf3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:45:10 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)) 07:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:45:10 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-SRj1To-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:45:10 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)) 07:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:45:10 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-Yg5fS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:45:10 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)) 07:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:45:10 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-BBgZSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:45:11 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-N0g86A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:45:11 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)) 07:45:11 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)) 07:45:11 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)) 07:45:11 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)) 07:45:11 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)) 07:45:11 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)) 07:45:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:45:11 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 07:45:11 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 07:45:11 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 07:45:11 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 07:45:11 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 07:45:11 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 07:45:13 INFO - Downloading blessings-1.6.tar.gz 07:45:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:45:13 INFO - Installing collected packages: blessings 07:45:13 INFO - Running setup.py install for blessings 07:45:13 INFO - Successfully installed blessings 07:45:13 INFO - Cleaning up... 07:45:14 INFO - Return code: 0 07:45:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:45:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:45:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:45:14 INFO - Reading from file tmpfile_stdout 07:45:14 INFO - Current package versions: 07:45:14 INFO - blessings == 1.6 07:45:14 INFO - blobuploader == 1.2.4 07:45:14 INFO - docopt == 0.6.1 07:45:14 INFO - functools32 == 3.2.3-2 07:45:14 INFO - jsonschema == 2.5.1 07:45:14 INFO - manifestparser == 1.1 07:45:14 INFO - mozInstall == 1.12 07:45:14 INFO - mozcrash == 1.0 07:45:14 INFO - mozdebug == 0.1 07:45:14 INFO - mozdevice == 0.49 07:45:14 INFO - mozfile == 1.2 07:45:14 INFO - mozhttpd == 0.7 07:45:14 INFO - mozinfo == 0.9 07:45:14 INFO - mozleak == 0.1 07:45:14 INFO - mozlog == 3.4 07:45:14 INFO - moznetwork == 0.27 07:45:14 INFO - mozprocess == 0.24 07:45:14 INFO - mozprofile == 0.28 07:45:14 INFO - mozrunner == 6.13 07:45:14 INFO - mozscreenshot == 0.1 07:45:14 INFO - mozsystemmonitor == 0.3 07:45:14 INFO - moztest == 0.8 07:45:14 INFO - mozversion == 1.4 07:45:14 INFO - psutil == 3.1.1 07:45:14 INFO - requests == 1.2.3 07:45:14 INFO - wsgiref == 0.1.2 07:45:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:45:14 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')]} 07:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:14 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')]} 07:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:14 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 0x10fe9ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe9d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2785dbb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc78d30>, '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 0x10fb9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6dbe8>, '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.408MIkmEV1/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.1G5cc0PzLo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 07:45:14 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 07:45:14 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 07:45:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.408MIkmEV1/Render', 07:45:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:45:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:45:14 INFO - 'HOME': '/Users/cltbld', 07:45:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:45:14 INFO - 'LOGNAME': 'cltbld', 07:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:14 INFO - 'MOZ_NO_REMOTE': '1', 07:45:14 INFO - 'NO_EM_RESTART': '1', 07:45:14 INFO - 'PAGER': '/bin/cat', 07:45:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:14 INFO - 'PWD': '/builds/slave/test', 07:45:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:45:14 INFO - 'SHELL': '/bin/bash', 07:45:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1G5cc0PzLo/Listeners', 07:45:14 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 07:45:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:45:14 INFO - 'USER': 'cltbld', 07:45:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:45:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:14 INFO - 'XPC_FLAGS': '0x0', 07:45:14 INFO - 'XPC_SERVICE_NAME': '0', 07:45:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:14 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)) 07:45:14 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)) 07:45:14 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)) 07:45:14 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)) 07:45:14 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)) 07:45:14 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)) 07:45:14 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)) 07:45:14 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)) 07:45:14 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)) 07:45:14 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)) 07:45:14 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)) 07:45:14 INFO - Cleaning up... 07:45:14 INFO - Return code: 0 07:45:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:45:14 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')]} 07:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:14 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')]} 07:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:14 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 0x10fe9ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe9d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2785dbb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc78d30>, '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 0x10fb9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6dbe8>, '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.408MIkmEV1/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.1G5cc0PzLo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 07:45:14 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 07:45:14 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 07:45:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.408MIkmEV1/Render', 07:45:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:45:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:45:14 INFO - 'HOME': '/Users/cltbld', 07:45:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:45:14 INFO - 'LOGNAME': 'cltbld', 07:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:14 INFO - 'MOZ_NO_REMOTE': '1', 07:45:14 INFO - 'NO_EM_RESTART': '1', 07:45:14 INFO - 'PAGER': '/bin/cat', 07:45:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:14 INFO - 'PWD': '/builds/slave/test', 07:45:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:45:14 INFO - 'SHELL': '/bin/bash', 07:45:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1G5cc0PzLo/Listeners', 07:45:14 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 07:45:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:45:14 INFO - 'USER': 'cltbld', 07:45:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:45:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:14 INFO - 'XPC_FLAGS': '0x0', 07:45:14 INFO - 'XPC_SERVICE_NAME': '0', 07:45:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:45:14 INFO - Cleaning up... 07:45:14 INFO - Return code: 0 07:45:14 INFO - Running post-action listener: _resource_record_post_action 07:45:14 INFO - Running post-action listener: _start_resource_monitoring 07:45:14 INFO - Starting resource monitoring. 07:45:14 INFO - [mozharness: 2017-01-16 15:45:14.987299Z] Finished create-virtualenv step (success) 07:45:14 INFO - [mozharness: 2017-01-16 15:45:14.988310Z] Running install step. 07:45:14 INFO - Running pre-action listener: _resource_record_pre_action 07:45:14 INFO - Running main action method: install 07:45:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:45:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:45:15 INFO - Reading from file tmpfile_stdout 07:45:15 INFO - Detecting whether we're running mozinstall >=1.0... 07:45:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:45:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:45:15 INFO - Reading from file tmpfile_stdout 07:45:15 INFO - Output received: 07:45:15 INFO - Usage: mozinstall [options] installer 07:45:15 INFO - Options: 07:45:15 INFO - -h, --help show this help message and exit 07:45:15 INFO - -d DEST, --destination=DEST 07:45:15 INFO - Directory to install application into. [default: 07:45:15 INFO - "/builds/slave/test"] 07:45:15 INFO - --app=APP Application being installed. [default: firefox] 07:45:15 INFO - mkdir: /builds/slave/test/build/application 07:45:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:45:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:45:37 INFO - Reading from file tmpfile_stdout 07:45:37 INFO - Output received: 07:45:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:45:37 INFO - Running post-action listener: _resource_record_post_action 07:45:37 INFO - [mozharness: 2017-01-16 15:45:37.870273Z] Finished install step (success) 07:45:37 INFO - [mozharness: 2017-01-16 15:45:37.870423Z] Running run-tests step. 07:45:37 INFO - Running pre-action listener: _resource_record_pre_action 07:45:37 INFO - Running main action method: run_tests 07:45:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:45:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:45:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:45:37 INFO - 2017-01-16 07:45:37.885 screenresolution[1639:9685] starting screenresolution argv=screenresolution get 07:45:37 INFO - 2017-01-16 07:45:37.888 screenresolution[1639:9685] Display 0: 1600x1200x32@60 07:45:37 INFO - 2017-01-16 07:45:37.894 screenresolution[1640:9688] starting screenresolution argv=screenresolution list 07:45:37 INFO - Available Modes on Display 0 07:45:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:45:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:45:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:45:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:45:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:45:38 INFO - Intel Iris: 07:45:38 INFO - Chipset Model: Intel Iris 07:45:38 INFO - Type: GPU 07:45:38 INFO - Bus: Built-In 07:45:38 INFO - VRAM (Dynamic, Max): 1536 MB 07:45:38 INFO - Vendor: Intel (0x8086) 07:45:38 INFO - Device ID: 0x0a2e 07:45:38 INFO - Revision ID: 0x0009 07:45:38 INFO - Displays: 07:45:38 INFO - Display: 07:45:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:45:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:45:38 INFO - Display Serial Number: 1600x1200 60 07:45:38 INFO - Main Display: Yes 07:45:38 INFO - Mirror: Off 07:45:38 INFO - Online: Yes 07:45:38 INFO - Rotation: Supported 07:45:38 INFO - Return code: 0 07:45:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:45:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:45:38 INFO - Python 2.7.3 07:45:38 INFO - Return code: 0 07:45:38 INFO - grabbing minidump binary from tooltool 07:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:38 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 0x10fc78d30>, '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 0x10fb9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:45:38 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 07:45:38 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 07:45:38 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 07:45:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:45:38 INFO - Return code: 0 07:45:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:45:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:45:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:45:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:45:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:45:38 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/D5ajY2KpSnOU1N1npK-Ntg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0018', '--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 07:45:38 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/D5ajY2KpSnOU1N1npK-Ntg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0018 --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 07:45:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.408MIkmEV1/Render', 07:45:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:45:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:45:38 INFO - 'HOME': '/Users/cltbld', 07:45:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:45:38 INFO - 'LOGNAME': 'cltbld', 07:45:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:45:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:38 INFO - 'MOZ_NO_REMOTE': '1', 07:45:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:45:38 INFO - 'NO_EM_RESTART': '1', 07:45:38 INFO - 'PAGER': '/bin/cat', 07:45:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:38 INFO - 'PWD': '/builds/slave/test', 07:45:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:45:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:45:38 INFO - 'SHELL': '/bin/bash', 07:45:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1G5cc0PzLo/Listeners', 07:45:38 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 07:45:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:45:38 INFO - 'USER': 'cltbld', 07:45:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:45:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:38 INFO - 'XPC_FLAGS': '0x0', 07:45:38 INFO - 'XPC_SERVICE_NAME': '0', 07:45:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:45:38 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/D5ajY2KpSnOU1N1npK-Ntg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0018', '--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 07:45:38 INFO - mozversion application_buildid: 20170116064321 07:45:38 INFO - mozversion application_changeset: 7884f9ed756bad6e9d73b8a5adb82d0773daae08 07:45:38 INFO - mozversion application_display_name: Nightly 07:45:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:45:38 INFO - mozversion application_name: Firefox 07:45:38 INFO - mozversion application_remotingname: firefox 07:45:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:45:38 INFO - mozversion application_vendor: Mozilla 07:45:38 INFO - mozversion application_version: 53.0a1 07:45:38 INFO - mozversion platform_buildid: 20170116064321 07:45:38 INFO - mozversion platform_changeset: 7884f9ed756bad6e9d73b8a5adb82d0773daae08 07:45:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:45:38 INFO - mozversion platform_version: 53.0a1 07:45:38 INFO - using testdate: 1484581538 07:45:38 INFO - actual date: 1484581538 07:45:38 INFO - starting webserver on 'localhost:49243' 07:45:38 INFO - SUITE-START | Running 2 tests 07:45:38 INFO - TEST-START | dromaeo_css 07:45:38 INFO - operating with platform_type : mac_ 07:45:38 INFO - Initialising browser for dromaeo_css test... 07:45:38 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/tmpG3HKcs/profile http://localhost:49243/getInfo.html) 07:45:41 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 07:45:41 INFO - PROCESS | 1650 | colorDepth:24 07:45:41 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 07:45:41 INFO - PROCESS | 1650 | __metrics 07:45:41 INFO - PROCESS | 1650 | 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" 07:45:41 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:45:42 INFO - TEST-INFO | 1650: exit 0 07:45:42 INFO - Browser initialized. 07:45:42 INFO - Running cycle 1/1 for dromaeo_css test... 07:45:42 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/tmpG3HKcs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:45:54 INFO - PROCESS | 1653 | RSS: Main: 235532288 07:45:54 INFO - PROCESS | 1653 | 07:48:58 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 07:48:59 INFO - PROCESS | 1653 | RSS: Main: 328380416 07:48:59 INFO - PROCESS | 1653 | 07:50:43 INFO - PROCESS | 1653 | ************************* 07:50:43 INFO - PROCESS | 1653 | A coding exception was thrown and uncaught in a Task. 07:50:43 INFO - PROCESS | 1653 | 07:50:43 ERROR - PROCESS | 1653 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:50:43 INFO - PROCESS | 1653 | Full stack: 07:50:43 INFO - PROCESS | 1653 | ************************* 07:52:02 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 07:52:03 INFO - PROCESS | 1653 | RSS: Main: 372002816 07:52:03 INFO - PROCESS | 1653 | 07:55:05 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 07:55:06 INFO - PROCESS | 1653 | RSS: Main: 347156480 07:55:06 INFO - PROCESS | 1653 | 07:58:08 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 07:58:09 INFO - PROCESS | 1653 | RSS: Main: 349282304 07:58:09 INFO - PROCESS | 1653 | 08:01:12 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 08:01:13 INFO - PROCESS | 1653 | RSS: Main: 327532544 08:01:13 INFO - PROCESS | 1653 | 08:04:16 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 08:04:17 INFO - PROCESS | 1653 | RSS: Main: 376889344 08:04:17 INFO - PROCESS | 1653 | 08:04:17 INFO - PROCESS | 1653 | __start_tp_report 08:04:17 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 08:04:17 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 08:04:17 INFO - PROCESS | 1653 | |i|pagename|runs| 08:04:17 INFO - PROCESS | 1653 | |0;dojo.html;3360.42872711639;3371.7808342457747;3375.37555552223;3385.9322813543713;3441.4837774333846;5670.007748643981;5743.9712801436035;5814.389489103647;5889.234399528061;5918.615290006147;5743.62666426682;5783.479486846183;5900.996830538808;5918.940810591904;5930.347661757203;5164.845054648366;5179.197224430201;5212.478752124776;5258.789648414059;5306.097963346221;5362.91955620666;5373.946260537384;5383.138697808351;5387.326584176958;5432.293801805759;5190.221466779975;5335.253064570963;5345;5346.064438723208;5367.141257398797;4448.199324121657;5198.532132108128;5218.530332270076;5274.657147285414;5292.02097611943;5221.1124108901195;5240.9213861792105;5264.368275806889;5272.894542109175;5310.415854256029;5759.798407055775;5788.768449262025;5804.796832110856;5814.5057670098095;5838.328592211908;6144.279601711528;6201.751929922798;6214.875702485971;6259.37406259375;6261.78083767066;6143.9385606143815;6183.907241391383;6203.565750397474;6208.937910620881;6220.098085777582;5836.328822185418;5914.757900840828;5928.08114742207;5931.0213814720955;5977.491913187384;6138.786925362681;6153.5692501525355;6197.96901015492;6231.906521402183;6291.1192433059405;6201.224846894138;6222.471089957405;6231.813045608639;6255.593386429959;6264.624122552661;6170.598911070766;6257.530685198537;6258.499320054385;6271.749130034747;6275;6161.568690191643;6179.073139029092;6200.844978875474;6230.158928544589;6253.843653908598;6251.562390632703;6255.030470277115;6277.654728989949;6285.842853928689;6302.275238347649;5009.173486374707;5012.724300163526;5013.54878060969;5033.245013247969;5047.823326183566;4424.026714122888;4453.866384008485;4465.843695470643;4499.887502812456;4515.932261016087;5837.29952405714;5878.030125029408;5882.617629854046;5920.940790592125;5995.220621319288;6215.409536094064;6220.03589443637;6231.034189700604;6239.96880015597;6240.251169859646;5831.795887144014;5860.765569377262;5922.585419020714;5944.524438044946;5953.22608060958;5342.652727572696;5387.649802762808;5391.083515802323;5469.835904922858;5513.035218836688;6276.497880169575;6332.145160403379;6354.777582784581;6364.331745166876;6370.840728981812;6119.3268740437625;6166.660833654192;6172.074188871705;6185.505159587312;6196;6135.508280839814;6303.306636270098;6356.586821856565;6367.554271200971;6376.043593461018;6135.967692822179;6139.4781443577795;6182.1345011699295;6225.62646241227;6280.528960328085;6216.72024758896;6223.595466294676;6232.844178895564;6249.375062493714;6264.467520260829;6121.901811248936;6206.906896396467;6207.844803879939;6229.813105606839;6234.189555357774;6021.518278537619;6089.969550152221;6099.451049405575;6122.44897959168;6132.5084813409785;6028.09578563219;6033.728482218223;6063.454289114001;6071.119687645355;6075.726592303446;6035.215421995113;6098.664573448503;6107.389261073857;6116.701002199415;6209.316975132641;5922.318933322723;6057.091436284416;6073.119397687399;6078.3921607838865;6115.113308570321 08:04:17 INFO - PROCESS | 1653 | |1;ext.html;446.4776211832156;480.30355983823455;513.5762995528688;515.4819406496471;521.7130578181999;31932.68067319326;40673.593264067385;42474.36288455676;42569.78715106424;44422;43705;43950.560494395046;44016.55983440165;44090;44270.77864610672;9190.448573085603;9398.765030874214;9400.81198376032;9408.388454750419;9415.340926135174;8380.455270407434;8595.44129631572;11135.443227838616;11369.658910232665;11396.658100257006;11212.495437705282;11271.154663400237;11332.206745527816;11349.375784331858;11368;8390.202930721573;11301.773964520704;11321.377324247163;11369.829452558177;11373.203875728703;8423.620937057847;11081.944590276997;11298;11363.772724545463;11431.542738290458;41287.1742565147;41417.58582414198;41491.7925410371;41644;41649.79175104135;4039;4057.4378864137225;4083.591640835922;4126.525449573308;4180.540140584533;30463.93376231821;31368;31482.329973305736;31701;31748.365032699447;3167.255694911694;3204.118867311485;3299.2081900343746;3371.2414706691043;3375.4261775498226;425619;425641;426192;427845;431037;63395;64259;64652;64752.35247647557;64853.67573162198;67868.32131678719;67981.32018679849;68003.65998170077;68165;68359.31640683529;16040;16602.667946641242;16638.916805415894;16651.33394664224;16675;11355;11675.941620291844;12651.545072316618;12718;12744.872551274368;16808.74786878198;18780.812191877907;18846.419180355962;19229.230830766894;19474.513137171685;7356.448266380043;7425.702971881173;7429.962850185714;7464.850702986018;7495.587742674205;879.6041781198486;881.6737807011318;887.2148148888281;912.4434095201922;921.5668635741191;29964.550531742043;30121.397572048438;30164.24589385283;30215.213302832086;30473.695263047528;931.417863835103;988.7330420786348;1017.9565944906531;1071.4535586850607;1210.3645586067385;15113.09321440695;15673.451429200151;15717.921410393104;15735.134567598892;15805.36778528869;579564;583808;584209;584508;586185;61431;61789.38210617836;61834;61901;62016.68991655013;1423.9572812815632;1458.7082583483345;1480.274665413961;1484.9034812737139;1485.049568276304;28362.57456138118;29076;29360.853195733886;29986.100416986654;30030.69969300279;52378;52904;52950.20574691306;53037.46962530325;53205.73397132989;496200;496415;498709;498991;499395;32886.01341959745;40941.38587921243;41197.79401103095;41311.586884131975;42601.786991064844;46934.530654693015;48058.51941480541;48347.27479087746;48623.02753944972;48809.2678609814;39308;39359.40960885646;39403.40894886522;40783.1843363137;41394.58605414028;36825.07937301589;38270.42594361142;38373.424398633484;40096.79951600223;40324.991875202184;35532.467012995345;36234.8188259057;36372.09069773277;37688.6808961685;38315.42526862155;29254.41491170122;32384.35231295408;32601.836990814892;32756;33040.83479582587;19725;24105;24235.87882060649;24536.38659033467;24645.63031554564 08:04:17 INFO - PROCESS | 1653 | |2;jquery.html;382.91575853312264;389.84406237505;392.6171982317243;394.1368403196999;415.7650927226117;13687.726245475109;20184.39446816596;20492.795072049274;21267.255646052392;21296.36110916673;20771.376858694264;20866.478338041557;21319;21362.786372136274;21563.784362156373;5507.421720719317;5820.330661973863;5827.35899051104;5831.825045248628;5838.591298609099;5109.20807274873;5456.890862182754;5640.182173584828;5650.208970744099;5759.395263497336;5576.804811831586;5654.6041777075625;5670;5670.121131224667;5675.290588676416;5417.4853388927795;5631.690257035862;5656.151577263402;5665.320161580596;5678.063119585264;5024;5036.269740887587;5048.444671086178;5058;5064.139096353629;25778.613320800203;26265.212043638723;26266.60600091;26285.73714262871;26560;2520.8991640334366;2941.955870661942;3102;3125.6405513366026;3216.1477208539754;14710.926445367812;15784;16240.593985150466;16260;16323.83676163235;1834.4221570205343;1836.9448916532526;1850.9722354164699;1876.3807943378652;1927.884326940388;130725;131920.99999999904;133042;133685.6631433683;134586;11449.370284634426;11749.588764393206;11919.821202681967;11928.642140735792;11932.403379830974;13828.654283642989;14596.197209153386;15773;15820.683586328209;15838.208089595475;7723.9572657691615;7958.482698624571;8024.398170137147;8262.058416272172;8704.52125133111;8312.916870831335;8332.791680208044;8343.791405214797;8480.812686223933;8486.236238738544;4710.24636058229;4781.676734669371;4789.880252993703;4863.440704318978;4869.172240719086;1709.3504468301965;1944.7277381166648;1967.7737060238255;2001.9499512512305;2015.1334925981969;929.4702019848756;954.6801821389773;977.7848873247874;1008.2780222238765;1009.7728011197422;19688.507787305432;20564.794352056586;20735.481612959495;20774.948884967285;20825.79174208269;967.7000129959735;975.3855071305032;993.0813997052697;1001.0790073132736;1002.5438425516372;10452.372857628567;10728.678139655824;10811.567537298577;10874.728131796768;10882.455877206108;673824;674504;702907;727152.2847715187;731368;155258;159161;159298;159371.6288434278;160968;953.3421938862163;971;991.1822746234385;998.6205242007991;999.7100840756244;18558.536036599195;18580.44258672242;18623.90688046551;18627.627447451247;18637.068146592344;45697.77151114223;49110.52668419953;55489;57848.42151578431;57975.71012144912;82671;85290.57354713186;86594.56702716446;87579.56210218908;87967;6371.585846919936;8128.512289262663;8291.378146638906;8359.623816928131;8674.306055515417;11943.522259109539;13324.800127998282;13381.264030478416;13669.658258543615;13803.10279831848;11351.829722554003;11398.487068081791;11555.768884622428;11714.355710436008;11770.234934729215;9572.32993690435;11087.778244435227;11281.492332845206;11507.654770356903;11686.824697629372;10091.79816403653;11556.47995840206;11779.172998480131;11814.94092529532;11870;8231.917680823115;8373.162683731578;8467.83064338722;8469.110743371857;8472.49165050099;8980.416272942239;11229.49467273991;11230.494627741607;11272.549098035986;11621.302721836717 08:04:17 INFO - PROCESS | 1653 | |3;mootools.html;1440.4670271999362;1469.1478942213516;1481.2297605245274;1488.8585584369482;1496.3416096917351;8065.91934080659;8492.447990880597;8498.830023399543;8504.532250726208;8526.70156544521;7478.813029674261;7712.807179820507;7731.188225236354;8054.677812887478;8318.625661845217;2122.3632910126976;2240.8655480671214;2256.898439570219;2314.89582968766;2316.976830231693;2025.6961455781604;2315.849469784467;2333.1600623775425;2339.321596736953;2345.2846881701075;1800.2259028617689;2011.6278488479677;2075.180303780006;2254.9098036078617;2337.1703045418885;2312.2485192312483;2329.324495896188;2329.592321343758;2339.0877557752406;2342.2153578551206;2073.460900165953;2268.5122698619875;2330.673705681206;2363.7990770784504;2364.9172278970327;7572.091349038095;8272.37957153216;8380.497170169749;8459.703910363169;8470.872936905951;5027.723475208862;5202.03762303975;5211.166213405837;5216.634835561512;5231.921521177185;3341.9331613367594;3482.9303413931834;3494.860205591773;3544.7518673692853;3561.198730285691;1148.8104462763633;1194.5401020607042;1196.0670676872053;1236.0482428530072;1250.7310928150491;10786.46067696612;10810.135189184924;10889.83665245022;10931.398773067478;10935.453227338601;3772.43413487979;4587.357769912215;4655.930161047587;4684.1568517666465;4689.484156742756;9464.668736594185;9469.053094690613;9486.525673716287;9489.810203795885;9491.19324857381;5140.614453915971;5223.425423203445;5235.110031294689;5245.527902488794;5248.895022099537;4622.38835058191;4685.718856868599;4722.740249286322;4755.83354582588;4801.399825021872;3792.412176112707;3836.36699944506;3852.036990752312;3884.1454879926373;3920.4511368408444;1114.6210288501786;1276.2533917658275;1282.5062350994933;1291.2381694800113;1294.3528235882059;769.9692012319445;773.3426587400664;795.6379847169524;797.5812698333422;812.3947658994088;5528.778848846082;5629.099344104923;5645.322561292671;5685.630434021776;5704.8859022819315;549.9697516636544;571.040651705131;579.6174524813687;581.5115303145294;582.126809785322;3653.8173091345325;3746.756460830092;3853;3860.4595356650093;3861.3242682530445;9770;10169.440680762482;10179.18566514677;10202.234832387601;10206.540705668263;9675.322727409013;9907.504624768733;10119.089281964658;10125.291229613857;10159.898401016044;7724.961375193088;7769.261920117579;7889.921100788919;7899.881501777478;7905.130435652189;5510.6969116698965;5621.803236886853;5623.662580245198;5639.407862174413;5642.492175704207;9132.680356187502;9193.080691930754;9283.582238799405;9310.441373517611;9328.347015708836;9199.35604507678;9292.767680808034;9409.388389754644;9547;9600.85598716006;7120.60836653989;7239.565626062453;7240.710371585077;7240.8913866290995;7250.419966402781;7527.473076884566;7769;7786.805329866798;7895.7236496722335;7899.881501777363;7175.138983322035;7197.71209151628;7256.891146632699;7292.270772922878;7316.8902466464115;7058.153021637437;7136.143662760502;7141.214466408587;7184.066071410683;7210.315020073084;5940.970295148497;6245.594036387621;6389.361063893573;6493.188351456068;6520.315366886409;4679.157751604744;4804.759762011816;4911.803527858846;5000.824971125993;5051.191809310492;4930.852074437629;4975.7512124392915;5100.719460429712;5115.079285728604;5238.061917090701 08:04:17 INFO - PROCESS | 1653 | |4;prototype.html;283.8907020796993;351.12919958502914;353.325148965476;358.9551306086739;369.3388833987163;4825.71045737256;4848.80604775809;4920.237363208699;4982.683052380642;5002.8249011284615;4489.506154323022;4733.254712266886;4931.728754918478;5150.27896094547;5177.249298851673;3933.429652700364;4070.61329173728;4087.264292427362;4089.7546147231114;4103.425520427142;3894.435306880515;3928.410738389236;3975.383815508601;4091.9590804091877;4102.610252026053;3602.621724718906;4025.6175663311938;4036.6568841648495;4048.8987775305704;4059.675225981929;3605.9098522537015;3878.26313000529;4049.5950404959563;4076.408920706481;4108.794560271975;3264.4657011204695;3418.1967237699123;3567.5362202913716;3612.963870361289;3627.4014787560022;5091.87270318245;5096.439391666913;5115.2071428928575;5131.179011358202;5139.226966696484;3949.6445319921345;4441.244988351988;4627.791749371287;4686.695364801311;4694.131585656664;5083.669561478529;5302.242833726479;5458.781648734046;5523.922835047168;5529.198266251411;3632.1124705858906;3969.2458432897947;3991.381335892941;4012.959870401288;4040.1111755413763;4636.605888499448;5317.73411329432;5787.565932555033;5833.9581146598775;5854.541092741059;3283.6223834259367;4076.735012224255;4092.0179157002103;4099.642705444381;4115.32097203964;3476.37425263455;3850.614938506127;3978.4537895746744;4148.128892932457;4160.209560183616;4114.835406583763;4540.387047748578;4542.954570454319;4564.612007979293;4662.860114196579;4616.884577885513;4955.281484184773;5297.390800057966;5473.425290344457;5505.3393592768325;1134.6652737442473;1138.8576427946507;1328.1499840102342;1333.386642144605;1342.3154191362476;920.3097676742443;942.1520631431766;942.6135284533445;948.6632245552729;958.1281034258931;4727.432708075053;4818.951810481921;4877.707337559757;4904.754762261872;4965.627577931669;4988.700677959334;5018.824341148043;5418.972905135449;5446.482584154499;5491.505764481216;4313;4362.847300344472;4591.8392856249875;4818.84347756543;4833.758312084382;2415.625578035407;2458.840175388594;2554.5018721349156;2804.340979869729;2812.7609153222206;4776.188048031843;5590.338328394908;5603.674475092872;5605.439456054443;5693.459121383462;5218.846832126106;5444.047291723932;5519.806806761824;5568.860778480571;5574.163875418639;4735;5247.632665713363;5319.468053194727;5569.248151499577;5577.693226872561;4839.879003024953;5368.194770784257;5387.461253874581;5390.353157621111;5403.783848646168;5133.486651334837;5585.916211256916;5606.411326810789;5623;5646.661200327993;5843.590948633555;5873.530117590497;5880.411958804086;5893.2872290456735;5913.970430147821;3202.2794871153806;3535.8232088395994;3553.680168784822;3863.4784304118584;3875.903102422462;4734.952650473451;5010.5240002199735;5572.721363931706;5597.412271711411;5752.71236438168;4619.514950930104;5014.899702005867;5361.705106219196;5409.486098820606;5440.748627815546;4848;5301.310829592128;5449.446907631306;5489.149181876815;5511.736291841202;4630.476390367326;4845.861222612753;5089.440161582297;5358.552401506662;5364.865878353073;5472.151816468454;5488.710153113935;5516.689986008363;5532.889342213214;5546.833594992157;5401.378841433286;5407.972960135174;5413.24214609947;5453.7818487260065;5470.070088084955 08:04:17 INFO - PROCESS | 1653 | |5;yui.html;717.9784606461805;718.971241150354;778.8052986753308;802.630789836675;819.8155415031616;14225.928870355647;15174.848251517482;15198.088114713111;15917.681646367066;16780.412685555977;15741.921290393531;15965.92017039916;16059.437919672784;16189.271482783273;16281.674366512663;853.9444936079166;870.229846585773;872.4459967920385;874.3136637739376;875.4090988582712;689.1282527602586;711.4059760100297;714.3178264757145;870.8650159225299;873.6854732296368;881.030866047346;899.7570655922897;909.3180114913814;910.4036855859423;915.2540679346345;900.837849187146;901.4320977783987;902.2917010147069;902.6750369866843;902.7788191893028;533.0724539301626;548.8380927626359;656.980290591283;674.9696263668146;676.6075676107895;14880.107193568421;15119.924400378037;15458.768118478232;15481.225938703132;15501.534953951399;13640.045196836225;13640.386182621805;13661.590152295446;13667.658308542266;13727.931360343235;9592.952035239849;11156.553737850476;11337.943310283395;11449.255798373079;11623.360715160663;3589.5154154189113;3617.5478065241846;3737.2712321097397;3775.4903088083033;3880.9805950970062;98393.60441571275;107978.3803242952;110789.44605277003;111892.4405377976;112973.87026129715;9039.45763254207;10317.587296508205;10921.290116142583;11062.785547553109;11421.942890285496;21630.56738865214;21908;22041.00815463308;22181.334559963227;22187.001584928716;7501.849963000709;7608.581528016012;7725.690972361042;7726.806829829299;7968.800779980431;4327.2643650579475;4335.544767799399;4418.6023257906945;4501.707389019703;4604.447466304065;3588.569371675416;3642.016655502999;3649.434337677664;3698.68561172298;3698.8335524901445;619.3373090792899;625.8998560230341;634.8666779976164;635.2028204603193;640.8782331357028;665.5174998126416;676.8815457295052;704.306258335539;706.3148745716646;727.6689106456549;10129.696109116738;10182.847257291147;10202.642907498202;10504.527296271686;10704.250702450909;688.6281408039603;711.9427649939835;712.6116266634697;717.8384863405796;723.6273319240595;4700.811967521261;4993.675411098267;4998.9500104999215;5005.27423523587;5239.187925871496;76924.46151076947;85025.72461413084;99581.50627740589;102314;103313;83473.16526834776;83586;83961.90095247667;85711;85815.14184858071;79176.81234781483;79817.20182798097;80179.59910200411;80648.59675701702;83202;10595.94702026485;10844.511996960313;11052.281601695864;11164.330140191614;11238;47141.29288060751;48628.27057594209;48861;49987.75030624263;51927.27778219104;63271;67709;68262;68769.65615171893;71881.92177117452;13057.738845222852;13082.934585327013;13346.733065338445;13393.531226407029;13493.460261589427;14575.416983320973;14613.455954492649;14692.191929443983;14962.17708026069;15400.15299158557;13074;13300.401481933142;13365.599032029055;13757.587272381845;13880.236586987812;13555.796663049865;13560.660983475493;13766.449342026206;13922.930385348414;14202.360893759598;13365.732685346044;13416.664583385493;13523.526676566273;13578.185308881499;13980.860191397956;11284;11309.491072901574;11801.870604921374;11899.524019039487;11901.345426001653;10833.566657333618;10967.890321096687;10990.285631434252;11088.5564577416;11108.722281942693 08:04:17 INFO - PROCESS | 1653 | __end_tp_report 08:04:17 INFO - PROCESS | 1653 | __start_cc_report 08:04:17 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1047 08:04:17 INFO - PROCESS | 1653 | __end_cc_report 08:04:17 INFO - PROCESS | 1653 | __startTimestamp1484582657120__endTimestamp 08:04:17 INFO - PROCESS | 1653 | 08:04:17 INFO - PROCESS | 1653 | ------- Summary: start ------- 08:04:17 INFO - PROCESS | 1653 | Number of tests: 6 08:04:17 INFO - PROCESS | 1653 | 08:04:17 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5797.73 Median:6071.12 stddev:630.30 (10.4%) stddev-sans-first:602.53 08:04:17 INFO - PROCESS | 1653 | Values: 3360.4 3371.8 3375.4 3385.9 3441.5 5670.0 5744.0 5814.4 5889.2 5918.6 5743.6 5783.5 5901.0 5918.9 5930.3 5164.8 5179.2 5212.5 5258.8 5306.1 5362.9 5373.9 5383.1 5387.3 5432.3 5190.2 5335.3 5345.0 5346.1 5367.1 4448.2 5198.5 5218.5 5274.7 5292.0 5221.1 5240.9 5264.4 5272.9 5310.4 5759.8 5788.8 5804.8 5814.5 5838.3 6144.3 6201.8 6214.9 6259.4 6261.8 6143.9 6183.9 6203.6 6208.9 6220.1 5836.3 5914.8 5928.1 5931.0 5977.5 6138.8 6153.6 6198.0 6231.9 6291.1 6201.2 6222.5 6231.8 6255.6 6264.6 6170.6 6257.5 6258.5 6271.7 6275.0 6161.6 6179.1 6200.8 6230.2 6253.8 6251.6 6255.0 6277.7 6285.8 6302.3 5009.2 5012.7 5013.5 5033.2 5047.8 4424.0 4453.9 4465.8 4499.9 4515.9 5837.3 5878.0 5882.6 5920.9 5995.2 6215.4 6220.0 6231.0 6240.0 6240.3 5831.8 5860.8 5922.6 5944.5 5953.2 5342.7 5387.6 5391.1 5469.8 5513.0 6276.5 6332.1 6354.8 6364.3 6370.8 6119.3 6166.7 6172.1 6185.5 6196.0 6135.5 6303.3 6356.6 6367.6 6376.0 6136.0 6139.5 6182.1 6225.6 6280.5 6216.7 6223.6 6232.8 6249.4 6264.5 6121.9 6206.9 6207.8 6229.8 6234.2 6021.5 6090.0 6099.5 6122.4 6132.5 6028.1 6033.7 6063.5 6071.1 6075.7 6035.2 6098.7 6107.4 6116.7 6209.3 5922.3 6057.1 6073.1 6078.4 6115.1 08:04:17 INFO - PROCESS | 1653 | 08:04:17 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:65719.76 Median:22365.52 stddev:134824.78 (602.8%) stddev-sans-first:135113.93 08:04:17 INFO - PROCESS | 1653 | Values: 446.5 480.3 513.6 515.5 521.7 31932.7 40673.6 42474.4 42569.8 44422.0 43705.0 43950.6 44016.6 44090.0 44270.8 9190.4 9398.8 9400.8 9408.4 9415.3 8380.5 8595.4 11135.4 11369.7 11396.7 11212.5 11271.2 11332.2 11349.4 11368.0 8390.2 11301.8 11321.4 11369.8 11373.2 8423.6 11081.9 11298.0 11363.8 11431.5 41287.2 41417.6 41491.8 41644.0 41649.8 4039.0 4057.4 4083.6 4126.5 4180.5 30463.9 31368.0 31482.3 31701.0 31748.4 3167.3 3204.1 3299.2 3371.2 3375.4 425619.0 425641.0 426192.0 427845.0 431037.0 63395.0 64259.0 64652.0 64752.4 64853.7 67868.3 67981.3 68003.7 68165.0 68359.3 16040.0 16602.7 16638.9 16651.3 16675.0 11355.0 11675.9 12651.5 12718.0 12744.9 16808.7 18780.8 18846.4 19229.2 19474.5 7356.4 7425.7 7430.0 7464.9 7495.6 879.6 881.7 887.2 912.4 921.6 29964.6 30121.4 30164.2 30215.2 30473.7 931.4 988.7 1018.0 1071.5 1210.4 15113.1 15673.5 15717.9 15735.1 15805.4 579564.0 583808.0 584209.0 584508.0 586185.0 61431.0 61789.4 61834.0 61901.0 62016.7 1424.0 1458.7 1480.3 1484.9 1485.0 28362.6 29076.0 29360.9 29986.1 30030.7 52378.0 52904.0 52950.2 53037.5 53205.7 496200.0 496415.0 498709.0 498991.0 499395.0 32886.0 40941.4 41197.8 41311.6 42601.8 46934.5 48058.5 48347.3 48623.0 48809.3 39308.0 39359.4 39403.4 40783.2 41394.6 36825.1 38270.4 38373.4 40096.8 40325.0 35532.5 36234.8 36372.1 37688.7 38315.4 29254.4 32384.4 32601.8 32756.0 33040.8 19725.0 24105.0 24235.9 24536.4 24645.6 08:04:17 INFO - PROCESS | 1653 | 08:04:17 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:39605.64 Median:26276.17 stddev:117488.68 (447.1%) stddev-sans-first:117781.35 08:04:17 INFO - PROCESS | 1653 | Values: 382.9 389.8 392.6 394.1 415.8 13687.7 20184.4 20492.8 21267.3 21296.4 20771.4 20866.5 21319.0 21362.8 21563.8 5507.4 5820.3 5827.4 5831.8 5838.6 5109.2 5456.9 5640.2 5650.2 5759.4 5576.8 5654.6 5670.0 5670.1 5675.3 5417.5 5631.7 5656.2 5665.3 5678.1 5024.0 5036.3 5048.4 5058.0 5064.1 25778.6 26265.2 26266.6 26285.7 26560.0 2520.9 2942.0 3102.0 3125.6 3216.1 14710.9 15784.0 16240.6 16260.0 16323.8 1834.4 1836.9 1851.0 1876.4 1927.9 130725.0 131921.0 133042.0 133685.7 134586.0 11449.4 11749.6 11919.8 11928.6 11932.4 13828.7 14596.2 15773.0 15820.7 15838.2 7724.0 7958.5 8024.4 8262.1 8704.5 8312.9 8332.8 8343.8 8480.8 8486.2 4710.2 4781.7 4789.9 4863.4 4869.2 1709.4 1944.7 1967.8 2001.9 2015.1 929.5 954.7 977.8 1008.3 1009.8 19688.5 20564.8 20735.5 20774.9 20825.8 967.7 975.4 993.1 1001.1 1002.5 10452.4 10728.7 10811.6 10874.7 10882.5 673824.0 674504.0 702907.0 727152.3 731368.0 155258.0 159161.0 159298.0 159371.6 160968.0 953.3 971.0 991.2 998.6 999.7 18558.5 18580.4 18623.9 18627.6 18637.1 45697.8 49110.5 55489.0 57848.4 57975.7 82671.0 85290.6 86594.6 87579.6 87967.0 6371.6 8128.5 8291.4 8359.6 8674.3 11943.5 13324.8 13381.3 13669.7 13803.1 11351.8 11398.5 11555.8 11714.4 11770.2 9572.3 11087.8 11281.5 11507.7 11686.8 10091.8 11556.5 11779.2 11814.9 11870.0 8231.9 8373.2 8467.8 8469.1 8472.5 8980.4 11229.5 11230.5 11272.5 11621.3 08:04:17 INFO - PROCESS | 1653 | 08:04:17 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5434.06 Median:5220.03 stddev:2998.02 (57.4%) stddev-sans-first:2991.41 08:04:17 INFO - PROCESS | 1653 | Values: 1440.5 1469.1 1481.2 1488.9 1496.3 8065.9 8492.4 8498.8 8504.5 8526.7 7478.8 7712.8 7731.2 8054.7 8318.6 2122.4 2240.9 2256.9 2314.9 2317.0 2025.7 2315.8 2333.2 2339.3 2345.3 1800.2 2011.6 2075.2 2254.9 2337.2 2312.2 2329.3 2329.6 2339.1 2342.2 2073.5 2268.5 2330.7 2363.8 2364.9 7572.1 8272.4 8380.5 8459.7 8470.9 5027.7 5202.0 5211.2 5216.6 5231.9 3341.9 3482.9 3494.9 3544.8 3561.2 1148.8 1194.5 1196.1 1236.0 1250.7 10786.5 10810.1 10889.8 10931.4 10935.5 3772.4 4587.4 4655.9 4684.2 4689.5 9464.7 9469.1 9486.5 9489.8 9491.2 5140.6 5223.4 5235.1 5245.5 5248.9 4622.4 4685.7 4722.7 4755.8 4801.4 3792.4 3836.4 3852.0 3884.1 3920.5 1114.6 1276.3 1282.5 1291.2 1294.4 770.0 773.3 795.6 797.6 812.4 5528.8 5629.1 5645.3 5685.6 5704.9 550.0 571.0 579.6 581.5 582.1 3653.8 3746.8 3853.0 3860.5 3861.3 9770.0 10169.4 10179.2 10202.2 10206.5 9675.3 9907.5 10119.1 10125.3 10159.9 7725.0 7769.3 7889.9 7899.9 7905.1 5510.7 5621.8 5623.7 5639.4 5642.5 9132.7 9193.1 9283.6 9310.4 9328.3 9199.4 9292.8 9409.4 9547.0 9600.9 7120.6 7239.6 7240.7 7240.9 7250.4 7527.5 7769.0 7786.8 7895.7 7899.9 7175.1 7197.7 7256.9 7292.3 7316.9 7058.2 7136.1 7141.2 7184.1 7210.3 5941.0 6245.6 6389.4 6493.2 6520.3 4679.2 4804.8 4911.8 5000.8 5051.2 4930.9 4975.8 5100.7 5115.1 5238.1 08:04:17 INFO - PROCESS | 1653 | 08:04:17 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4426.27 Median:4863.26 stddev:1327.58 (27.3%) stddev-sans-first:1294.39 08:04:17 INFO - PROCESS | 1653 | Values: 283.9 351.1 353.3 359.0 369.3 4825.7 4848.8 4920.2 4982.7 5002.8 4489.5 4733.3 4931.7 5150.3 5177.2 3933.4 4070.6 4087.3 4089.8 4103.4 3894.4 3928.4 3975.4 4092.0 4102.6 3602.6 4025.6 4036.7 4048.9 4059.7 3605.9 3878.3 4049.6 4076.4 4108.8 3264.5 3418.2 3567.5 3613.0 3627.4 5091.9 5096.4 5115.2 5131.2 5139.2 3949.6 4441.2 4627.8 4686.7 4694.1 5083.7 5302.2 5458.8 5523.9 5529.2 3632.1 3969.2 3991.4 4013.0 4040.1 4636.6 5317.7 5787.6 5834.0 5854.5 3283.6 4076.7 4092.0 4099.6 4115.3 3476.4 3850.6 3978.5 4148.1 4160.2 4114.8 4540.4 4543.0 4564.6 4662.9 4616.9 4955.3 5297.4 5473.4 5505.3 1134.7 1138.9 1328.1 1333.4 1342.3 920.3 942.2 942.6 948.7 958.1 4727.4 4819.0 4877.7 4904.8 4965.6 4988.7 5018.8 5419.0 5446.5 5491.5 4313.0 4362.8 4591.8 4818.8 4833.8 2415.6 2458.8 2554.5 2804.3 2812.8 4776.2 5590.3 5603.7 5605.4 5693.5 5218.8 5444.0 5519.8 5568.9 5574.2 4735.0 5247.6 5319.5 5569.2 5577.7 4839.9 5368.2 5387.5 5390.4 5403.8 5133.5 5585.9 5606.4 5623.0 5646.7 5843.6 5873.5 5880.4 5893.3 5914.0 3202.3 3535.8 3553.7 3863.5 3875.9 4735.0 5010.5 5572.7 5597.4 5752.7 4619.5 5014.9 5361.7 5409.5 5440.7 4848.0 5301.3 5449.4 5489.1 5511.7 4630.5 4845.9 5089.4 5358.6 5364.9 5472.2 5488.7 5516.7 5532.9 5546.8 5401.4 5408.0 5413.2 5453.8 5470.1 08:04:17 INFO - PROCESS | 1653 | 08:04:17 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:20349.68 Median:3718.05 stddev:28767.58 (773.7%) stddev-sans-first:28810.51 08:04:17 INFO - PROCESS | 1653 | Values: 718.0 719.0 778.8 802.6 819.8 14225.9 15174.8 15198.1 15917.7 16780.4 15741.9 15965.9 16059.4 16189.3 16281.7 853.9 870.2 872.4 874.3 875.4 689.1 711.4 714.3 870.9 873.7 881.0 899.8 909.3 910.4 915.3 900.8 901.4 902.3 902.7 902.8 533.1 548.8 657.0 675.0 676.6 14880.1 15119.9 15458.8 15481.2 15501.5 13640.0 13640.4 13661.6 13667.7 13727.9 9593.0 11156.6 11337.9 11449.3 11623.4 3589.5 3617.5 3737.3 3775.5 3881.0 98393.6 107978.4 110789.4 111892.4 112973.9 9039.5 10317.6 10921.3 11062.8 11421.9 21630.6 21908.0 22041.0 22181.3 22187.0 7501.8 7608.6 7725.7 7726.8 7968.8 4327.3 4335.5 4418.6 4501.7 4604.4 3588.6 3642.0 3649.4 3698.7 3698.8 619.3 625.9 634.9 635.2 640.9 665.5 676.9 704.3 706.3 727.7 10129.7 10182.8 10202.6 10504.5 10704.3 688.6 711.9 712.6 717.8 723.6 4700.8 4993.7 4999.0 5005.3 5239.2 76924.5 85025.7 99581.5 102314.0 103313.0 83473.2 83586.0 83961.9 85711.0 85815.1 79176.8 79817.2 80179.6 80648.6 83202.0 10595.9 10844.5 11052.3 11164.3 11238.0 47141.3 48628.3 48861.0 49987.8 51927.3 63271.0 67709.0 68262.0 68769.7 71881.9 13057.7 13082.9 13346.7 13393.5 13493.5 14575.4 14613.5 14692.2 14962.2 15400.2 13074.0 13300.4 13365.6 13757.6 13880.2 13555.8 13560.7 13766.4 13922.9 14202.4 13365.7 13416.7 13523.5 13578.2 13980.9 11284.0 11309.5 11801.9 11899.5 11901.3 10833.6 10967.9 10990.3 11088.6 11108.7 08:04:17 INFO - PROCESS | 1653 | -------- Summary: end -------- 08:04:17 INFO - PROCESS | 1653 | 08:04:17 INFO - TEST-INFO | 1653: exit 0 08:04:17 INFO - TEST-OK | dromaeo_css | took 1119298ms 08:04:17 INFO - TEST-START | kraken 08:04:17 INFO - operating with platform_type : mac_ 08:04:17 INFO - Initialising browser for kraken test... 08:04:17 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/tmphSDjvy/profile http://localhost:49243/getInfo.html) 08:04:20 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 08:04:20 INFO - PROCESS | 1659 | colorDepth:24 08:04:20 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 08:04:20 INFO - PROCESS | 1659 | __metrics 08:04:20 INFO - PROCESS | 1659 | 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:04:20 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:04:21 INFO - TEST-INFO | 1659: exit 0 08:04:21 INFO - Browser initialized. 08:04:21 INFO - Running cycle 1/1 for kraken test... 08:04:21 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/tmphSDjvy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:04:33 INFO - PROCESS | 1660 | RSS: Main: 235315200 08:04:33 INFO - PROCESS | 1660 | 08:04:35 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 08:04:36 INFO - PROCESS | 1660 | RSS: Main: 288694272 08:04:36 INFO - PROCESS | 1660 | 08:04:39 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 08:04:39 INFO - PROCESS | 1660 | RSS: Main: 288534528 08:04:39 INFO - PROCESS | 1660 | 08:04:43 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 08:04:43 INFO - PROCESS | 1660 | RSS: Main: 380616704 08:04:43 INFO - PROCESS | 1660 | 08:04:45 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 08:04:46 INFO - PROCESS | 1660 | RSS: Main: 281939968 08:04:46 INFO - PROCESS | 1660 | 08:04:48 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:04:49 INFO - PROCESS | 1660 | RSS: Main: 286838784 08:04:49 INFO - PROCESS | 1660 | 08:04:51 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 08:04:52 INFO - PROCESS | 1660 | RSS: Main: 327659520 08:04:52 INFO - PROCESS | 1660 | 08:04:55 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 08:04:56 INFO - PROCESS | 1660 | RSS: Main: 330919936 08:04:56 INFO - PROCESS | 1660 | 08:04:59 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 08:04:59 INFO - PROCESS | 1660 | RSS: Main: 330100736 08:04:59 INFO - PROCESS | 1660 | 08:05:01 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:05:01 INFO - PROCESS | 1660 | RSS: Main: 303890432 08:05:01 INFO - PROCESS | 1660 | 08:05:03 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:05:04 INFO - PROCESS | 1660 | RSS: Main: 308006912 08:05:04 INFO - PROCESS | 1660 | 08:05:06 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:05:07 INFO - PROCESS | 1660 | RSS: Main: 308801536 08:05:07 INFO - PROCESS | 1660 | 08:05:10 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:05:11 INFO - PROCESS | 1660 | RSS: Main: 325820416 08:05:11 INFO - PROCESS | 1660 | 08:05:14 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:05:14 INFO - PROCESS | 1660 | RSS: Main: 319995904 08:05:14 INFO - PROCESS | 1660 | 08:05:16 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 08:05:16 INFO - PROCESS | 1660 | RSS: Main: 364425216 08:05:16 INFO - PROCESS | 1660 | 08:05:16 INFO - PROCESS | 1660 | __start_tp_report 08:05:16 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 08:05:16 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 08:05:16 INFO - PROCESS | 1660 | |i|pagename|runs| 08:05:16 INFO - PROCESS | 1660 | |0;ai-astar;115;114;116;114;115;115;113;114;115;114 08:05:16 INFO - PROCESS | 1660 | |1;audio-beat-detection;144;112;109;148;112;111;111;108;147;111 08:05:16 INFO - PROCESS | 1660 | |2;audio-dft;187;184;184;185;185;184;184;190;183;185 08:05:16 INFO - PROCESS | 1660 | |3;audio-fft;80;57;78;109;61;58;58;57;71;58 08:05:16 INFO - PROCESS | 1660 | |4;audio-oscillator;88;68;85;70;67;69;80;68;67;83 08:05:16 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;90;87;89;127;90;87;90;87;90;87 08:05:16 INFO - PROCESS | 1660 | |6;imaging-darkroom;147;104;94;95;95;96;96;96;94;101 08:05:16 INFO - PROCESS | 1660 | |7;imaging-desaturate;87;92;129;112;86;85;86;85;86;87 08:05:16 INFO - PROCESS | 1660 | |8;json-parse-financial;56;55;54;54;59;55;57;55;54;55 08:05:16 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;65;72;71;86;106;101;85;71;72;76 08:05:16 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;86;87;89;87;88;87;88;86;87;92 08:05:16 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;134;159;162;143;134;126;145;149;214;145 08:05:16 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;172;172;173;172;172;169;172;173;173;175 08:05:16 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;68;67;68;66;68;67;67;66;67;66 08:05:16 INFO - PROCESS | 1660 | __end_tp_report 08:05:16 INFO - PROCESS | 1660 | __start_cc_report 08:05:16 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,1986 08:05:16 INFO - PROCESS | 1660 | __end_cc_report 08:05:16 INFO - PROCESS | 1660 | __startTimestamp1484582716648__endTimestamp 08:05:16 INFO - PROCESS | 1660 | 08:05:16 INFO - PROCESS | 1660 | ------- Summary: start ------- 08:05:16 INFO - PROCESS | 1660 | Number of tests: 14 08:05:16 INFO - PROCESS | 1660 | 08:05:16 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:0.85 (0.7%) stddev-sans-first:0.88 08:05:16 INFO - PROCESS | 1660 | Values: 115.0 114.0 116.0 114.0 115.0 115.0 113.0 114.0 115.0 114.0 08:05:16 INFO - PROCESS | 1660 | 08:05:16 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:121.30 Median:112.00 stddev:17.35 (15.5%) stddev-sans-first:16.34 08:05:16 INFO - PROCESS | 1660 | Values: 144.0 112.0 109.0 148.0 112.0 111.0 111.0 108.0 147.0 111.0 08:05:16 INFO - PROCESS | 1660 | 08:05:16 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:185.10 Median:185.00 stddev:2.02 (1.1%) stddev-sans-first:2.03 08:05:16 INFO - PROCESS | 1660 | Values: 187.0 184.0 184.0 185.0 185.0 184.0 184.0 190.0 183.0 185.0 08:05:16 INFO - PROCESS | 1660 | 08:05:16 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:68.70 Median:59.50 stddev:16.73 (28.1%) stddev-sans-first:17.24 08:05:16 INFO - PROCESS | 1660 | Values: 80.0 57.0 78.0 109.0 61.0 58.0 58.0 57.0 71.0 58.0 08:05:16 INFO - PROCESS | 1660 | 08:05:16 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:74.50 Median:75.00 stddev:8.45 (11.3%) stddev-sans-first:7.42 08:05:16 INFO - PROCESS | 1660 | Values: 88.0 68.0 85.0 70.0 67.0 69.0 80.0 68.0 67.0 83.0 08:05:16 INFO - PROCESS | 1660 | 08:05:16 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:92.40 Median:89.50 stddev:12.24 (13.7%) stddev-sans-first:12.95 08:05:16 INFO - PROCESS | 1660 | Values: 90.0 87.0 89.0 127.0 90.0 87.0 90.0 87.0 90.0 87.0 08:05:16 INFO - PROCESS | 1660 | 08:05:16 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:101.80 Median:95.00 stddev:16.21 (17.1%) stddev-sans-first:3.42 08:05:16 INFO - PROCESS | 1660 | Values: 147.0 104.0 94.0 95.0 95.0 96.0 96.0 96.0 94.0 101.0 08:05:16 INFO - PROCESS | 1660 | 08:05:16 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:93.50 Median:86.00 stddev:14.92 (17.3%) stddev-sans-first:15.63 08:05:16 INFO - PROCESS | 1660 | Values: 87.0 92.0 129.0 112.0 86.0 85.0 86.0 85.0 86.0 87.0 08:05:16 INFO - PROCESS | 1660 | 08:05:16 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:1.58 (2.9%) stddev-sans-first:1.66 08:05:16 INFO - PROCESS | 1660 | Values: 56.0 55.0 54.0 54.0 59.0 55.0 57.0 55.0 54.0 55.0 08:05:16 INFO - PROCESS | 1660 | 08:05:16 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:80.50 Median:72.00 stddev:13.77 (19.1%) stddev-sans-first:13.41 08:05:16 INFO - PROCESS | 1660 | Values: 65.0 72.0 71.0 86.0 106.0 101.0 85.0 71.0 72.0 76.0 08:05:16 INFO - PROCESS | 1660 | 08:05:16 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:87.50 stddev:1.77 (2.0%) stddev-sans-first:1.76 08:05:16 INFO - PROCESS | 1660 | Values: 86.0 87.0 89.0 87.0 88.0 87.0 88.0 86.0 87.0 92.0 08:05:16 INFO - PROCESS | 1660 | 08:05:16 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:151.10 Median:147.00 stddev:24.71 (16.8%) stddev-sans-first:25.43 08:05:16 INFO - PROCESS | 1660 | Values: 134.0 159.0 162.0 143.0 134.0 126.0 145.0 149.0 214.0 145.0 08:05:16 INFO - PROCESS | 1660 | 08:05:16 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:172.50 stddev:1.49 (0.9%) stddev-sans-first:1.58 08:05:16 INFO - PROCESS | 1660 | Values: 172.0 172.0 173.0 172.0 172.0 169.0 172.0 173.0 173.0 175.0 08:05:16 INFO - PROCESS | 1660 | 08:05:16 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 08:05:16 INFO - PROCESS | 1660 | Values: 68.0 67.0 68.0 66.0 68.0 67.0 67.0 66.0 67.0 66.0 08:05:16 INFO - PROCESS | 1660 | -------- Summary: end -------- 08:05:16 INFO - PROCESS | 1660 | 08:05:17 INFO - TEST-INFO | 1660: exit 0 08:05:17 INFO - TEST-OK | kraken | took 59774ms 08:05:17 INFO - SUITE-END | took 1179s 08:05:17 INFO - Completed test suite (00:19:39) 08:05:17 INFO - javascript benchmark 08:05:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3360.42872711639, 3371.7808342457747, 3375.37555552223, 3385.9322813543713, 3441.4837774333846, 5670.007748643981, 5743.9712801436035, 5814.389489103647, 5889.234399528061, 5918.615290006147, 5743.62666426682, 5783.479486846183, 5900.996830538808, 5918.940810591904, 5930.347661757203, 5164.845054648366, 5179.197224430201, 5212.478752124776, 5258.789648414059, 5306.097963346221, 5362.91955620666, 5373.946260537384, 5383.138697808351, 5387.326584176958, 5432.293801805759, 5190.221466779975, 5335.253064570963, 5345.0, 5346.064438723208, 5367.141257398797, 4448.199324121657, 5198.532132108128, 5218.530332270076, 5274.657147285414, 5292.02097611943, 5221.1124108901195, 5240.9213861792105, 5264.368275806889, 5272.894542109175, 5310.415854256029, 5759.798407055775, 5788.768449262025, 5804.796832110856, 5814.5057670098095, 5838.328592211908, 6144.279601711528, 6201.751929922798, 6214.875702485971, 6259.37406259375, 6261.78083767066, 6143.9385606143815, 6183.907241391383, 6203.565750397474, 6208.937910620881, 6220.098085777582, 5836.328822185418, 5914.757900840828, 5928.08114742207, 5931.0213814720955, 5977.491913187384, 6138.786925362681, 6153.5692501525355, 6197.96901015492, 6231.906521402183, 6291.1192433059405, 6201.224846894138, 6222.471089957405, 6231.813045608639, 6255.593386429959, 6264.624122552661, 6170.598911070766, 6257.530685198537, 6258.499320054385, 6271.749130034747, 6275.0, 6161.568690191643, 6179.073139029092, 6200.844978875474, 6230.158928544589, 6253.843653908598, 6251.562390632703, 6255.030470277115, 6277.654728989949, 6285.842853928689, 6302.275238347649, 5009.173486374707, 5012.724300163526, 5013.54878060969, 5033.245013247969, 5047.823326183566, 4424.026714122888, 4453.866384008485, 4465.843695470643, 4499.887502812456, 4515.932261016087, 5837.29952405714, 5878.030125029408, 5882.617629854046, 5920.940790592125, 5995.220621319288, 6215.409536094064, 6220.03589443637, 6231.034189700604, 6239.96880015597, 6240.251169859646, 5831.795887144014, 5860.765569377262, 5922.585419020714, 5944.524438044946, 5953.22608060958, 5342.652727572696, 5387.649802762808, 5391.083515802323, 5469.835904922858, 5513.035218836688, 6276.497880169575, 6332.145160403379, 6354.777582784581, 6364.331745166876, 6370.840728981812, 6119.3268740437625, 6166.660833654192, 6172.074188871705, 6185.505159587312, 6196.0, 6135.508280839814, 6303.306636270098, 6356.586821856565, 6367.554271200971, 6376.043593461018, 6135.967692822179, 6139.4781443577795, 6182.1345011699295, 6225.62646241227, 6280.528960328085, 6216.72024758896, 6223.595466294676, 6232.844178895564, 6249.375062493714, 6264.467520260829, 6121.901811248936, 6206.906896396467, 6207.844803879939, 6229.813105606839, 6234.189555357774, 6021.518278537619, 6089.969550152221, 6099.451049405575, 6122.44897959168, 6132.5084813409785, 6028.09578563219, 6033.728482218223, 6063.454289114001, 6071.119687645355, 6075.726592303446, 6035.215421995113, 6098.664573448503, 6107.389261073857, 6116.701002199415, 6209.316975132641, 5922.318933322723, 6057.091436284416, 6073.119397687399, 6078.3921607838865, 6115.113308570321], "value": 5757.141138796064, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [446.4776211832156, 480.30355983823455, 513.5762995528688, 515.4819406496471, 521.7130578181999, 31932.68067319326, 40673.593264067385, 42474.36288455676, 42569.78715106424, 44422.0, 43705.0, 43950.560494395046, 44016.55983440165, 44090.0, 44270.77864610672, 9190.448573085603, 9398.765030874214, 9400.81198376032, 9408.388454750419, 9415.340926135174, 8380.455270407434, 8595.44129631572, 11135.443227838616, 11369.658910232665, 11396.658100257006, 11212.495437705282, 11271.154663400237, 11332.206745527816, 11349.375784331858, 11368.0, 8390.202930721573, 11301.773964520704, 11321.377324247163, 11369.829452558177, 11373.203875728703, 8423.620937057847, 11081.944590276997, 11298.0, 11363.772724545463, 11431.542738290458, 41287.1742565147, 41417.58582414198, 41491.7925410371, 41644.0, 41649.79175104135, 4039.0, 4057.4378864137225, 4083.591640835922, 4126.525449573308, 4180.540140584533, 30463.93376231821, 31368.0, 31482.329973305736, 31701.0, 31748.365032699447, 3167.255694911694, 3204.118867311485, 3299.2081900343746, 3371.2414706691043, 3375.4261775498226, 425619.0, 425641.0, 426192.0, 427845.0, 431037.0, 63395.0, 64259.0, 64652.0, 64752.35247647557, 64853.67573162198, 67868.32131678719, 67981.32018679849, 68003.65998170077, 68165.0, 68359.31640683529, 16040.0, 16602.667946641242, 16638.916805415894, 16651.33394664224, 16675.0, 11355.0, 11675.941620291844, 12651.545072316618, 12718.0, 12744.872551274368, 16808.74786878198, 18780.812191877907, 18846.419180355962, 19229.230830766894, 19474.513137171685, 7356.448266380043, 7425.702971881173, 7429.962850185714, 7464.850702986018, 7495.587742674205, 879.6041781198486, 881.6737807011318, 887.2148148888281, 912.4434095201922, 921.5668635741191, 29964.550531742043, 30121.397572048438, 30164.24589385283, 30215.213302832086, 30473.695263047528, 931.417863835103, 988.7330420786348, 1017.9565944906531, 1071.4535586850607, 1210.3645586067385, 15113.09321440695, 15673.451429200151, 15717.921410393104, 15735.134567598892, 15805.36778528869, 579564.0, 583808.0, 584209.0, 584508.0, 586185.0, 61431.0, 61789.38210617836, 61834.0, 61901.0, 62016.68991655013, 1423.9572812815632, 1458.7082583483345, 1480.274665413961, 1484.9034812737139, 1485.049568276304, 28362.57456138118, 29076.0, 29360.853195733886, 29986.100416986654, 30030.69969300279, 52378.0, 52904.0, 52950.20574691306, 53037.46962530325, 53205.73397132989, 496200.0, 496415.0, 498709.0, 498991.0, 499395.0, 32886.01341959745, 40941.38587921243, 41197.79401103095, 41311.586884131975, 42601.786991064844, 46934.530654693015, 48058.51941480541, 48347.27479087746, 48623.02753944972, 48809.2678609814, 39308.0, 39359.40960885646, 39403.40894886522, 40783.1843363137, 41394.58605414028, 36825.07937301589, 38270.42594361142, 38373.424398633484, 40096.79951600223, 40324.991875202184, 35532.467012995345, 36234.8188259057, 36372.09069773277, 37688.6808961685, 38315.42526862155, 29254.41491170122, 32384.35231295408, 32601.836990814892, 32756.0, 33040.83479582587, 19725.0, 24105.0, 24235.87882060649, 24536.38659033467, 24645.63031554564], "value": 20437.020437533134, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.91575853312264, 389.84406237505, 392.6171982317243, 394.1368403196999, 415.7650927226117, 13687.726245475109, 20184.39446816596, 20492.795072049274, 21267.255646052392, 21296.36110916673, 20771.376858694264, 20866.478338041557, 21319.0, 21362.786372136274, 21563.784362156373, 5507.421720719317, 5820.330661973863, 5827.35899051104, 5831.825045248628, 5838.591298609099, 5109.20807274873, 5456.890862182754, 5640.182173584828, 5650.208970744099, 5759.395263497336, 5576.804811831586, 5654.6041777075625, 5670.0, 5670.121131224667, 5675.290588676416, 5417.4853388927795, 5631.690257035862, 5656.151577263402, 5665.320161580596, 5678.063119585264, 5024.0, 5036.269740887587, 5048.444671086178, 5058.0, 5064.139096353629, 25778.613320800203, 26265.212043638723, 26266.60600091, 26285.73714262871, 26560.0, 2520.8991640334366, 2941.955870661942, 3102.0, 3125.6405513366026, 3216.1477208539754, 14710.926445367812, 15784.0, 16240.593985150466, 16260.0, 16323.83676163235, 1834.4221570205343, 1836.9448916532526, 1850.9722354164699, 1876.3807943378652, 1927.884326940388, 130725.0, 131920.99999999904, 133042.0, 133685.6631433683, 134586.0, 11449.370284634426, 11749.588764393206, 11919.821202681967, 11928.642140735792, 11932.403379830974, 13828.654283642989, 14596.197209153386, 15773.0, 15820.683586328209, 15838.208089595475, 7723.9572657691615, 7958.482698624571, 8024.398170137147, 8262.058416272172, 8704.52125133111, 8312.916870831335, 8332.791680208044, 8343.791405214797, 8480.812686223933, 8486.236238738544, 4710.24636058229, 4781.676734669371, 4789.880252993703, 4863.440704318978, 4869.172240719086, 1709.3504468301965, 1944.7277381166648, 1967.7737060238255, 2001.9499512512305, 2015.1334925981969, 929.4702019848756, 954.6801821389773, 977.7848873247874, 1008.2780222238765, 1009.7728011197422, 19688.507787305432, 20564.794352056586, 20735.481612959495, 20774.948884967285, 20825.79174208269, 967.7000129959735, 975.3855071305032, 993.0813997052697, 1001.0790073132736, 1002.5438425516372, 10452.372857628567, 10728.678139655824, 10811.567537298577, 10874.728131796768, 10882.455877206108, 673824.0, 674504.0, 702907.0, 727152.2847715187, 731368.0, 155258.0, 159161.0, 159298.0, 159371.6288434278, 160968.0, 953.3421938862163, 971.0, 991.1822746234385, 998.6205242007991, 999.7100840756244, 18558.536036599195, 18580.44258672242, 18623.90688046551, 18627.627447451247, 18637.068146592344, 45697.77151114223, 49110.52668419953, 55489.0, 57848.42151578431, 57975.71012144912, 82671.0, 85290.57354713186, 86594.56702716446, 87579.56210218908, 87967.0, 6371.585846919936, 8128.512289262663, 8291.378146638906, 8359.623816928131, 8674.306055515417, 11943.522259109539, 13324.800127998282, 13381.264030478416, 13669.658258543615, 13803.10279831848, 11351.829722554003, 11398.487068081791, 11555.768884622428, 11714.355710436008, 11770.234934729215, 9572.32993690435, 11087.778244435227, 11281.492332845206, 11507.654770356903, 11686.824697629372, 10091.79816403653, 11556.47995840206, 11779.172998480131, 11814.94092529532, 11870.0, 8231.917680823115, 8373.162683731578, 8467.83064338722, 8469.110743371857, 8472.49165050099, 8980.416272942239, 11229.49467273991, 11230.494627741607, 11272.549098035986, 11621.302721836717], "value": 9939.092853812768, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.4670271999362, 1469.1478942213516, 1481.2297605245274, 1488.8585584369482, 1496.3416096917351, 8065.91934080659, 8492.447990880597, 8498.830023399543, 8504.532250726208, 8526.70156544521, 7478.813029674261, 7712.807179820507, 7731.188225236354, 8054.677812887478, 8318.625661845217, 2122.3632910126976, 2240.8655480671214, 2256.898439570219, 2314.89582968766, 2316.976830231693, 2025.6961455781604, 2315.849469784467, 2333.1600623775425, 2339.321596736953, 2345.2846881701075, 1800.2259028617689, 2011.6278488479677, 2075.180303780006, 2254.9098036078617, 2337.1703045418885, 2312.2485192312483, 2329.324495896188, 2329.592321343758, 2339.0877557752406, 2342.2153578551206, 2073.460900165953, 2268.5122698619875, 2330.673705681206, 2363.7990770784504, 2364.9172278970327, 7572.091349038095, 8272.37957153216, 8380.497170169749, 8459.703910363169, 8470.872936905951, 5027.723475208862, 5202.03762303975, 5211.166213405837, 5216.634835561512, 5231.921521177185, 3341.9331613367594, 3482.9303413931834, 3494.860205591773, 3544.7518673692853, 3561.198730285691, 1148.8104462763633, 1194.5401020607042, 1196.0670676872053, 1236.0482428530072, 1250.7310928150491, 10786.46067696612, 10810.135189184924, 10889.83665245022, 10931.398773067478, 10935.453227338601, 3772.43413487979, 4587.357769912215, 4655.930161047587, 4684.1568517666465, 4689.484156742756, 9464.668736594185, 9469.053094690613, 9486.525673716287, 9489.810203795885, 9491.19324857381, 5140.614453915971, 5223.425423203445, 5235.110031294689, 5245.527902488794, 5248.895022099537, 4622.38835058191, 4685.718856868599, 4722.740249286322, 4755.83354582588, 4801.399825021872, 3792.412176112707, 3836.36699944506, 3852.036990752312, 3884.1454879926373, 3920.4511368408444, 1114.6210288501786, 1276.2533917658275, 1282.5062350994933, 1291.2381694800113, 1294.3528235882059, 769.9692012319445, 773.3426587400664, 795.6379847169524, 797.5812698333422, 812.3947658994088, 5528.778848846082, 5629.099344104923, 5645.322561292671, 5685.630434021776, 5704.8859022819315, 549.9697516636544, 571.040651705131, 579.6174524813687, 581.5115303145294, 582.126809785322, 3653.8173091345325, 3746.756460830092, 3853.0, 3860.4595356650093, 3861.3242682530445, 9770.0, 10169.440680762482, 10179.18566514677, 10202.234832387601, 10206.540705668263, 9675.322727409013, 9907.504624768733, 10119.089281964658, 10125.291229613857, 10159.898401016044, 7724.961375193088, 7769.261920117579, 7889.921100788919, 7899.881501777478, 7905.130435652189, 5510.6969116698965, 5621.803236886853, 5623.662580245198, 5639.407862174413, 5642.492175704207, 9132.680356187502, 9193.080691930754, 9283.582238799405, 9310.441373517611, 9328.347015708836, 9199.35604507678, 9292.767680808034, 9409.388389754644, 9547.0, 9600.85598716006, 7120.60836653989, 7239.565626062453, 7240.710371585077, 7240.8913866290995, 7250.419966402781, 7527.473076884566, 7769.0, 7786.805329866798, 7895.7236496722335, 7899.881501777363, 7175.138983322035, 7197.71209151628, 7256.891146632699, 7292.270772922878, 7316.8902466464115, 7058.153021637437, 7136.143662760502, 7141.214466408587, 7184.066071410683, 7210.315020073084, 5940.970295148497, 6245.594036387621, 6389.361063893573, 6493.188351456068, 6520.315366886409, 4679.157751604744, 4804.759762011816, 4911.803527858846, 5000.824971125993, 5051.191809310492, 4930.852074437629, 4975.7512124392915, 5100.719460429712, 5115.079285728604, 5238.061917090701], "value": 4345.672303449228, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.8907020796993, 351.12919958502914, 353.325148965476, 358.9551306086739, 369.3388833987163, 4825.71045737256, 4848.80604775809, 4920.237363208699, 4982.683052380642, 5002.8249011284615, 4489.506154323022, 4733.254712266886, 4931.728754918478, 5150.27896094547, 5177.249298851673, 3933.429652700364, 4070.61329173728, 4087.264292427362, 4089.7546147231114, 4103.425520427142, 3894.435306880515, 3928.410738389236, 3975.383815508601, 4091.9590804091877, 4102.610252026053, 3602.621724718906, 4025.6175663311938, 4036.6568841648495, 4048.8987775305704, 4059.675225981929, 3605.9098522537015, 3878.26313000529, 4049.5950404959563, 4076.408920706481, 4108.794560271975, 3264.4657011204695, 3418.1967237699123, 3567.5362202913716, 3612.963870361289, 3627.4014787560022, 5091.87270318245, 5096.439391666913, 5115.2071428928575, 5131.179011358202, 5139.226966696484, 3949.6445319921345, 4441.244988351988, 4627.791749371287, 4686.695364801311, 4694.131585656664, 5083.669561478529, 5302.242833726479, 5458.781648734046, 5523.922835047168, 5529.198266251411, 3632.1124705858906, 3969.2458432897947, 3991.381335892941, 4012.959870401288, 4040.1111755413763, 4636.605888499448, 5317.73411329432, 5787.565932555033, 5833.9581146598775, 5854.541092741059, 3283.6223834259367, 4076.735012224255, 4092.0179157002103, 4099.642705444381, 4115.32097203964, 3476.37425263455, 3850.614938506127, 3978.4537895746744, 4148.128892932457, 4160.209560183616, 4114.835406583763, 4540.387047748578, 4542.954570454319, 4564.612007979293, 4662.860114196579, 4616.884577885513, 4955.281484184773, 5297.390800057966, 5473.425290344457, 5505.3393592768325, 1134.6652737442473, 1138.8576427946507, 1328.1499840102342, 1333.386642144605, 1342.3154191362476, 920.3097676742443, 942.1520631431766, 942.6135284533445, 948.6632245552729, 958.1281034258931, 4727.432708075053, 4818.951810481921, 4877.707337559757, 4904.754762261872, 4965.627577931669, 4988.700677959334, 5018.824341148043, 5418.972905135449, 5446.482584154499, 5491.505764481216, 4313.0, 4362.847300344472, 4591.8392856249875, 4818.84347756543, 4833.758312084382, 2415.625578035407, 2458.840175388594, 2554.5018721349156, 2804.340979869729, 2812.7609153222206, 4776.188048031843, 5590.338328394908, 5603.674475092872, 5605.439456054443, 5693.459121383462, 5218.846832126106, 5444.047291723932, 5519.806806761824, 5568.860778480571, 5574.163875418639, 4735.0, 5247.632665713363, 5319.468053194727, 5569.248151499577, 5577.693226872561, 4839.879003024953, 5368.194770784257, 5387.461253874581, 5390.353157621111, 5403.783848646168, 5133.486651334837, 5585.916211256916, 5606.411326810789, 5623.0, 5646.661200327993, 5843.590948633555, 5873.530117590497, 5880.411958804086, 5893.2872290456735, 5913.970430147821, 3202.2794871153806, 3535.8232088395994, 3553.680168784822, 3863.4784304118584, 3875.903102422462, 4734.952650473451, 5010.5240002199735, 5572.721363931706, 5597.412271711411, 5752.71236438168, 4619.514950930104, 5014.899702005867, 5361.705106219196, 5409.486098820606, 5440.748627815546, 4848.0, 5301.310829592128, 5449.446907631306, 5489.149181876815, 5511.736291841202, 4630.476390367326, 4845.861222612753, 5089.440161582297, 5358.552401506662, 5364.865878353073, 5472.151816468454, 5488.710153113935, 5516.689986008363, 5532.889342213214, 5546.833594992157, 5401.378841433286, 5407.972960135174, 5413.24214609947, 5453.7818487260065, 5470.070088084955], "value": 4016.3018485009516, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.9784606461805, 718.971241150354, 778.8052986753308, 802.630789836675, 819.8155415031616, 14225.928870355647, 15174.848251517482, 15198.088114713111, 15917.681646367066, 16780.412685555977, 15741.921290393531, 15965.92017039916, 16059.437919672784, 16189.271482783273, 16281.674366512663, 853.9444936079166, 870.229846585773, 872.4459967920385, 874.3136637739376, 875.4090988582712, 689.1282527602586, 711.4059760100297, 714.3178264757145, 870.8650159225299, 873.6854732296368, 881.030866047346, 899.7570655922897, 909.3180114913814, 910.4036855859423, 915.2540679346345, 900.837849187146, 901.4320977783987, 902.2917010147069, 902.6750369866843, 902.7788191893028, 533.0724539301626, 548.8380927626359, 656.980290591283, 674.9696263668146, 676.6075676107895, 14880.107193568421, 15119.924400378037, 15458.768118478232, 15481.225938703132, 15501.534953951399, 13640.045196836225, 13640.386182621805, 13661.590152295446, 13667.658308542266, 13727.931360343235, 9592.952035239849, 11156.553737850476, 11337.943310283395, 11449.255798373079, 11623.360715160663, 3589.5154154189113, 3617.5478065241846, 3737.2712321097397, 3775.4903088083033, 3880.9805950970062, 98393.60441571275, 107978.3803242952, 110789.44605277003, 111892.4405377976, 112973.87026129715, 9039.45763254207, 10317.587296508205, 10921.290116142583, 11062.785547553109, 11421.942890285496, 21630.56738865214, 21908.0, 22041.00815463308, 22181.334559963227, 22187.001584928716, 7501.849963000709, 7608.581528016012, 7725.690972361042, 7726.806829829299, 7968.800779980431, 4327.2643650579475, 4335.544767799399, 4418.6023257906945, 4501.707389019703, 4604.447466304065, 3588.569371675416, 3642.016655502999, 3649.434337677664, 3698.68561172298, 3698.8335524901445, 619.3373090792899, 625.8998560230341, 634.8666779976164, 635.2028204603193, 640.8782331357028, 665.5174998126416, 676.8815457295052, 704.306258335539, 706.3148745716646, 727.6689106456549, 10129.696109116738, 10182.847257291147, 10202.642907498202, 10504.527296271686, 10704.250702450909, 688.6281408039603, 711.9427649939835, 712.6116266634697, 717.8384863405796, 723.6273319240595, 4700.811967521261, 4993.675411098267, 4998.9500104999215, 5005.27423523587, 5239.187925871496, 76924.46151076947, 85025.72461413084, 99581.50627740589, 102314.0, 103313.0, 83473.16526834776, 83586.0, 83961.90095247667, 85711.0, 85815.14184858071, 79176.81234781483, 79817.20182798097, 80179.59910200411, 80648.59675701702, 83202.0, 10595.94702026485, 10844.511996960313, 11052.281601695864, 11164.330140191614, 11238.0, 47141.29288060751, 48628.27057594209, 48861.0, 49987.75030624263, 51927.27778219104, 63271.0, 67709.0, 68262.0, 68769.65615171893, 71881.92177117452, 13057.738845222852, 13082.934585327013, 13346.733065338445, 13393.531226407029, 13493.460261589427, 14575.416983320973, 14613.455954492649, 14692.191929443983, 14962.17708026069, 15400.15299158557, 13074.0, 13300.401481933142, 13365.599032029055, 13757.587272381845, 13880.236586987812, 13555.796663049865, 13560.660983475493, 13766.449342026206, 13922.930385348414, 14202.360893759598, 13365.732685346044, 13416.664583385493, 13523.526676566273, 13578.185308881499, 13980.860191397956, 11284.0, 11309.491072901574, 11801.870604921374, 11899.524019039487, 11901.345426001653, 10833.566657333618, 10967.890321096687, 10990.285631434252, 11088.5564577416, 11108.722281942693], "value": 7558.923807833704, "unit": "score"}], "name": "dromaeo_css", "value": 7323.64745774302, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 116.0, 114.0, 115.0, 115.0, 113.0, 114.0, 115.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 112.0, 109.0, 148.0, 112.0, 111.0, 111.0, 108.0, 147.0, 111.0], "value": 121.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 184.0, 184.0, 185.0, 185.0, 184.0, 184.0, 190.0, 183.0, 185.0], "value": 185.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 78.0, 109.0, 61.0, 58.0, 58.0, 57.0, 71.0, 58.0], "value": 68.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 68.0, 85.0, 70.0, 67.0, 69.0, 80.0, 68.0, 67.0, 83.0], "value": 74.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 127.0, 90.0, 87.0, 90.0, 87.0, 90.0, 87.0], "value": 92.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 104.0, 94.0, 95.0, 95.0, 96.0, 96.0, 96.0, 94.0, 101.0], "value": 101.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 92.0, 129.0, 112.0, 86.0, 85.0, 86.0, 85.0, 86.0, 87.0], "value": 93.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 54.0, 59.0, 55.0, 57.0, 55.0, 54.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 71.0, 86.0, 106.0, 101.0, 85.0, 71.0, 72.0, 76.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 89.0, 87.0, 88.0, 87.0, 88.0, 86.0, 87.0, 92.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 159.0, 162.0, 143.0, 134.0, 126.0, 145.0, 149.0, 214.0, 145.0], "value": 151.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 173.0, 172.0, 172.0, 169.0, 172.0, 173.0, 173.0, 175.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 66.0, 68.0, 67.0, 67.0, 66.0, 67.0, 66.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1465.7999999999997, "alertThreshold": 2.0}]} 08:05:17 INFO - Return code: 0 08:05:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:05:17 ERROR - # TBPL SUCCESS # 08:05:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:05:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:05:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:05:17 INFO - 2017-01-16 08:05:17.934 screenresolution[1664:11948] starting screenresolution argv=screenresolution get 08:05:17 INFO - 2017-01-16 08:05:17.937 screenresolution[1664:11948] Display 0: 1600x1200x32@60 08:05:17 INFO - 2017-01-16 08:05:17.943 screenresolution[1665:11952] starting screenresolution argv=screenresolution list 08:05:17 INFO - Available Modes on Display 0 08:05:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:05:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:05:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:05:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:05:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:05:18 INFO - Intel Iris: 08:05:18 INFO - Chipset Model: Intel Iris 08:05:18 INFO - Type: GPU 08:05:18 INFO - Bus: Built-In 08:05:18 INFO - VRAM (Dynamic, Max): 1536 MB 08:05:18 INFO - Vendor: Intel (0x8086) 08:05:18 INFO - Device ID: 0x0a2e 08:05:18 INFO - Revision ID: 0x0009 08:05:18 INFO - Displays: 08:05:18 INFO - Display: 08:05:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:05:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:05:18 INFO - Display Serial Number: 1600x1200 60 08:05:18 INFO - Main Display: Yes 08:05:18 INFO - Mirror: Off 08:05:18 INFO - Online: Yes 08:05:18 INFO - Rotation: Supported 08:05:18 INFO - Return code: 0 08:05:18 INFO - Running post-action listener: _resource_record_post_action 08:05:18 INFO - [mozharness: 2017-01-16 16:05:18.187406Z] Finished run-tests step (success) 08:05:18 INFO - Running post-run listener: _resource_record_post_run 08:05:18 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 32025600; Write bytes: 553825280; Read time: 312; Write time: 1780 08:05:18 INFO - TinderboxPrint: CPU usage
54.0% 08:05:18 INFO - TinderboxPrint: I/O read bytes / time
32,025,600 / 312 08:05:18 INFO - TinderboxPrint: I/O write bytes / time
553,825,280 / 1,780 08:05:18 INFO - TinderboxPrint: CPU idle
2,213.6 (46.0%) 08:05:18 INFO - TinderboxPrint: CPU system
965.3 (20.1%) 08:05:18 INFO - TinderboxPrint: CPU user
1,630.8 (33.9%) 08:05:18 INFO - TinderboxPrint: Swap in / out
279,007,232 / 0 08:05:18 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 234981888; Write bytes: 228855808; Read time: 17653; Write time: 440 08:05:18 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 31099904; Write bytes: 299889664; Read time: 297; Write time: 1287 08:05:18 INFO - Running post-run listener: _upload_blobber_files 08:05:18 INFO - Blob upload gear active. 08:05:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:05:18 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 08:05:18 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'] 08:05:18 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 08:05:19 INFO - (blobuploader) - INFO - Open directory for files ... 08:05:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:05:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:05:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:05:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:05:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:05:20 INFO - (blobuploader) - INFO - Done attempting. 08:05:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:05:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:05:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:05:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:05:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:05:22 INFO - (blobuploader) - INFO - Done attempting. 08:05:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:05:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:05:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:05:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:05:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:05:22 INFO - (blobuploader) - INFO - Done attempting. 08:05:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:05:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:05:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:05:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:05:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:05:25 INFO - (blobuploader) - INFO - Done attempting. 08:05:25 INFO - (blobuploader) - INFO - Iteration through files over. 08:05:25 INFO - Return code: 0 08:05:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:05:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:05:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/212d48fe297efe3ce51ed29488ef37d2d0b049335066806bb419578ee265f83888de3bef585e346ade6d2ecea61e36077a78ffba784a6c2cac5320048dad0859", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4c9fd4fd8b0d51a847a867f93736faaf0ef70d81bfbb8e56b884b4d945c380dae3ccde353c025eb96f638329172d417d7e7ff37536b24c40f46e5c2124c65db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f529fd380f763bb6153247f68a6d57cb5093ac8e64d0847d9710bac52070b1cfda64584429370f6dcebf4afed19529eaa14319a2886fe1f601b0f3b1a8ea2361", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f93f7c40468a51da3fa345151194f774d2afddd18726c478c45ef1395875bbb846a976b1dabde9c6aa7405dd9df6d13e66c795a224cc486a6b2f3a5d26942a3"} 08:05:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:05:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:05:25 INFO - Contents: 08:05:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/212d48fe297efe3ce51ed29488ef37d2d0b049335066806bb419578ee265f83888de3bef585e346ade6d2ecea61e36077a78ffba784a6c2cac5320048dad0859", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4c9fd4fd8b0d51a847a867f93736faaf0ef70d81bfbb8e56b884b4d945c380dae3ccde353c025eb96f638329172d417d7e7ff37536b24c40f46e5c2124c65db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f529fd380f763bb6153247f68a6d57cb5093ac8e64d0847d9710bac52070b1cfda64584429370f6dcebf4afed19529eaa14319a2886fe1f601b0f3b1a8ea2361", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f93f7c40468a51da3fa345151194f774d2afddd18726c478c45ef1395875bbb846a976b1dabde9c6aa7405dd9df6d13e66c795a224cc486a6b2f3a5d26942a3"} 08:05:25 INFO - Running post-run listener: copy_logs_to_upload_dir 08:05:25 INFO - Copying logs to upload dir... 08:05:25 INFO - mkdir: /builds/slave/test/build/upload/logs 08:05:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.445486 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-01-16 08:05:25.385185) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 08:05:25.388318) ========= 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.408MIkmEV1/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.1G5cc0PzLo/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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/212d48fe297efe3ce51ed29488ef37d2d0b049335066806bb419578ee265f83888de3bef585e346ade6d2ecea61e36077a78ffba784a6c2cac5320048dad0859", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4c9fd4fd8b0d51a847a867f93736faaf0ef70d81bfbb8e56b884b4d945c380dae3ccde353c025eb96f638329172d417d7e7ff37536b24c40f46e5c2124c65db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f529fd380f763bb6153247f68a6d57cb5093ac8e64d0847d9710bac52070b1cfda64584429370f6dcebf4afed19529eaa14319a2886fe1f601b0f3b1a8ea2361", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f93f7c40468a51da3fa345151194f774d2afddd18726c478c45ef1395875bbb846a976b1dabde9c6aa7405dd9df6d13e66c795a224cc486a6b2f3a5d26942a3"} build_url:https://queue.taskcluster.net/v1/task/D5ajY2KpSnOU1N1npK-Ntg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011188 build_url: 'https://queue.taskcluster.net/v1/task/D5ajY2KpSnOU1N1npK-Ntg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/212d48fe297efe3ce51ed29488ef37d2d0b049335066806bb419578ee265f83888de3bef585e346ade6d2ecea61e36077a78ffba784a6c2cac5320048dad0859", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4c9fd4fd8b0d51a847a867f93736faaf0ef70d81bfbb8e56b884b4d945c380dae3ccde353c025eb96f638329172d417d7e7ff37536b24c40f46e5c2124c65db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f529fd380f763bb6153247f68a6d57cb5093ac8e64d0847d9710bac52070b1cfda64584429370f6dcebf4afed19529eaa14319a2886fe1f601b0f3b1a8ea2361", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f93f7c40468a51da3fa345151194f774d2afddd18726c478c45ef1395875bbb846a976b1dabde9c6aa7405dd9df6d13e66c795a224cc486a6b2f3a5d26942a3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 08:05:25.422666) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 08:05:25.423033) ========= 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.408MIkmEV1/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.1G5cc0PzLo/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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.005106 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 08:05:25.471512) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 08:05:25.471821) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 08:05:25.472142) ========= ========= Total master_lag: 0.17 =========