builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0022 starttime: 1492855132.16 results: success (0) buildid: 20170422014920 builduid: e13ee837e9994ce2b9ecd72039b83838 revision: 42c8a716081e6a8aa33c1e61944f36f6f89245fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-22 02:58:52.164938) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-22 02:58:52.165384) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-22 02:58:52.165665) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-22 02:58:52.193035) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 02:58:52.193315) ========= 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.D3s8RZOcEd/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.GguB3X6lff/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-22 02:58:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 3.23M=0.004s 2017-04-22 02:58:52 (3.23 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.510575 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 02:58:52.728494) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 02:58:52.729110) ========= 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.D3s8RZOcEd/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.GguB3X6lff/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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.022318 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 02:58:52.778686) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-22 02:58:52.779092) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 42c8a716081e6a8aa33c1e61944f36f6f89245fb --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 42c8a716081e6a8aa33c1e61944f36f6f89245fb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.D3s8RZOcEd/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.GguB3X6lff/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-22 02:58:52,868 truncating revision to first 12 chars 2017-04-22 02:58:52,869 Setting DEBUG logging. 2017-04-22 02:58:52,869 attempt 1/10 2017-04-22 02:58:52,869 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/42c8a716081e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-22 02:58:54,708 unpacking tar archive at: mozilla-central-42c8a716081e/testing/mozharness/ program finished with exit code 0 elapsedTime=2.097531 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-22 02:58:54.901023) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-22 02:58:54.901328) ========= script_repo_revision: 42c8a716081e6a8aa33c1e61944f36f6f89245fb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-22 02:58:54.901927) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-22 02:58:54.902218) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-22 02:58:54.922945) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-22 02:58:54.923234) ========= /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.D3s8RZOcEd/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.GguB3X6lff/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 02:58:55 INFO - MultiFileLogger online at 20170422 02:58:55 in /builds/slave/test 02:58:55 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 02:58:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:58:55 INFO - {'append_to_log': False, 02:58:55 INFO - 'base_work_dir': '/builds/slave/test', 02:58:55 INFO - 'blob_upload_branch': 'Firefox', 02:58:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:58:55 INFO - 'branch': 'Firefox', 02:58:55 INFO - 'buildbot_json_path': 'buildprops.json', 02:58:55 INFO - 'config_files': ('talos/mac_config.py',), 02:58:55 INFO - 'default_actions': ('clobber', 02:58:55 INFO - 'read-buildbot-config', 02:58:55 INFO - 'download-and-extract', 02:58:55 INFO - 'populate-webroot', 02:58:55 INFO - 'create-virtualenv', 02:58:55 INFO - 'install', 02:58:55 INFO - 'run-tests'), 02:58:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:58:55 INFO - 'download_minidump_stackwalk': True, 02:58:55 INFO - 'download_symbols': 'ondemand', 02:58:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:58:55 INFO - 'tooltool.py': '/tools/tooltool.py', 02:58:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:58:55 INFO - '/tools/misc-python/virtualenv.py')}, 02:58:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:58:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:58:55 INFO - 'gecko_profile': False, 02:58:55 INFO - 'gecko_profile_interval': 0, 02:58:55 INFO - 'installer_path': 'installer.exe', 02:58:55 INFO - 'log_level': 'info', 02:58:55 INFO - 'log_name': 'talos', 02:58:55 INFO - 'log_to_console': True, 02:58:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:58:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:58:55 INFO - 'opt_config_files': (), 02:58:55 INFO - 'pip_index': False, 02:58:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:58:55 INFO - 'cmd': ('bash', 02:58:55 INFO - '-c', 02:58:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:58:55 INFO - 'enabled': True, 02:58:55 INFO - 'halt_on_failure': False, 02:58:55 INFO - 'name': 'check_screen_resolution'},), 02:58:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:58:55 INFO - 'cmd': ('bash', 02:58:55 INFO - '-c', 02:58:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:58:55 INFO - 'enabled': True, 02:58:55 INFO - 'halt_on_failure': False, 02:58:55 INFO - 'name': 'check_screen_resolution'},), 02:58:55 INFO - 'run_cmd_checks_enabled': True, 02:58:55 INFO - 'suite': 'dromaeojs', 02:58:55 INFO - 'system_bits': '32', 02:58:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:58:55 INFO - 'title': 't-yosemite-r7-0022', 02:58:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:58:55 INFO - 'use_talos_json': True, 02:58:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:58:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:58:55 INFO - 'work_dir': 'build'} 02:58:55 INFO - [mozharness: 2017-04-22 09:58:55.136069Z] Running clobber step. 02:58:55 INFO - Running pre-action listener: _resource_record_pre_action 02:58:55 INFO - Running main action method: clobber 02:58:55 INFO - rmtree: /builds/slave/test/build 02:58:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:58:55 INFO - Running post-action listener: _resource_record_post_action 02:58:55 INFO - [mozharness: 2017-04-22 09:58:55.559853Z] Finished clobber step (success) 02:58:55 INFO - [mozharness: 2017-04-22 09:58:55.560069Z] Running read-buildbot-config step. 02:58:55 INFO - Running pre-action listener: _resource_record_pre_action 02:58:55 INFO - Running main action method: read_buildbot_config 02:58:55 INFO - Using buildbot properties: 02:58:55 INFO - { 02:58:55 INFO - "project": "", 02:58:55 INFO - "product": "firefox", 02:58:55 INFO - "script_repo_revision": "production", 02:58:55 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 02:58:55 INFO - "repository": "", 02:58:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 02:58:55 INFO - "buildid": "20170422014920", 02:58:55 INFO - "pgo_build": "False", 02:58:55 INFO - "basedir": "/builds/slave/test", 02:58:55 INFO - "buildnumber": 16, 02:58:55 INFO - "slavename": "t-yosemite-r7-0022", 02:58:55 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 02:58:55 INFO - "platform": "yosemite_r7", 02:58:55 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 02:58:55 INFO - "branch": "mozilla-central", 02:58:55 INFO - "repo_path": "mozilla-central", 02:58:55 INFO - "revision": "42c8a716081e6a8aa33c1e61944f36f6f89245fb", 02:58:55 INFO - "stage_platform": "macosx64", 02:58:55 INFO - "builduid": "e13ee837e9994ce2b9ecd72039b83838", 02:58:55 INFO - "slavebuilddir": "test" 02:58:55 INFO - } 02:58:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 02:58:55 INFO - Running post-action listener: _resource_record_post_action 02:58:55 INFO - [mozharness: 2017-04-22 09:58:55.565496Z] Finished read-buildbot-config step (success) 02:58:55 INFO - [mozharness: 2017-04-22 09:58:55.565691Z] Running download-and-extract step. 02:58:55 INFO - Running pre-action listener: _resource_record_pre_action 02:58:55 INFO - Running main action method: download_and_extract 02:58:55 INFO - mkdir: /builds/slave/test/build/tests 02:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:55 INFO - trying https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 02:58:55 INFO - Downloading https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 02:58:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 02:58:56 INFO - Downloaded 1325 bytes. 02:58:56 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 02:58:56 INFO - Using the following test package requirements: 02:58:56 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:58:56 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 02:58:56 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 02:58:56 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:58:56 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 02:58:56 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:58:56 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 02:58:56 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:58:56 INFO - u'jsshell-mac.zip'], 02:58:56 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:58:56 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 02:58:56 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 02:58:56 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:58:56 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 02:58:56 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:58:56 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 02:58:56 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:58:56 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 02:58:56 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:58:56 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 02:58:56 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:58:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 02:58:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:58:56 INFO - Fetch https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 02:58:58 INFO - Content-Length response header: 52522819 02:58:58 INFO - Bytes received: 52522819 02:59:14 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 02:59:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 02:59:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:59:14 INFO - Fetch https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 02:59:16 INFO - Content-Length response header: 52522819 02:59:16 INFO - Bytes received: 52522819 02:59:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 02:59:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:59:32 INFO - Fetch https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 02:59:33 INFO - Content-Length response header: 14408811 02:59:33 INFO - Bytes received: 14408811 02:59: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')]} 02:59:33 INFO - trying https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 02:59:33 INFO - Downloading https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 02:59:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 02:59:35 INFO - Downloaded 71041025 bytes. 02:59:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 02:59:35 INFO - mkdir: /builds/slave/test/properties 02:59:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:59:35 INFO - Writing to file /builds/slave/test/properties/build_url 02:59:35 INFO - Contents: 02:59:35 INFO - build_url:https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 02:59:36 INFO - Running post-action listener: _resource_record_post_action 02:59:36 INFO - Running post-action listener: set_extra_try_arguments 02:59:36 INFO - [mozharness: 2017-04-22 09:59:36.476240Z] Finished download-and-extract step (success) 02:59:36 INFO - [mozharness: 2017-04-22 09:59:36.476360Z] Running populate-webroot step. 02:59:36 INFO - Running pre-action listener: _resource_record_pre_action 02:59:36 INFO - Running main action method: populate_webroot 02:59:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:59:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:59:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:59:36 INFO - '--tppagecycles', 02:59:36 INFO - '7'], 02:59:36 INFO - 'tests': ['tsvgm']}}, 02:59:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:59:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:59:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:59:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:59:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:59:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:59:36 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:59:36 INFO - 'talos_options': ['--disable-e10s'], 02:59:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:59:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:59:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:59:36 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:59:36 INFO - 'talos_options': ['--disable-e10s'], 02:59:36 INFO - 'tests': ['damp', 'tps']}, 02:59:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:59:36 INFO - 'tests': ['damp', 'tps']}, 02:59:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:59:36 INFO - 'tests': ['dromaeo_dom']}, 02:59:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:59:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:59:36 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:59:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:59:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:59:36 INFO - 'tests': ['a11yr', 02:59:36 INFO - 'ts_paint', 02:59:36 INFO - 'tpaint', 02:59:36 INFO - 'sessionrestore', 02:59:36 INFO - 'sessionrestore_no_auto_restore', 02:59:36 INFO - 'tabpaint']}, 02:59:36 INFO - 'other-e10s': {'tests': ['a11yr', 02:59:36 INFO - 'ts_paint', 02:59:36 INFO - 'tpaint', 02:59:36 INFO - 'sessionrestore', 02:59:36 INFO - 'sessionrestore_no_auto_restore', 02:59:36 INFO - 'tabpaint']}, 02:59:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:59:36 INFO - 'ts_paint', 02:59:36 INFO - 'tpaint', 02:59:36 INFO - 'sessionrestore', 02:59:36 INFO - 'sessionrestore_no_auto_restore', 02:59:36 INFO - 'tabpaint']}, 02:59:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:59:36 INFO - 'ts_paint', 02:59:36 INFO - 'tpaint', 02:59:36 INFO - 'sessionrestore', 02:59:36 INFO - 'sessionrestore_no_auto_restore', 02:59:36 INFO - 'tabpaint']}, 02:59:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:59:36 INFO - 'tests': ['a11yr', 02:59:36 INFO - 'ts_paint', 02:59:36 INFO - 'tpaint', 02:59:36 INFO - 'sessionrestore', 02:59:36 INFO - 'sessionrestore_no_auto_restore', 02:59:36 INFO - 'tabpaint']}, 02:59:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:59:36 INFO - 'tests': ['a11yr', 02:59:36 INFO - 'ts_paint', 02:59:36 INFO - 'tpaint', 02:59:36 INFO - 'sessionrestore', 02:59:36 INFO - 'sessionrestore_no_auto_restore', 02:59:36 INFO - 'tabpaint']}, 02:59:36 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:59:36 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:59:36 INFO - 'bloom_basic_ref']}, 02:59:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:59:36 INFO - 'tests': ['tsvgx', 02:59:36 INFO - 'tsvgr_opacity', 02:59:36 INFO - 'tart', 02:59:36 INFO - 'tscrollx', 02:59:36 INFO - 'cart', 02:59:36 INFO - 'tsvg_static']}, 02:59:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:59:36 INFO - 'tsvgr_opacity', 02:59:36 INFO - 'tart', 02:59:36 INFO - 'tscrollx', 02:59:36 INFO - 'cart', 02:59:36 INFO - 'tsvg_static']}, 02:59:36 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:59:36 INFO - 'talos_options': ['--disable-e10s'], 02:59:36 INFO - 'tests': ['tp5o']}, 02:59:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:59:36 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:59:36 INFO - 'talos_options': ['--disable-e10s', 02:59:36 INFO - '--xperf_path', 02:59:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:59:36 INFO - 'tests': ['tp5n']}, 02:59:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:59:36 INFO - 'talos_options': ['--xperf_path', 02:59:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:59:36 INFO - 'tests': ['tp5n']}}, 02:59:36 INFO - 'talos.zip': {'path': '', 02:59:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:59:36 INFO - Running post-action listener: _resource_record_post_action 02:59:36 INFO - [mozharness: 2017-04-22 09:59:36.495932Z] Finished populate-webroot step (success) 02:59:36 INFO - [mozharness: 2017-04-22 09:59:36.496061Z] Running create-virtualenv step. 02:59:36 INFO - Running pre-action listener: _resource_record_pre_action 02:59:36 INFO - Running main action method: create_virtualenv 02:59:36 INFO - Creating virtualenv /builds/slave/test/build/venv 02:59:36 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 02:59:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:59:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:59:36 INFO - Using real prefix '/tools/python27' 02:59:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:59:37 INFO - Installing distribute.............................................................................................................................................................................................done. 02:59:40 INFO - Installing pip.................done. 02:59:40 INFO - Return code: 0 02:59:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:59:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:59:40 INFO - Reading from file tmpfile_stdout 02:59:40 INFO - Output received: 02:59:40 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) 02:59:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:59:40 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')]} 02:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:40 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')]} 02:59:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:40 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 0x10f4fcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4ff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7d25cff20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2dad30>, '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 0x10f200db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2cfbe8>, '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.D3s8RZOcEd/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.GguB3X6lff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 02:59:40 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 02:59:40 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 02:59:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D3s8RZOcEd/Render', 02:59:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:59:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:59:40 INFO - 'HOME': '/Users/cltbld', 02:59:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:59:40 INFO - 'LOGNAME': 'cltbld', 02:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:40 INFO - 'MOZ_NO_REMOTE': '1', 02:59:40 INFO - 'NO_EM_RESTART': '1', 02:59:40 INFO - 'PAGER': '/bin/cat', 02:59:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:40 INFO - 'PWD': '/builds/slave/test', 02:59:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:59:40 INFO - 'SHELL': '/bin/bash', 02:59:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GguB3X6lff/Listeners', 02:59:40 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 02:59:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:59:40 INFO - 'USER': 'cltbld', 02:59:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:59:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:40 INFO - 'XPC_FLAGS': '0x0', 02:59:40 INFO - 'XPC_SERVICE_NAME': '0', 02:59:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:40 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 02:59:40 INFO - Cleaning up... 02:59:40 INFO - Return code: 0 02:59:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:59:40 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')]} 02:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:40 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')]} 02:59:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:40 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 0x10f4fcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4ff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7d25cff20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2dad30>, '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 0x10f200db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2cfbe8>, '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.D3s8RZOcEd/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.GguB3X6lff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 02:59:40 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 02:59:40 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 02:59:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D3s8RZOcEd/Render', 02:59:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:59:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:59:40 INFO - 'HOME': '/Users/cltbld', 02:59:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:59:40 INFO - 'LOGNAME': 'cltbld', 02:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:40 INFO - 'MOZ_NO_REMOTE': '1', 02:59:40 INFO - 'NO_EM_RESTART': '1', 02:59:40 INFO - 'PAGER': '/bin/cat', 02:59:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:40 INFO - 'PWD': '/builds/slave/test', 02:59:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:59:40 INFO - 'SHELL': '/bin/bash', 02:59:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GguB3X6lff/Listeners', 02:59:40 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 02:59:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:59:40 INFO - 'USER': 'cltbld', 02:59:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:59:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:40 INFO - 'XPC_FLAGS': '0x0', 02:59:40 INFO - 'XPC_SERVICE_NAME': '0', 02:59:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:40 INFO - Downloading/unpacking psutil>=3.1.1 02:59:40 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 02:59:40 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 02:59:40 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 02:59:40 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 02:59:40 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 02:59:40 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 02:59:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:59:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:59:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:59:44 INFO - Installing collected packages: psutil 02:59:44 INFO - Running setup.py install for psutil 02:59:44 INFO - building 'psutil._psutil_osx' extension 02:59:44 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 02:59: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 02:59: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 02:59: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 02:59:45 INFO - building 'psutil._psutil_posix' extension 02:59: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 02:59:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:59:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:59:45 INFO - ^ 02:59:45 INFO - 1 warning generated. 02:59: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 02:59:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:59:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:59:45 INFO - Successfully installed psutil 02:59:45 INFO - Cleaning up... 02:59:45 INFO - Return code: 0 02:59:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f4fcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4ff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7d25cff20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2dad30>, '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 0x10f200db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2cfbe8>, '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.D3s8RZOcEd/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.GguB3X6lff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 02:59:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:59:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D3s8RZOcEd/Render', 02:59:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:59:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:59:45 INFO - 'HOME': '/Users/cltbld', 02:59:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:59:45 INFO - 'LOGNAME': 'cltbld', 02:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:45 INFO - 'MOZ_NO_REMOTE': '1', 02:59:45 INFO - 'NO_EM_RESTART': '1', 02:59:45 INFO - 'PAGER': '/bin/cat', 02:59:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:45 INFO - 'PWD': '/builds/slave/test', 02:59:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:59:45 INFO - 'SHELL': '/bin/bash', 02:59:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GguB3X6lff/Listeners', 02:59:45 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 02:59:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:59:45 INFO - 'USER': 'cltbld', 02:59:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:59:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:45 INFO - 'XPC_FLAGS': '0x0', 02:59:45 INFO - 'XPC_SERVICE_NAME': '0', 02:59:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:59:48 INFO - Installing collected packages: mozsystemmonitor 02:59:48 INFO - Running setup.py install for mozsystemmonitor 02:59:48 INFO - Successfully installed mozsystemmonitor 02:59:48 INFO - Cleaning up... 02:59:49 INFO - Return code: 0 02:59:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:59:49 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')]} 02:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:49 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')]} 02:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:49 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 0x10f4fcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4ff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7d25cff20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2dad30>, '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 0x10f200db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2cfbe8>, '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.D3s8RZOcEd/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.GguB3X6lff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 02:59:49 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 02:59:49 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 02:59:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D3s8RZOcEd/Render', 02:59:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:59:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:59:49 INFO - 'HOME': '/Users/cltbld', 02:59:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:59:49 INFO - 'LOGNAME': 'cltbld', 02:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:49 INFO - 'MOZ_NO_REMOTE': '1', 02:59:49 INFO - 'NO_EM_RESTART': '1', 02:59:49 INFO - 'PAGER': '/bin/cat', 02:59:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:49 INFO - 'PWD': '/builds/slave/test', 02:59:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:59:49 INFO - 'SHELL': '/bin/bash', 02:59:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GguB3X6lff/Listeners', 02:59:49 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 02:59:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:59:49 INFO - 'USER': 'cltbld', 02:59:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:59:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:49 INFO - 'XPC_FLAGS': '0x0', 02:59:49 INFO - 'XPC_SERVICE_NAME': '0', 02:59:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:49 INFO - Downloading/unpacking jsonschema==2.5.1 02:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:59:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:59:51 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 02:59:51 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 02:59:51 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 02:59:51 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 02:59:51 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 02:59:51 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 02:59:52 INFO - Downloading functools32-3.2.3-2.tar.gz 02:59:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:59:52 INFO - warning: no files found matching '*.txt' 02:59:52 INFO - no previously-included directories found matching 'build' 02:59:52 INFO - no previously-included directories found matching 'dist' 02:59:52 INFO - no previously-included directories found matching '.git*' 02:59:52 INFO - Installing collected packages: jsonschema, functools32 02:59:52 INFO - Running setup.py install for functools32 02:59:52 INFO - warning: no files found matching '*.txt' 02:59:52 INFO - no previously-included directories found matching 'build' 02:59:52 INFO - no previously-included directories found matching 'dist' 02:59:52 INFO - no previously-included directories found matching '.git*' 02:59:52 INFO - Successfully installed jsonschema functools32 02:59:52 INFO - Cleaning up... 02:59:52 INFO - Return code: 0 02:59:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f4fcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4ff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7d25cff20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2dad30>, '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 0x10f200db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2cfbe8>, '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.D3s8RZOcEd/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.GguB3X6lff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 02:59:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:59:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:59:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D3s8RZOcEd/Render', 02:59:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:59:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:59:52 INFO - 'HOME': '/Users/cltbld', 02:59:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:59:52 INFO - 'LOGNAME': 'cltbld', 02:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:52 INFO - 'MOZ_NO_REMOTE': '1', 02:59:52 INFO - 'NO_EM_RESTART': '1', 02:59:52 INFO - 'PAGER': '/bin/cat', 02:59:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:52 INFO - 'PWD': '/builds/slave/test', 02:59:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:59:52 INFO - 'SHELL': '/bin/bash', 02:59:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GguB3X6lff/Listeners', 02:59:52 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 02:59:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:59:52 INFO - 'USER': 'cltbld', 02:59:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:59:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:52 INFO - 'XPC_FLAGS': '0x0', 02:59:52 INFO - 'XPC_SERVICE_NAME': '0', 02:59:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:59:52 INFO - Cleaning up... 02:59:52 INFO - Return code: 0 02:59:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f4fcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4ff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7d25cff20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2dad30>, '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 0x10f200db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2cfbe8>, '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.D3s8RZOcEd/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.GguB3X6lff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 02:59:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:59:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:59:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D3s8RZOcEd/Render', 02:59:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:59:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:59:52 INFO - 'HOME': '/Users/cltbld', 02:59:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:59:52 INFO - 'LOGNAME': 'cltbld', 02:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:52 INFO - 'MOZ_NO_REMOTE': '1', 02:59:52 INFO - 'NO_EM_RESTART': '1', 02:59:52 INFO - 'PAGER': '/bin/cat', 02:59:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:52 INFO - 'PWD': '/builds/slave/test', 02:59:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:59:52 INFO - 'SHELL': '/bin/bash', 02:59:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GguB3X6lff/Listeners', 02:59:52 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 02:59:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:59:52 INFO - 'USER': 'cltbld', 02:59:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:59:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:52 INFO - 'XPC_FLAGS': '0x0', 02:59:52 INFO - 'XPC_SERVICE_NAME': '0', 02:59:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:53 INFO - Downloading/unpacking blobuploader==1.2.4 02:59: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 02:59: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 02:59: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 02:59: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 02:59: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 02:59: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 02:59:55 INFO - Downloading blobuploader-1.2.4.tar.gz 02:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:59:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:59:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:59:56 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 02:59:56 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 02:59:56 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 02:59:56 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 02:59:56 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 02:59:56 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 02:59:57 INFO - Downloading docopt-0.6.1.tar.gz 02:59:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:59:57 INFO - Installing collected packages: blobuploader, requests, docopt 02:59:57 INFO - Running setup.py install for blobuploader 02:59:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:59:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:59:57 INFO - Running setup.py install for requests 02:59:57 INFO - Running setup.py install for docopt 02:59:57 INFO - Successfully installed blobuploader requests docopt 02:59:57 INFO - Cleaning up... 02:59:58 INFO - Return code: 0 02:59:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:59:58 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')]} 02:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:58 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')]} 02:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:58 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 0x10f4fcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4ff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7d25cff20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2dad30>, '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 0x10f200db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2cfbe8>, '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.D3s8RZOcEd/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.GguB3X6lff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 02:59:58 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 02:59:58 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 02:59:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D3s8RZOcEd/Render', 02:59:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:59:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:59:58 INFO - 'HOME': '/Users/cltbld', 02:59:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:59:58 INFO - 'LOGNAME': 'cltbld', 02:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:58 INFO - 'MOZ_NO_REMOTE': '1', 02:59:58 INFO - 'NO_EM_RESTART': '1', 02:59:58 INFO - 'PAGER': '/bin/cat', 02:59:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:58 INFO - 'PWD': '/builds/slave/test', 02:59:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:59:58 INFO - 'SHELL': '/bin/bash', 02:59:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GguB3X6lff/Listeners', 02:59:58 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 02:59:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:59:58 INFO - 'USER': 'cltbld', 02:59:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:59:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:58 INFO - 'XPC_FLAGS': '0x0', 02:59:58 INFO - 'XPC_SERVICE_NAME': '0', 02:59:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:59:58 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-yt4Mit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:59:58 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-WtUCrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:59:58 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-n21NTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:59:58 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-IsUhiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:59:58 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-pQ7JxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:59:58 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-zwYJCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:59:58 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-sFkzLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:59:59 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-FyB2c3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:59:59 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-ntoLHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:59:59 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-VYPpVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:59:59 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-MNRdsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:59:59 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-oEByMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:59:59 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-JQh1Yt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:59:59 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-1ETtNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:59 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-awHPnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:59:59 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-4LO0lQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:00 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-nKSRrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:00:00 INFO - Running setup.py install for manifestparser 03:00:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:00:00 INFO - Running setup.py install for mozcrash 03:00:00 INFO - Running setup.py install for mozdebug 03:00:00 INFO - Running setup.py install for mozdevice 03:00:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:00:00 INFO - Running setup.py install for mozfile 03:00:00 INFO - Running setup.py install for mozhttpd 03:00:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:00:00 INFO - Running setup.py install for mozinfo 03:00:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:00:01 INFO - Running setup.py install for mozInstall 03:00:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:00:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:00:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:00:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:00:01 INFO - Running setup.py install for mozleak 03:00:01 INFO - Running setup.py install for mozlog 03:00:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:00:01 INFO - Running setup.py install for moznetwork 03:00:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:00:01 INFO - Running setup.py install for mozprocess 03:00:01 INFO - Running setup.py install for mozprofile 03:00:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:00:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:00:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:00:02 INFO - Running setup.py install for mozrunner 03:00:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:00:02 INFO - Running setup.py install for mozscreenshot 03:00:02 INFO - Running setup.py install for moztest 03:00:02 INFO - Running setup.py install for mozversion 03:00:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:00:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:00:02 INFO - Cleaning up... 03:00:02 INFO - Return code: 0 03:00:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:02 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 0x10f4fcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4ff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7d25cff20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2dad30>, '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 0x10f200db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2cfbe8>, '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.D3s8RZOcEd/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.GguB3X6lff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 03:00:02 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 03:00:02 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 03:00:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D3s8RZOcEd/Render', 03:00:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:02 INFO - 'HOME': '/Users/cltbld', 03:00:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:02 INFO - 'LOGNAME': 'cltbld', 03:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:02 INFO - 'MOZ_NO_REMOTE': '1', 03:00:02 INFO - 'NO_EM_RESTART': '1', 03:00:02 INFO - 'PAGER': '/bin/cat', 03:00:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:02 INFO - 'PWD': '/builds/slave/test', 03:00:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:02 INFO - 'SHELL': '/bin/bash', 03:00:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GguB3X6lff/Listeners', 03:00:02 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 03:00:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:02 INFO - 'USER': 'cltbld', 03:00:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:02 INFO - 'XPC_FLAGS': '0x0', 03:00:02 INFO - 'XPC_SERVICE_NAME': '0', 03:00:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:02 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-hb7YUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:03 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)) 03:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:03 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-HXAqBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:03 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)) 03:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:03 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-rqSqJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:03 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)) 03:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:03 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-Wplxq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:03 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-kkCkzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:03 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)) 03:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:03 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-c1bboR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:03 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)) 03:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:03 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-RTD5Qg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:03 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)) 03:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:03 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-ERhrUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:03 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)) 03:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:03 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-jD3x9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:03 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)) 03:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:03 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-Ii4KCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:04 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)) 03:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:04 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-LT5_Bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00:04 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)) 03:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:04 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-jhRQZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:04 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-6AVRw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:04 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)) 03:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:04 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-8oKxvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:04 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)) 03:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:04 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-znO1Gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:04 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)) 03:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:04 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-YIYFly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:04 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)) 03:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:04 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-f4Mjds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:04 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)) 03:00:04 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)) 03:00:04 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)) 03:00:04 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)) 03:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:00:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:00:04 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 03:00:04 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 03:00:04 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 03:00:04 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 03:00:04 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 03:00:04 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 03:00:07 INFO - Downloading blessings-1.6.tar.gz 03:00:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:00:07 INFO - Installing collected packages: blessings 03:00:07 INFO - Running setup.py install for blessings 03:00:07 INFO - Successfully installed blessings 03:00:07 INFO - Cleaning up... 03:00:07 INFO - Return code: 0 03:00:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:00:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:08 INFO - Reading from file tmpfile_stdout 03:00:08 INFO - Current package versions: 03:00:08 INFO - blessings == 1.6 03:00:08 INFO - blobuploader == 1.2.4 03:00:08 INFO - docopt == 0.6.1 03:00:08 INFO - functools32 == 3.2.3-2 03:00:08 INFO - jsonschema == 2.5.1 03:00:08 INFO - manifestparser == 1.1 03:00:08 INFO - mozInstall == 1.12 03:00:08 INFO - mozcrash == 1.0 03:00:08 INFO - mozdebug == 0.1 03:00:08 INFO - mozdevice == 0.50 03:00:08 INFO - mozfile == 1.2 03:00:08 INFO - mozhttpd == 0.7 03:00:08 INFO - mozinfo == 0.9 03:00:08 INFO - mozleak == 0.1 03:00:08 INFO - mozlog == 3.4 03:00:08 INFO - moznetwork == 0.27 03:00:08 INFO - mozprocess == 0.25 03:00:08 INFO - mozprofile == 0.28 03:00:08 INFO - mozrunner == 6.13 03:00:08 INFO - mozscreenshot == 0.1 03:00:08 INFO - mozsystemmonitor == 0.3 03:00:08 INFO - moztest == 0.8 03:00:08 INFO - mozversion == 1.4 03:00:08 INFO - psutil == 3.1.1 03:00:08 INFO - requests == 1.2.3 03:00:08 INFO - wsgiref == 0.1.2 03:00:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:08 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')]} 03:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:08 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')]} 03:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:08 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 0x10f4fcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4ff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7d25cff20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2dad30>, '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 0x10f200db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2cfbe8>, '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.D3s8RZOcEd/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.GguB3X6lff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 03:00:08 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 03:00:08 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 03:00:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D3s8RZOcEd/Render', 03:00:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:08 INFO - 'HOME': '/Users/cltbld', 03:00:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:08 INFO - 'LOGNAME': 'cltbld', 03:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:08 INFO - 'MOZ_NO_REMOTE': '1', 03:00:08 INFO - 'NO_EM_RESTART': '1', 03:00:08 INFO - 'PAGER': '/bin/cat', 03:00:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:08 INFO - 'PWD': '/builds/slave/test', 03:00:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:08 INFO - 'SHELL': '/bin/bash', 03:00:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GguB3X6lff/Listeners', 03:00:08 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 03:00:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:08 INFO - 'USER': 'cltbld', 03:00:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:08 INFO - 'XPC_FLAGS': '0x0', 03:00:08 INFO - 'XPC_SERVICE_NAME': '0', 03:00:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:08 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)) 03:00:08 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)) 03:00:08 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)) 03:00:08 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)) 03:00:08 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)) 03:00:08 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)) 03:00:08 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)) 03:00:08 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)) 03:00:08 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)) 03:00:08 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)) 03:00:08 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)) 03:00:08 INFO - Cleaning up... 03:00:08 INFO - Return code: 0 03:00:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:00:08 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')]} 03:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:08 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')]} 03:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:08 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 0x10f4fcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4ff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7d25cff20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2dad30>, '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 0x10f200db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2cfbe8>, '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.D3s8RZOcEd/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.GguB3X6lff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 03:00:08 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 03:00:08 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 03:00:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D3s8RZOcEd/Render', 03:00:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:08 INFO - 'HOME': '/Users/cltbld', 03:00:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:08 INFO - 'LOGNAME': 'cltbld', 03:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:08 INFO - 'MOZ_NO_REMOTE': '1', 03:00:08 INFO - 'NO_EM_RESTART': '1', 03:00:08 INFO - 'PAGER': '/bin/cat', 03:00:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:08 INFO - 'PWD': '/builds/slave/test', 03:00:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:08 INFO - 'SHELL': '/bin/bash', 03:00:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GguB3X6lff/Listeners', 03:00:08 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 03:00:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:08 INFO - 'USER': 'cltbld', 03:00:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:08 INFO - 'XPC_FLAGS': '0x0', 03:00:08 INFO - 'XPC_SERVICE_NAME': '0', 03:00:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:00:08 INFO - Cleaning up... 03:00:08 INFO - Return code: 0 03:00:08 INFO - Running post-action listener: _resource_record_post_action 03:00:08 INFO - Running post-action listener: _start_resource_monitoring 03:00:08 INFO - Starting resource monitoring. 03:00:08 INFO - [mozharness: 2017-04-22 10:00:08.625252Z] Finished create-virtualenv step (success) 03:00:08 INFO - [mozharness: 2017-04-22 10:00:08.626228Z] Running install step. 03:00:08 INFO - Running pre-action listener: _resource_record_pre_action 03:00:08 INFO - Running main action method: install 03:00:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:08 INFO - Reading from file tmpfile_stdout 03:00:08 INFO - Detecting whether we're running mozinstall >=1.0... 03:00:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:00:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:00:08 INFO - Reading from file tmpfile_stdout 03:00:08 INFO - Output received: 03:00:08 INFO - Usage: mozinstall [options] installer 03:00:08 INFO - Options: 03:00:08 INFO - -h, --help show this help message and exit 03:00:08 INFO - -d DEST, --destination=DEST 03:00:08 INFO - Directory to install application into. [default: 03:00:08 INFO - "/builds/slave/test"] 03:00:08 INFO - --app=APP Application being installed. [default: firefox] 03:00:08 INFO - mkdir: /builds/slave/test/build/application 03:00:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:00:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:00:28 INFO - Reading from file tmpfile_stdout 03:00:28 INFO - Output received: 03:00:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:00:28 INFO - Running post-action listener: _resource_record_post_action 03:00:28 INFO - [mozharness: 2017-04-22 10:00:28.857066Z] Finished install step (success) 03:00:28 INFO - [mozharness: 2017-04-22 10:00:28.857207Z] Running run-tests step. 03:00:28 INFO - Running pre-action listener: _resource_record_pre_action 03:00:28 INFO - Running main action method: run_tests 03:00:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:00:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:00:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:00:28 INFO - 2017-04-22 03:00:28.872 screenresolution[85292:743950] starting screenresolution argv=screenresolution get 03:00:28 INFO - 2017-04-22 03:00:28.874 screenresolution[85292:743950] Display 0: 1600x1200x32@60 03:00:28 INFO - 2017-04-22 03:00:28.880 screenresolution[85293:743952] starting screenresolution argv=screenresolution list 03:00:28 INFO - Available Modes on Display 0 03:00:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:00:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:00:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:00:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:00:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:00:29 INFO - Intel Iris: 03:00:29 INFO - Chipset Model: Intel Iris 03:00:29 INFO - Type: GPU 03:00:29 INFO - Bus: Built-In 03:00:29 INFO - VRAM (Dynamic, Max): 1536 MB 03:00:29 INFO - Vendor: Intel (0x8086) 03:00:29 INFO - Device ID: 0x0a2e 03:00:29 INFO - Revision ID: 0x0009 03:00:29 INFO - Displays: 03:00:29 INFO - Display: 03:00:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:00:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:00:29 INFO - Display Serial Number: 1600x1200 60 03:00:29 INFO - Main Display: Yes 03:00:29 INFO - Mirror: Off 03:00:29 INFO - Online: Yes 03:00:29 INFO - Rotation: Supported 03:00:29 INFO - Return code: 0 03:00:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:00:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:00:29 INFO - Python 2.7.3 03:00:29 INFO - Return code: 0 03:00:29 INFO - grabbing minidump binary from tooltool 03:00:29 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')]} 03:00:29 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 0x10f2dad30>, '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 0x10f200db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2cfbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:00:29 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 03:00:29 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 03:00:29 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 03:00:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:00:29 INFO - Return code: 0 03:00:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:00:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:00:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:00:29 INFO - ENV: RUST_BACKTRACE is now 1 03:00:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:00:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:00:29 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/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0022', '--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 03:00:29 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/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0022 --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 03:00:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D3s8RZOcEd/Render', 03:00:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:29 INFO - 'HOME': '/Users/cltbld', 03:00:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:29 INFO - 'LOGNAME': 'cltbld', 03:00:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:00:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:29 INFO - 'MOZ_NO_REMOTE': '1', 03:00:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:00:29 INFO - 'NO_EM_RESTART': '1', 03:00:29 INFO - 'PAGER': '/bin/cat', 03:00:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:29 INFO - 'PWD': '/builds/slave/test', 03:00:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:00:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:29 INFO - 'RUST_BACKTRACE': '1', 03:00:29 INFO - 'SHELL': '/bin/bash', 03:00:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GguB3X6lff/Listeners', 03:00:29 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 03:00:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:29 INFO - 'USER': 'cltbld', 03:00:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:29 INFO - 'XPC_FLAGS': '0x0', 03:00:29 INFO - 'XPC_SERVICE_NAME': '0', 03:00:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:29 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/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0022', '--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 03:00:29 INFO - mozversion application_buildid: 20170422014920 03:00:29 INFO - mozversion application_changeset: 42c8a716081e6a8aa33c1e61944f36f6f89245fb 03:00:29 INFO - mozversion application_display_name: Nightly 03:00:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:00:29 INFO - mozversion application_name: Firefox 03:00:29 INFO - mozversion application_remotingname: firefox 03:00:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:00:29 INFO - mozversion application_vendor: Mozilla 03:00:29 INFO - mozversion application_version: 55.0a1 03:00:29 INFO - mozversion platform_buildid: 20170422014920 03:00:29 INFO - mozversion platform_changeset: 42c8a716081e6a8aa33c1e61944f36f6f89245fb 03:00:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:00:29 INFO - mozversion platform_version: 55.0a1 03:00:29 INFO - using testdate: 1492855229 03:00:29 INFO - actual date: 1492855229 03:00:29 INFO - starting webserver on 'localhost:56850' 03:00:29 INFO - SUITE-START | Running 2 tests 03:00:29 INFO - TEST-START | dromaeo_css 03:00:29 INFO - operating with platform_type : mac_ 03:00:29 INFO - Initialising browser for dromaeo_css test... 03:00:29 INFO - TEST-INFO | started process 85303 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmp31qwjm/profile http://localhost:56850/getInfo.html) 03:00:32 INFO - PID 85303 | __metrics Screen width/height:1600/1200 03:00:32 INFO - PID 85303 | colorDepth:24 03:00:32 INFO - PID 85303 | Browser inner width/height: 1024/689 03:00:32 INFO - PID 85303 | __metrics 03:00:32 INFO - PID 85303 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:00:32 INFO - PID 85303 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:00:33 INFO - TEST-INFO | 85303: exit 0 03:00:33 INFO - Browser initialized. 03:00:33 INFO - Running cycle 1/1 for dromaeo_css test... 03:00:33 INFO - TEST-INFO | started process 85306 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmp31qwjm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:00:45 INFO - PID 85306 | RSS: Main: 241733632 03:00:45 INFO - PID 85306 | 03:03:50 INFO - PID 85306 | Cycle 1(1): loaded http://localhost:56850/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56850/tests/dromaeo/cssquery-ext.html) 03:03:52 INFO - PID 85306 | RSS: Main: 453431296 03:03:52 INFO - PID 85306 | 03:05:35 INFO - PID 85306 | ************************* 03:05:35 INFO - PID 85306 | A coding exception was thrown and uncaught in a Task. 03:05:35 INFO - PID 85306 | 03:05:35 ERROR - PID 85306 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:05:35 INFO - PID 85306 | Full stack: 03:05:35 INFO - PID 85306 | ************************* 03:05:35 INFO - PID 85306 | ************************* 03:05:35 INFO - PID 85306 | A coding exception was thrown and uncaught in a Task. 03:05:35 INFO - PID 85306 | 03:05:35 ERROR - PID 85306 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:05:35 INFO - PID 85306 | Full stack: 03:05:35 INFO - PID 85306 | ************************* 03:05:35 INFO - PID 85306 | ************************* 03:05:35 INFO - PID 85306 | A coding exception was thrown and uncaught in a Task. 03:05:35 INFO - PID 85306 | 03:05:35 ERROR - PID 85306 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:05:35 INFO - PID 85306 | Full stack: 03:05:35 INFO - PID 85306 | ************************* 03:05:35 INFO - PID 85306 | ************************* 03:05:35 INFO - PID 85306 | A coding exception was thrown and uncaught in a Task. 03:05:35 INFO - PID 85306 | 03:05:35 ERROR - PID 85306 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:05:35 INFO - PID 85306 | Full stack: 03:05:35 INFO - PID 85306 | ************************* 03:06:55 INFO - PID 85306 | Cycle 1(1): loaded http://localhost:56850/tests/dromaeo/cssquery-ext.html (next: http://localhost:56850/tests/dromaeo/cssquery-jquery.html) 03:06:55 INFO - PID 85306 | RSS: Main: 366002176 03:06:55 INFO - PID 85306 | 03:09:58 INFO - PID 85306 | Cycle 1(1): loaded http://localhost:56850/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56850/tests/dromaeo/cssquery-mootools.html) 03:09:58 INFO - PID 85306 | RSS: Main: 358842368 03:09:58 INFO - PID 85306 | 03:13:01 INFO - PID 85306 | Cycle 1(1): loaded http://localhost:56850/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56850/tests/dromaeo/cssquery-prototype.html) 03:13:01 INFO - PID 85306 | RSS: Main: 332103680 03:13:01 INFO - PID 85306 | 03:16:05 INFO - PID 85306 | Cycle 1(1): loaded http://localhost:56850/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56850/tests/dromaeo/cssquery-yui.html) 03:16:05 INFO - PID 85306 | RSS: Main: 338808832 03:16:05 INFO - PID 85306 | 03:19:08 INFO - PID 85306 | Cycle 1(1): loaded http://localhost:56850/tests/dromaeo/cssquery-yui.html (next: http://localhost:56850/tests/dromaeo/cssquery-dojo.html) 03:19:08 INFO - PID 85306 | RSS: Main: 376467456 03:19:08 INFO - PID 85306 | 03:19:08 INFO - PID 85306 | __start_tp_report 03:19:08 INFO - PID 85306 | _x_x_mozilla_page_load 03:19:08 INFO - PID 85306 | _x_x_mozilla_page_load_details 03:19:08 INFO - PID 85306 | |i|pagename|runs| 03:19:08 INFO - PID 85306 | |0;dojo.html;2866.7276608722173;3478.4956181353687;3513.069036705272;3525.0658575477487;3546.953648673641;6173.3517980612005;6185.56701030928;6192.195014648089;6205.503559715224;6211.06833974904;6017.661058197435;6065.848353791146;6110.862540392742;6176.907346389808;6183.288921773998;4858.1983972644475;5154.561862241714;5241.397239317489;5297.629165958385;5380.166074258476;5216.582673386139;5308.283381743473;5359.5712343012665;5406;5465.289512363407;5235.528802407783;5237.057329680656;5323.946760532423;5324.866878328034;5374.5700343972385;5302.125149350352;5313.57491400687;5324.094903866313;5327.067763141435;5393.946060539383;5289.285946397225;5297.205419187114;5325.627206095575;5328.333958255218;5339.679619222859;5918.556108291896;5937.821865344046;5961.374055724174;5972.641641501524;6155.569110162291;6361.872762544769;6365.840853978688;6367.872642547123;6369.426751592333;6373.872522549569;6338.58799178052;6436.131122298477;6564.310747371505;6604.1084453599115;6626.602403855784;6182.258129024501;6237.625742455467;6246.718897649616;6249.2813326467585;6265.749370025239;6450.967745161244;6706.59760414367;6718.49611279156;6725.293844146392;6733.730650773914;5233.267342572043;6344.746210151542;6385.680715964183;6441.452476539453;6445.903311450332;6564.5076619252795;6570.901436478457;6580.473562115019;6581.506387020992;6583.63789991555;5348.465153484621;6393.073004414334;6477.676116194171;6479.546431749733;6488.643124628191;5245.554127899095;6335.461485773761;6338.049292606146;6343.809685709436;6475.579087359307;5130.871728206825;5144.639875208774;5145.07388670043;5151.5878729701535;5152.587792976553;4480.193565158238;4621.676482646182;4677.6257899367965;4686.109639168547;4688.226442636927;6029.186059881948;6081.27024757032;6091.208142941389;6091.786787462417;6099.603525770811;6387.904181437282;6513.902291465537;6568.901466478007;6574.539782215199;6604.3395660434535;6178.073289006595;6183.412575805291;6188.81433556994;6191.84520386994;6196.411340922605;5743.62666426681;5753.798617048383;5755.366909639936;5759.798407055733;5807.303123625192;6387.840303992437;6486.708098135595;6519.348065193538;6544.280129185881;6562.770303039275;6412.647304398303;6515.869682606416;6544.181977252843;6544.705488253136;6574.53978221539;6741.932580674131;6754.5609535380045;6772.52592318533;6772.93227067723;6781.423578995643;6471.579347342407;6473.352664733489;6481.092647029325;6481.125048118443;6484.643344616092;6342.334054924167;6383.457406120532;6395.712192951235;6395.936040639534;6565.835854103686;5211.557017653542;6270.341614130451;6278.968605156945;6291.622502649856;6297.937020629918;6119.41115851624;6272.466840318624;6309.936900630935;6352.555321127476;6389.393007664265;6272.6236425814595;6298.401651843067;6310.368963103653;6314.052892066226;6318.715657795502;5574.9721251393485;6251;6370.8088757337355;6408.391202835724;6440.516961228021;6222.751089956532;6249.187605611241;6259.155014073224;6262.248530176408;6267.185265915402 03:19:08 INFO - PID 85306 | |1;ext.html;740.9481336306459;797.310326567519;955.6320816485655;1112.599464192891;1125.6510481750663;36317.63682363176;36430;36744.26511469776;36767;36780.264394712125;39314;39585.40621890674;39661;39773;39866.6046688366;5992.221011268529;6147.538934579902;8371.079181290053;8541.743747687578;8555.743327700178;8257.545834979073;8460.36547258955;8478.745637630851;8479.83040339196;8515.105913879046;7835.746280595106;8051.879221811678;8489.95755021224;8548;8550.187732165434;8472.322214222848;8528.70149544766;8529.360297977677;8541.530215838126;8574.614142363545;8360.45657032291;8369.874451883226;8424.326053915673;8425.747227583182;8438.620262088221;36726.449103263476;37018;37082.25835483275;37087.81456092702;37202.44196337057;3544.680978711928;3567.0369000369756;3570.107473131717;3570.410882204459;3570.9822700530226;30198;30213.244668883235;30257.697423025707;30270.84864575685;30297.545536816964;3123.04747052149;3146.5437511560926;3173;3187.2987942652812;3193.7125658690597;275994;281144;281450;281651;282790;39150.80424597859;39286.80356598199;39298.607013930065;48912.51087489151;48952.77618059577;48499.515004850204;48779.78050548694;48880.02239955181;48899;50064.9987000258;13530.797038044437;13622.523211687543;13636.250006249751;13638.863611363959;13663;8831.646734130563;8832.38173327861;8836.513991730517;11075.390853502973;11082.445877706083;10764.730881728019;10802.94598527018;10813.08088812444;12291.631251062483;12381.566645167375;5472.960137573848;5474.069408200616;5502;5508.118701007819;5524.972375138099;979.5102448775613;995.8257304971601;1022.5245260953692;1043.7234132954773;1074.4359211413914;23770.286891393287;23885.164019259242;23902.282931512083;23922;24162.395940101636;1110.3837370259585;1111.283222321598;1143.2511704833348;1147.3288126446123;1167.9941600291945;9123.635054597742;10733.463326833784;11811;12238.636476834707;12277.856275746653;308573;309053;309215;309665;309692;52629.947401051766;52659.736701317015;52704.68238294074;52715.73642131841;52717;1471.220253265771;1489.7020595880651;1535.1786794065122;1536.0476504567016;1541.814982202143;20148.194072237533;21422.464438389165;23419.648705269094;23556.411089722893;23572.88213558921;37294.81352593219;37395.81302093472;37401;37426.43860342151;37454;286598.567007172;287339;287379.1262087352;287536;287737;33934.32131357408;33957.830210848784;33975.66024339725;34032.829835851655;34077.14807129842;37243.62756372402;39405.605943940194;43472;43562.564374355854;44339.33490997702;29435.11694649164;29786.851065744533;29861.253468663457;30433.847830760704;30914.072577822702;30389.544156837223;30484.542731858597;30586.84706576453;30945.226369340948;31040.223994399417;35644.643553564136;35712.92861214168;36255.91232263036;36408.90773276806;36521.08697282589;24836.875815620806;29514.852425737732;29828.70171298346;30729.231769205948;31005.68994310028;22260.109595616643;22612.773872261725;22777.77222227823;23608;24049.158279460135 03:19:08 INFO - PID 85306 | |2;jquery.html;391.1980440097799;395.9663428608568;422.44815519616105;434.889103278664;440.67390131302835;13098.41057152428;15161.014534055292;21271.255506057292;21543.56912861742;21650.133994640197;16296.10371429574;18502.629947401045;20865.791342086573;21980.230691925786;22255.44361390962;5904.114382842565;5959.433853783884;6111.816645500619;6178.8455288617915;6182.567220294559;3613.331533666267;3667.1748856507206;6061;6175.876482470348;6186.793575252827;5832.708364581754;6135.754569817202;6158.84602884927;6166.321704612489;6179.3202747697715;6047.334793172748;6065.878682426327;6140.6929653517145;6159.445649891509;6168.722407491651;5285.86785330366;5439.945600544023;5446.346438427375;5452.173521870178;5456.290682211326;26094.086706965354;26666.73333266662;27231.319217019733;27517.449651007068;27761.86119069412;2148.924787632441;2203.2178576605393;2204.481946742514;2206.6028114939304;2210.8894555272173;17548.122593870256;17857.642847142983;18121.818781812275;18266.452006439828;18594.90702546492;2063.1953538120147;2135.7010018597407;2162.837787165953;2164.805167534914;2175.119076773909;161574.34489792917;161665;164795;165010.3498965007;166370.1681491597;9855.457949812686;12374.195677280948;12590.43343049565;12645.87354126447;12840.61478155657;16647.83352166487;16664.75002874958;16683.582910427336;16748.83251167497;16780;8593.398462107592;8936.329775266751;8947.239484643747;9037.909620903838;9078.273738100936;6873.828154296082;8392.370572207108;8398.538080405637;8568.400211985227;8572.871406928902;7662;7802.024746906637;7833.451658383859;7836;7848.882266766003;2154.4829240982367;2168.9566208676056;2170.197027099983;2180.8146307564034;2363.959857662623;939.3893968920256;941.3692825806726;941.924646028316;945.680775318427;972.9951350243346;20138.597228055358;20273;20474.283400081225;20532.794672053387;20785.688214676793;944.4380593546829;981.9803603927882;984.5274268351232;987.7579992901641;994.9701508954743;9904.950475247722;10574.365538067741;10651.041406273473;10729.409882456384;10759.408232547128;565781;567779;573537;578041;579130;114325;119183.2122518163;120918;122249;129914;1151.3379806611233;1159.3380522142438;1201.7596480703894;1205.4635687119148;1208.2810727617054;21026.158953641683;21156.89421552944;21325.36023919285;21518;21607.783922160575;55294.17058744202;56150.87698246094;56469.43530564642;57989.710051449474;58617.70691146517;57110;75650.62174689092;76555.85166222623;77063.22936770784;77397.226027739;8449.95775021121;8725.171108744658;9038.186563209343;9181.7992275693;9284.489353085644;14115.858841411455;14201.928990354982;14209.360578774187;14722.116672999655;14753.336099875745;11872.109591780823;11877.287362758263;12142.75714485723;12221.877781222074;12236.816447753468;11344.20590558653;11550.711232219262;11587.88412115868;11940.641780746591;11976.700582485159;12142.210756300812;12166.635000949986;12406.62780116598;12592.685182870502;12622.810657839957;8955.865662014945;8999.595018224065;9038.051004644418;9054.728358149267;9070.866141732284;11865.406729663655;12032.480071297648;12085.274883507018;12219.205751626116;12280 03:19:08 INFO - PID 85306 | |3;mootools.html;1344.0255814534457;1389.6664800447893;1408.2465880753793;1447.9927600362003;1449.7028109237608;10716.946415267923;11764.941155296021;11781.764364712712;11782.116341274395;11799.292042477457;10595.576176952913;11433.028192603619;11470.827937580943;11716.472758725857;11730.120240981918;2502.6120951252583;2542.5677634802037;2543.860087695176;2543.860087695176;2548.3883867871764;2103.295396042328;2410.7468715784853;2520.1053625962704;2524.4572416930355;2525.532776436356;2136.412486566199;2157.363577744561;2160.4490854832075;2162.264829957814;2164.2857856907262;2142.571485702858;2419.830611857162;2469.715982661981;2471.0486462711806;2503.6119401492797;2438.926832195037;2467.9136230231857;2472.1347528364927;2474.1958863369478;2479.1075212923333;9279.628814847398;11652.126090543243;11667.299962002222;11669.183157179;11669.70825729355;6454;6704.966475167642;6711.731530738764;6718;6720.3951644351755;3531.311394278117;3656.1773600939578;3732;3745.75652582584;4325.610695037431;1243.1608664151752;1250.2123662092915;1272.249372870011;1304.9934750326188;1305.9085863989524;16392.75410868838;16505.33978640853;16529.173541322885;16568.917155414387;16575.751363729552;4833.767389315702;4961.2558116282125;5395.487428694268;5423.701696406657;5574.749136288877;12121.69695757613;12126.696832579257;12132.332721700215;12138.75722485563;12151.392430378446;6457.1282876811965;6509.056186852879;6509.544331896816;6515.250746164157;6515.511336649675;6029.547783916224;6086.756529738849;6167.84580385494;6248;6268.561200715906;3887.028242939265;4138.937915931264;4212.831486740496;4357.193919124972;4414.337849322627;1252.6179515247754;1254.1221145198397;1270.3203785974458;1272.0968112639944;1278.910476266671;786.5241528875063;792.3558615872089;807.7092246791151;811.3306522119275;827.1521690267524;5884.323302820145;5887.76448942046;7382.5939573323985;7444.739434119888;7470.887936680954;580.0863639767383;580.8373655376502;587.4683411512588;588.7468388592946;599.9190109335184;4173.812178451977;4345.369921361448;4345.804438800262;4348.847790327323;4474.7762611869275;11754.76490470203;15022.09867407959;15164.620884477756;15181.544553663407;15220.695586088215;12131.818022729665;13423.597292081253;14303.070300430647;15010.924945375204;15047.473338433103;8414.158584141536;8620.267277281377;8639.092895245909;8644;8678.088800675965;6627.403533681992;6829.829254268683;7095.148582169966;7100.893486597808;7207.297263526178;13222.603321900358;13563.79654305206;13621.523246686715;13636.659083522594;13642.976776741983;13601.251931143883;13841.723165536834;13953;13977.161370317814;14046.719065618834;9403.294752893697;9482.905170948203;9618.855717164108;9623.133917947418;9634.470104144339;10620.575176993143;10623.840642390216;10704.946475267574;10744.677659670222;10773.084287835622;9241.306901982512;9284.30367722437;9286.489243091695;9336.719898403058;9337.813243735223;7262.854742905007;9009.27925765924;9132.452052876848;9229.630814767603;9284.675036373694;8189.058258300133;8284.295834853863;8289.171082891662;8298;8302.833943320979;4478.910421791611;5798.536117110705;6170.660613666291;6187.690615469299;6222.937770622417;5684.886302274014;6174.8147555573405;6238.563300568917;6258.092576576462;6356.459700925288 03:19:08 INFO - PID 85306 | |4;prototype.html;358.4587273217441;386.5573917864045;390.1027636436196;394.56991878852045;405.426321754717;4846.491118432562;5434.864128396792;5606.887862242757;5931.288245410557;5932.88134237315;4613.077384523092;5039.72281524516;5277.472252774721;5728.885422291552;5854;4153.252414565377;4299.742015479065;4316.309390497506;4326.783660816962;4351.738895666254;4334.111507141044;4338.436003319564;4360.694751367406;4360.869173924787;4362.956370436303;3579.4093974494176;4080.795960201993;4319.69762116652;4320.1575692739925;4334.1765064637775;3499.2476617527227;3509.631488693676;3826.5982071882468;4183.100633363811;4302.827886884521;3752.7935963521995;3755.7746535207702;3765.491658626078;3782.583915769263;3784.678302344304;5653.689047102408;5673.602847800656;5679.829605111853;5680.176374425727;5706.77172913083;3882.8446862125766;4090.529589097262;4841.2496063110275;5087.87280317995;5160.225966105077;5048.394192696863;5857;6206.493331267864;6231.750729970796;6246.687665616746;3746.3631182699005;4279.379489973968;4290.871273861789;4295.5060168080445;4302.548232435581;4744.5492678195515;6206.317305096436;6236.721472098209;6364.013577895434;6502.252240992299;4312.331588603709;4315;4316.2446571849805;4329.675274354373;4343.761093139845;4375.059362237134;4377.868663940087;4388.407564978687;4396.956030439655;4401.779911004437;4744.667873248839;4849.2968519564465;5097.949020509822;5128.333316668809;5150.510701483353;5433.592480563973;6223.541701028069;6237.688115594202;6243.96878015607;6244.375562443719;1196.3300551691082;1253.8527247568554;1464.4435114656362;1494.6786440915039;1506.7513860213162;961.5817119553017;989.302541708094;996.6212839121088;1000.5697550053401;1006.642641862143;4605.065872333628;5831.620944638585;5848.239728835224;5858.384869588717;5867.178594996704;5174.741262936838;6321.747130114744;6361.681915904186;6387.169667943231;6396.648184349812;4856.2958371036;5697.259356283656;5803.88392232153;5861.501772349313;5870.677112758839;2658.494885971659;2881.8270903745843;3323.2220761892754;3327.284633803744;3361.596608407007;6257.124002639634;6468.514861385415;6510.21877374718;6557.049227861933;6717.56335838169;6505.284418713938;6647;6673.733050678015;6689.297623749436;6692.933070669328;5995.370486098896;6568.310327415553;6647.66761661915;6676;6694.430973367318;6442.549021568632;6452.12896258999;6456.9354306456335;6473.640535487601;6474.223093228843;5359.3032905722;5402.945970540244;6303.054541818764;6401.487880969605;6408.679566021773;4540.500544939988;5457.8265672880525;6550.279469258282;6657.833554161185;6666.933210723122;3512.279982603509;3608.1520842601444;3859.899928520358;4295.871123866289;4347.5652434756275;5335.759890804846;6211.3478084800445;6451.225852897683;6496.415322620986;6544.54188206821;5433.320834895638;6239.344868788712;6251.124842521959;6264.436200741955;6276.403741644536;5409.648372855751;6057.212562366864;6155.384461553988;6235;6266.279377871603;5371.677699338053;5756.164821549751;5880.7356418370255;6139.693015349126;6148.44663980244;5729.770809167587;6188.690565471798;6247.969085101089;6284.214473190851;6305.684715764285;5905.52755779528;6062.151298818081;6129.233845769279;6141.9078713818435;6157.507399408126 03:19:08 INFO - PID 85306 | |5;yui.html;706.0961968680091;854.6581367453014;856.0668870930684;858.2490320969152;879.6569337958196;12595;12879.162854414457;12896.22622642641;12901.354932253385;13141.47434102637;13093.67265818355;16567;17034;17183;17460.214290356933;971.1162841813933;991.2317953585992;993.587661120634;995.0845222395377;995.6365926436835;971.5385192033798;971.5919313888148;971.9659811906585;972.1153750087421;975.1077763846072;680.2619158213345;702.5257950883133;983.6409710455667;1030.361176070837;1032.7469769906345;1025.1030348445147;1026.4970164619358;1026.9229807764373;1029.3103620574234;1031.437866362834;758.8140905478193;759.9740350526745;761.790507610406;761.8628646843566;770.8342706318168;15860.52418427449;16261.024338539608;16348.83651163485;16367.345306187739;16723.91638041814;16683.6663266734;16781.83218167815;16970.575735606708;17209;17228.138593070296;12874.519430265545;13163.407646655924;13969.301534923214;14085.014049016572;14195.929020354832;3391.355642427931;3431.656834316548;3432.1419645088727;3432.2449061206494;3432.8111953842526;114160;115828;115834;115996;116830.22791923152;11016.504257308441;12260.938695306644;12269.2638441692;12273.877261227452;12284.815727764091;18543.72184417235;24547.140850070162;24554.754452455603;24659.506809864062;25018.624720629206;7731.690732370642;7906;7907.2488113629115;7913.050433947963;7924.564148971862;3875.5155605549307;3888.9027774305305;3912.158885839558;3935.2326296371934;3951.9922419783347;4273.658107351404;4359.738415695005;4359.738415695068;4366;4366.214081465303;786.8983423207441;881.3037700216757;884.5046773806689;892.7544925145637;901.1169054326797;644.9838754031186;674.8515326628134;681.8602186551745;683.6957553888471;693.9583624982517;10989.285696429706;11593.536258549731;11740.354280514654;12031.458584363725;12153.331566763913;643.6459947029115;644.2848438233557;647.3235468934975;659.2122413715659;677.7831094049857;5227.895442091137;5449.591280653887;5492.450754924475;5604.523615492647;5654.434556544395;96064;102152;102947.13160854894;105547.41678874823;106088.46955765327;91236.08763912276;91792;92595;93512.59731104039;93909.0609093914;79058.20941790624;79560;80050;81331.59334203291;81393;8751.693690720795;11333.829992549954;11336.319820810777;11404.011747049606;11441.599544015919;39888.80055599703;40362.798186008884;41230.587694122674;41400;41454.79272603738;35617.64382356247;51759.964800704525;52646;53059.469405307;54238;11907.702307442383;14044.227567483886;14101.717965640424;14314.212718300594;14365.20991345486;15257;17568.56078598045;17949.282028718706;18535.90732046331;18612.44162675122;16575.41986030483;16785.91607042006;16961.321547137977;17125.400610978555;17153.74269385985;16617.169141542632;16730.49808505747;16763.910345827484;16959.406420775213;17081.658366832344;16714.665706685555;16851.073190974123;16919.069451180305;16987.150642468074;17107.48677539676;11571.594994175164;11635.941820291184;12038.435003449495;12064.691535724252;12155.270683759003;11396.544138234378;11809.23239989398;11828.52685892589;11829.52681892749;11928.821067684165 03:19:08 INFO - PID 85306 | __end_tp_report 03:19:08 INFO - PID 85306 | __start_cc_report 03:19:08 INFO - PID 85306 | _x_x_mozilla_cycle_collect,2290 03:19:08 INFO - PID 85306 | __end_cc_report 03:19:08 INFO - PID 85306 | __startTimestamp1492856348488__endTimestamp 03:19:08 INFO - PID 85306 | 03:19:08 INFO - PID 85306 | ------- Summary: start ------- 03:19:08 INFO - PID 85306 | Number of tests: 6 03:19:08 INFO - PID 85306 | 03:19:08 INFO - PID 85306 | [#0] dojo.html Cycles:165 Average:5976.32 Median:6251.00 stddev:710.70 (11.4%) stddev-sans-first:669.71 03:19:08 INFO - PID 85306 | Values: 2866.7 3478.5 3513.1 3525.1 3547.0 6173.4 6185.6 6192.2 6205.5 6211.1 6017.7 6065.8 6110.9 6176.9 6183.3 4858.2 5154.6 5241.4 5297.6 5380.2 5216.6 5308.3 5359.6 5406.0 5465.3 5235.5 5237.1 5323.9 5324.9 5374.6 5302.1 5313.6 5324.1 5327.1 5393.9 5289.3 5297.2 5325.6 5328.3 5339.7 5918.6 5937.8 5961.4 5972.6 6155.6 6361.9 6365.8 6367.9 6369.4 6373.9 6338.6 6436.1 6564.3 6604.1 6626.6 6182.3 6237.6 6246.7 6249.3 6265.7 6451.0 6706.6 6718.5 6725.3 6733.7 5233.3 6344.7 6385.7 6441.5 6445.9 6564.5 6570.9 6580.5 6581.5 6583.6 5348.5 6393.1 6477.7 6479.5 6488.6 5245.6 6335.5 6338.0 6343.8 6475.6 5130.9 5144.6 5145.1 5151.6 5152.6 4480.2 4621.7 4677.6 4686.1 4688.2 6029.2 6081.3 6091.2 6091.8 6099.6 6387.9 6513.9 6568.9 6574.5 6604.3 6178.1 6183.4 6188.8 6191.8 6196.4 5743.6 5753.8 5755.4 5759.8 5807.3 6387.8 6486.7 6519.3 6544.3 6562.8 6412.6 6515.9 6544.2 6544.7 6574.5 6741.9 6754.6 6772.5 6772.9 6781.4 6471.6 6473.4 6481.1 6481.1 6484.6 6342.3 6383.5 6395.7 6395.9 6565.8 5211.6 6270.3 6279.0 6291.6 6297.9 6119.4 6272.5 6309.9 6352.6 6389.4 6272.6 6298.4 6310.4 6314.1 6318.7 5575.0 6251.0 6370.8 6408.4 6440.5 6222.8 6249.2 6259.2 6262.2 6267.2 03:19:08 INFO - PID 85306 | 03:19:08 INFO - PID 85306 | [#1] ext.html Cycles:180 Average:43833.90 Median:18810.91 stddev:76746.74 (408.0%) stddev-sans-first:76893.84 03:19:08 INFO - PID 85306 | Values: 740.9 797.3 955.6 1112.6 1125.7 36317.6 36430.0 36744.3 36767.0 36780.3 39314.0 39585.4 39661.0 39773.0 39866.6 5992.2 6147.5 8371.1 8541.7 8555.7 8257.5 8460.4 8478.7 8479.8 8515.1 7835.7 8051.9 8490.0 8548.0 8550.2 8472.3 8528.7 8529.4 8541.5 8574.6 8360.5 8369.9 8424.3 8425.7 8438.6 36726.4 37018.0 37082.3 37087.8 37202.4 3544.7 3567.0 3570.1 3570.4 3571.0 30198.0 30213.2 30257.7 30270.8 30297.5 3123.0 3146.5 3173.0 3187.3 3193.7 275994.0 281144.0 281450.0 281651.0 282790.0 39150.8 39286.8 39298.6 48912.5 48952.8 48499.5 48779.8 48880.0 48899.0 50065.0 13530.8 13622.5 13636.3 13638.9 13663.0 8831.6 8832.4 8836.5 11075.4 11082.4 10764.7 10802.9 10813.1 12291.6 12381.6 5473.0 5474.1 5502.0 5508.1 5525.0 979.5 995.8 1022.5 1043.7 1074.4 23770.3 23885.2 23902.3 23922.0 24162.4 1110.4 1111.3 1143.3 1147.3 1168.0 9123.6 10733.5 11811.0 12238.6 12277.9 308573.0 309053.0 309215.0 309665.0 309692.0 52629.9 52659.7 52704.7 52715.7 52717.0 1471.2 1489.7 1535.2 1536.0 1541.8 20148.2 21422.5 23419.6 23556.4 23572.9 37294.8 37395.8 37401.0 37426.4 37454.0 286598.6 287339.0 287379.1 287536.0 287737.0 33934.3 33957.8 33975.7 34032.8 34077.1 37243.6 39405.6 43472.0 43562.6 44339.3 29435.1 29786.9 29861.3 30433.8 30914.1 30389.5 30484.5 30586.8 30945.2 31040.2 35644.6 35712.9 36255.9 36408.9 36521.1 24836.9 29514.9 29828.7 30729.2 31005.7 22260.1 22612.8 22777.8 23608.0 24049.2 03:19:08 INFO - PID 85306 | 03:19:08 INFO - PID 85306 | [#2] jquery.html Cycles:180 Average:36022.39 Median:12233.17 stddev:96914.72 (792.2%) stddev-sans-first:97149.66 03:19:08 INFO - PID 85306 | Values: 391.2 396.0 422.4 434.9 440.7 13098.4 15161.0 21271.3 21543.6 21650.1 16296.1 18502.6 20865.8 21980.2 22255.4 5904.1 5959.4 6111.8 6178.8 6182.6 3613.3 3667.2 6061.0 6175.9 6186.8 5832.7 6135.8 6158.8 6166.3 6179.3 6047.3 6065.9 6140.7 6159.4 6168.7 5285.9 5439.9 5446.3 5452.2 5456.3 26094.1 26666.7 27231.3 27517.4 27761.9 2148.9 2203.2 2204.5 2206.6 2210.9 17548.1 17857.6 18121.8 18266.5 18594.9 2063.2 2135.7 2162.8 2164.8 2175.1 161574.3 161665.0 164795.0 165010.3 166370.2 9855.5 12374.2 12590.4 12645.9 12840.6 16647.8 16664.8 16683.6 16748.8 16780.0 8593.4 8936.3 8947.2 9037.9 9078.3 6873.8 8392.4 8398.5 8568.4 8572.9 7662.0 7802.0 7833.5 7836.0 7848.9 2154.5 2169.0 2170.2 2180.8 2364.0 939.4 941.4 941.9 945.7 973.0 20138.6 20273.0 20474.3 20532.8 20785.7 944.4 982.0 984.5 987.8 995.0 9905.0 10574.4 10651.0 10729.4 10759.4 565781.0 567779.0 573537.0 578041.0 579130.0 114325.0 119183.2 120918.0 122249.0 129914.0 1151.3 1159.3 1201.8 1205.5 1208.3 21026.2 21156.9 21325.4 21518.0 21607.8 55294.2 56150.9 56469.4 57989.7 58617.7 57110.0 75650.6 76555.9 77063.2 77397.2 8450.0 8725.2 9038.2 9181.8 9284.5 14115.9 14201.9 14209.4 14722.1 14753.3 11872.1 11877.3 12142.8 12221.9 12236.8 11344.2 11550.7 11587.9 11940.6 11976.7 12142.2 12166.6 12406.6 12592.7 12622.8 8955.9 8999.6 9038.1 9054.7 9070.9 11865.4 12032.5 12085.3 12219.2 12280.0 03:19:08 INFO - PID 85306 | 03:19:08 INFO - PID 85306 | [#3] mootools.html Cycles:180 Average:7049.57 Median:3694.09 stddev:4492.24 (121.6%) stddev-sans-first:4484.38 03:19:08 INFO - PID 85306 | Values: 1344.0 1389.7 1408.2 1448.0 1449.7 10716.9 11764.9 11781.8 11782.1 11799.3 10595.6 11433.0 11470.8 11716.5 11730.1 2502.6 2542.6 2543.9 2543.9 2548.4 2103.3 2410.7 2520.1 2524.5 2525.5 2136.4 2157.4 2160.4 2162.3 2164.3 2142.6 2419.8 2469.7 2471.0 2503.6 2438.9 2467.9 2472.1 2474.2 2479.1 9279.6 11652.1 11667.3 11669.2 11669.7 6454.0 6705.0 6711.7 6718.0 6720.4 3531.3 3656.2 3732.0 3745.8 4325.6 1243.2 1250.2 1272.2 1305.0 1305.9 16392.8 16505.3 16529.2 16568.9 16575.8 4833.8 4961.3 5395.5 5423.7 5574.7 12121.7 12126.7 12132.3 12138.8 12151.4 6457.1 6509.1 6509.5 6515.3 6515.5 6029.5 6086.8 6167.8 6248.0 6268.6 3887.0 4138.9 4212.8 4357.2 4414.3 1252.6 1254.1 1270.3 1272.1 1278.9 786.5 792.4 807.7 811.3 827.2 5884.3 5887.8 7382.6 7444.7 7470.9 580.1 580.8 587.5 588.7 599.9 4173.8 4345.4 4345.8 4348.8 4474.8 11754.8 15022.1 15164.6 15181.5 15220.7 12131.8 13423.6 14303.1 15010.9 15047.5 8414.2 8620.3 8639.1 8644.0 8678.1 6627.4 6829.8 7095.1 7100.9 7207.3 13222.6 13563.8 13621.5 13636.7 13643.0 13601.3 13841.7 13953.0 13977.2 14046.7 9403.3 9482.9 9618.9 9623.1 9634.5 10620.6 10623.8 10704.9 10744.7 10773.1 9241.3 9284.3 9286.5 9336.7 9337.8 7262.9 9009.3 9132.5 9229.6 9284.7 8189.1 8284.3 8289.2 8298.0 8302.8 4478.9 5798.5 6170.7 6187.7 6222.9 5684.9 6174.8 6238.6 6258.1 6356.5 03:19:08 INFO - PID 85306 | 03:19:08 INFO - PID 85306 | [#4] prototype.html Cycles:180 Average:4974.13 Median:5532.36 stddev:1580.99 (28.6%) stddev-sans-first:1547.00 03:19:08 INFO - PID 85306 | Values: 358.5 386.6 390.1 394.6 405.4 4846.5 5434.9 5606.9 5931.3 5932.9 4613.1 5039.7 5277.5 5728.9 5854.0 4153.3 4299.7 4316.3 4326.8 4351.7 4334.1 4338.4 4360.7 4360.9 4363.0 3579.4 4080.8 4319.7 4320.2 4334.2 3499.2 3509.6 3826.6 4183.1 4302.8 3752.8 3755.8 3765.5 3782.6 3784.7 5653.7 5673.6 5679.8 5680.2 5706.8 3882.8 4090.5 4841.2 5087.9 5160.2 5048.4 5857.0 6206.5 6231.8 6246.7 3746.4 4279.4 4290.9 4295.5 4302.5 4744.5 6206.3 6236.7 6364.0 6502.3 4312.3 4315.0 4316.2 4329.7 4343.8 4375.1 4377.9 4388.4 4397.0 4401.8 4744.7 4849.3 5097.9 5128.3 5150.5 5433.6 6223.5 6237.7 6244.0 6244.4 1196.3 1253.9 1464.4 1494.7 1506.8 961.6 989.3 996.6 1000.6 1006.6 4605.1 5831.6 5848.2 5858.4 5867.2 5174.7 6321.7 6361.7 6387.2 6396.6 4856.3 5697.3 5803.9 5861.5 5870.7 2658.5 2881.8 3323.2 3327.3 3361.6 6257.1 6468.5 6510.2 6557.0 6717.6 6505.3 6647.0 6673.7 6689.3 6692.9 5995.4 6568.3 6647.7 6676.0 6694.4 6442.5 6452.1 6456.9 6473.6 6474.2 5359.3 5402.9 6303.1 6401.5 6408.7 4540.5 5457.8 6550.3 6657.8 6666.9 3512.3 3608.2 3859.9 4295.9 4347.6 5335.8 6211.3 6451.2 6496.4 6544.5 5433.3 6239.3 6251.1 6264.4 6276.4 5409.6 6057.2 6155.4 6235.0 6266.3 5371.7 5756.2 5880.7 6139.7 6148.4 5729.8 6188.7 6248.0 6284.2 6305.7 5905.5 6062.2 6129.2 6141.9 6157.5 03:19:08 INFO - PID 85306 | 03:19:08 INFO - PID 85306 | [#5] yui.html Cycles:180 Average:20944.64 Median:21579.79 stddev:29537.66 (136.9%) stddev-sans-first:29581.43 03:19:08 INFO - PID 85306 | Values: 706.1 854.7 856.1 858.2 879.7 12595.0 12879.2 12896.2 12901.4 13141.5 13093.7 16567.0 17034.0 17183.0 17460.2 971.1 991.2 993.6 995.1 995.6 971.5 971.6 972.0 972.1 975.1 680.3 702.5 983.6 1030.4 1032.7 1025.1 1026.5 1026.9 1029.3 1031.4 758.8 760.0 761.8 761.9 770.8 15860.5 16261.0 16348.8 16367.3 16723.9 16683.7 16781.8 16970.6 17209.0 17228.1 12874.5 13163.4 13969.3 14085.0 14195.9 3391.4 3431.7 3432.1 3432.2 3432.8 114160.0 115828.0 115834.0 115996.0 116830.2 11016.5 12260.9 12269.3 12273.9 12284.8 18543.7 24547.1 24554.8 24659.5 25018.6 7731.7 7906.0 7907.2 7913.1 7924.6 3875.5 3888.9 3912.2 3935.2 3952.0 4273.7 4359.7 4359.7 4366.0 4366.2 786.9 881.3 884.5 892.8 901.1 645.0 674.9 681.9 683.7 694.0 10989.3 11593.5 11740.4 12031.5 12153.3 643.6 644.3 647.3 659.2 677.8 5227.9 5449.6 5492.5 5604.5 5654.4 96064.0 102152.0 102947.1 105547.4 106088.5 91236.1 91792.0 92595.0 93512.6 93909.1 79058.2 79560.0 80050.0 81331.6 81393.0 8751.7 11333.8 11336.3 11404.0 11441.6 39888.8 40362.8 41230.6 41400.0 41454.8 35617.6 51760.0 52646.0 53059.5 54238.0 11907.7 14044.2 14101.7 14314.2 14365.2 15257.0 17568.6 17949.3 18535.9 18612.4 16575.4 16785.9 16961.3 17125.4 17153.7 16617.2 16730.5 16763.9 16959.4 17081.7 16714.7 16851.1 16919.1 16987.2 17107.5 11571.6 11635.9 12038.4 12064.7 12155.3 11396.5 11809.2 11828.5 11829.5 11928.8 03:19:08 INFO - PID 85306 | -------- Summary: end -------- 03:19:08 INFO - PID 85306 | 03:19:09 INFO - TEST-INFO | 85306: exit 0 03:19:09 INFO - TEST-OK | dromaeo_css | took 1119718ms 03:19:09 INFO - TEST-START | kraken 03:19:09 INFO - operating with platform_type : mac_ 03:19:09 INFO - Initialising browser for kraken test... 03:19:09 INFO - TEST-INFO | started process 85311 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmpruhSOw/profile http://localhost:56850/getInfo.html) 03:19:11 INFO - PID 85311 | __metrics Screen width/height:1600/1200 03:19:11 INFO - PID 85311 | colorDepth:24 03:19:11 INFO - PID 85311 | Browser inner width/height: 1024/689 03:19:11 INFO - PID 85311 | __metrics 03:19:11 INFO - PID 85311 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:19:11 INFO - PID 85311 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:19:12 INFO - TEST-INFO | 85311: exit 0 03:19:12 INFO - Browser initialized. 03:19:12 INFO - Running cycle 1/1 for kraken test... 03:19:12 INFO - TEST-INFO | started process 85312 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmpruhSOw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:25 INFO - PID 85312 | RSS: Main: 241590272 03:19:25 INFO - PID 85312 | 03:19:27 INFO - PID 85312 | Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56850/tests/kraken/driver.html?testName=audio-beat-detection) 03:19:28 INFO - PID 85312 | RSS: Main: 312692736 03:19:28 INFO - PID 85312 | 03:19:31 INFO - PID 85312 | Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56850/tests/kraken/driver.html?testName=audio-dft) 03:19:31 INFO - PID 85312 | RSS: Main: 293937152 03:19:31 INFO - PID 85312 | 03:19:35 INFO - PID 85312 | Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56850/tests/kraken/driver.html?testName=audio-fft) 03:19:35 INFO - PID 85312 | RSS: Main: 386191360 03:19:35 INFO - PID 85312 | 03:19:37 INFO - PID 85312 | Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56850/tests/kraken/driver.html?testName=audio-oscillator) 03:19:38 INFO - PID 85312 | RSS: Main: 287084544 03:19:38 INFO - PID 85312 | 03:19:40 INFO - PID 85312 | Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56850/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:19:41 INFO - PID 85312 | RSS: Main: 290398208 03:19:41 INFO - PID 85312 | 03:19:44 INFO - PID 85312 | Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56850/tests/kraken/driver.html?testName=imaging-darkroom) 03:19:44 INFO - PID 85312 | RSS: Main: 353206272 03:19:44 INFO - PID 85312 | 03:19:47 INFO - PID 85312 | Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56850/tests/kraken/driver.html?testName=imaging-desaturate) 03:19:48 INFO - PID 85312 | RSS: Main: 375443456 03:19:48 INFO - PID 85312 | 03:19:50 INFO - PID 85312 | Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56850/tests/kraken/driver.html?testName=json-parse-financial) 03:19:51 INFO - PID 85312 | RSS: Main: 390008832 03:19:51 INFO - PID 85312 | 03:19:53 INFO - PID 85312 | Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56850/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:19:53 INFO - PID 85312 | RSS: Main: 332177408 03:19:53 INFO - PID 85312 | 03:19:55 INFO - PID 85312 | Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56850/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:19:56 INFO - PID 85312 | RSS: Main: 335564800 03:19:56 INFO - PID 85312 | 03:19:58 INFO - PID 85312 | Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56850/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:19:58 INFO - PID 85312 | RSS: Main: 336826368 03:19:58 INFO - PID 85312 | 03:20:01 INFO - PID 85312 | Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56850/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:20:02 INFO - PID 85312 | RSS: Main: 336498688 03:20:02 INFO - PID 85312 | 03:20:05 INFO - PID 85312 | Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56850/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:20:06 INFO - PID 85312 | RSS: Main: 345698304 03:20:06 INFO - PID 85312 | 03:20:08 INFO - PID 85312 | Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56850/tests/kraken/driver.html?testName=ai-astar) 03:20:08 INFO - PID 85312 | RSS: Main: 388550656 03:20:08 INFO - PID 85312 | 03:20:08 INFO - PID 85312 | __start_tp_report 03:20:08 INFO - PID 85312 | _x_x_mozilla_page_load 03:20:08 INFO - PID 85312 | _x_x_mozilla_page_load_details 03:20:08 INFO - PID 85312 | |i|pagename|runs| 03:20:08 INFO - PID 85312 | |0;ai-astar;109;110;110;111;111;110;111;110;110;111 03:20:08 INFO - PID 85312 | |1;audio-beat-detection;133;110;107;152;113;109;106;115;152;92 03:20:08 INFO - PID 85312 | |2;audio-dft;187;185;184;188;187;186;184;184;185;184 03:20:08 INFO - PID 85312 | |3;audio-fft;79;59;57;93;81;88;89;83;81;58 03:20:08 INFO - PID 85312 | |4;audio-oscillator;91;68;85;69;68;93;111;103;68;89 03:20:08 INFO - PID 85312 | |5;imaging-gaussian-blur;89;88;89;88;89;88;88;88;95;88 03:20:08 INFO - PID 85312 | |6;imaging-darkroom;96;97;96;96;96;96;96;95;96;96 03:20:08 INFO - PID 85312 | |7;imaging-desaturate;87;85;84;85;84;84;84;86;88;85 03:20:08 INFO - PID 85312 | |8;json-parse-financial;49;49;49;48;48;50;48;48;49;47 03:20:08 INFO - PID 85312 | |9;json-stringify-tinderbox;53;52;61;69;63;60;58;57;56;57 03:20:08 INFO - PID 85312 | |10;stanford-crypto-aes;84;84;82;80;82;82;83;101;82;82 03:20:08 INFO - PID 85312 | |11;stanford-crypto-ccm;136;166;163;122;137;152;146;129;202;164 03:20:08 INFO - PID 85312 | |12;stanford-crypto-pbkdf2;186;184;233;206;185;185;183;181;235;231 03:20:08 INFO - PID 85312 | |13;stanford-crypto-sha256-iterative;67;68;68;66;68;65;67;70;68;67 03:20:08 INFO - PID 85312 | __end_tp_report 03:20:08 INFO - PID 85312 | __start_cc_report 03:20:08 INFO - PID 85312 | _x_x_mozilla_cycle_collect,2208 03:20:08 INFO - PID 85312 | __end_cc_report 03:20:08 INFO - PID 85312 | __startTimestamp1492856408585__endTimestamp 03:20:08 INFO - PID 85312 | 03:20:08 INFO - PID 85312 | ------- Summary: start ------- 03:20:08 INFO - PID 85312 | Number of tests: 14 03:20:08 INFO - PID 85312 | 03:20:08 INFO - PID 85312 | [#0] ai-astar Cycles:10 Average:110.30 Median:110.50 stddev:0.67 (0.6%) stddev-sans-first:0.53 03:20:08 INFO - PID 85312 | Values: 109.0 110.0 110.0 111.0 111.0 110.0 111.0 110.0 110.0 111.0 03:20:08 INFO - PID 85312 | 03:20:08 INFO - PID 85312 | [#1] audio-beat-detection Cycles:10 Average:118.90 Median:124.00 stddev:20.14 (16.2%) stddev-sans-first:20.70 03:20:08 INFO - PID 85312 | Values: 133.0 110.0 107.0 152.0 113.0 109.0 106.0 115.0 152.0 92.0 03:20:08 INFO - PID 85312 | 03:20:08 INFO - PID 85312 | [#2] audio-dft Cycles:10 Average:185.40 Median:185.50 stddev:1.51 (0.8%) stddev-sans-first:1.48 03:20:08 INFO - PID 85312 | Values: 187.0 185.0 184.0 188.0 187.0 186.0 184.0 184.0 185.0 184.0 03:20:08 INFO - PID 85312 | 03:20:08 INFO - PID 85312 | [#3] audio-fft Cycles:10 Average:76.80 Median:82.00 stddev:13.65 (16.6%) stddev-sans-first:14.46 03:20:08 INFO - PID 85312 | Values: 79.0 59.0 57.0 93.0 81.0 88.0 89.0 83.0 81.0 58.0 03:20:08 INFO - PID 85312 | 03:20:08 INFO - PID 85312 | [#4] audio-oscillator Cycles:10 Average:84.50 Median:77.00 stddev:15.76 (20.5%) stddev-sans-first:16.54 03:20:08 INFO - PID 85312 | Values: 91.0 68.0 85.0 69.0 68.0 93.0 111.0 103.0 68.0 89.0 03:20:08 INFO - PID 85312 | 03:20:08 INFO - PID 85312 | [#5] imaging-gaussian-blur Cycles:10 Average:89.00 Median:88.50 stddev:2.16 (2.4%) stddev-sans-first:2.29 03:20:08 INFO - PID 85312 | Values: 89.0 88.0 89.0 88.0 89.0 88.0 88.0 88.0 95.0 88.0 03:20:08 INFO - PID 85312 | 03:20:08 INFO - PID 85312 | [#6] imaging-darkroom Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 03:20:08 INFO - PID 85312 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 03:20:08 INFO - PID 85312 | 03:20:08 INFO - PID 85312 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:1.40 (1.6%) stddev-sans-first:1.32 03:20:08 INFO - PID 85312 | Values: 87.0 85.0 84.0 85.0 84.0 84.0 84.0 86.0 88.0 85.0 03:20:08 INFO - PID 85312 | 03:20:08 INFO - PID 85312 | [#8] json-parse-financial Cycles:10 Average:48.50 Median:49.00 stddev:0.85 (1.7%) stddev-sans-first:0.88 03:20:08 INFO - PID 85312 | Values: 49.0 49.0 49.0 48.0 48.0 50.0 48.0 48.0 49.0 47.0 03:20:08 INFO - PID 85312 | 03:20:08 INFO - PID 85312 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:4.97 (8.4%) stddev-sans-first:4.84 03:20:08 INFO - PID 85312 | Values: 53.0 52.0 61.0 69.0 63.0 60.0 58.0 57.0 56.0 57.0 03:20:08 INFO - PID 85312 | 03:20:08 INFO - PID 85312 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:82.00 stddev:6.01 (7.3%) stddev-sans-first:6.38 03:20:08 INFO - PID 85312 | Values: 84.0 84.0 82.0 80.0 82.0 82.0 83.0 101.0 82.0 82.0 03:20:08 INFO - PID 85312 | 03:20:08 INFO - PID 85312 | [#11] stanford-crypto-ccm Cycles:10 Average:151.70 Median:157.50 stddev:23.35 (14.8%) stddev-sans-first:24.06 03:20:08 INFO - PID 85312 | Values: 136.0 166.0 163.0 122.0 137.0 152.0 146.0 129.0 202.0 164.0 03:20:08 INFO - PID 85312 | 03:20:08 INFO - PID 85312 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:200.90 Median:196.00 stddev:23.23 (11.8%) stddev-sans-first:24.00 03:20:08 INFO - PID 85312 | Values: 186.0 184.0 233.0 206.0 185.0 185.0 183.0 181.0 235.0 231.0 03:20:08 INFO - PID 85312 | 03:20:08 INFO - PID 85312 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:1.35 (2.0%) stddev-sans-first:1.42 03:20:08 INFO - PID 85312 | Values: 67.0 68.0 68.0 66.0 68.0 65.0 67.0 70.0 68.0 67.0 03:20:08 INFO - PID 85312 | -------- Summary: end -------- 03:20:08 INFO - PID 85312 | 03:20:09 INFO - TEST-INFO | 85312: exit 0 03:20:09 INFO - TEST-OK | kraken | took 60484ms 03:20:09 INFO - SUITE-END | took 1180s 03:20:09 INFO - Completed test suite (00:19:40) 03:20:09 INFO - javascript benchmark 03:20:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7637.739992697977, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2866.7276608722173, 3478.4956181353687, 3513.069036705272, 3525.0658575477487, 3546.953648673641, 6173.3517980612005, 6185.56701030928, 6192.195014648089, 6205.503559715224, 6211.06833974904, 6017.661058197435, 6065.848353791146, 6110.862540392742, 6176.907346389808, 6183.288921773998, 4858.1983972644475, 5154.561862241714, 5241.397239317489, 5297.629165958385, 5380.166074258476, 5216.582673386139, 5308.283381743473, 5359.5712343012665, 5406.0, 5465.289512363407, 5235.528802407783, 5237.057329680656, 5323.946760532423, 5324.866878328034, 5374.5700343972385, 5302.125149350352, 5313.57491400687, 5324.094903866313, 5327.067763141435, 5393.946060539383, 5289.285946397225, 5297.205419187114, 5325.627206095575, 5328.333958255218, 5339.679619222859, 5918.556108291896, 5937.821865344046, 5961.374055724174, 5972.641641501524, 6155.569110162291, 6361.872762544769, 6365.840853978688, 6367.872642547123, 6369.426751592333, 6373.872522549569, 6338.58799178052, 6436.131122298477, 6564.310747371505, 6604.1084453599115, 6626.602403855784, 6182.258129024501, 6237.625742455467, 6246.718897649616, 6249.2813326467585, 6265.749370025239, 6450.967745161244, 6706.59760414367, 6718.49611279156, 6725.293844146392, 6733.730650773914, 5233.267342572043, 6344.746210151542, 6385.680715964183, 6441.452476539453, 6445.903311450332, 6564.5076619252795, 6570.901436478457, 6580.473562115019, 6581.506387020992, 6583.63789991555, 5348.465153484621, 6393.073004414334, 6477.676116194171, 6479.546431749733, 6488.643124628191, 5245.554127899095, 6335.461485773761, 6338.049292606146, 6343.809685709436, 6475.579087359307, 5130.871728206825, 5144.639875208774, 5145.07388670043, 5151.5878729701535, 5152.587792976553, 4480.193565158238, 4621.676482646182, 4677.6257899367965, 4686.109639168547, 4688.226442636927, 6029.186059881948, 6081.27024757032, 6091.208142941389, 6091.786787462417, 6099.603525770811, 6387.904181437282, 6513.902291465537, 6568.901466478007, 6574.539782215199, 6604.3395660434535, 6178.073289006595, 6183.412575805291, 6188.81433556994, 6191.84520386994, 6196.411340922605, 5743.62666426681, 5753.798617048383, 5755.366909639936, 5759.798407055733, 5807.303123625192, 6387.840303992437, 6486.708098135595, 6519.348065193538, 6544.280129185881, 6562.770303039275, 6412.647304398303, 6515.869682606416, 6544.181977252843, 6544.705488253136, 6574.53978221539, 6741.932580674131, 6754.5609535380045, 6772.52592318533, 6772.93227067723, 6781.423578995643, 6471.579347342407, 6473.352664733489, 6481.092647029325, 6481.125048118443, 6484.643344616092, 6342.334054924167, 6383.457406120532, 6395.712192951235, 6395.936040639534, 6565.835854103686, 5211.557017653542, 6270.341614130451, 6278.968605156945, 6291.622502649856, 6297.937020629918, 6119.41115851624, 6272.466840318624, 6309.936900630935, 6352.555321127476, 6389.393007664265, 6272.6236425814595, 6298.401651843067, 6310.368963103653, 6314.052892066226, 6318.715657795502, 5574.9721251393485, 6251.0, 6370.8088757337355, 6408.391202835724, 6440.516961228021, 6222.751089956532, 6249.187605611241, 6259.155014073224, 6262.248530176408, 6267.185265915402], "value": 5928.9519633415075, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.9481336306459, 797.310326567519, 955.6320816485655, 1112.599464192891, 1125.6510481750663, 36317.63682363176, 36430.0, 36744.26511469776, 36767.0, 36780.264394712125, 39314.0, 39585.40621890674, 39661.0, 39773.0, 39866.6046688366, 5992.221011268529, 6147.538934579902, 8371.079181290053, 8541.743747687578, 8555.743327700178, 8257.545834979073, 8460.36547258955, 8478.745637630851, 8479.83040339196, 8515.105913879046, 7835.746280595106, 8051.879221811678, 8489.95755021224, 8548.0, 8550.187732165434, 8472.322214222848, 8528.70149544766, 8529.360297977677, 8541.530215838126, 8574.614142363545, 8360.45657032291, 8369.874451883226, 8424.326053915673, 8425.747227583182, 8438.620262088221, 36726.449103263476, 37018.0, 37082.25835483275, 37087.81456092702, 37202.44196337057, 3544.680978711928, 3567.0369000369756, 3570.107473131717, 3570.410882204459, 3570.9822700530226, 30198.0, 30213.244668883235, 30257.697423025707, 30270.84864575685, 30297.545536816964, 3123.04747052149, 3146.5437511560926, 3173.0, 3187.2987942652812, 3193.7125658690597, 275994.0, 281144.0, 281450.0, 281651.0, 282790.0, 39150.80424597859, 39286.80356598199, 39298.607013930065, 48912.51087489151, 48952.77618059577, 48499.515004850204, 48779.78050548694, 48880.02239955181, 48899.0, 50064.9987000258, 13530.797038044437, 13622.523211687543, 13636.250006249751, 13638.863611363959, 13663.0, 8831.646734130563, 8832.38173327861, 8836.513991730517, 11075.390853502973, 11082.445877706083, 10764.730881728019, 10802.94598527018, 10813.08088812444, 12291.631251062483, 12381.566645167375, 5472.960137573848, 5474.069408200616, 5502.0, 5508.118701007819, 5524.972375138099, 979.5102448775613, 995.8257304971601, 1022.5245260953692, 1043.7234132954773, 1074.4359211413914, 23770.286891393287, 23885.164019259242, 23902.282931512083, 23922.0, 24162.395940101636, 1110.3837370259585, 1111.283222321598, 1143.2511704833348, 1147.3288126446123, 1167.9941600291945, 9123.635054597742, 10733.463326833784, 11811.0, 12238.636476834707, 12277.856275746653, 308573.0, 309053.0, 309215.0, 309665.0, 309692.0, 52629.947401051766, 52659.736701317015, 52704.68238294074, 52715.73642131841, 52717.0, 1471.220253265771, 1489.7020595880651, 1535.1786794065122, 1536.0476504567016, 1541.814982202143, 20148.194072237533, 21422.464438389165, 23419.648705269094, 23556.411089722893, 23572.88213558921, 37294.81352593219, 37395.81302093472, 37401.0, 37426.43860342151, 37454.0, 286598.567007172, 287339.0, 287379.1262087352, 287536.0, 287737.0, 33934.32131357408, 33957.830210848784, 33975.66024339725, 34032.829835851655, 34077.14807129842, 37243.62756372402, 39405.605943940194, 43472.0, 43562.564374355854, 44339.33490997702, 29435.11694649164, 29786.851065744533, 29861.253468663457, 30433.847830760704, 30914.072577822702, 30389.544156837223, 30484.542731858597, 30586.84706576453, 30945.226369340948, 31040.223994399417, 35644.643553564136, 35712.92861214168, 36255.91232263036, 36408.90773276806, 36521.08697282589, 24836.875815620806, 29514.852425737732, 29828.70171298346, 30729.231769205948, 31005.68994310028, 22260.109595616643, 22612.773872261725, 22777.77222227823, 23608.0, 24049.158279460135], "value": 16983.847300910915, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.1980440097799, 395.9663428608568, 422.44815519616105, 434.889103278664, 440.67390131302835, 13098.41057152428, 15161.014534055292, 21271.255506057292, 21543.56912861742, 21650.133994640197, 16296.10371429574, 18502.629947401045, 20865.791342086573, 21980.230691925786, 22255.44361390962, 5904.114382842565, 5959.433853783884, 6111.816645500619, 6178.8455288617915, 6182.567220294559, 3613.331533666267, 3667.1748856507206, 6061.0, 6175.876482470348, 6186.793575252827, 5832.708364581754, 6135.754569817202, 6158.84602884927, 6166.321704612489, 6179.3202747697715, 6047.334793172748, 6065.878682426327, 6140.6929653517145, 6159.445649891509, 6168.722407491651, 5285.86785330366, 5439.945600544023, 5446.346438427375, 5452.173521870178, 5456.290682211326, 26094.086706965354, 26666.73333266662, 27231.319217019733, 27517.449651007068, 27761.86119069412, 2148.924787632441, 2203.2178576605393, 2204.481946742514, 2206.6028114939304, 2210.8894555272173, 17548.122593870256, 17857.642847142983, 18121.818781812275, 18266.452006439828, 18594.90702546492, 2063.1953538120147, 2135.7010018597407, 2162.837787165953, 2164.805167534914, 2175.119076773909, 161574.34489792917, 161665.0, 164795.0, 165010.3498965007, 166370.1681491597, 9855.457949812686, 12374.195677280948, 12590.43343049565, 12645.87354126447, 12840.61478155657, 16647.83352166487, 16664.75002874958, 16683.582910427336, 16748.83251167497, 16780.0, 8593.398462107592, 8936.329775266751, 8947.239484643747, 9037.909620903838, 9078.273738100936, 6873.828154296082, 8392.370572207108, 8398.538080405637, 8568.400211985227, 8572.871406928902, 7662.0, 7802.024746906637, 7833.451658383859, 7836.0, 7848.882266766003, 2154.4829240982367, 2168.9566208676056, 2170.197027099983, 2180.8146307564034, 2363.959857662623, 939.3893968920256, 941.3692825806726, 941.924646028316, 945.680775318427, 972.9951350243346, 20138.597228055358, 20273.0, 20474.283400081225, 20532.794672053387, 20785.688214676793, 944.4380593546829, 981.9803603927882, 984.5274268351232, 987.7579992901641, 994.9701508954743, 9904.950475247722, 10574.365538067741, 10651.041406273473, 10729.409882456384, 10759.408232547128, 565781.0, 567779.0, 573537.0, 578041.0, 579130.0, 114325.0, 119183.2122518163, 120918.0, 122249.0, 129914.0, 1151.3379806611233, 1159.3380522142438, 1201.7596480703894, 1205.4635687119148, 1208.2810727617054, 21026.158953641683, 21156.89421552944, 21325.36023919285, 21518.0, 21607.783922160575, 55294.17058744202, 56150.87698246094, 56469.43530564642, 57989.710051449474, 58617.70691146517, 57110.0, 75650.62174689092, 76555.85166222623, 77063.22936770784, 77397.226027739, 8449.95775021121, 8725.171108744658, 9038.186563209343, 9181.7992275693, 9284.489353085644, 14115.858841411455, 14201.928990354982, 14209.360578774187, 14722.116672999655, 14753.336099875745, 11872.109591780823, 11877.287362758263, 12142.75714485723, 12221.877781222074, 12236.816447753468, 11344.20590558653, 11550.711232219262, 11587.88412115868, 11940.641780746591, 11976.700582485159, 12142.210756300812, 12166.635000949986, 12406.62780116598, 12592.685182870502, 12622.810657839957, 8955.865662014945, 8999.595018224065, 9038.051004644418, 9054.728358149267, 9070.866141732284, 11865.406729663655, 12032.480071297648, 12085.274883507018, 12219.205751626116, 12280.0], "value": 10338.303860210346, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.0255814534457, 1389.6664800447893, 1408.2465880753793, 1447.9927600362003, 1449.7028109237608, 10716.946415267923, 11764.941155296021, 11781.764364712712, 11782.116341274395, 11799.292042477457, 10595.576176952913, 11433.028192603619, 11470.827937580943, 11716.472758725857, 11730.120240981918, 2502.6120951252583, 2542.5677634802037, 2543.860087695176, 2543.860087695176, 2548.3883867871764, 2103.295396042328, 2410.7468715784853, 2520.1053625962704, 2524.4572416930355, 2525.532776436356, 2136.412486566199, 2157.363577744561, 2160.4490854832075, 2162.264829957814, 2164.2857856907262, 2142.571485702858, 2419.830611857162, 2469.715982661981, 2471.0486462711806, 2503.6119401492797, 2438.926832195037, 2467.9136230231857, 2472.1347528364927, 2474.1958863369478, 2479.1075212923333, 9279.628814847398, 11652.126090543243, 11667.299962002222, 11669.183157179, 11669.70825729355, 6454.0, 6704.966475167642, 6711.731530738764, 6718.0, 6720.3951644351755, 3531.311394278117, 3656.1773600939578, 3732.0, 3745.75652582584, 4325.610695037431, 1243.1608664151752, 1250.2123662092915, 1272.249372870011, 1304.9934750326188, 1305.9085863989524, 16392.75410868838, 16505.33978640853, 16529.173541322885, 16568.917155414387, 16575.751363729552, 4833.767389315702, 4961.2558116282125, 5395.487428694268, 5423.701696406657, 5574.749136288877, 12121.69695757613, 12126.696832579257, 12132.332721700215, 12138.75722485563, 12151.392430378446, 6457.1282876811965, 6509.056186852879, 6509.544331896816, 6515.250746164157, 6515.511336649675, 6029.547783916224, 6086.756529738849, 6167.84580385494, 6248.0, 6268.561200715906, 3887.028242939265, 4138.937915931264, 4212.831486740496, 4357.193919124972, 4414.337849322627, 1252.6179515247754, 1254.1221145198397, 1270.3203785974458, 1272.0968112639944, 1278.910476266671, 786.5241528875063, 792.3558615872089, 807.7092246791151, 811.3306522119275, 827.1521690267524, 5884.323302820145, 5887.76448942046, 7382.5939573323985, 7444.739434119888, 7470.887936680954, 580.0863639767383, 580.8373655376502, 587.4683411512588, 588.7468388592946, 599.9190109335184, 4173.812178451977, 4345.369921361448, 4345.804438800262, 4348.847790327323, 4474.7762611869275, 11754.76490470203, 15022.09867407959, 15164.620884477756, 15181.544553663407, 15220.695586088215, 12131.818022729665, 13423.597292081253, 14303.070300430647, 15010.924945375204, 15047.473338433103, 8414.158584141536, 8620.267277281377, 8639.092895245909, 8644.0, 8678.088800675965, 6627.403533681992, 6829.829254268683, 7095.148582169966, 7100.893486597808, 7207.297263526178, 13222.603321900358, 13563.79654305206, 13621.523246686715, 13636.659083522594, 13642.976776741983, 13601.251931143883, 13841.723165536834, 13953.0, 13977.161370317814, 14046.719065618834, 9403.294752893697, 9482.905170948203, 9618.855717164108, 9623.133917947418, 9634.470104144339, 10620.575176993143, 10623.840642390216, 10704.946475267574, 10744.677659670222, 10773.084287835622, 9241.306901982512, 9284.30367722437, 9286.489243091695, 9336.719898403058, 9337.813243735223, 7262.854742905007, 9009.27925765924, 9132.452052876848, 9229.630814767603, 9284.675036373694, 8189.058258300133, 8284.295834853863, 8289.171082891662, 8298.0, 8302.833943320979, 4478.910421791611, 5798.536117110705, 6170.660613666291, 6187.690615469299, 6222.937770622417, 5684.886302274014, 6174.8147555573405, 6238.563300568917, 6258.092576576462, 6356.459700925288], "value": 5262.355692674498, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.4587273217441, 386.5573917864045, 390.1027636436196, 394.56991878852045, 405.426321754717, 4846.491118432562, 5434.864128396792, 5606.887862242757, 5931.288245410557, 5932.88134237315, 4613.077384523092, 5039.72281524516, 5277.472252774721, 5728.885422291552, 5854.0, 4153.252414565377, 4299.742015479065, 4316.309390497506, 4326.783660816962, 4351.738895666254, 4334.111507141044, 4338.436003319564, 4360.694751367406, 4360.869173924787, 4362.956370436303, 3579.4093974494176, 4080.795960201993, 4319.69762116652, 4320.1575692739925, 4334.1765064637775, 3499.2476617527227, 3509.631488693676, 3826.5982071882468, 4183.100633363811, 4302.827886884521, 3752.7935963521995, 3755.7746535207702, 3765.491658626078, 3782.583915769263, 3784.678302344304, 5653.689047102408, 5673.602847800656, 5679.829605111853, 5680.176374425727, 5706.77172913083, 3882.8446862125766, 4090.529589097262, 4841.2496063110275, 5087.87280317995, 5160.225966105077, 5048.394192696863, 5857.0, 6206.493331267864, 6231.750729970796, 6246.687665616746, 3746.3631182699005, 4279.379489973968, 4290.871273861789, 4295.5060168080445, 4302.548232435581, 4744.5492678195515, 6206.317305096436, 6236.721472098209, 6364.013577895434, 6502.252240992299, 4312.331588603709, 4315.0, 4316.2446571849805, 4329.675274354373, 4343.761093139845, 4375.059362237134, 4377.868663940087, 4388.407564978687, 4396.956030439655, 4401.779911004437, 4744.667873248839, 4849.2968519564465, 5097.949020509822, 5128.333316668809, 5150.510701483353, 5433.592480563973, 6223.541701028069, 6237.688115594202, 6243.96878015607, 6244.375562443719, 1196.3300551691082, 1253.8527247568554, 1464.4435114656362, 1494.6786440915039, 1506.7513860213162, 961.5817119553017, 989.302541708094, 996.6212839121088, 1000.5697550053401, 1006.642641862143, 4605.065872333628, 5831.620944638585, 5848.239728835224, 5858.384869588717, 5867.178594996704, 5174.741262936838, 6321.747130114744, 6361.681915904186, 6387.169667943231, 6396.648184349812, 4856.2958371036, 5697.259356283656, 5803.88392232153, 5861.501772349313, 5870.677112758839, 2658.494885971659, 2881.8270903745843, 3323.2220761892754, 3327.284633803744, 3361.596608407007, 6257.124002639634, 6468.514861385415, 6510.21877374718, 6557.049227861933, 6717.56335838169, 6505.284418713938, 6647.0, 6673.733050678015, 6689.297623749436, 6692.933070669328, 5995.370486098896, 6568.310327415553, 6647.66761661915, 6676.0, 6694.430973367318, 6442.549021568632, 6452.12896258999, 6456.9354306456335, 6473.640535487601, 6474.223093228843, 5359.3032905722, 5402.945970540244, 6303.054541818764, 6401.487880969605, 6408.679566021773, 4540.500544939988, 5457.8265672880525, 6550.279469258282, 6657.833554161185, 6666.933210723122, 3512.279982603509, 3608.1520842601444, 3859.899928520358, 4295.871123866289, 4347.5652434756275, 5335.759890804846, 6211.3478084800445, 6451.225852897683, 6496.415322620986, 6544.54188206821, 5433.320834895638, 6239.344868788712, 6251.124842521959, 6264.436200741955, 6276.403741644536, 5409.648372855751, 6057.212562366864, 6155.384461553988, 6235.0, 6266.279377871603, 5371.677699338053, 5756.164821549751, 5880.7356418370255, 6139.693015349126, 6148.44663980244, 5729.770809167587, 6188.690565471798, 6247.969085101089, 6284.214473190851, 6305.684715764285, 5905.52755779528, 6062.151298818081, 6129.233845769279, 6141.9078713818435, 6157.507399408126], "value": 4489.1923161821005, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.0961968680091, 854.6581367453014, 856.0668870930684, 858.2490320969152, 879.6569337958196, 12595.0, 12879.162854414457, 12896.22622642641, 12901.354932253385, 13141.47434102637, 13093.67265818355, 16567.0, 17034.0, 17183.0, 17460.214290356933, 971.1162841813933, 991.2317953585992, 993.587661120634, 995.0845222395377, 995.6365926436835, 971.5385192033798, 971.5919313888148, 971.9659811906585, 972.1153750087421, 975.1077763846072, 680.2619158213345, 702.5257950883133, 983.6409710455667, 1030.361176070837, 1032.7469769906345, 1025.1030348445147, 1026.4970164619358, 1026.9229807764373, 1029.3103620574234, 1031.437866362834, 758.8140905478193, 759.9740350526745, 761.790507610406, 761.8628646843566, 770.8342706318168, 15860.52418427449, 16261.024338539608, 16348.83651163485, 16367.345306187739, 16723.91638041814, 16683.6663266734, 16781.83218167815, 16970.575735606708, 17209.0, 17228.138593070296, 12874.519430265545, 13163.407646655924, 13969.301534923214, 14085.014049016572, 14195.929020354832, 3391.355642427931, 3431.656834316548, 3432.1419645088727, 3432.2449061206494, 3432.8111953842526, 114160.0, 115828.0, 115834.0, 115996.0, 116830.22791923152, 11016.504257308441, 12260.938695306644, 12269.2638441692, 12273.877261227452, 12284.815727764091, 18543.72184417235, 24547.140850070162, 24554.754452455603, 24659.506809864062, 25018.624720629206, 7731.690732370642, 7906.0, 7907.2488113629115, 7913.050433947963, 7924.564148971862, 3875.5155605549307, 3888.9027774305305, 3912.158885839558, 3935.2326296371934, 3951.9922419783347, 4273.658107351404, 4359.738415695005, 4359.738415695068, 4366.0, 4366.214081465303, 786.8983423207441, 881.3037700216757, 884.5046773806689, 892.7544925145637, 901.1169054326797, 644.9838754031186, 674.8515326628134, 681.8602186551745, 683.6957553888471, 693.9583624982517, 10989.285696429706, 11593.536258549731, 11740.354280514654, 12031.458584363725, 12153.331566763913, 643.6459947029115, 644.2848438233557, 647.3235468934975, 659.2122413715659, 677.7831094049857, 5227.895442091137, 5449.591280653887, 5492.450754924475, 5604.523615492647, 5654.434556544395, 96064.0, 102152.0, 102947.13160854894, 105547.41678874823, 106088.46955765327, 91236.08763912276, 91792.0, 92595.0, 93512.59731104039, 93909.0609093914, 79058.20941790624, 79560.0, 80050.0, 81331.59334203291, 81393.0, 8751.693690720795, 11333.829992549954, 11336.319820810777, 11404.011747049606, 11441.599544015919, 39888.80055599703, 40362.798186008884, 41230.587694122674, 41400.0, 41454.79272603738, 35617.64382356247, 51759.964800704525, 52646.0, 53059.469405307, 54238.0, 11907.702307442383, 14044.227567483886, 14101.717965640424, 14314.212718300594, 14365.20991345486, 15257.0, 17568.56078598045, 17949.282028718706, 18535.90732046331, 18612.44162675122, 16575.41986030483, 16785.91607042006, 16961.321547137977, 17125.400610978555, 17153.74269385985, 16617.169141542632, 16730.49808505747, 16763.910345827484, 16959.406420775213, 17081.658366832344, 16714.665706685555, 16851.073190974123, 16919.069451180305, 16987.150642468074, 17107.48677539676, 11571.594994175164, 11635.941820291184, 12038.435003449495, 12064.691535724252, 12155.270683759003, 11396.544138234378, 11809.23239989398, 11828.52685892589, 11829.52681892749, 11928.821067684165], "value": 8071.323965135476, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1457.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 110.0, 111.0, 111.0, 110.0, 111.0, 110.0, 110.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 110.0, 107.0, 152.0, 113.0, 109.0, 106.0, 115.0, 152.0, 92.0], "value": 118.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 185.0, 184.0, 188.0, 187.0, 186.0, 184.0, 184.0, 185.0, 184.0], "value": 185.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 57.0, 93.0, 81.0, 88.0, 89.0, 83.0, 81.0, 58.0], "value": 76.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 68.0, 85.0, 69.0, 68.0, 93.0, 111.0, 103.0, 68.0, 89.0], "value": 84.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 89.0, 88.0, 89.0, 88.0, 88.0, 88.0, 95.0, 88.0], "value": 89.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 84.0, 85.0, 84.0, 84.0, 84.0, 86.0, 88.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 49.0, 48.0, 48.0, 50.0, 48.0, 48.0, 49.0, 47.0], "value": 48.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 61.0, 69.0, 63.0, 60.0, 58.0, 57.0, 56.0, 57.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 82.0, 80.0, 82.0, 82.0, 83.0, 101.0, 82.0, 82.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 166.0, 163.0, 122.0, 137.0, 152.0, 146.0, 129.0, 202.0, 164.0], "value": 151.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 233.0, 206.0, 185.0, 185.0, 183.0, 181.0, 235.0, 231.0], "value": 200.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 66.0, 68.0, 65.0, 67.0, 70.0, 68.0, 67.0], "value": 67.4, "unit": "score"}]}]} 03:20:09 INFO - Return code: 0 03:20:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:20:09 ERROR - # TBPL SUCCESS # 03:20:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:20:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:20:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:20:09 INFO - 2017-04-22 03:20:09.916 screenresolution[85316:746154] starting screenresolution argv=screenresolution get 03:20:09 INFO - 2017-04-22 03:20:09.920 screenresolution[85316:746154] Display 0: 1600x1200x32@60 03:20:09 INFO - 2017-04-22 03:20:09.926 screenresolution[85317:746158] starting screenresolution argv=screenresolution list 03:20:09 INFO - Available Modes on Display 0 03:20:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:20:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:20:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:20:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:20:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:20:10 INFO - Intel Iris: 03:20:10 INFO - Chipset Model: Intel Iris 03:20:10 INFO - Type: GPU 03:20:10 INFO - Bus: Built-In 03:20:10 INFO - VRAM (Dynamic, Max): 1536 MB 03:20:10 INFO - Vendor: Intel (0x8086) 03:20:10 INFO - Device ID: 0x0a2e 03:20:10 INFO - Revision ID: 0x0009 03:20:10 INFO - Displays: 03:20:10 INFO - Display: 03:20:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:20:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:20:10 INFO - Display Serial Number: 1600x1200 60 03:20:10 INFO - Main Display: Yes 03:20:10 INFO - Mirror: Off 03:20:10 INFO - Online: Yes 03:20:10 INFO - Rotation: Supported 03:20:10 INFO - Return code: 0 03:20:10 INFO - Running post-action listener: _resource_record_post_action 03:20:10 INFO - [mozharness: 2017-04-22 10:20:10.175248Z] Finished run-tests step (success) 03:20:10 INFO - Running post-run listener: _resource_record_post_run 03:20:10 INFO - Total resource usage - Wall time: 1201s; CPU: 53.0%; Read bytes: 6877696; Write bytes: 517731328; Read time: 56; Write time: 1680 03:20:10 INFO - TinderboxPrint: CPU usage
53.1% 03:20:10 INFO - TinderboxPrint: I/O read bytes / time
6,877,696 / 56 03:20:10 INFO - TinderboxPrint: I/O write bytes / time
517,731,328 / 1,680 03:20:10 INFO - TinderboxPrint: CPU idle
2,252.3 (46.9%) 03:20:10 INFO - TinderboxPrint: CPU system
956.1 (19.9%) 03:20:10 INFO - TinderboxPrint: CPU user
1,597.3 (33.2%) 03:20:10 INFO - TinderboxPrint: Swap in / out
222,334,976 / 0 03:20:10 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207383040; Write bytes: 204779520; Read time: 15905; Write time: 443 03:20:10 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 6820352; Write bytes: 305714176; Read time: 55; Write time: 1206 03:20:10 INFO - Running post-run listener: _upload_blobber_files 03:20:10 INFO - Blob upload gear active. 03:20:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:20:10 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 03:20:10 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'] 03:20:10 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 03:20:11 INFO - (blobuploader) - INFO - Open directory for files ... 03:20:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:20:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:20:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:11 INFO - (blobuploader) - INFO - Done attempting. 03:20:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:20:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:20:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:12 INFO - (blobuploader) - INFO - Done attempting. 03:20:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:20:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:20:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:14 INFO - (blobuploader) - INFO - Done attempting. 03:20:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:20:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:20:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:16 INFO - (blobuploader) - INFO - Done attempting. 03:20:16 INFO - (blobuploader) - INFO - Iteration through files over. 03:20:16 INFO - Return code: 0 03:20:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:20:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:20:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7fd6f96e489589b9fc7e71d6c383a7f9323dbb70ce465bffe1105b0a935a784309dc9f7e245ca2d6b9b632d3237eb9bc4d785de26658b00e65fba6529926e27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1648d93771f08e468d9bed6fa70321b3eb0c1e8f3a4d6dee63b27ea4e55a3db1dca5b29219f1e7b3e1c548fb7a0b722936020e532ce0d58c37c7d49698e6746b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21a892fa71f79bef5bf03c212b1c8bab3c1a2d53a55c64499ae80f17b50fda132cbe14555c240b878afc5812ce3a6fb61ddad07597a6d0b14e0a7d49db3a1aeb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8101d36bea52e10b0719e36b8f70cf16aba757b7bca54f63ede52f3afbecb9169930eaceb49249e1cdf4035ba6c5d88e4fe5feb33ba55185220eb020c163aa1a"} 03:20:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:20:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:20:16 INFO - Contents: 03:20:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7fd6f96e489589b9fc7e71d6c383a7f9323dbb70ce465bffe1105b0a935a784309dc9f7e245ca2d6b9b632d3237eb9bc4d785de26658b00e65fba6529926e27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1648d93771f08e468d9bed6fa70321b3eb0c1e8f3a4d6dee63b27ea4e55a3db1dca5b29219f1e7b3e1c548fb7a0b722936020e532ce0d58c37c7d49698e6746b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21a892fa71f79bef5bf03c212b1c8bab3c1a2d53a55c64499ae80f17b50fda132cbe14555c240b878afc5812ce3a6fb61ddad07597a6d0b14e0a7d49db3a1aeb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8101d36bea52e10b0719e36b8f70cf16aba757b7bca54f63ede52f3afbecb9169930eaceb49249e1cdf4035ba6c5d88e4fe5feb33ba55185220eb020c163aa1a"} 03:20:16 INFO - Running post-run listener: copy_logs_to_upload_dir 03:20:16 INFO - Copying logs to upload dir... 03:20:16 INFO - mkdir: /builds/slave/test/build/upload/logs 03:20:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.519913 ========= master_lag: 1.54 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-22 03:20:17.983849) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-22 03:20:17.989194) ========= 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.D3s8RZOcEd/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.GguB3X6lff/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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/e7fd6f96e489589b9fc7e71d6c383a7f9323dbb70ce465bffe1105b0a935a784309dc9f7e245ca2d6b9b632d3237eb9bc4d785de26658b00e65fba6529926e27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1648d93771f08e468d9bed6fa70321b3eb0c1e8f3a4d6dee63b27ea4e55a3db1dca5b29219f1e7b3e1c548fb7a0b722936020e532ce0d58c37c7d49698e6746b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21a892fa71f79bef5bf03c212b1c8bab3c1a2d53a55c64499ae80f17b50fda132cbe14555c240b878afc5812ce3a6fb61ddad07597a6d0b14e0a7d49db3a1aeb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8101d36bea52e10b0719e36b8f70cf16aba757b7bca54f63ede52f3afbecb9169930eaceb49249e1cdf4035ba6c5d88e4fe5feb33ba55185220eb020c163aa1a"} build_url:https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011197 build_url: 'https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7fd6f96e489589b9fc7e71d6c383a7f9323dbb70ce465bffe1105b0a935a784309dc9f7e245ca2d6b9b632d3237eb9bc4d785de26658b00e65fba6529926e27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1648d93771f08e468d9bed6fa70321b3eb0c1e8f3a4d6dee63b27ea4e55a3db1dca5b29219f1e7b3e1c548fb7a0b722936020e532ce0d58c37c7d49698e6746b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21a892fa71f79bef5bf03c212b1c8bab3c1a2d53a55c64499ae80f17b50fda132cbe14555c240b878afc5812ce3a6fb61ddad07597a6d0b14e0a7d49db3a1aeb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8101d36bea52e10b0719e36b8f70cf16aba757b7bca54f63ede52f3afbecb9169930eaceb49249e1cdf4035ba6c5d88e4fe5feb33ba55185220eb020c163aa1a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-22 03:20:18.025365) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 03:20:18.025756) ========= 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.D3s8RZOcEd/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.GguB3X6lff/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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.005280 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 03:20:18.074712) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-22 03:20:18.075032) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-22 03:20:18.075350) ========= ========= Total master_lag: 1.69 =========