builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0006 starttime: 1486990131.95 results: success (0) buildid: 20170213033940 builduid: 2c8483137e584b5ebf28088ee738b705 revision: 3c300355a94d24e0c1c156f9de4a6e9c60beaa28 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 04:48:51.955089) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 04:48:51.955607) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 04:48:51.955921) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 04:48:51.981815) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 04:48:51.982264) ========= 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.ZfGDLDIJPM/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.uQfSEr4nrH/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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-02-13 04:48:51-- 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% 72.6M=0s 2017-02-13 04:48:52 (72.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123472 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 04:48:52.130069) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 04:48:52.130455) ========= 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.ZfGDLDIJPM/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.uQfSEr4nrH/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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.021198 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 04:48:52.179427) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-13 04:48:52.179837) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3c300355a94d24e0c1c156f9de4a6e9c60beaa28 --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 3c300355a94d24e0c1c156f9de4a6e9c60beaa28 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZfGDLDIJPM/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.uQfSEr4nrH/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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-02-13 04:48:52,256 truncating revision to first 12 chars 2017-02-13 04:48:52,256 Setting DEBUG logging. 2017-02-13 04:48:52,256 attempt 1/10 2017-02-13 04:48:52,256 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3c300355a94d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-13 04:48:54,108 unpacking tar archive at: mozilla-central-3c300355a94d/testing/mozharness/ program finished with exit code 0 elapsedTime=2.096546 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-13 04:48:54.302085) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 04:48:54.302683) ========= script_repo_revision: 3c300355a94d24e0c1c156f9de4a6e9c60beaa28 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 04:48:54.303331) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 04:48:54.303726) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 04:48:54.324863) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-02-13 04:48:54.325400) ========= /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.ZfGDLDIJPM/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.uQfSEr4nrH/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:48:54 INFO - MultiFileLogger online at 20170213 04:48:54 in /builds/slave/test 04:48:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:48:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:48:54 INFO - {'append_to_log': False, 04:48:54 INFO - 'base_work_dir': '/builds/slave/test', 04:48:54 INFO - 'blob_upload_branch': 'Firefox', 04:48:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:48:54 INFO - 'branch': 'Firefox', 04:48:54 INFO - 'buildbot_json_path': 'buildprops.json', 04:48:54 INFO - 'config_files': ('talos/mac_config.py',), 04:48:54 INFO - 'default_actions': ('clobber', 04:48:54 INFO - 'read-buildbot-config', 04:48:54 INFO - 'download-and-extract', 04:48:54 INFO - 'populate-webroot', 04:48:54 INFO - 'create-virtualenv', 04:48:54 INFO - 'install', 04:48:54 INFO - 'run-tests'), 04:48:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:48:54 INFO - 'download_minidump_stackwalk': True, 04:48:54 INFO - 'download_symbols': 'ondemand', 04:48:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:48:54 INFO - 'tooltool.py': '/tools/tooltool.py', 04:48:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:48:54 INFO - '/tools/misc-python/virtualenv.py')}, 04:48:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:48:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:48:54 INFO - 'installer_path': 'installer.exe', 04:48:54 INFO - 'log_level': 'info', 04:48:54 INFO - 'log_name': 'talos', 04:48:54 INFO - 'log_to_console': True, 04:48:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:48:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:48:54 INFO - 'opt_config_files': (), 04:48:54 INFO - 'pip_index': False, 04:48:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:48:54 INFO - 'cmd': ('bash', 04:48:54 INFO - '-c', 04:48:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:48:54 INFO - 'enabled': True, 04:48:54 INFO - 'halt_on_failure': False, 04:48:54 INFO - 'name': 'check_screen_resolution'},), 04:48:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:48:54 INFO - 'cmd': ('bash', 04:48:54 INFO - '-c', 04:48:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:48:54 INFO - 'enabled': True, 04:48:54 INFO - 'halt_on_failure': False, 04:48:54 INFO - 'name': 'check_screen_resolution'},), 04:48:54 INFO - 'run_cmd_checks_enabled': True, 04:48:54 INFO - 'sps_profile': False, 04:48:54 INFO - 'sps_profile_interval': 0, 04:48:54 INFO - 'suite': 'dromaeojs', 04:48:54 INFO - 'system_bits': '32', 04:48:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:48:54 INFO - 'title': 't-yosemite-r7-0006', 04:48:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:48:54 INFO - 'use_talos_json': True, 04:48:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:48:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:48:54 INFO - 'work_dir': 'build'} 04:48:54 INFO - [mozharness: 2017-02-13 12:48:54.525416Z] Running clobber step. 04:48:54 INFO - Running pre-action listener: _resource_record_pre_action 04:48:54 INFO - Running main action method: clobber 04:48:54 INFO - rmtree: /builds/slave/test/build 04:48:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:48:56 INFO - Running post-action listener: _resource_record_post_action 04:48:56 INFO - [mozharness: 2017-02-13 12:48:56.190119Z] Finished clobber step (success) 04:48:56 INFO - [mozharness: 2017-02-13 12:48:56.190262Z] Running read-buildbot-config step. 04:48:56 INFO - Running pre-action listener: _resource_record_pre_action 04:48:56 INFO - Running main action method: read_buildbot_config 04:48:56 INFO - Using buildbot properties: 04:48:56 INFO - { 04:48:56 INFO - "project": "", 04:48:56 INFO - "product": "firefox", 04:48:56 INFO - "script_repo_revision": "production", 04:48:56 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:48:56 INFO - "repository": "", 04:48:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:48:56 INFO - "buildid": "20170213033940", 04:48:56 INFO - "pgo_build": "False", 04:48:56 INFO - "basedir": "/builds/slave/test", 04:48:56 INFO - "buildnumber": 0, 04:48:56 INFO - "slavename": "t-yosemite-r7-0006", 04:48:56 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 04:48:56 INFO - "platform": "yosemite_r7", 04:48:56 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:48:56 INFO - "branch": "mozilla-central", 04:48:56 INFO - "repo_path": "mozilla-central", 04:48:56 INFO - "revision": "3c300355a94d24e0c1c156f9de4a6e9c60beaa28", 04:48:56 INFO - "stage_platform": "macosx64", 04:48:56 INFO - "builduid": "2c8483137e584b5ebf28088ee738b705", 04:48:56 INFO - "slavebuilddir": "test" 04:48:56 INFO - } 04:48:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 04:48:56 INFO - Running post-action listener: _resource_record_post_action 04:48:56 INFO - [mozharness: 2017-02-13 12:48:56.193636Z] Finished read-buildbot-config step (success) 04:48:56 INFO - [mozharness: 2017-02-13 12:48:56.193749Z] Running download-and-extract step. 04:48:56 INFO - Running pre-action listener: _resource_record_pre_action 04:48:56 INFO - Running main action method: download_and_extract 04:48:56 INFO - mkdir: /builds/slave/test/build/tests 04:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:48:56 INFO - trying https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 04:48:56 INFO - Downloading https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:48:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 04:48:57 INFO - Downloaded 1199 bytes. 04:48:57 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:48:57 INFO - Using the following test package requirements: 04:48:57 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:48:57 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:48:57 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 04:48:57 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:48:57 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 04:48:57 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:48:57 INFO - u'jsshell-mac.zip'], 04:48:57 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:48:57 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 04:48:57 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:48:57 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:48:57 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 04:48:57 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:48:57 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 04:48:57 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:48:57 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 04:48:57 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:48:57 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 04:48:57 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:48:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:48:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:48:57 INFO - Fetch https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:48:59 INFO - Expected file size: 51504268 04:48:59 INFO - Obtained file size: 51504268 04:49:15 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:49:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:49:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:49:15 INFO - Fetch https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:49:16 INFO - Expected file size: 51504268 04:49:16 INFO - Obtained file size: 51504268 04:49:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 04:49:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:49:32 INFO - Fetch https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 04:49:34 INFO - Expected file size: 14403647 04:49:34 INFO - Obtained file size: 14403647 04:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:34 INFO - trying https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:49:34 INFO - Downloading https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 04:49:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 04:49:36 INFO - Downloaded 70385435 bytes. 04:49:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:49:36 INFO - mkdir: /builds/slave/test/properties 04:49:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:49:36 INFO - Writing to file /builds/slave/test/properties/build_url 04:49:36 INFO - Contents: 04:49:36 INFO - build_url:https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:49:37 INFO - Running post-action listener: _resource_record_post_action 04:49:37 INFO - Running post-action listener: set_extra_try_arguments 04:49:37 INFO - [mozharness: 2017-02-13 12:49:37.078339Z] Finished download-and-extract step (success) 04:49:37 INFO - [mozharness: 2017-02-13 12:49:37.078458Z] Running populate-webroot step. 04:49:37 INFO - Running pre-action listener: _resource_record_pre_action 04:49:37 INFO - Running main action method: populate_webroot 04:49:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:49:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:49:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:49:37 INFO - '--tppagecycles', 04:49:37 INFO - '7'], 04:49:37 INFO - 'tests': ['tsvgm']}}, 04:49:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:49:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:49:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:49:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:49:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:49:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:49:37 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:49:37 INFO - 'talos_options': ['--disable-e10s'], 04:49:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:49:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:49:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:49:37 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:49:37 INFO - 'talos_options': ['--disable-e10s'], 04:49:37 INFO - 'tests': ['damp', 'tps']}, 04:49:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:49:37 INFO - 'tests': ['damp', 'tps']}, 04:49:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:49:37 INFO - 'tests': ['dromaeo_dom']}, 04:49:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:49:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:49:37 INFO - 'tests': ['basic_compositor_video']}, 04:49:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:49:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:49:37 INFO - 'tests': ['a11yr', 04:49:37 INFO - 'ts_paint', 04:49:37 INFO - 'tpaint', 04:49:37 INFO - 'sessionrestore', 04:49:37 INFO - 'sessionrestore_no_auto_restore', 04:49:37 INFO - 'tabpaint']}, 04:49:37 INFO - 'other-e10s': {'tests': ['a11yr', 04:49:37 INFO - 'ts_paint', 04:49:37 INFO - 'tpaint', 04:49:37 INFO - 'sessionrestore', 04:49:37 INFO - 'sessionrestore_no_auto_restore', 04:49:37 INFO - 'tabpaint']}, 04:49:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:49:37 INFO - 'ts_paint', 04:49:37 INFO - 'tpaint', 04:49:37 INFO - 'sessionrestore', 04:49:37 INFO - 'sessionrestore_no_auto_restore', 04:49:37 INFO - 'tabpaint']}, 04:49:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:49:37 INFO - 'ts_paint', 04:49:37 INFO - 'tpaint', 04:49:37 INFO - 'sessionrestore', 04:49:37 INFO - 'sessionrestore_no_auto_restore', 04:49:37 INFO - 'tabpaint']}, 04:49:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:49:37 INFO - 'tests': ['a11yr', 04:49:37 INFO - 'ts_paint', 04:49:37 INFO - 'tpaint', 04:49:37 INFO - 'sessionrestore', 04:49:37 INFO - 'sessionrestore_no_auto_restore', 04:49:37 INFO - 'tabpaint']}, 04:49:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:49:37 INFO - 'tests': ['a11yr', 04:49:37 INFO - 'ts_paint', 04:49:37 INFO - 'tpaint', 04:49:37 INFO - 'sessionrestore', 04:49:37 INFO - 'sessionrestore_no_auto_restore', 04:49:37 INFO - 'tabpaint']}, 04:49:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:49:37 INFO - 'tests': ['tsvgx', 04:49:37 INFO - 'tsvgr_opacity', 04:49:37 INFO - 'tart', 04:49:37 INFO - 'tscrollx', 04:49:37 INFO - 'cart', 04:49:37 INFO - 'tsvg_static']}, 04:49:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:49:37 INFO - 'tsvgr_opacity', 04:49:37 INFO - 'tart', 04:49:37 INFO - 'tscrollx', 04:49:37 INFO - 'cart', 04:49:37 INFO - 'tsvg_static']}, 04:49:37 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:49:37 INFO - 'talos_options': ['--disable-e10s'], 04:49:37 INFO - 'tests': ['tp5o']}, 04:49:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:49:37 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:49:37 INFO - 'talos_options': ['--disable-e10s', 04:49:37 INFO - '--xperf_path', 04:49:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:49:37 INFO - 'tests': ['tp5n']}, 04:49:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:49:37 INFO - 'talos_options': ['--xperf_path', 04:49:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:49:37 INFO - 'tests': ['tp5n']}}, 04:49:37 INFO - 'talos.zip': {'path': '', 04:49:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:49:37 INFO - Running post-action listener: _resource_record_post_action 04:49:37 INFO - [mozharness: 2017-02-13 12:49:37.096798Z] Finished populate-webroot step (success) 04:49:37 INFO - [mozharness: 2017-02-13 12:49:37.096939Z] Running create-virtualenv step. 04:49:37 INFO - Running pre-action listener: _resource_record_pre_action 04:49:37 INFO - Running main action method: create_virtualenv 04:49:37 INFO - Creating virtualenv /builds/slave/test/build/venv 04:49:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:49:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:49:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:49:37 INFO - Using real prefix '/tools/python27' 04:49:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:49:37 INFO - Installing distribute.............................................................................................................................................................................................done. 04:49:40 INFO - Installing pip.................done. 04:49:40 INFO - Return code: 0 04:49:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:49:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:49:41 INFO - Reading from file tmpfile_stdout 04:49:41 INFO - Output received: 04:49:41 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:49:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:41 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 0x10a75ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a75d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd40357bd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a538d30>, '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 0x10a45fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52dbe8>, '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.ZfGDLDIJPM/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.uQfSEr4nrH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:49:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:49:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:49:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZfGDLDIJPM/Render', 04:49:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:41 INFO - 'HOME': '/Users/cltbld', 04:49:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:41 INFO - 'LOGNAME': 'cltbld', 04:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:41 INFO - 'MOZ_NO_REMOTE': '1', 04:49:41 INFO - 'NO_EM_RESTART': '1', 04:49:41 INFO - 'PAGER': '/bin/cat', 04:49:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:41 INFO - 'PWD': '/builds/slave/test', 04:49:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:41 INFO - 'SHELL': '/bin/bash', 04:49:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uQfSEr4nrH/Listeners', 04:49:41 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 04:49:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:41 INFO - 'USER': 'cltbld', 04:49:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:41 INFO - 'XPC_FLAGS': '0x0', 04:49:41 INFO - 'XPC_SERVICE_NAME': '0', 04:49:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:49:41 INFO - Cleaning up... 04:49:41 INFO - Return code: 0 04:49:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:41 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 0x10a75ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a75d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd40357bd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a538d30>, '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 0x10a45fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52dbe8>, '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.ZfGDLDIJPM/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.uQfSEr4nrH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:49:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:49:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:49:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZfGDLDIJPM/Render', 04:49:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:41 INFO - 'HOME': '/Users/cltbld', 04:49:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:41 INFO - 'LOGNAME': 'cltbld', 04:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:41 INFO - 'MOZ_NO_REMOTE': '1', 04:49:41 INFO - 'NO_EM_RESTART': '1', 04:49:41 INFO - 'PAGER': '/bin/cat', 04:49:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:41 INFO - 'PWD': '/builds/slave/test', 04:49:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:41 INFO - 'SHELL': '/bin/bash', 04:49:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uQfSEr4nrH/Listeners', 04:49:41 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 04:49:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:41 INFO - 'USER': 'cltbld', 04:49:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:41 INFO - 'XPC_FLAGS': '0x0', 04:49:41 INFO - 'XPC_SERVICE_NAME': '0', 04:49:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:41 INFO - Downloading/unpacking psutil>=3.1.1 04:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:49:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:49:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:49:45 INFO - Installing collected packages: psutil 04:49:45 INFO - Running setup.py install for psutil 04:49:45 INFO - building 'psutil._psutil_osx' extension 04:49:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:49:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:49:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:49:45 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:49:45 INFO - building 'psutil._psutil_posix' extension 04:49:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:49:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:49:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:49:45 INFO - ^ 04:49:45 INFO - 1 warning generated. 04:49:45 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:49:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:49:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:49:46 INFO - Successfully installed psutil 04:49:46 INFO - Cleaning up... 04:49:46 INFO - Return code: 0 04:49:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a75ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a75d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd40357bd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a538d30>, '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 0x10a45fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52dbe8>, '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.ZfGDLDIJPM/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.uQfSEr4nrH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:49: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:49: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 mozsystemmonitor==0.3 04:49:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZfGDLDIJPM/Render', 04:49:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:46 INFO - 'HOME': '/Users/cltbld', 04:49:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:46 INFO - 'LOGNAME': 'cltbld', 04:49:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:46 INFO - 'MOZ_NO_REMOTE': '1', 04:49:46 INFO - 'NO_EM_RESTART': '1', 04:49:46 INFO - 'PAGER': '/bin/cat', 04:49:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:46 INFO - 'PWD': '/builds/slave/test', 04:49:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:46 INFO - 'SHELL': '/bin/bash', 04:49:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uQfSEr4nrH/Listeners', 04:49:46 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 04:49:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:46 INFO - 'USER': 'cltbld', 04:49:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:46 INFO - 'XPC_FLAGS': '0x0', 04:49:46 INFO - 'XPC_SERVICE_NAME': '0', 04:49:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:49:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:49:50 INFO - Installing collected packages: mozsystemmonitor 04:49:50 INFO - Running setup.py install for mozsystemmonitor 04:49:50 INFO - Successfully installed mozsystemmonitor 04:49:50 INFO - Cleaning up... 04:49:50 INFO - Return code: 0 04:49:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:50 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 0x10a75ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a75d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd40357bd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a538d30>, '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 0x10a45fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52dbe8>, '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.ZfGDLDIJPM/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.uQfSEr4nrH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:49:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:49:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:49:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZfGDLDIJPM/Render', 04:49:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:50 INFO - 'HOME': '/Users/cltbld', 04:49:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:50 INFO - 'LOGNAME': 'cltbld', 04:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:50 INFO - 'MOZ_NO_REMOTE': '1', 04:49:50 INFO - 'NO_EM_RESTART': '1', 04:49:50 INFO - 'PAGER': '/bin/cat', 04:49:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:50 INFO - 'PWD': '/builds/slave/test', 04:49:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:50 INFO - 'SHELL': '/bin/bash', 04:49:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uQfSEr4nrH/Listeners', 04:49:50 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 04:49:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:50 INFO - 'USER': 'cltbld', 04:49:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:50 INFO - 'XPC_FLAGS': '0x0', 04:49:50 INFO - 'XPC_SERVICE_NAME': '0', 04:49:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:50 INFO - Downloading/unpacking jsonschema==2.5.1 04:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:49:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:53 INFO - Downloading functools32-3.2.3-2.tar.gz 04:49:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:49:53 INFO - warning: no files found matching '*.txt' 04:49:53 INFO - no previously-included directories found matching 'build' 04:49:53 INFO - no previously-included directories found matching 'dist' 04:49:53 INFO - no previously-included directories found matching '.git*' 04:49:53 INFO - Installing collected packages: jsonschema, functools32 04:49:54 INFO - Running setup.py install for functools32 04:49:54 INFO - warning: no files found matching '*.txt' 04:49:54 INFO - no previously-included directories found matching 'build' 04:49:54 INFO - no previously-included directories found matching 'dist' 04:49:54 INFO - no previously-included directories found matching '.git*' 04:49:54 INFO - Successfully installed jsonschema functools32 04:49:54 INFO - Cleaning up... 04:49:54 INFO - Return code: 0 04:49:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:54 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 0x10a75ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a75d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd40357bd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a538d30>, '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 0x10a45fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52dbe8>, '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.ZfGDLDIJPM/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.uQfSEr4nrH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:49:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:49:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZfGDLDIJPM/Render', 04:49:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:54 INFO - 'HOME': '/Users/cltbld', 04:49:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:54 INFO - 'LOGNAME': 'cltbld', 04:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:54 INFO - 'MOZ_NO_REMOTE': '1', 04:49:54 INFO - 'NO_EM_RESTART': '1', 04:49:54 INFO - 'PAGER': '/bin/cat', 04:49:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:54 INFO - 'PWD': '/builds/slave/test', 04:49:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:54 INFO - 'SHELL': '/bin/bash', 04:49:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uQfSEr4nrH/Listeners', 04:49:54 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 04:49:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:54 INFO - 'USER': 'cltbld', 04:49:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:54 INFO - 'XPC_FLAGS': '0x0', 04:49:54 INFO - 'XPC_SERVICE_NAME': '0', 04:49:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:49:54 INFO - Cleaning up... 04:49:54 INFO - Return code: 0 04:49:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:54 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 0x10a75ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a75d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd40357bd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a538d30>, '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 0x10a45fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52dbe8>, '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.ZfGDLDIJPM/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.uQfSEr4nrH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:49:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:49:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZfGDLDIJPM/Render', 04:49:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:54 INFO - 'HOME': '/Users/cltbld', 04:49:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:54 INFO - 'LOGNAME': 'cltbld', 04:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:54 INFO - 'MOZ_NO_REMOTE': '1', 04:49:54 INFO - 'NO_EM_RESTART': '1', 04:49:54 INFO - 'PAGER': '/bin/cat', 04:49:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:54 INFO - 'PWD': '/builds/slave/test', 04:49:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:54 INFO - 'SHELL': '/bin/bash', 04:49:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uQfSEr4nrH/Listeners', 04:49:54 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 04:49:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:54 INFO - 'USER': 'cltbld', 04:49:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:54 INFO - 'XPC_FLAGS': '0x0', 04:49:54 INFO - 'XPC_SERVICE_NAME': '0', 04:49:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:54 INFO - Downloading/unpacking blobuploader==1.2.4 04:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:57 INFO - Downloading blobuploader-1.2.4.tar.gz 04:49:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:49:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:49:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:58 INFO - Downloading docopt-0.6.1.tar.gz 04:49:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:49:58 INFO - Installing collected packages: blobuploader, requests, docopt 04:49:58 INFO - Running setup.py install for blobuploader 04:49:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:49:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:49:58 INFO - Running setup.py install for requests 04:49:59 INFO - Running setup.py install for docopt 04:49:59 INFO - Successfully installed blobuploader requests docopt 04:49:59 INFO - Cleaning up... 04:49:59 INFO - Return code: 0 04:49:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:59 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 0x10a75ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a75d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd40357bd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a538d30>, '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 0x10a45fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52dbe8>, '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.ZfGDLDIJPM/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.uQfSEr4nrH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:49:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:49:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:49:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZfGDLDIJPM/Render', 04:49:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:59 INFO - 'HOME': '/Users/cltbld', 04:49:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:59 INFO - 'LOGNAME': 'cltbld', 04:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:59 INFO - 'MOZ_NO_REMOTE': '1', 04:49:59 INFO - 'NO_EM_RESTART': '1', 04:49:59 INFO - 'PAGER': '/bin/cat', 04:49:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:59 INFO - 'PWD': '/builds/slave/test', 04:49:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:59 INFO - 'SHELL': '/bin/bash', 04:49:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uQfSEr4nrH/Listeners', 04:49:59 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 04:49:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:59 INFO - 'USER': 'cltbld', 04:49:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:59 INFO - 'XPC_FLAGS': '0x0', 04:49:59 INFO - 'XPC_SERVICE_NAME': '0', 04:49:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:49:59 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-o0zQMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:49:59 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-fjTw51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:50:00 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-LvPTTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:50:00 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-kb_5z7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:50:00 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-4JUtyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:50:00 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-5OukwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:50:00 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-pQePJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:50:00 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-HCaHyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:50:00 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-vS1nHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:50:00 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-FtQt4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:50:00 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-7c4FUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:50:00 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-7I_7YU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:50:01 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-UpEM4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:50:01 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-8TfjuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:01 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-u4FmTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:50:01 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-48Utjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:50:01 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-0qPSme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:50:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:50:01 INFO - Running setup.py install for manifestparser 04:50:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:50:01 INFO - Running setup.py install for mozcrash 04:50:01 INFO - Running setup.py install for mozdebug 04:50:02 INFO - Running setup.py install for mozdevice 04:50:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:50:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:50:02 INFO - Running setup.py install for mozfile 04:50:02 INFO - Running setup.py install for mozhttpd 04:50:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:50:02 INFO - Running setup.py install for mozinfo 04:50:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:50:02 INFO - Running setup.py install for mozInstall 04:50:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:50:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:50:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:50:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:50:02 INFO - Running setup.py install for mozleak 04:50:02 INFO - Running setup.py install for mozlog 04:50:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:50:03 INFO - Running setup.py install for moznetwork 04:50:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:50:03 INFO - Running setup.py install for mozprocess 04:50:03 INFO - Running setup.py install for mozprofile 04:50:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:50:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:50:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:50:03 INFO - Running setup.py install for mozrunner 04:50:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:50:03 INFO - Running setup.py install for mozscreenshot 04:50:03 INFO - Running setup.py install for moztest 04:50:04 INFO - Running setup.py install for mozversion 04:50:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:50:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:50:04 INFO - Cleaning up... 04:50:04 INFO - Return code: 0 04:50:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:50: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')]} 04:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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')]} 04:50:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:04 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 0x10a75ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a75d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd40357bd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a538d30>, '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 0x10a45fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52dbe8>, '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.ZfGDLDIJPM/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.uQfSEr4nrH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:50:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:50:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:50:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZfGDLDIJPM/Render', 04:50:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:04 INFO - 'HOME': '/Users/cltbld', 04:50:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:04 INFO - 'LOGNAME': 'cltbld', 04:50:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:04 INFO - 'MOZ_NO_REMOTE': '1', 04:50:04 INFO - 'NO_EM_RESTART': '1', 04:50:04 INFO - 'PAGER': '/bin/cat', 04:50:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:04 INFO - 'PWD': '/builds/slave/test', 04:50:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:04 INFO - 'SHELL': '/bin/bash', 04:50:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uQfSEr4nrH/Listeners', 04:50:04 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 04:50:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:04 INFO - 'USER': 'cltbld', 04:50:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:04 INFO - 'XPC_FLAGS': '0x0', 04:50:04 INFO - 'XPC_SERVICE_NAME': '0', 04:50:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:50:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:50:04 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-DUnKy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:50:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:50:04 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-Vt5EO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:50:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:50:04 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-XrN7Sb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:50:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:50:04 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-GKIqmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:50:04 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)) 04:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:50:04 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-QcfC0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:50:05 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-4Z_MRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:50:05 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-ve1elp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:50:05 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-FA5XfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:50:05 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-d0QhUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:50:05 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-nyJi6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:50:05 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-R_Gt4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:50:05 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-MjGKmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:50:05 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)) 04:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:50:05 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-CkAAYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:50:05 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-OcKtxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:06 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-r2gPN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:50:06 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-uuIE16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:50:06 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-tjvWoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:50:06 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)) 04:50:06 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)) 04:50:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:50:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:08 INFO - Downloading blessings-1.6.tar.gz 04:50:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:50:09 INFO - Installing collected packages: blessings 04:50:09 INFO - Running setup.py install for blessings 04:50:09 INFO - Successfully installed blessings 04:50:09 INFO - Cleaning up... 04:50:09 INFO - Return code: 0 04:50:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:50:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:50:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:50:09 INFO - Reading from file tmpfile_stdout 04:50:09 INFO - Current package versions: 04:50:09 INFO - blessings == 1.6 04:50:09 INFO - blobuploader == 1.2.4 04:50:09 INFO - docopt == 0.6.1 04:50:09 INFO - functools32 == 3.2.3-2 04:50:09 INFO - jsonschema == 2.5.1 04:50:09 INFO - manifestparser == 1.1 04:50:09 INFO - mozInstall == 1.12 04:50:09 INFO - mozcrash == 1.0 04:50:09 INFO - mozdebug == 0.1 04:50:09 INFO - mozdevice == 0.49 04:50:09 INFO - mozfile == 1.2 04:50:09 INFO - mozhttpd == 0.7 04:50:09 INFO - mozinfo == 0.9 04:50:09 INFO - mozleak == 0.1 04:50:09 INFO - mozlog == 3.4 04:50:09 INFO - moznetwork == 0.27 04:50:09 INFO - mozprocess == 0.24 04:50:09 INFO - mozprofile == 0.28 04:50:09 INFO - mozrunner == 6.13 04:50:09 INFO - mozscreenshot == 0.1 04:50:09 INFO - mozsystemmonitor == 0.3 04:50:09 INFO - moztest == 0.8 04:50:09 INFO - mozversion == 1.4 04:50:09 INFO - psutil == 3.1.1 04:50:09 INFO - requests == 1.2.3 04:50:09 INFO - wsgiref == 0.1.2 04:50:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:50: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')]} 04:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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')]} 04:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:09 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 0x10a75ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a75d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd40357bd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a538d30>, '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 0x10a45fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52dbe8>, '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.ZfGDLDIJPM/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.uQfSEr4nrH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:50:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:50:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:50:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZfGDLDIJPM/Render', 04:50:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:09 INFO - 'HOME': '/Users/cltbld', 04:50:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:09 INFO - 'LOGNAME': 'cltbld', 04:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:09 INFO - 'MOZ_NO_REMOTE': '1', 04:50:09 INFO - 'NO_EM_RESTART': '1', 04:50:09 INFO - 'PAGER': '/bin/cat', 04:50:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:09 INFO - 'PWD': '/builds/slave/test', 04:50:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:09 INFO - 'SHELL': '/bin/bash', 04:50:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uQfSEr4nrH/Listeners', 04:50:09 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 04:50:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:09 INFO - 'USER': 'cltbld', 04:50:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:09 INFO - 'XPC_FLAGS': '0x0', 04:50:09 INFO - 'XPC_SERVICE_NAME': '0', 04:50:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:50:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:50:09 INFO - Cleaning up... 04:50:09 INFO - Return code: 0 04:50:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:50: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')]} 04:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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')]} 04:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a75ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a75d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd40357bd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a538d30>, '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 0x10a45fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52dbe8>, '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.ZfGDLDIJPM/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.uQfSEr4nrH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:50:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:50:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:50:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZfGDLDIJPM/Render', 04:50:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:09 INFO - 'HOME': '/Users/cltbld', 04:50:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:09 INFO - 'LOGNAME': 'cltbld', 04:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:09 INFO - 'MOZ_NO_REMOTE': '1', 04:50:09 INFO - 'NO_EM_RESTART': '1', 04:50:09 INFO - 'PAGER': '/bin/cat', 04:50:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:09 INFO - 'PWD': '/builds/slave/test', 04:50:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:09 INFO - 'SHELL': '/bin/bash', 04:50:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uQfSEr4nrH/Listeners', 04:50:09 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 04:50:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:09 INFO - 'USER': 'cltbld', 04:50:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:09 INFO - 'XPC_FLAGS': '0x0', 04:50:09 INFO - 'XPC_SERVICE_NAME': '0', 04:50:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:50:10 INFO - Cleaning up... 04:50:10 INFO - Return code: 0 04:50:10 INFO - Running post-action listener: _resource_record_post_action 04:50:10 INFO - Running post-action listener: _start_resource_monitoring 04:50:10 INFO - Starting resource monitoring. 04:50:10 INFO - [mozharness: 2017-02-13 12:50:10.197263Z] Finished create-virtualenv step (success) 04:50:10 INFO - [mozharness: 2017-02-13 12:50:10.198300Z] Running install step. 04:50:10 INFO - Running pre-action listener: _resource_record_pre_action 04:50:10 INFO - Running main action method: install 04:50:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:50:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:50:10 INFO - Reading from file tmpfile_stdout 04:50:10 INFO - Detecting whether we're running mozinstall >=1.0... 04:50:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:50:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:50:10 INFO - Reading from file tmpfile_stdout 04:50:10 INFO - Output received: 04:50:10 INFO - Usage: mozinstall [options] installer 04:50:10 INFO - Options: 04:50:10 INFO - -h, --help show this help message and exit 04:50:10 INFO - -d DEST, --destination=DEST 04:50:10 INFO - Directory to install application into. [default: 04:50:10 INFO - "/builds/slave/test"] 04:50:10 INFO - --app=APP Application being installed. [default: firefox] 04:50:10 INFO - mkdir: /builds/slave/test/build/application 04:50:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:50:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:50:32 INFO - Reading from file tmpfile_stdout 04:50:32 INFO - Output received: 04:50:32 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:50:32 INFO - Running post-action listener: _resource_record_post_action 04:50:32 INFO - [mozharness: 2017-02-13 12:50:32.813290Z] Finished install step (success) 04:50:32 INFO - [mozharness: 2017-02-13 12:50:32.813446Z] Running run-tests step. 04:50:32 INFO - Running pre-action listener: _resource_record_pre_action 04:50:32 INFO - Running main action method: run_tests 04:50:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:50:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:50:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:50:32 INFO - 2017-02-13 04:50:32.828 screenresolution[2244:24377] starting screenresolution argv=screenresolution get 04:50:32 INFO - 2017-02-13 04:50:32.831 screenresolution[2244:24377] Display 0: 1600x1200x32@60 04:50:32 INFO - 2017-02-13 04:50:32.837 screenresolution[2245:24381] starting screenresolution argv=screenresolution list 04:50:32 INFO - Available Modes on Display 0 04:50:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:50:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:50:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:50:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:50:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:50:33 INFO - Intel Iris: 04:50:33 INFO - Chipset Model: Intel Iris 04:50:33 INFO - Type: GPU 04:50:33 INFO - Bus: Built-In 04:50:33 INFO - VRAM (Dynamic, Max): 1536 MB 04:50:33 INFO - Vendor: Intel (0x8086) 04:50:33 INFO - Device ID: 0x0a2e 04:50:33 INFO - Revision ID: 0x0009 04:50:33 INFO - Displays: 04:50:33 INFO - Display: 04:50:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:50:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:50:33 INFO - Display Serial Number: 1600x1200 60 04:50:33 INFO - Main Display: Yes 04:50:33 INFO - Mirror: Off 04:50:33 INFO - Online: Yes 04:50:33 INFO - Rotation: Supported 04:50:33 INFO - Return code: 0 04:50:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:50:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:50:33 INFO - Python 2.7.3 04:50:33 INFO - Return code: 0 04:50:33 INFO - grabbing minidump binary from tooltool 04:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:50:33 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 0x10a538d30>, '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 0x10a45fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:50:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:50:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:50:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:50:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:50:33 INFO - Return code: 0 04:50:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:50:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:50:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:50:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:50:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:50:33 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/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:50:33 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/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:50:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZfGDLDIJPM/Render', 04:50:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:33 INFO - 'HOME': '/Users/cltbld', 04:50:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:33 INFO - 'LOGNAME': 'cltbld', 04:50:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:50:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:50:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:33 INFO - 'MOZ_NO_REMOTE': '1', 04:50:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:50:33 INFO - 'NO_EM_RESTART': '1', 04:50:33 INFO - 'PAGER': '/bin/cat', 04:50:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:33 INFO - 'PWD': '/builds/slave/test', 04:50:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:50:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:33 INFO - 'SHELL': '/bin/bash', 04:50:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uQfSEr4nrH/Listeners', 04:50:33 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 04:50:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:33 INFO - 'USER': 'cltbld', 04:50:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:33 INFO - 'XPC_FLAGS': '0x0', 04:50:33 INFO - 'XPC_SERVICE_NAME': '0', 04:50:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:50:33 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/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:50:33 INFO - mozversion application_buildid: 20170213033940 04:50:33 INFO - mozversion application_changeset: 3c300355a94d24e0c1c156f9de4a6e9c60beaa28 04:50:33 INFO - mozversion application_display_name: Nightly 04:50:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:50:33 INFO - mozversion application_name: Firefox 04:50:33 INFO - mozversion application_remotingname: firefox 04:50:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:50:33 INFO - mozversion application_vendor: Mozilla 04:50:33 INFO - mozversion application_version: 54.0a1 04:50:33 INFO - mozversion platform_buildid: 20170213033940 04:50:33 INFO - mozversion platform_changeset: 3c300355a94d24e0c1c156f9de4a6e9c60beaa28 04:50:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:50:33 INFO - mozversion platform_version: 54.0a1 04:50:33 INFO - using testdate: 1486990233 04:50:33 INFO - actual date: 1486990233 04:50:33 INFO - starting webserver on 'localhost:56424' 04:50:33 INFO - SUITE-START | Running 2 tests 04:50:33 INFO - TEST-START | dromaeo_css 04:50:33 INFO - operating with platform_type : mac_ 04:50:33 INFO - Initialising browser for dromaeo_css test... 04:50:33 INFO - TEST-INFO | started process 2255 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/tmpTJXPpP/profile http://localhost:56424/getInfo.html) 04:50:35 INFO - PROCESS | 2255 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 04:50:35 INFO - PROCESS | 2255 | __metrics Screen width/height:1600/1200 04:50:35 INFO - PROCESS | 2255 | colorDepth:24 04:50:35 INFO - PROCESS | 2255 | Browser inner width/height: 1024/689 04:50:35 INFO - PROCESS | 2255 | __metrics 04:50:35 INFO - PROCESS | 2255 | 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" 04:50:35 INFO - PROCESS | 2255 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:50:36 INFO - TEST-INFO | 2255: exit 0 04:50:36 INFO - Browser initialized. 04:50:36 INFO - Running cycle 1/1 for dromaeo_css test... 04:50:36 INFO - TEST-INFO | started process 2257 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/tmpTJXPpP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:50:48 INFO - PROCESS | 2257 | RSS: Main: 236232704 04:50:48 INFO - PROCESS | 2257 | 04:53:54 INFO - PROCESS | 2257 | Cycle 1(1): loaded http://localhost:56424/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56424/tests/dromaeo/cssquery-ext.html) 04:53:56 INFO - PROCESS | 2257 | RSS: Main: 423018496 04:53:56 INFO - PROCESS | 2257 | 04:55:38 INFO - PROCESS | 2257 | ************************* 04:55:38 INFO - PROCESS | 2257 | A coding exception was thrown and uncaught in a Task. 04:55:38 INFO - PROCESS | 2257 | 04:55:38 ERROR - PROCESS | 2257 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:55:38 INFO - PROCESS | 2257 | Full stack: 04:55:38 INFO - PROCESS | 2257 | ************************* 04:56:59 INFO - PROCESS | 2257 | Cycle 1(1): loaded http://localhost:56424/tests/dromaeo/cssquery-ext.html (next: http://localhost:56424/tests/dromaeo/cssquery-jquery.html) 04:56:59 INFO - PROCESS | 2257 | RSS: Main: 371908608 04:56:59 INFO - PROCESS | 2257 | 05:00:02 INFO - PROCESS | 2257 | Cycle 1(1): loaded http://localhost:56424/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56424/tests/dromaeo/cssquery-mootools.html) 05:00:02 INFO - PROCESS | 2257 | RSS: Main: 347021312 05:00:02 INFO - PROCESS | 2257 | 05:03:04 INFO - PROCESS | 2257 | Cycle 1(1): loaded http://localhost:56424/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56424/tests/dromaeo/cssquery-prototype.html) 05:03:05 INFO - PROCESS | 2257 | RSS: Main: 342622208 05:03:05 INFO - PROCESS | 2257 | 05:06:09 INFO - PROCESS | 2257 | Cycle 1(1): loaded http://localhost:56424/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56424/tests/dromaeo/cssquery-yui.html) 05:06:09 INFO - PROCESS | 2257 | RSS: Main: 334364672 05:06:09 INFO - PROCESS | 2257 | 05:09:12 INFO - PROCESS | 2257 | Cycle 1(1): loaded http://localhost:56424/tests/dromaeo/cssquery-yui.html (next: http://localhost:56424/tests/dromaeo/cssquery-dojo.html) 05:09:12 INFO - PROCESS | 2257 | RSS: Main: 554496000 05:09:12 INFO - PROCESS | 2257 | 05:09:12 INFO - PROCESS | 2257 | __start_tp_report 05:09:12 INFO - PROCESS | 2257 | _x_x_mozilla_page_load 05:09:12 INFO - PROCESS | 2257 | _x_x_mozilla_page_load_details 05:09:12 INFO - PROCESS | 2257 | |i|pagename|runs| 05:09:12 INFO - PROCESS | 2257 | |0;dojo.html;3272.2146684795644;3276.9508457373136;3277.4756039033746;3305.3554556861422;3320.6015278166624;5396.487333703292;5527.55779537637;5580.972095139524;5626.578006649497;5640.9999999999945;5459.071957767179;5475.5072043516075;5525.613207075507;5539.058360078786;5553.583481238903;4966.627502937276;4986.152354099793;5036.471170527097;5040.672356296847;5084.262781896623;5166.405863325709;5175.689458632494;5176.482351764831;5201.817936372227;5227;4959.181735013718;4998.775055122492;5001.824936127255;5058.747062646889;5120.718360490171;5035.647504674675;5045.445001049881;5048.671836330626;5053.570446512051;5067.9239811402485;4960.677555958887;4985.825496107619;4994.475580064077;5000.924986125211;5005.374328208974;5454.890902181974;5457.672539647634;5463;5469.753861076221;5470.64440811346;5899.498542623882;5902.173695682608;5908.497777688902;5911.261092363455;5912.201852749867;6085.9087113692885;6104.890867003787;6112.442689633878;6129.1725617041575;6132.030754953286;5596;5663.631863928873;5679.261695979579;5679.346875109332;5681.261436013333;6313.905291420632;6317.526185536103;6325;6335.778247761306;6373.298937116913;5738.713064346849;5788.957987562195;5804.65172089676;6017.879642407127;6033.5474839387225;5994.37059108796;6007.609505382136;6008.188894499187;6012.699365031731;6020.518358531307;5890.528757699374;5893.705314734246;5896.1450589664255;5900.734466948998;5902.852428689232;5883.970580147072;5937.139114828412;5940.8811823764145;5941.049432090845;5962.135490353961;4334.674899382559;4735.526447355306;4829.637777166727;4866.9513304867205;4881.731504767201;4299.97850010748;4309.482862056573;4328.7402755834755;4330.198913201068;4339.500957389878;5530.806421775219;5646.265985421951;5651.095824668033;5674.829755107354;5679.943200567942;6211.875762484725;6238.719257633417;6245.812625621239;6261.154744109578;6263.091851681572;5433.592480563973;5472.781088756406;5482.314710661168;5625.774969001194;5627.5779316551425;5221.086309895753;5320.920186197211;5345.732713364394;5383.892322153535;5441.564674826004;6329.145565348619;6329.3354197809485;6340.873182536231;6341.27075386318;6358;5843.065109582616;6198.132261483306;6205.100260462298;6222.439980401786;6227.813165605039;6155.169052177898;6195.070739389128;6216.751329946932;6244.063390491281;6278.6860656966055;6083.543734219863;6090.177825993434;6109.450149486567;6109.694515274307;6133.84665383369;5049.621278404208;6132;6135.53983451234;6140.692965351625;6143.047827586731;5734.111212762028;5753.280839895013;5788.044972579477;5931.495822854933;5988.790392336247;5329.960657671717;5805.129230615442;5988.311344195473;6027.547933904887;6079.696015199134;5831.766729330949;5856.385079566755;5860.443257890493;5861.3845546217035;5888.057910734433;5734.971325143348;5803.564732644984;5982.551308651781;6007.939920600913;6039.6678182698615;5713.542916566582;5717.42825717425;5726.713664316684;5732.627379220337;5733.082706766897 05:09:12 INFO - PROCESS | 2257 | |1;ext.html;454.81807277089166;482.6380214838871;484.45982729256843;508.9160288552389;515.6983164848564;21572.89213553932;37797.81101094494;39407.40888886669;39418.80290598547;39626.60373396265;40126.59873401265;40650.796746016225;40672.38991415131;40764.79617601908;40779;7820.843583128334;9059.864102038458;9288.72133835986;9288.907110928905;9289.256859451227;7831.099423566277;7932.444728868982;7935.880961785578;7941.08677502086;10802;10792.406417647066;10811.243212975094;10811.405372704497;10820.783584328348;10837.729056773604;10927.836082458729;10950.616728414467;10984.395858227834;10993.065589424908;11007.954244346774;7758.340541054017;7957.721479748181;10839.078678312353;10900.890991090067;10938.124950003981;37663.62336376629;38331.425028624595;38411.47005009155;39423.60576394228;39523;3703.648153425447;3727;3753.5120434343635;3769.491118698968;3784.9432258516144;28291.575626365415;28296.71703282982;28535.429291414057;28641.57037644437;28745.42509149805;3020.9546856797165;3036.30165062037;3111.159986803573;3148.5906832111677;3154.0853152585723;441687.79156104336;441952;443543.6861655074;443734;452083.47916521074;59247.40752592419;60269.698651506464;60372.39627603668;60608;60624.69687651622;62141;62302;62494.0625890612;62597.37402625915;62654;14303.28483575817;14763.409463621334;14777.039492433172;14804.555863324118;14819.77770333446;11297.152713546517;11351.94324028391;11393.544258229744;11394.25937314072;11400.087992960543;16800.411985580446;17120.74318885218;17127.74572831158;17150.228239729244;17168.22742976569;5654.6324488908085;5705.429457054262;6811.25076241613;6841.247462779091;6849.383555479931;784.697891311849;806.3710305961359;835.2065537739172;841.9559745915021;854.2610641794803;23597.646035309484;26794.062207822633;27952.30119247035;28686.676478313075;28971.855140724583;990;995.581855620641;997.7954519323521;1035.0787798859021;1042.0725554256717;14589.562313130624;14674.926625366805;14682.889204050744;14777.335019924129;14787.260636968109;555470;559503;559525;560147;560580;56195.43804561902;56377.154342684895;56389.87220255572;56513.71743141258;56725;1123.685368096934;1179.2334982261598;1278.3288773394042;1326.4826717580152;1334.219481603273;20371;27926.3018424541;28594.999175029607;29638.110856674335;30122.24694382658;49266.26100608565;49855.750721246164;49865.75067124641;49908;49947.50157495281;529771;536966.3151684217;539178;539263;539876;23623.039161776218;23824.16615418452;23885.164019259937;24037.278881633578;24121.51756964886;39490.802545987084;39780;39791.00522486845;40946.385804213554;41159;27547.86226068857;31742.36515269728;32103.839480802446;33125.33749325048;34671.95984120481;32615.369231538803;32841.50737738888;33726.325473490884;33805.32389352249;34999.7750078746;27144.457110857278;33398.833005834815;33622.327553448304;33630.49554256737;34082.65917340795;21475.46311342229;29109.85445072761;29781.10656680303;29850.85074574613;30558;20991.790082098985;23036.539269214856;23063.705592604765;23192.652110218023;23387.532249354575 05:09:12 INFO - PROCESS | 2257 | |2;jquery.html;346.0569946894711;381.2946049807856;387.3589209857686;395.5174686882004;422.37699393394746;14190.858091419082;14761;19010.61978760424;20060.398188054347;20341.084651190697;20223.59552808943;20559.280425185123;20639.968001599937;20930;21066.157353705832;5578.2748242728385;5881.382454842244;5886.293644762634;5893.410658934115;5915.467607915287;3943.467631869704;4040.7373520721208;4092.0997380576373;4139.648129908961;5741.311042674884;6303.306636270029;6380.521460890452;6382.329855365167;6392.360763923617;6398.808035758934;5512.145617429305;5753.165790960329;5849.473547380713;6365.58623689461;6365.777197798078;5735.885282294331;5741.799037033726;5743.167240750068;5754.539636829044;5766.62516936402;13349.265790381525;17095.316187352615;18907.338243161423;24844.50310993788;25370.365740856443;2464.6116618453125;2465.3836540864786;2502.8373155744816;2520.1305549585363;2530.4053547416343;9432;10338.53476593555;10375.533101010473;10376.014278643517;14287.57137285883;1740.2342969093559;1824.9452516424528;1830.5789668376215;1859.33064096925;1863.8229368209998;129357;134586;140224;141668;144023;8247.051768938589;9947.900520994843;11114.110601197815;11121.16591255643;11650.825237621442;13859.099158554662;14795.482158124629;15488.922555387377;15511.301991410413;15547.123782100347;8196.959015204886;8217.671293148207;8274.089850116483;8287.254147126787;8397.6221070052;6404.583702059351;6893.827654308582;7465.7013719450615;7841.843163136706;8034.357251419872;3961.8613348532663;4638.536146385402;4703.341532185496;4719.905601888012;4831.661783675179;1934.3809980806288;1988.7514060742408;1998.1407994562187;1998.8400927925732;2017.636825371418;826.8057006603443;986.9358491698017;994.8060128274917;1016.2479764974014;1019.8623185869812;18686.159122839505;19991.40025799228;20930.89534552348;21718.674219886714;21781.782182178293;782.8512582609286;984.2962281968427;984.6947446291673;1026.2559644257854;1034.4569101221769;9064.682736104205;10102.444365559817;10865.207240805179;11278.7180320491;11399.544018239343;448223;658691;672168;677142;679632;151101;154077;155967.01649175413;157757;158762.4123758771;1054.1988089052375;1077.4020418667715;1107.6898468428853;1109.8224284114503;1112.0158659586164;18123.72814407811;18878.433646990612;19763;19766.91281979505;19801.009949502757;57841.42158578528;58804.41195587989;60240;60618.05784669639;62858.685706571174;85446.57276713576;88694.55652721695;89782.55108724415;90626;91386.54306728423;8276.379271554537;8285.4200205985;8591.312694984512;8678.435901666371;8701.129887011248;7943.165967573322;9310.72067837966;12410.75178496407;13117.672058198239;13243.933780331037;10821.863704310934;11189.272697274651;11438.08495320389;11746;11850.940745296562;8962.596683149144;10630.618019657395;11254.718632034264;11271.887281127083;11679.416029198675;11538.365389903636;11566.94216528912;11819.11356648272;11820.40897955116;11934.880651193376;8203.384746144182;8351.540665263226;8474.364422668448;8577.571121443778;8657.653693852175;8849.601767920587;11147.442627868411;11256.943715281372;11639.59261425846;11817.054635629302 05:09:12 INFO - PROCESS | 2257 | |3;mootools.html;1276.8148618450323;1415.8159439272893;1427.9000469967093;1432.8925330600207;1435.3397437178896;8000.639971201295;8413.621387037583;8414.074451810304;8416.116307787686;8435.40952133351;6597.736090556372;8181.386396020307;8216.58917054148;8271.379646526504;8295.626696798643;2213.081571147976;2255.12050300383;2258.841881068326;2263.7057182566246;2270.8069814065743;2166.7399912010583;2248.8875556222124;2250.0437314141504;2253.6281513550243;2280.806131478818;1922.7788804287545;1987.8310343620738;1989.2639723302325;2181.7381914170323;2243.9663405048937;1840.7330937014192;2176.5102851858364;2224.1881713174735;2253.752087270407;2254.3011666383472;2042.8662092538634;2051.651219292724;2228.9219877304376;2246.6969157888384;2268.727752669674;8160.26557609818;8235.13531079234;8241.546714930677;8245;8258.215469530385;3919.7844118573466;5193.246979188034;5194.68831870089;5194.896102077937;5217.921731174036;3283.868645254187;3442.535257740198;3470.0977745786026;3523.894283171509;3531;1142.2232881640482;1184.2420850655587;1235.2403271987753;1240.5161986825146;1245.035097799213;10569.524371403306;10770.138388928945;10775.892241077645;10783.191260655403;10789.352638841694;4466.196084704784;4555.886102847389;4586.036932244266;4656.580907718321;4682.648801339913;8665.783355416164;8724.825503489894;8725.52009639476;8736.519491428033;8744.69393571222;5055.8988820223385;5056.241563765391;5058.974705126451;5059.822906198339;5081.364829396325;4525.434320709911;4690.061987602493;4728.432588089382;4730.905381892412;4781.6891902026255;3500.6674365935196;3587.65917237862;3620.2759448110482;3650.671439570451;3662.9633703663153;1117.8486159255979;1128.7573171768108;1131.2081542919825;1143.3197247637643;1144.9370284634424;647.9287278399372;767.4819496839611;854.6026097864523;858.8668756342777;898.7169041751959;4289.335153051282;5332.093544097435;5467.535259502987;5637.210790489335;5693.089105743061;829.6059371798348;920.8756817829641;928.3965422475445;941.1905761045496;949.3164921256684;2752.8898844046416;3587;3673.834677439468;3777.33896568105;3812.980935095307;7579.393648508106;9729.416235025921;9759.463229522302;9801.411915285105;9816.312858099864;9669.419834809934;9752.073553012453;9788.9021109788;9806.803863922823;9810.264230182765;7290.708371665074;7632.69469221225;7732.757500324955;7733.49732267412;7747.651355689008;5288.7355632219005;5695.800646977336;5702.315722113373;5745.2818397700285;5790.710464476675;8561.400701951054;8659.740207793777;8948;9074.909250907407;9098.226650734498;8942.73171804847;9073.13805188506;9263.53682315895;9383.202427793442;9395.530223488935;6875.89686154698;7092.361687448154;7114.893276600752;7120.60836653989;7129.287071292829;7354.70581176747;7619.352355049883;7700.229977002255;7703.499272547267;7703.614819259126;5407.675539467645;6840.247572767091;6949.235584085645;6994.860102798018;6998.6500674967065;5722.570807189394;6874.65626718652;6882.242953275236;6929.826754331182;6964.129483814523;6242.469390101892;6289.339619339903;6370.9487934492145;6379.712912918837;6395.552311338161;4835.492273311252;4882.170031094652;4927.187014142626;4958.652894297509;5052.873678158076;4861.295112208781;4880.975595122001;4932.654714169974;4996.325496057985;5030.673006254582 05:09:12 INFO - PROCESS | 2257 | |4;prototype.html;350.08452895677794;355.2167470727047;365.8097789149642;368.3020675819321;370.7034372501998;4025.879223623296;5025.924611130827;5386.165144402614;5464.808731694391;5487.286652735143;4740.407449068866;4795.448523419799;5255.290535777678;5304.673831542114;5354.5716342692585;4182.017225951899;4192.979035104828;4202.642775364097;4209.663226941837;4212.894677633069;3720.2001569662516;3875.302445559798;4062.6546743526687;4099.3441049432095;4257.254980378437;3966.4843570335815;4107.363358679395;4194.349875769245;4215.283401821697;4223.831046758126;3554.8222588870453;4116.650084742801;4183.832646694159;4194.0982688721915;4205.5794420558;3685.649863262986;3701.370766969622;3702.7037836973245;3702.796346200958;3733.8133093345223;4408.911821763547;4500.049746293875;5181.393767931953;5217.765200565984;5270.525652691276;4613.723176609415;4732.716037037754;4822.68652537584;4852.902941941176;4855.126077306083;4984.825531106394;5083.669561478529;5289.788408463657;5675.404082571312;5677.460641239076;4109.013836679175;4111.938320925188;4146.460960075171;4151.356539736345;4172.228137794517;4901.803927842882;5037.848864534069;5133.537981581639;5430.877245583765;5543.223948647193;4082.7346222495444;4180.581941805795;4187.361961964004;4217.451731274915;4236.2586547354085;3604.3692353837973;4046.716729828943;4248.383984322256;4276.807543660543;4308.030693094029;3989.7007724420782;4339.392485052095;4470.754108524063;4878.365812444359;4904.705717656952;4906.852794416173;5666.320041595035;5696.060150075191;5707.1153971134545;5709.942900570941;1288.5554483703108;1291.373683763374;1376.8347798264272;1386.9029167958347;1407.7325308191412;770.7649167004006;884.4516399832145;887.587271918561;966.1594412860856;970.8883328588727;5019.774110165052;5025.246213067996;5033.245013247969;5050.368703912011;5060;4864.610831133501;5000.524950129732;5127.359080114986;5201.635885487979;5574.163875418639;4102.097538541516;4708.375610414401;5024.271480635288;5047.419546752097;5053.949460505348;2401.6157414813547;2429.4047958250344;2606.5012617744874;2897.3625802323877;2912.475754364235;5315.687675861012;5723.6851973141875;5727.312722473246;5757.481826635623;5760.251167348301;4136.420901073852;5530.889382212334;5558.360788509373;5679.2333035040565;5967.910481342783;5959.553033522417;6023.807382087501;6031.577789554689;6036.637801731822;6046.365131661112;5178.326817513699;5613.522850557748;5827.193569993316;5867.479512292591;5892.616979896293;4922.409310882717;5079.619028572945;5387.568994480511;5473.151661492475;5488.286522752017;4634.629229661687;5335.413104558418;5474.864802727019;5841.649501029951;6004.037335358817;3895.7078219133114;3902.746321489094;3905.453236546829;3908.863189788344;3935.8228879701055;4669.206234940137;5517.834464966058;5539.252200952981;5625.109241179686;5642.915356269741;4332.176886391576;5000.974995125001;5499.230107784833;5596.636218645775;5619.628223066127;4776.426828780569;5642.181883626933;5658.179563963285;5673.574481913955;5675.77296908119;5179.613202269597;5510.8071217507195;5514.310711161105;5532.008476948376;5585.748641311232;4817.9036419272115;5115.9232611510115;5649.265595472562;5675.971620141873;5709.22925405065;4518.9548104519845;5233.424323324355;5568.8233824631525;5569.275994120739;5587.6088673794075 05:09:12 INFO - PROCESS | 2257 | |5;yui.html;718.1578554732187;749.0823740917374;774.3882332956961;776.5301992294662;789.6407134753688;14039.578812635624;14471.276436178176;14537.49118780843;14560.92719536401;14609.342579583918;13010.674733131676;13226.404811783494;13299.202047877134;13334.266615336153;13571.185728856275;848.7835601921516;860.3246451535515;861.8147098373848;861.8276344731079;862.4351050062219;712.4478529139906;823.8558252305852;865.2385900407664;866.9176428239307;870.1342164546254;915.9679411220609;920.2775820980531;922.4649703172178;922.7693076730817;923.3813345058827;916.1296768070293;917.47703808829;917.7292698653846;917.8531434970373;920.1994264989435;678.223434167875;678.8981652752127;680.3128839871715;680.3740558686021;683.5830143612393;14523.564293071226;14738.189399583018;14765.33555989983;14806.407743690239;14913.70172596542;13429.798553021712;13511.66220844477;13516.986226033086;13754.518591849237;13859;10862.762850903167;11233.269837460539;11254.549818007352;11275.32348059119;11729.589464368706;3543.964560354389;3557.7153827693724;3560.4481305397703;3568.125809176768;3590.982045089784;94643.52678236633;96144;96204;97840.99999999929;98241.0175898239;10109.797804043877;10259.631490787204;10264.58941642326;10343.120834729132;10755.56977720898;21237.36287911365;21384.251551195634;21506.784932150476;21762.455938601346;21825.345239642837;7276.454265930077;7320.633968301564;7377.114746230487;7389.556626602421;7539.811504712426;3972.781497017692;4041.7372870763306;4064.776437295918;4086.6117718816663;4091.4067460218102;3539.557555305587;3583.6595523425235;3612.313660404515;3616.728745344057;3622.2755448910325;643.5334382572692;645.3256347117274;657.3557913245047;660.1286302081206;663.426136392027;638.1703785079378;648.1962366665396;648.4763281389239;671.8958561422987;674.1236392689484;9504.809903801885;9602.471864047404;9700.757481062888;9910.454924979196;9933.751656208507;635.8156134720879;635.9077933699588;653.1476423267586;666.6566718140161;677.461418172554;4251.936220956688;4320.330348795942;4678.111158879802;4680.7114522334705;4710.26990816424;91009.54495227481;97051.02948970562;97086.51456742812;97158.51420742992;98848.50575747075;73634.63182684052;79830;79831;81504;82544.76182857262;70396;72658.2734172662;73495.63252183812;73702.63148684222;74806;10404.015305868967;10452.68641940743;10457.26799124054;10511;10638.255322127377;38529.614703853724;42648;44562.55437445714;45092.54907450883;46679.53320466888;59619.807603848545;63287.68356158374;63634;63768.68115659392;64685.35314646982;12126.454309555915;12487.875121248671;12559.93720031394;12578.685532861751;12595.181313214613;13599.388027538587;13639.590812275648;13734.976750174592;13735.313234338044;13835.86164138386;12850.871491284968;13011.479540818262;13096.476140954255;13464.05751597418;13672.179669219879;12725;12899.742005160031;12927.288999104763;12957.028222883133;13315.733685326433;12484.625461236177;12708.237505749685;12711.491540338282;12939.223646581235;12971.5459958901;10649.414282214553;10713.678589642012;10798.73003174927;10906.291091079054;10973.3964631946;9074.274058075207;9438.669646562337;10440.843387349043;10454.268201225841;10548.419836908737 05:09:12 INFO - PROCESS | 2257 | __end_tp_report 05:09:12 INFO - PROCESS | 2257 | __start_cc_report 05:09:12 INFO - PROCESS | 2257 | _x_x_mozilla_cycle_collect,1861 05:09:12 INFO - PROCESS | 2257 | __end_cc_report 05:09:12 INFO - PROCESS | 2257 | __startTimestamp1486991352816__endTimestamp 05:09:12 INFO - PROCESS | 2257 | 05:09:12 INFO - PROCESS | 2257 | ------- Summary: start ------- 05:09:12 INFO - PROCESS | 2257 | Number of tests: 6 05:09:12 INFO - PROCESS | 2257 | 05:09:12 INFO - PROCESS | 2257 | [#0] dojo.html Cycles:165 Average:5591.98 Median:5734.11 stddev:638.36 (11.1%) stddev-sans-first:613.83 05:09:12 INFO - PROCESS | 2257 | Values: 3272.2 3277.0 3277.5 3305.4 3320.6 5396.5 5527.6 5581.0 5626.6 5641.0 5459.1 5475.5 5525.6 5539.1 5553.6 4966.6 4986.2 5036.5 5040.7 5084.3 5166.4 5175.7 5176.5 5201.8 5227.0 4959.2 4998.8 5001.8 5058.7 5120.7 5035.6 5045.4 5048.7 5053.6 5067.9 4960.7 4985.8 4994.5 5000.9 5005.4 5454.9 5457.7 5463.0 5469.8 5470.6 5899.5 5902.2 5908.5 5911.3 5912.2 6085.9 6104.9 6112.4 6129.2 6132.0 5596.0 5663.6 5679.3 5679.3 5681.3 6313.9 6317.5 6325.0 6335.8 6373.3 5738.7 5789.0 5804.7 6017.9 6033.5 5994.4 6007.6 6008.2 6012.7 6020.5 5890.5 5893.7 5896.1 5900.7 5902.9 5884.0 5937.1 5940.9 5941.0 5962.1 4334.7 4735.5 4829.6 4867.0 4881.7 4300.0 4309.5 4328.7 4330.2 4339.5 5530.8 5646.3 5651.1 5674.8 5679.9 6211.9 6238.7 6245.8 6261.2 6263.1 5433.6 5472.8 5482.3 5625.8 5627.6 5221.1 5320.9 5345.7 5383.9 5441.6 6329.1 6329.3 6340.9 6341.3 6358.0 5843.1 6198.1 6205.1 6222.4 6227.8 6155.2 6195.1 6216.8 6244.1 6278.7 6083.5 6090.2 6109.5 6109.7 6133.8 5049.6 6132.0 6135.5 6140.7 6143.0 5734.1 5753.3 5788.0 5931.5 5988.8 5330.0 5805.1 5988.3 6027.5 6079.7 5831.8 5856.4 5860.4 5861.4 5888.1 5735.0 5803.6 5982.6 6007.9 6039.7 5713.5 5717.4 5726.7 5732.6 5733.1 05:09:12 INFO - PROCESS | 2257 | 05:09:12 INFO - PROCESS | 2257 | [#1] ext.html Cycles:180 Average:63993.25 Median:34835.87 stddev:137746.72 (395.4%) stddev-sans-first:138050.53 05:09:12 INFO - PROCESS | 2257 | Values: 454.8 482.6 484.5 508.9 515.7 21572.9 37797.8 39407.4 39418.8 39626.6 40126.6 40650.8 40672.4 40764.8 40779.0 7820.8 9059.9 9288.7 9288.9 9289.3 7831.1 7932.4 7935.9 7941.1 10802.0 10792.4 10811.2 10811.4 10820.8 10837.7 10927.8 10950.6 10984.4 10993.1 11008.0 7758.3 7957.7 10839.1 10900.9 10938.1 37663.6 38331.4 38411.5 39423.6 39523.0 3703.6 3727.0 3753.5 3769.5 3784.9 28291.6 28296.7 28535.4 28641.6 28745.4 3021.0 3036.3 3111.2 3148.6 3154.1 441687.8 441952.0 443543.7 443734.0 452083.5 59247.4 60269.7 60372.4 60608.0 60624.7 62141.0 62302.0 62494.1 62597.4 62654.0 14303.3 14763.4 14777.0 14804.6 14819.8 11297.2 11351.9 11393.5 11394.3 11400.1 16800.4 17120.7 17127.7 17150.2 17168.2 5654.6 5705.4 6811.3 6841.2 6849.4 784.7 806.4 835.2 842.0 854.3 23597.6 26794.1 27952.3 28686.7 28971.9 990.0 995.6 997.8 1035.1 1042.1 14589.6 14674.9 14682.9 14777.3 14787.3 555470.0 559503.0 559525.0 560147.0 560580.0 56195.4 56377.2 56389.9 56513.7 56725.0 1123.7 1179.2 1278.3 1326.5 1334.2 20371.0 27926.3 28595.0 29638.1 30122.2 49266.3 49855.8 49865.8 49908.0 49947.5 529771.0 536966.3 539178.0 539263.0 539876.0 23623.0 23824.2 23885.2 24037.3 24121.5 39490.8 39780.0 39791.0 40946.4 41159.0 27547.9 31742.4 32103.8 33125.3 34672.0 32615.4 32841.5 33726.3 33805.3 34999.8 27144.5 33398.8 33622.3 33630.5 34082.7 21475.5 29109.9 29781.1 29850.9 30558.0 20991.8 23036.5 23063.7 23192.7 23387.5 05:09:12 INFO - PROCESS | 2257 | 05:09:12 INFO - PROCESS | 2257 | [#2] jquery.html Cycles:180 Average:37396.38 Median:13654.94 stddev:106954.64 (783.3%) stddev-sans-first:107218.50 05:09:12 INFO - PROCESS | 2257 | Values: 346.1 381.3 387.4 395.5 422.4 14190.9 14761.0 19010.6 20060.4 20341.1 20223.6 20559.3 20640.0 20930.0 21066.2 5578.3 5881.4 5886.3 5893.4 5915.5 3943.5 4040.7 4092.1 4139.6 5741.3 6303.3 6380.5 6382.3 6392.4 6398.8 5512.1 5753.2 5849.5 6365.6 6365.8 5735.9 5741.8 5743.2 5754.5 5766.6 13349.3 17095.3 18907.3 24844.5 25370.4 2464.6 2465.4 2502.8 2520.1 2530.4 9432.0 10338.5 10375.5 10376.0 14287.6 1740.2 1824.9 1830.6 1859.3 1863.8 129357.0 134586.0 140224.0 141668.0 144023.0 8247.1 9947.9 11114.1 11121.2 11650.8 13859.1 14795.5 15488.9 15511.3 15547.1 8197.0 8217.7 8274.1 8287.3 8397.6 6404.6 6893.8 7465.7 7841.8 8034.4 3961.9 4638.5 4703.3 4719.9 4831.7 1934.4 1988.8 1998.1 1998.8 2017.6 826.8 986.9 994.8 1016.2 1019.9 18686.2 19991.4 20930.9 21718.7 21781.8 782.9 984.3 984.7 1026.3 1034.5 9064.7 10102.4 10865.2 11278.7 11399.5 448223.0 658691.0 672168.0 677142.0 679632.0 151101.0 154077.0 155967.0 157757.0 158762.4 1054.2 1077.4 1107.7 1109.8 1112.0 18123.7 18878.4 19763.0 19766.9 19801.0 57841.4 58804.4 60240.0 60618.1 62858.7 85446.6 88694.6 89782.6 90626.0 91386.5 8276.4 8285.4 8591.3 8678.4 8701.1 7943.2 9310.7 12410.8 13117.7 13243.9 10821.9 11189.3 11438.1 11746.0 11850.9 8962.6 10630.6 11254.7 11271.9 11679.4 11538.4 11566.9 11819.1 11820.4 11934.9 8203.4 8351.5 8474.4 8577.6 8657.7 8849.6 11147.4 11256.9 11639.6 11817.1 05:09:12 INFO - PROCESS | 2257 | 05:09:12 INFO - PROCESS | 2257 | [#3] mootools.html Cycles:180 Average:5279.81 Median:5253.33 stddev:2895.38 (55.1%) stddev-sans-first:2887.87 05:09:12 INFO - PROCESS | 2257 | Values: 1276.8 1415.8 1427.9 1432.9 1435.3 8000.6 8413.6 8414.1 8416.1 8435.4 6597.7 8181.4 8216.6 8271.4 8295.6 2213.1 2255.1 2258.8 2263.7 2270.8 2166.7 2248.9 2250.0 2253.6 2280.8 1922.8 1987.8 1989.3 2181.7 2244.0 1840.7 2176.5 2224.2 2253.8 2254.3 2042.9 2051.7 2228.9 2246.7 2268.7 8160.3 8235.1 8241.5 8245.0 8258.2 3919.8 5193.2 5194.7 5194.9 5217.9 3283.9 3442.5 3470.1 3523.9 3531.0 1142.2 1184.2 1235.2 1240.5 1245.0 10569.5 10770.1 10775.9 10783.2 10789.4 4466.2 4555.9 4586.0 4656.6 4682.6 8665.8 8724.8 8725.5 8736.5 8744.7 5055.9 5056.2 5059.0 5059.8 5081.4 4525.4 4690.1 4728.4 4730.9 4781.7 3500.7 3587.7 3620.3 3650.7 3663.0 1117.8 1128.8 1131.2 1143.3 1144.9 647.9 767.5 854.6 858.9 898.7 4289.3 5332.1 5467.5 5637.2 5693.1 829.6 920.9 928.4 941.2 949.3 2752.9 3587.0 3673.8 3777.3 3813.0 7579.4 9729.4 9759.5 9801.4 9816.3 9669.4 9752.1 9788.9 9806.8 9810.3 7290.7 7632.7 7732.8 7733.5 7747.7 5288.7 5695.8 5702.3 5745.3 5790.7 8561.4 8659.7 8948.0 9074.9 9098.2 8942.7 9073.1 9263.5 9383.2 9395.5 6875.9 7092.4 7114.9 7120.6 7129.3 7354.7 7619.4 7700.2 7703.5 7703.6 5407.7 6840.2 6949.2 6994.9 6998.7 5722.6 6874.7 6882.2 6929.8 6964.1 6242.5 6289.3 6370.9 6379.7 6395.6 4835.5 4882.2 4927.2 4958.7 5052.9 4861.3 4881.0 4932.7 4996.3 5030.7 05:09:12 INFO - PROCESS | 2257 | 05:09:12 INFO - PROCESS | 2257 | [#4] prototype.html Cycles:180 Average:4523.06 Median:5010.37 stddev:1340.99 (26.8%) stddev-sans-first:1307.66 05:09:12 INFO - PROCESS | 2257 | Values: 350.1 355.2 365.8 368.3 370.7 4025.9 5025.9 5386.2 5464.8 5487.3 4740.4 4795.4 5255.3 5304.7 5354.6 4182.0 4193.0 4202.6 4209.7 4212.9 3720.2 3875.3 4062.7 4099.3 4257.3 3966.5 4107.4 4194.3 4215.3 4223.8 3554.8 4116.7 4183.8 4194.1 4205.6 3685.6 3701.4 3702.7 3702.8 3733.8 4408.9 4500.0 5181.4 5217.8 5270.5 4613.7 4732.7 4822.7 4852.9 4855.1 4984.8 5083.7 5289.8 5675.4 5677.5 4109.0 4111.9 4146.5 4151.4 4172.2 4901.8 5037.8 5133.5 5430.9 5543.2 4082.7 4180.6 4187.4 4217.5 4236.3 3604.4 4046.7 4248.4 4276.8 4308.0 3989.7 4339.4 4470.8 4878.4 4904.7 4906.9 5666.3 5696.1 5707.1 5709.9 1288.6 1291.4 1376.8 1386.9 1407.7 770.8 884.5 887.6 966.2 970.9 5019.8 5025.2 5033.2 5050.4 5060.0 4864.6 5000.5 5127.4 5201.6 5574.2 4102.1 4708.4 5024.3 5047.4 5053.9 2401.6 2429.4 2606.5 2897.4 2912.5 5315.7 5723.7 5727.3 5757.5 5760.3 4136.4 5530.9 5558.4 5679.2 5967.9 5959.6 6023.8 6031.6 6036.6 6046.4 5178.3 5613.5 5827.2 5867.5 5892.6 4922.4 5079.6 5387.6 5473.2 5488.3 4634.6 5335.4 5474.9 5841.6 6004.0 3895.7 3902.7 3905.5 3908.9 3935.8 4669.2 5517.8 5539.3 5625.1 5642.9 4332.2 5001.0 5499.2 5596.6 5619.6 4776.4 5642.2 5658.2 5673.6 5675.8 5179.6 5510.8 5514.3 5532.0 5585.7 4817.9 5115.9 5649.3 5676.0 5709.2 4519.0 5233.4 5568.8 5569.3 5587.6 05:09:12 INFO - PROCESS | 2257 | 05:09:12 INFO - PROCESS | 2257 | [#5] yui.html Cycles:180 Average:19091.22 Median:23484.17 stddev:26893.64 (114.5%) stddev-sans-first:26933.70 05:09:12 INFO - PROCESS | 2257 | Values: 718.2 749.1 774.4 776.5 789.6 14039.6 14471.3 14537.5 14560.9 14609.3 13010.7 13226.4 13299.2 13334.3 13571.2 848.8 860.3 861.8 861.8 862.4 712.4 823.9 865.2 866.9 870.1 916.0 920.3 922.5 922.8 923.4 916.1 917.5 917.7 917.9 920.2 678.2 678.9 680.3 680.4 683.6 14523.6 14738.2 14765.3 14806.4 14913.7 13429.8 13511.7 13517.0 13754.5 13859.0 10862.8 11233.3 11254.5 11275.3 11729.6 3544.0 3557.7 3560.4 3568.1 3591.0 94643.5 96144.0 96204.0 97841.0 98241.0 10109.8 10259.6 10264.6 10343.1 10755.6 21237.4 21384.3 21506.8 21762.5 21825.3 7276.5 7320.6 7377.1 7389.6 7539.8 3972.8 4041.7 4064.8 4086.6 4091.4 3539.6 3583.7 3612.3 3616.7 3622.3 643.5 645.3 657.4 660.1 663.4 638.2 648.2 648.5 671.9 674.1 9504.8 9602.5 9700.8 9910.5 9933.8 635.8 635.9 653.1 666.7 677.5 4251.9 4320.3 4678.1 4680.7 4710.3 91009.5 97051.0 97086.5 97158.5 98848.5 73634.6 79830.0 79831.0 81504.0 82544.8 70396.0 72658.3 73495.6 73702.6 74806.0 10404.0 10452.7 10457.3 10511.0 10638.3 38529.6 42648.0 44562.6 45092.5 46679.5 59619.8 63287.7 63634.0 63768.7 64685.4 12126.5 12487.9 12559.9 12578.7 12595.2 13599.4 13639.6 13735.0 13735.3 13835.9 12850.9 13011.5 13096.5 13464.1 13672.2 12725.0 12899.7 12927.3 12957.0 13315.7 12484.6 12708.2 12711.5 12939.2 12971.5 10649.4 10713.7 10798.7 10906.3 10973.4 9074.3 9438.7 10440.8 10454.3 10548.4 05:09:12 INFO - PROCESS | 2257 | -------- Summary: end -------- 05:09:12 INFO - PROCESS | 2257 | 05:09:13 INFO - TEST-INFO | 2257: exit 0 05:09:13 INFO - TEST-OK | dromaeo_css | took 1120160ms 05:09:13 INFO - TEST-START | kraken 05:09:13 INFO - operating with platform_type : mac_ 05:09:13 INFO - Initialising browser for kraken test... 05:09:13 INFO - TEST-INFO | started process 2262 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/tmp7eNBnu/profile http://localhost:56424/getInfo.html) 05:09:15 INFO - PROCESS | 2262 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 05:09:15 INFO - PROCESS | 2262 | __metrics Screen width/height:1600/1200 05:09:15 INFO - PROCESS | 2262 | colorDepth:24 05:09:15 INFO - PROCESS | 2262 | Browser inner width/height: 1024/689 05:09:15 INFO - PROCESS | 2262 | __metrics 05:09:15 INFO - PROCESS | 2262 | 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" 05:09:15 INFO - PROCESS | 2262 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:09:16 INFO - TEST-INFO | 2262: exit 0 05:09:16 INFO - Browser initialized. 05:09:16 INFO - Running cycle 1/1 for kraken test... 05:09:16 INFO - TEST-INFO | started process 2263 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/tmp7eNBnu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:09:28 INFO - PROCESS | 2263 | RSS: Main: 235941888 05:09:28 INFO - PROCESS | 2263 | 05:09:31 INFO - PROCESS | 2263 | Cycle 1(1): loaded http://localhost:56424/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56424/tests/kraken/driver.html?testName=audio-beat-detection) 05:09:32 INFO - PROCESS | 2263 | RSS: Main: 288870400 05:09:32 INFO - PROCESS | 2263 | 05:09:35 INFO - PROCESS | 2263 | Cycle 1(1): loaded http://localhost:56424/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56424/tests/kraken/driver.html?testName=audio-dft) 05:09:35 INFO - PROCESS | 2263 | RSS: Main: 290463744 05:09:35 INFO - PROCESS | 2263 | 05:09:39 INFO - PROCESS | 2263 | Cycle 1(1): loaded http://localhost:56424/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56424/tests/kraken/driver.html?testName=audio-fft) 05:09:39 INFO - PROCESS | 2263 | RSS: Main: 381411328 05:09:39 INFO - PROCESS | 2263 | 05:09:41 INFO - PROCESS | 2263 | Cycle 1(1): loaded http://localhost:56424/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56424/tests/kraken/driver.html?testName=audio-oscillator) 05:09:42 INFO - PROCESS | 2263 | RSS: Main: 285782016 05:09:42 INFO - PROCESS | 2263 | 05:09:44 INFO - PROCESS | 2263 | Cycle 1(1): loaded http://localhost:56424/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56424/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:09:45 INFO - PROCESS | 2263 | RSS: Main: 287518720 05:09:45 INFO - PROCESS | 2263 | 05:09:47 INFO - PROCESS | 2263 | Cycle 1(1): loaded http://localhost:56424/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56424/tests/kraken/driver.html?testName=imaging-darkroom) 05:09:48 INFO - PROCESS | 2263 | RSS: Main: 329457664 05:09:48 INFO - PROCESS | 2263 | 05:09:51 INFO - PROCESS | 2263 | Cycle 1(1): loaded http://localhost:56424/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56424/tests/kraken/driver.html?testName=imaging-desaturate) 05:09:52 INFO - PROCESS | 2263 | RSS: Main: 332685312 05:09:52 INFO - PROCESS | 2263 | 05:09:54 INFO - PROCESS | 2263 | Cycle 1(1): loaded http://localhost:56424/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56424/tests/kraken/driver.html?testName=json-parse-financial) 05:09:55 INFO - PROCESS | 2263 | RSS: Main: 330022912 05:09:55 INFO - PROCESS | 2263 | 05:09:57 INFO - PROCESS | 2263 | Cycle 1(1): loaded http://localhost:56424/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56424/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:09:57 INFO - PROCESS | 2263 | RSS: Main: 305397760 05:09:57 INFO - PROCESS | 2263 | 05:09:59 INFO - PROCESS | 2263 | Cycle 1(1): loaded http://localhost:56424/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56424/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:10:00 INFO - PROCESS | 2263 | RSS: Main: 309637120 05:10:00 INFO - PROCESS | 2263 | 05:10:02 INFO - PROCESS | 2263 | Cycle 1(1): loaded http://localhost:56424/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56424/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:10:03 INFO - PROCESS | 2263 | RSS: Main: 310337536 05:10:03 INFO - PROCESS | 2263 | 05:10:06 INFO - PROCESS | 2263 | Cycle 1(1): loaded http://localhost:56424/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56424/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:10:07 INFO - PROCESS | 2263 | RSS: Main: 329752576 05:10:07 INFO - PROCESS | 2263 | 05:10:10 INFO - PROCESS | 2263 | Cycle 1(1): loaded http://localhost:56424/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56424/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:10:10 INFO - PROCESS | 2263 | RSS: Main: 323342336 05:10:10 INFO - PROCESS | 2263 | 05:10:12 INFO - PROCESS | 2263 | Cycle 1(1): loaded http://localhost:56424/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56424/tests/kraken/driver.html?testName=ai-astar) 05:10:12 INFO - PROCESS | 2263 | RSS: Main: 368095232 05:10:12 INFO - PROCESS | 2263 | 05:10:12 INFO - PROCESS | 2263 | __start_tp_report 05:10:12 INFO - PROCESS | 2263 | _x_x_mozilla_page_load 05:10:12 INFO - PROCESS | 2263 | _x_x_mozilla_page_load_details 05:10:12 INFO - PROCESS | 2263 | |i|pagename|runs| 05:10:12 INFO - PROCESS | 2263 | |0;ai-astar;113;115;115;115;114;115;114;115;114;128 05:10:12 INFO - PROCESS | 2263 | |1;audio-beat-detection;141;110;109;149;113;113;115;112;132;118 05:10:12 INFO - PROCESS | 2263 | |2;audio-dft;186;187;188;184;184;187;181;185;184;184 05:10:12 INFO - PROCESS | 2263 | |3;audio-fft;83;58;59;87;71;74;61;59;76;59 05:10:12 INFO - PROCESS | 2263 | |4;audio-oscillator;88;70;89;68;70;70;86;68;70;85 05:10:12 INFO - PROCESS | 2263 | |5;imaging-gaussian-blur;87;86;87;86;87;87;86;86;87;87 05:10:12 INFO - PROCESS | 2263 | |6;imaging-darkroom;95;94;94;94;95;94;95;94;94;94 05:10:12 INFO - PROCESS | 2263 | |7;imaging-desaturate;85;88;86;87;86;88;130;138;86;87 05:10:12 INFO - PROCESS | 2263 | |8;json-parse-financial;60;59;59;57;57;58;59;59;58;59 05:10:12 INFO - PROCESS | 2263 | |9;json-stringify-tinderbox;66;69;73;80;74;73;72;72;72;74 05:10:12 INFO - PROCESS | 2263 | |10;stanford-crypto-aes;89;95;90;88;82;92;83;100;113;108 05:10:12 INFO - PROCESS | 2263 | |11;stanford-crypto-ccm;146;145;137;139;154;149;153;143;185;161 05:10:12 INFO - PROCESS | 2263 | |12;stanford-crypto-pbkdf2;175;178;173;175;172;169;175;174;176;172 05:10:12 INFO - PROCESS | 2263 | |13;stanford-crypto-sha256-iterative;68;67;69;77;83;73;66;66;66;65 05:10:12 INFO - PROCESS | 2263 | __end_tp_report 05:10:12 INFO - PROCESS | 2263 | __start_cc_report 05:10:12 INFO - PROCESS | 2263 | _x_x_mozilla_cycle_collect,2204 05:10:12 INFO - PROCESS | 2263 | __end_cc_report 05:10:12 INFO - PROCESS | 2263 | __startTimestamp1486991412699__endTimestamp 05:10:12 INFO - PROCESS | 2263 | 05:10:12 INFO - PROCESS | 2263 | ------- Summary: start ------- 05:10:12 INFO - PROCESS | 2263 | Number of tests: 14 05:10:12 INFO - PROCESS | 2263 | 05:10:12 INFO - PROCESS | 2263 | [#0] ai-astar Cycles:10 Average:115.80 Median:115.00 stddev:4.34 (3.8%) stddev-sans-first:4.48 05:10:12 INFO - PROCESS | 2263 | Values: 113.0 115.0 115.0 115.0 114.0 115.0 114.0 115.0 114.0 128.0 05:10:12 INFO - PROCESS | 2263 | 05:10:12 INFO - PROCESS | 2263 | [#1] audio-beat-detection Cycles:10 Average:121.20 Median:116.50 stddev:14.23 (12.2%) stddev-sans-first:13.17 05:10:12 INFO - PROCESS | 2263 | Values: 141.0 110.0 109.0 149.0 113.0 113.0 115.0 112.0 132.0 118.0 05:10:12 INFO - PROCESS | 2263 | 05:10:12 INFO - PROCESS | 2263 | [#2] audio-dft Cycles:10 Average:185.00 Median:185.50 stddev:2.05 (1.1%) stddev-sans-first:2.15 05:10:12 INFO - PROCESS | 2263 | Values: 186.0 187.0 188.0 184.0 184.0 187.0 181.0 185.0 184.0 184.0 05:10:12 INFO - PROCESS | 2263 | 05:10:12 INFO - PROCESS | 2263 | [#3] audio-fft Cycles:10 Average:68.70 Median:72.50 stddev:10.97 (15.1%) stddev-sans-first:10.34 05:10:12 INFO - PROCESS | 2263 | Values: 83.0 58.0 59.0 87.0 71.0 74.0 61.0 59.0 76.0 59.0 05:10:12 INFO - PROCESS | 2263 | 05:10:12 INFO - PROCESS | 2263 | [#4] audio-oscillator Cycles:10 Average:76.40 Median:77.50 stddev:9.22 (11.9%) stddev-sans-first:8.77 05:10:12 INFO - PROCESS | 2263 | Values: 88.0 70.0 89.0 68.0 70.0 70.0 86.0 68.0 70.0 85.0 05:10:12 INFO - PROCESS | 2263 | 05:10:12 INFO - PROCESS | 2263 | [#5] imaging-gaussian-blur Cycles:10 Average:86.60 Median:87.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 05:10:12 INFO - PROCESS | 2263 | Values: 87.0 86.0 87.0 86.0 87.0 87.0 86.0 86.0 87.0 87.0 05:10:12 INFO - PROCESS | 2263 | 05:10:12 INFO - PROCESS | 2263 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 05:10:12 INFO - PROCESS | 2263 | Values: 95.0 94.0 94.0 94.0 95.0 94.0 95.0 94.0 94.0 94.0 05:10:12 INFO - PROCESS | 2263 | 05:10:12 INFO - PROCESS | 2263 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:86.50 stddev:20.09 (23.2%) stddev-sans-first:20.90 05:10:12 INFO - PROCESS | 2263 | Values: 85.0 88.0 86.0 87.0 86.0 88.0 130.0 138.0 86.0 87.0 05:10:12 INFO - PROCESS | 2263 | 05:10:12 INFO - PROCESS | 2263 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:59.00 stddev:0.97 (1.6%) stddev-sans-first:0.87 05:10:12 INFO - PROCESS | 2263 | Values: 60.0 59.0 59.0 57.0 57.0 58.0 59.0 59.0 58.0 59.0 05:10:12 INFO - PROCESS | 2263 | 05:10:12 INFO - PROCESS | 2263 | [#9] json-stringify-tinderbox Cycles:10 Average:72.50 Median:73.00 stddev:3.60 (4.9%) stddev-sans-first:2.95 05:10:12 INFO - PROCESS | 2263 | Values: 66.0 69.0 73.0 80.0 74.0 73.0 72.0 72.0 72.0 74.0 05:10:12 INFO - PROCESS | 2263 | 05:10:12 INFO - PROCESS | 2263 | [#10] stanford-crypto-aes Cycles:10 Average:94.00 Median:88.50 stddev:10.22 (11.5%) stddev-sans-first:10.68 05:10:12 INFO - PROCESS | 2263 | Values: 89.0 95.0 90.0 88.0 82.0 92.0 83.0 100.0 113.0 108.0 05:10:12 INFO - PROCESS | 2263 | 05:10:12 INFO - PROCESS | 2263 | [#11] stanford-crypto-ccm Cycles:10 Average:151.20 Median:151.00 stddev:13.89 (9.2%) stddev-sans-first:14.61 05:10:12 INFO - PROCESS | 2263 | Values: 146.0 145.0 137.0 139.0 154.0 149.0 153.0 143.0 185.0 161.0 05:10:12 INFO - PROCESS | 2263 | 05:10:12 INFO - PROCESS | 2263 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.90 Median:175.00 stddev:2.51 (1.4%) stddev-sans-first:2.64 05:10:12 INFO - PROCESS | 2263 | Values: 175.0 178.0 173.0 175.0 172.0 169.0 175.0 174.0 176.0 172.0 05:10:12 INFO - PROCESS | 2263 | 05:10:12 INFO - PROCESS | 2263 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:68.50 stddev:5.91 (8.6%) stddev-sans-first:6.22 05:10:12 INFO - PROCESS | 2263 | Values: 68.0 67.0 69.0 77.0 83.0 73.0 66.0 66.0 66.0 65.0 05:10:12 INFO - PROCESS | 2263 | -------- Summary: end -------- 05:10:12 INFO - PROCESS | 2263 | 05:10:13 INFO - TEST-INFO | 2263: exit 0 05:10:13 INFO - TEST-OK | kraken | took 60052ms 05:10:13 INFO - SUITE-END | took 1180s 05:10:13 INFO - Completed test suite (00:19:40) 05:10:13 INFO - javascript benchmark 05:10:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7086.056261520303, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3272.2146684795644, 3276.9508457373136, 3277.4756039033746, 3305.3554556861422, 3320.6015278166624, 5396.487333703292, 5527.55779537637, 5580.972095139524, 5626.578006649497, 5640.9999999999945, 5459.071957767179, 5475.5072043516075, 5525.613207075507, 5539.058360078786, 5553.583481238903, 4966.627502937276, 4986.152354099793, 5036.471170527097, 5040.672356296847, 5084.262781896623, 5166.405863325709, 5175.689458632494, 5176.482351764831, 5201.817936372227, 5227.0, 4959.181735013718, 4998.775055122492, 5001.824936127255, 5058.747062646889, 5120.718360490171, 5035.647504674675, 5045.445001049881, 5048.671836330626, 5053.570446512051, 5067.9239811402485, 4960.677555958887, 4985.825496107619, 4994.475580064077, 5000.924986125211, 5005.374328208974, 5454.890902181974, 5457.672539647634, 5463.0, 5469.753861076221, 5470.64440811346, 5899.498542623882, 5902.173695682608, 5908.497777688902, 5911.261092363455, 5912.201852749867, 6085.9087113692885, 6104.890867003787, 6112.442689633878, 6129.1725617041575, 6132.030754953286, 5596.0, 5663.631863928873, 5679.261695979579, 5679.346875109332, 5681.261436013333, 6313.905291420632, 6317.526185536103, 6325.0, 6335.778247761306, 6373.298937116913, 5738.713064346849, 5788.957987562195, 5804.65172089676, 6017.879642407127, 6033.5474839387225, 5994.37059108796, 6007.609505382136, 6008.188894499187, 6012.699365031731, 6020.518358531307, 5890.528757699374, 5893.705314734246, 5896.1450589664255, 5900.734466948998, 5902.852428689232, 5883.970580147072, 5937.139114828412, 5940.8811823764145, 5941.049432090845, 5962.135490353961, 4334.674899382559, 4735.526447355306, 4829.637777166727, 4866.9513304867205, 4881.731504767201, 4299.97850010748, 4309.482862056573, 4328.7402755834755, 4330.198913201068, 4339.500957389878, 5530.806421775219, 5646.265985421951, 5651.095824668033, 5674.829755107354, 5679.943200567942, 6211.875762484725, 6238.719257633417, 6245.812625621239, 6261.154744109578, 6263.091851681572, 5433.592480563973, 5472.781088756406, 5482.314710661168, 5625.774969001194, 5627.5779316551425, 5221.086309895753, 5320.920186197211, 5345.732713364394, 5383.892322153535, 5441.564674826004, 6329.145565348619, 6329.3354197809485, 6340.873182536231, 6341.27075386318, 6358.0, 5843.065109582616, 6198.132261483306, 6205.100260462298, 6222.439980401786, 6227.813165605039, 6155.169052177898, 6195.070739389128, 6216.751329946932, 6244.063390491281, 6278.6860656966055, 6083.543734219863, 6090.177825993434, 6109.450149486567, 6109.694515274307, 6133.84665383369, 5049.621278404208, 6132.0, 6135.53983451234, 6140.692965351625, 6143.047827586731, 5734.111212762028, 5753.280839895013, 5788.044972579477, 5931.495822854933, 5988.790392336247, 5329.960657671717, 5805.129230615442, 5988.311344195473, 6027.547933904887, 6079.696015199134, 5831.766729330949, 5856.385079566755, 5860.443257890493, 5861.3845546217035, 5888.057910734433, 5734.971325143348, 5803.564732644984, 5982.551308651781, 6007.939920600913, 6039.6678182698615, 5713.542916566582, 5717.42825717425, 5726.713664316684, 5732.627379220337, 5733.082706766897], "value": 5550.56535928893, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [454.81807277089166, 482.6380214838871, 484.45982729256843, 508.9160288552389, 515.6983164848564, 21572.89213553932, 37797.81101094494, 39407.40888886669, 39418.80290598547, 39626.60373396265, 40126.59873401265, 40650.796746016225, 40672.38991415131, 40764.79617601908, 40779.0, 7820.843583128334, 9059.864102038458, 9288.72133835986, 9288.907110928905, 9289.256859451227, 7831.099423566277, 7932.444728868982, 7935.880961785578, 7941.08677502086, 10802.0, 10792.406417647066, 10811.243212975094, 10811.405372704497, 10820.783584328348, 10837.729056773604, 10927.836082458729, 10950.616728414467, 10984.395858227834, 10993.065589424908, 11007.954244346774, 7758.340541054017, 7957.721479748181, 10839.078678312353, 10900.890991090067, 10938.124950003981, 37663.62336376629, 38331.425028624595, 38411.47005009155, 39423.60576394228, 39523.0, 3703.648153425447, 3727.0, 3753.5120434343635, 3769.491118698968, 3784.9432258516144, 28291.575626365415, 28296.71703282982, 28535.429291414057, 28641.57037644437, 28745.42509149805, 3020.9546856797165, 3036.30165062037, 3111.159986803573, 3148.5906832111677, 3154.0853152585723, 441687.79156104336, 441952.0, 443543.6861655074, 443734.0, 452083.47916521074, 59247.40752592419, 60269.698651506464, 60372.39627603668, 60608.0, 60624.69687651622, 62141.0, 62302.0, 62494.0625890612, 62597.37402625915, 62654.0, 14303.28483575817, 14763.409463621334, 14777.039492433172, 14804.555863324118, 14819.77770333446, 11297.152713546517, 11351.94324028391, 11393.544258229744, 11394.25937314072, 11400.087992960543, 16800.411985580446, 17120.74318885218, 17127.74572831158, 17150.228239729244, 17168.22742976569, 5654.6324488908085, 5705.429457054262, 6811.25076241613, 6841.247462779091, 6849.383555479931, 784.697891311849, 806.3710305961359, 835.2065537739172, 841.9559745915021, 854.2610641794803, 23597.646035309484, 26794.062207822633, 27952.30119247035, 28686.676478313075, 28971.855140724583, 990.0, 995.581855620641, 997.7954519323521, 1035.0787798859021, 1042.0725554256717, 14589.562313130624, 14674.926625366805, 14682.889204050744, 14777.335019924129, 14787.260636968109, 555470.0, 559503.0, 559525.0, 560147.0, 560580.0, 56195.43804561902, 56377.154342684895, 56389.87220255572, 56513.71743141258, 56725.0, 1123.685368096934, 1179.2334982261598, 1278.3288773394042, 1326.4826717580152, 1334.219481603273, 20371.0, 27926.3018424541, 28594.999175029607, 29638.110856674335, 30122.24694382658, 49266.26100608565, 49855.750721246164, 49865.75067124641, 49908.0, 49947.50157495281, 529771.0, 536966.3151684217, 539178.0, 539263.0, 539876.0, 23623.039161776218, 23824.16615418452, 23885.164019259937, 24037.278881633578, 24121.51756964886, 39490.802545987084, 39780.0, 39791.00522486845, 40946.385804213554, 41159.0, 27547.86226068857, 31742.36515269728, 32103.839480802446, 33125.33749325048, 34671.95984120481, 32615.369231538803, 32841.50737738888, 33726.325473490884, 33805.32389352249, 34999.7750078746, 27144.457110857278, 33398.833005834815, 33622.327553448304, 33630.49554256737, 34082.65917340795, 21475.46311342229, 29109.85445072761, 29781.10656680303, 29850.85074574613, 30558.0, 20991.790082098985, 23036.539269214856, 23063.705592604765, 23192.652110218023, 23387.532249354575], "value": 18587.957992734973, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.0569946894711, 381.2946049807856, 387.3589209857686, 395.5174686882004, 422.37699393394746, 14190.858091419082, 14761.0, 19010.61978760424, 20060.398188054347, 20341.084651190697, 20223.59552808943, 20559.280425185123, 20639.968001599937, 20930.0, 21066.157353705832, 5578.2748242728385, 5881.382454842244, 5886.293644762634, 5893.410658934115, 5915.467607915287, 3943.467631869704, 4040.7373520721208, 4092.0997380576373, 4139.648129908961, 5741.311042674884, 6303.306636270029, 6380.521460890452, 6382.329855365167, 6392.360763923617, 6398.808035758934, 5512.145617429305, 5753.165790960329, 5849.473547380713, 6365.58623689461, 6365.777197798078, 5735.885282294331, 5741.799037033726, 5743.167240750068, 5754.539636829044, 5766.62516936402, 13349.265790381525, 17095.316187352615, 18907.338243161423, 24844.50310993788, 25370.365740856443, 2464.6116618453125, 2465.3836540864786, 2502.8373155744816, 2520.1305549585363, 2530.4053547416343, 9432.0, 10338.53476593555, 10375.533101010473, 10376.014278643517, 14287.57137285883, 1740.2342969093559, 1824.9452516424528, 1830.5789668376215, 1859.33064096925, 1863.8229368209998, 129357.0, 134586.0, 140224.0, 141668.0, 144023.0, 8247.051768938589, 9947.900520994843, 11114.110601197815, 11121.16591255643, 11650.825237621442, 13859.099158554662, 14795.482158124629, 15488.922555387377, 15511.301991410413, 15547.123782100347, 8196.959015204886, 8217.671293148207, 8274.089850116483, 8287.254147126787, 8397.6221070052, 6404.583702059351, 6893.827654308582, 7465.7013719450615, 7841.843163136706, 8034.357251419872, 3961.8613348532663, 4638.536146385402, 4703.341532185496, 4719.905601888012, 4831.661783675179, 1934.3809980806288, 1988.7514060742408, 1998.1407994562187, 1998.8400927925732, 2017.636825371418, 826.8057006603443, 986.9358491698017, 994.8060128274917, 1016.2479764974014, 1019.8623185869812, 18686.159122839505, 19991.40025799228, 20930.89534552348, 21718.674219886714, 21781.782182178293, 782.8512582609286, 984.2962281968427, 984.6947446291673, 1026.2559644257854, 1034.4569101221769, 9064.682736104205, 10102.444365559817, 10865.207240805179, 11278.7180320491, 11399.544018239343, 448223.0, 658691.0, 672168.0, 677142.0, 679632.0, 151101.0, 154077.0, 155967.01649175413, 157757.0, 158762.4123758771, 1054.1988089052375, 1077.4020418667715, 1107.6898468428853, 1109.8224284114503, 1112.0158659586164, 18123.72814407811, 18878.433646990612, 19763.0, 19766.91281979505, 19801.009949502757, 57841.42158578528, 58804.41195587989, 60240.0, 60618.05784669639, 62858.685706571174, 85446.57276713576, 88694.55652721695, 89782.55108724415, 90626.0, 91386.54306728423, 8276.379271554537, 8285.4200205985, 8591.312694984512, 8678.435901666371, 8701.129887011248, 7943.165967573322, 9310.72067837966, 12410.75178496407, 13117.672058198239, 13243.933780331037, 10821.863704310934, 11189.272697274651, 11438.08495320389, 11746.0, 11850.940745296562, 8962.596683149144, 10630.618019657395, 11254.718632034264, 11271.887281127083, 11679.416029198675, 11538.365389903636, 11566.94216528912, 11819.11356648272, 11820.40897955116, 11934.880651193376, 8203.384746144182, 8351.540665263226, 8474.364422668448, 8577.571121443778, 8657.653693852175, 8849.601767920587, 11147.442627868411, 11256.943715281372, 11639.59261425846, 11817.054635629302], "value": 9639.57609162411, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1276.8148618450323, 1415.8159439272893, 1427.9000469967093, 1432.8925330600207, 1435.3397437178896, 8000.639971201295, 8413.621387037583, 8414.074451810304, 8416.116307787686, 8435.40952133351, 6597.736090556372, 8181.386396020307, 8216.58917054148, 8271.379646526504, 8295.626696798643, 2213.081571147976, 2255.12050300383, 2258.841881068326, 2263.7057182566246, 2270.8069814065743, 2166.7399912010583, 2248.8875556222124, 2250.0437314141504, 2253.6281513550243, 2280.806131478818, 1922.7788804287545, 1987.8310343620738, 1989.2639723302325, 2181.7381914170323, 2243.9663405048937, 1840.7330937014192, 2176.5102851858364, 2224.1881713174735, 2253.752087270407, 2254.3011666383472, 2042.8662092538634, 2051.651219292724, 2228.9219877304376, 2246.6969157888384, 2268.727752669674, 8160.26557609818, 8235.13531079234, 8241.546714930677, 8245.0, 8258.215469530385, 3919.7844118573466, 5193.246979188034, 5194.68831870089, 5194.896102077937, 5217.921731174036, 3283.868645254187, 3442.535257740198, 3470.0977745786026, 3523.894283171509, 3531.0, 1142.2232881640482, 1184.2420850655587, 1235.2403271987753, 1240.5161986825146, 1245.035097799213, 10569.524371403306, 10770.138388928945, 10775.892241077645, 10783.191260655403, 10789.352638841694, 4466.196084704784, 4555.886102847389, 4586.036932244266, 4656.580907718321, 4682.648801339913, 8665.783355416164, 8724.825503489894, 8725.52009639476, 8736.519491428033, 8744.69393571222, 5055.8988820223385, 5056.241563765391, 5058.974705126451, 5059.822906198339, 5081.364829396325, 4525.434320709911, 4690.061987602493, 4728.432588089382, 4730.905381892412, 4781.6891902026255, 3500.6674365935196, 3587.65917237862, 3620.2759448110482, 3650.671439570451, 3662.9633703663153, 1117.8486159255979, 1128.7573171768108, 1131.2081542919825, 1143.3197247637643, 1144.9370284634424, 647.9287278399372, 767.4819496839611, 854.6026097864523, 858.8668756342777, 898.7169041751959, 4289.335153051282, 5332.093544097435, 5467.535259502987, 5637.210790489335, 5693.089105743061, 829.6059371798348, 920.8756817829641, 928.3965422475445, 941.1905761045496, 949.3164921256684, 2752.8898844046416, 3587.0, 3673.834677439468, 3777.33896568105, 3812.980935095307, 7579.393648508106, 9729.416235025921, 9759.463229522302, 9801.411915285105, 9816.312858099864, 9669.419834809934, 9752.073553012453, 9788.9021109788, 9806.803863922823, 9810.264230182765, 7290.708371665074, 7632.69469221225, 7732.757500324955, 7733.49732267412, 7747.651355689008, 5288.7355632219005, 5695.800646977336, 5702.315722113373, 5745.2818397700285, 5790.710464476675, 8561.400701951054, 8659.740207793777, 8948.0, 9074.909250907407, 9098.226650734498, 8942.73171804847, 9073.13805188506, 9263.53682315895, 9383.202427793442, 9395.530223488935, 6875.89686154698, 7092.361687448154, 7114.893276600752, 7120.60836653989, 7129.287071292829, 7354.70581176747, 7619.352355049883, 7700.229977002255, 7703.499272547267, 7703.614819259126, 5407.675539467645, 6840.247572767091, 6949.235584085645, 6994.860102798018, 6998.6500674967065, 5722.570807189394, 6874.65626718652, 6882.242953275236, 6929.826754331182, 6964.129483814523, 6242.469390101892, 6289.339619339903, 6370.9487934492145, 6379.712912918837, 6395.552311338161, 4835.492273311252, 4882.170031094652, 4927.187014142626, 4958.652894297509, 5052.873678158076, 4861.295112208781, 4880.975595122001, 4932.654714169974, 4996.325496057985, 5030.673006254582], "value": 4274.163030670307, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.08452895677794, 355.2167470727047, 365.8097789149642, 368.3020675819321, 370.7034372501998, 4025.879223623296, 5025.924611130827, 5386.165144402614, 5464.808731694391, 5487.286652735143, 4740.407449068866, 4795.448523419799, 5255.290535777678, 5304.673831542114, 5354.5716342692585, 4182.017225951899, 4192.979035104828, 4202.642775364097, 4209.663226941837, 4212.894677633069, 3720.2001569662516, 3875.302445559798, 4062.6546743526687, 4099.3441049432095, 4257.254980378437, 3966.4843570335815, 4107.363358679395, 4194.349875769245, 4215.283401821697, 4223.831046758126, 3554.8222588870453, 4116.650084742801, 4183.832646694159, 4194.0982688721915, 4205.5794420558, 3685.649863262986, 3701.370766969622, 3702.7037836973245, 3702.796346200958, 3733.8133093345223, 4408.911821763547, 4500.049746293875, 5181.393767931953, 5217.765200565984, 5270.525652691276, 4613.723176609415, 4732.716037037754, 4822.68652537584, 4852.902941941176, 4855.126077306083, 4984.825531106394, 5083.669561478529, 5289.788408463657, 5675.404082571312, 5677.460641239076, 4109.013836679175, 4111.938320925188, 4146.460960075171, 4151.356539736345, 4172.228137794517, 4901.803927842882, 5037.848864534069, 5133.537981581639, 5430.877245583765, 5543.223948647193, 4082.7346222495444, 4180.581941805795, 4187.361961964004, 4217.451731274915, 4236.2586547354085, 3604.3692353837973, 4046.716729828943, 4248.383984322256, 4276.807543660543, 4308.030693094029, 3989.7007724420782, 4339.392485052095, 4470.754108524063, 4878.365812444359, 4904.705717656952, 4906.852794416173, 5666.320041595035, 5696.060150075191, 5707.1153971134545, 5709.942900570941, 1288.5554483703108, 1291.373683763374, 1376.8347798264272, 1386.9029167958347, 1407.7325308191412, 770.7649167004006, 884.4516399832145, 887.587271918561, 966.1594412860856, 970.8883328588727, 5019.774110165052, 5025.246213067996, 5033.245013247969, 5050.368703912011, 5060.0, 4864.610831133501, 5000.524950129732, 5127.359080114986, 5201.635885487979, 5574.163875418639, 4102.097538541516, 4708.375610414401, 5024.271480635288, 5047.419546752097, 5053.949460505348, 2401.6157414813547, 2429.4047958250344, 2606.5012617744874, 2897.3625802323877, 2912.475754364235, 5315.687675861012, 5723.6851973141875, 5727.312722473246, 5757.481826635623, 5760.251167348301, 4136.420901073852, 5530.889382212334, 5558.360788509373, 5679.2333035040565, 5967.910481342783, 5959.553033522417, 6023.807382087501, 6031.577789554689, 6036.637801731822, 6046.365131661112, 5178.326817513699, 5613.522850557748, 5827.193569993316, 5867.479512292591, 5892.616979896293, 4922.409310882717, 5079.619028572945, 5387.568994480511, 5473.151661492475, 5488.286522752017, 4634.629229661687, 5335.413104558418, 5474.864802727019, 5841.649501029951, 6004.037335358817, 3895.7078219133114, 3902.746321489094, 3905.453236546829, 3908.863189788344, 3935.8228879701055, 4669.206234940137, 5517.834464966058, 5539.252200952981, 5625.109241179686, 5642.915356269741, 4332.176886391576, 5000.974995125001, 5499.230107784833, 5596.636218645775, 5619.628223066127, 4776.426828780569, 5642.181883626933, 5658.179563963285, 5673.574481913955, 5675.77296908119, 5179.613202269597, 5510.8071217507195, 5514.310711161105, 5532.008476948376, 5585.748641311232, 4817.9036419272115, 5115.9232611510115, 5649.265595472562, 5675.971620141873, 5709.22925405065, 4518.9548104519845, 5233.424323324355, 5568.8233824631525, 5569.275994120739, 5587.6088673794075], "value": 4111.711896439574, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.1578554732187, 749.0823740917374, 774.3882332956961, 776.5301992294662, 789.6407134753688, 14039.578812635624, 14471.276436178176, 14537.49118780843, 14560.92719536401, 14609.342579583918, 13010.674733131676, 13226.404811783494, 13299.202047877134, 13334.266615336153, 13571.185728856275, 848.7835601921516, 860.3246451535515, 861.8147098373848, 861.8276344731079, 862.4351050062219, 712.4478529139906, 823.8558252305852, 865.2385900407664, 866.9176428239307, 870.1342164546254, 915.9679411220609, 920.2775820980531, 922.4649703172178, 922.7693076730817, 923.3813345058827, 916.1296768070293, 917.47703808829, 917.7292698653846, 917.8531434970373, 920.1994264989435, 678.223434167875, 678.8981652752127, 680.3128839871715, 680.3740558686021, 683.5830143612393, 14523.564293071226, 14738.189399583018, 14765.33555989983, 14806.407743690239, 14913.70172596542, 13429.798553021712, 13511.66220844477, 13516.986226033086, 13754.518591849237, 13859.0, 10862.762850903167, 11233.269837460539, 11254.549818007352, 11275.32348059119, 11729.589464368706, 3543.964560354389, 3557.7153827693724, 3560.4481305397703, 3568.125809176768, 3590.982045089784, 94643.52678236633, 96144.0, 96204.0, 97840.99999999929, 98241.0175898239, 10109.797804043877, 10259.631490787204, 10264.58941642326, 10343.120834729132, 10755.56977720898, 21237.36287911365, 21384.251551195634, 21506.784932150476, 21762.455938601346, 21825.345239642837, 7276.454265930077, 7320.633968301564, 7377.114746230487, 7389.556626602421, 7539.811504712426, 3972.781497017692, 4041.7372870763306, 4064.776437295918, 4086.6117718816663, 4091.4067460218102, 3539.557555305587, 3583.6595523425235, 3612.313660404515, 3616.728745344057, 3622.2755448910325, 643.5334382572692, 645.3256347117274, 657.3557913245047, 660.1286302081206, 663.426136392027, 638.1703785079378, 648.1962366665396, 648.4763281389239, 671.8958561422987, 674.1236392689484, 9504.809903801885, 9602.471864047404, 9700.757481062888, 9910.454924979196, 9933.751656208507, 635.8156134720879, 635.9077933699588, 653.1476423267586, 666.6566718140161, 677.461418172554, 4251.936220956688, 4320.330348795942, 4678.111158879802, 4680.7114522334705, 4710.26990816424, 91009.54495227481, 97051.02948970562, 97086.51456742812, 97158.51420742992, 98848.50575747075, 73634.63182684052, 79830.0, 79831.0, 81504.0, 82544.76182857262, 70396.0, 72658.2734172662, 73495.63252183812, 73702.63148684222, 74806.0, 10404.015305868967, 10452.68641940743, 10457.26799124054, 10511.0, 10638.255322127377, 38529.614703853724, 42648.0, 44562.55437445714, 45092.54907450883, 46679.53320466888, 59619.807603848545, 63287.68356158374, 63634.0, 63768.68115659392, 64685.35314646982, 12126.454309555915, 12487.875121248671, 12559.93720031394, 12578.685532861751, 12595.181313214613, 13599.388027538587, 13639.590812275648, 13734.976750174592, 13735.313234338044, 13835.86164138386, 12850.871491284968, 13011.479540818262, 13096.476140954255, 13464.05751597418, 13672.179669219879, 12725.0, 12899.742005160031, 12927.288999104763, 12957.028222883133, 13315.733685326433, 12484.625461236177, 12708.237505749685, 12711.491540338282, 12939.223646581235, 12971.5459958901, 10649.414282214553, 10713.678589642012, 10798.73003174927, 10906.291091079054, 10973.3964631946, 9074.274058075207, 9438.669646562337, 10440.843387349043, 10454.268201225841, 10548.419836908737], "value": 7242.372577064792, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1464.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 115.0, 115.0, 114.0, 115.0, 114.0, 115.0, 114.0, 128.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 110.0, 109.0, 149.0, 113.0, 113.0, 115.0, 112.0, 132.0, 118.0], "value": 121.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 187.0, 188.0, 184.0, 184.0, 187.0, 181.0, 185.0, 184.0, 184.0], "value": 185.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 59.0, 87.0, 71.0, 74.0, 61.0, 59.0, 76.0, 59.0], "value": 68.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 89.0, 68.0, 70.0, 70.0, 86.0, 68.0, 70.0, 85.0], "value": 76.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 87.0, 86.0, 87.0, 87.0, 86.0, 86.0, 87.0, 87.0], "value": 86.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 86.0, 87.0, 86.0, 88.0, 130.0, 138.0, 86.0, 87.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 57.0, 57.0, 58.0, 59.0, 59.0, 58.0, 59.0], "value": 58.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 73.0, 80.0, 74.0, 73.0, 72.0, 72.0, 72.0, 74.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 95.0, 90.0, 88.0, 82.0, 92.0, 83.0, 100.0, 113.0, 108.0], "value": 94.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 137.0, 139.0, 154.0, 149.0, 153.0, 143.0, 185.0, 161.0], "value": 151.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 178.0, 173.0, 175.0, 172.0, 169.0, 175.0, 174.0, 176.0, 172.0], "value": 173.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 69.0, 77.0, 83.0, 73.0, 66.0, 66.0, 66.0, 65.0], "value": 70.0, "unit": "score"}]}]} 05:10:13 INFO - Return code: 0 05:10:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:10:14 ERROR - # TBPL SUCCESS # 05:10:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:10:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:10:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:10:14 INFO - 2017-02-13 05:10:14.057 screenresolution[2267:26712] starting screenresolution argv=screenresolution get 05:10:14 INFO - 2017-02-13 05:10:14.060 screenresolution[2267:26712] Display 0: 1600x1200x32@60 05:10:14 INFO - 2017-02-13 05:10:14.066 screenresolution[2268:26715] starting screenresolution argv=screenresolution list 05:10:14 INFO - Available Modes on Display 0 05:10:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:10:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:10:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:10:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:10:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:10:14 INFO - Intel Iris: 05:10:14 INFO - Chipset Model: Intel Iris 05:10:14 INFO - Type: GPU 05:10:14 INFO - Bus: Built-In 05:10:14 INFO - VRAM (Dynamic, Max): 1536 MB 05:10:14 INFO - Vendor: Intel (0x8086) 05:10:14 INFO - Device ID: 0x0a2e 05:10:14 INFO - Revision ID: 0x0009 05:10:14 INFO - Displays: 05:10:14 INFO - Display: 05:10:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:10:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:10:14 INFO - Display Serial Number: 1600x1200 60 05:10:14 INFO - Main Display: Yes 05:10:14 INFO - Mirror: Off 05:10:14 INFO - Online: Yes 05:10:14 INFO - Rotation: Supported 05:10:14 INFO - Return code: 0 05:10:14 INFO - Running post-action listener: _resource_record_post_action 05:10:14 INFO - [mozharness: 2017-02-13 13:10:14.301147Z] Finished run-tests step (success) 05:10:14 INFO - Running post-run listener: _resource_record_post_run 05:10:14 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 196608; Write bytes: 554065920; Read time: 3; Write time: 1614 05:10:14 INFO - TinderboxPrint: CPU usage
53.7% 05:10:14 INFO - TinderboxPrint: I/O read bytes / time
196,608 / 3 05:10:14 INFO - TinderboxPrint: I/O write bytes / time
554,065,920 / 1,614 05:10:14 INFO - TinderboxPrint: CPU idle
2,226.7 (46.3%) 05:10:14 INFO - TinderboxPrint: CPU system
962.8 (20.0%) 05:10:14 INFO - TinderboxPrint: CPU user
1,624.3 (33.7%) 05:10:14 INFO - TinderboxPrint: Swap in / out
252,329,984 / 0 05:10:14 INFO - install - Wall time: 23s; CPU: 55.0%; Read bytes: 240536064; Write bytes: 235935744; Read time: 17318; Write time: 473 05:10:14 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 196608; Write bytes: 296663040; Read time: 3; Write time: 1097 05:10:14 INFO - Running post-run listener: _upload_blobber_files 05:10:14 INFO - Blob upload gear active. 05:10:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:10:14 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:10:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:10:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:10:15 INFO - (blobuploader) - INFO - Open directory for files ... 05:10:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:10:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:10:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:10:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:10:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:10:16 INFO - (blobuploader) - INFO - Done attempting. 05:10:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:10:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:10:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:10:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:10:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:10:16 INFO - (blobuploader) - INFO - Done attempting. 05:10:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:10:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:10:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:10:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:10:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:10:18 INFO - (blobuploader) - INFO - Done attempting. 05:10:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:10:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:10:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:10:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:10:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:10:20 INFO - (blobuploader) - INFO - Done attempting. 05:10:20 INFO - (blobuploader) - INFO - Iteration through files over. 05:10:20 INFO - Return code: 0 05:10:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:10:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:10:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f37f76871b9ab2944fdbb52eb7e3e5123bdb7fd57140f4c9c245344b399e51b69d7a9ae43481b1b11361cf11d796a390844fb9bcddfc4170ba8f1f656938a9f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa22202479b417f751262f028dd6c742152015dfacb30cad227a31bf80ff5b927890707f6db40c4facd15943433fc8ea3637ee441fcefd46cb61da90fbcfdcc5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7bfbbd551472b1951723141f910f42e6f2cb52db70069dd2485d914c279f3cee144a00880b693cf1b25575c1960a673701e796d4abb2fd84b6c8b21d7b22075", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c4b4b03f46b71b6be7d4734394287d72b9fe65d66da44fb606da11b1853b6b96bc7b738f22cea792fbc3bb1c56cf5f31c2e86cd51e2da043a7e2c463aa92c33"} 05:10:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:10:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:10:20 INFO - Contents: 05:10:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f37f76871b9ab2944fdbb52eb7e3e5123bdb7fd57140f4c9c245344b399e51b69d7a9ae43481b1b11361cf11d796a390844fb9bcddfc4170ba8f1f656938a9f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa22202479b417f751262f028dd6c742152015dfacb30cad227a31bf80ff5b927890707f6db40c4facd15943433fc8ea3637ee441fcefd46cb61da90fbcfdcc5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7bfbbd551472b1951723141f910f42e6f2cb52db70069dd2485d914c279f3cee144a00880b693cf1b25575c1960a673701e796d4abb2fd84b6c8b21d7b22075", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c4b4b03f46b71b6be7d4734394287d72b9fe65d66da44fb606da11b1853b6b96bc7b738f22cea792fbc3bb1c56cf5f31c2e86cd51e2da043a7e2c463aa92c33"} 05:10:20 INFO - Running post-run listener: copy_logs_to_upload_dir 05:10:20 INFO - Copying logs to upload dir... 05:10:20 INFO - mkdir: /builds/slave/test/build/upload/logs 05:10:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.186976 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-02-13 05:10:20.555721) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-13 05:10:20.559947) ========= 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.ZfGDLDIJPM/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.uQfSEr4nrH/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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/2f37f76871b9ab2944fdbb52eb7e3e5123bdb7fd57140f4c9c245344b399e51b69d7a9ae43481b1b11361cf11d796a390844fb9bcddfc4170ba8f1f656938a9f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa22202479b417f751262f028dd6c742152015dfacb30cad227a31bf80ff5b927890707f6db40c4facd15943433fc8ea3637ee441fcefd46cb61da90fbcfdcc5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7bfbbd551472b1951723141f910f42e6f2cb52db70069dd2485d914c279f3cee144a00880b693cf1b25575c1960a673701e796d4abb2fd84b6c8b21d7b22075", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c4b4b03f46b71b6be7d4734394287d72b9fe65d66da44fb606da11b1853b6b96bc7b738f22cea792fbc3bb1c56cf5f31c2e86cd51e2da043a7e2c463aa92c33"} build_url:https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011540 build_url: 'https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f37f76871b9ab2944fdbb52eb7e3e5123bdb7fd57140f4c9c245344b399e51b69d7a9ae43481b1b11361cf11d796a390844fb9bcddfc4170ba8f1f656938a9f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa22202479b417f751262f028dd6c742152015dfacb30cad227a31bf80ff5b927890707f6db40c4facd15943433fc8ea3637ee441fcefd46cb61da90fbcfdcc5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7bfbbd551472b1951723141f910f42e6f2cb52db70069dd2485d914c279f3cee144a00880b693cf1b25575c1960a673701e796d4abb2fd84b6c8b21d7b22075", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c4b4b03f46b71b6be7d4734394287d72b9fe65d66da44fb606da11b1853b6b96bc7b738f22cea792fbc3bb1c56cf5f31c2e86cd51e2da043a7e2c463aa92c33"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-13 05:10:20.595858) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 05:10:20.596189) ========= 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.ZfGDLDIJPM/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.uQfSEr4nrH/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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.005425 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 05:10:20.645203) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 05:10:20.645523) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 05:10:20.645841) ========= ========= Total master_lag: 0.19 =========