builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0191 starttime: 1489026768.65 results: success (0) buildid: 20170308164423 builduid: 63bd93bf70ea4a3cbda0161606103dd8 revision: 193989276571a5bd19bc669c6ca42828abe7b4f1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-08 18:32:48.649267) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-08 18:32:48.649719) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-08 18:32:48.650016) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-08 18:32:48.680034) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 18:32:48.680674) ========= 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.fbcvtfQdOR/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.vfWKdBOhTE/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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-03-08 18:32:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.8M=0.001s 2017-03-08 18:32:48 (13.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131701 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 18:32:48.837594) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 18:32:48.837917) ========= 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.fbcvtfQdOR/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.vfWKdBOhTE/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.028787 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 18:32:48.889027) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-08 18:32:48.889531) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 193989276571a5bd19bc669c6ca42828abe7b4f1 --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 193989276571a5bd19bc669c6ca42828abe7b4f1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fbcvtfQdOR/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.vfWKdBOhTE/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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-03-08 18:32:48,993 truncating revision to first 12 chars 2017-03-08 18:32:48,993 Setting DEBUG logging. 2017-03-08 18:32:48,993 attempt 1/10 2017-03-08 18:32:48,993 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/193989276571?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-08 18:32:50,381 unpacking tar archive at: mozilla-central-193989276571/testing/mozharness/ program finished with exit code 0 elapsedTime=1.677464 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-08 18:32:50.591448) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-08 18:32:50.591804) ========= script_repo_revision: 193989276571a5bd19bc669c6ca42828abe7b4f1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-08 18:32:50.592184) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-08 18:32:50.592497) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-08 18:32:50.613291) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-08 18:32:50.613690) ========= /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.fbcvtfQdOR/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.vfWKdBOhTE/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 18:32:50 INFO - MultiFileLogger online at 20170308 18:32:50 in /builds/slave/test 18:32:50 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 18:32:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:32:50 INFO - {'append_to_log': False, 18:32:50 INFO - 'base_work_dir': '/builds/slave/test', 18:32:50 INFO - 'blob_upload_branch': 'Firefox', 18:32:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:32:50 INFO - 'branch': 'Firefox', 18:32:50 INFO - 'buildbot_json_path': 'buildprops.json', 18:32:50 INFO - 'config_files': ('talos/mac_config.py',), 18:32:50 INFO - 'default_actions': ('clobber', 18:32:50 INFO - 'read-buildbot-config', 18:32:50 INFO - 'download-and-extract', 18:32:50 INFO - 'populate-webroot', 18:32:50 INFO - 'create-virtualenv', 18:32:50 INFO - 'install', 18:32:50 INFO - 'run-tests'), 18:32:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:32:50 INFO - 'download_minidump_stackwalk': True, 18:32:50 INFO - 'download_symbols': 'ondemand', 18:32:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:32:50 INFO - 'tooltool.py': '/tools/tooltool.py', 18:32:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:32:50 INFO - '/tools/misc-python/virtualenv.py')}, 18:32:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:32:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:32:50 INFO - 'gecko_profile': False, 18:32:50 INFO - 'gecko_profile_interval': 0, 18:32:50 INFO - 'installer_path': 'installer.exe', 18:32:50 INFO - 'log_level': 'info', 18:32:50 INFO - 'log_name': 'talos', 18:32:50 INFO - 'log_to_console': True, 18:32:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:32:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:32:50 INFO - 'opt_config_files': (), 18:32:50 INFO - 'pip_index': False, 18:32:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:32:50 INFO - 'cmd': ('bash', 18:32:50 INFO - '-c', 18:32:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:32:50 INFO - 'enabled': True, 18:32:50 INFO - 'halt_on_failure': False, 18:32:50 INFO - 'name': 'check_screen_resolution'},), 18:32:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:32:50 INFO - 'cmd': ('bash', 18:32:50 INFO - '-c', 18:32:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:32:50 INFO - 'enabled': True, 18:32:50 INFO - 'halt_on_failure': False, 18:32:50 INFO - 'name': 'check_screen_resolution'},), 18:32:50 INFO - 'run_cmd_checks_enabled': True, 18:32:50 INFO - 'suite': 'dromaeojs', 18:32:50 INFO - 'system_bits': '32', 18:32:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:32:50 INFO - 'title': 't-yosemite-r7-0191', 18:32:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:32:50 INFO - 'use_talos_json': True, 18:32:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:32:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:32:50 INFO - 'work_dir': 'build'} 18:32:50 INFO - [mozharness: 2017-03-09 02:32:50.830458Z] Running clobber step. 18:32:50 INFO - Running pre-action listener: _resource_record_pre_action 18:32:50 INFO - Running main action method: clobber 18:32:50 INFO - rmtree: /builds/slave/test/build 18:32:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:32:53 INFO - Running post-action listener: _resource_record_post_action 18:32:53 INFO - [mozharness: 2017-03-09 02:32:53.373290Z] Finished clobber step (success) 18:32:53 INFO - [mozharness: 2017-03-09 02:32:53.373493Z] Running read-buildbot-config step. 18:32:53 INFO - Running pre-action listener: _resource_record_pre_action 18:32:53 INFO - Running main action method: read_buildbot_config 18:32:53 INFO - Using buildbot properties: 18:32:53 INFO - { 18:32:53 INFO - "project": "", 18:32:53 INFO - "product": "firefox", 18:32:53 INFO - "script_repo_revision": "production", 18:32:53 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 18:32:53 INFO - "repository": "", 18:32:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 18:32:53 INFO - "buildid": "20170308164423", 18:32:53 INFO - "pgo_build": "False", 18:32:53 INFO - "basedir": "/builds/slave/test", 18:32:53 INFO - "buildnumber": 20, 18:32:53 INFO - "slavename": "t-yosemite-r7-0191", 18:32:53 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 18:32:53 INFO - "platform": "yosemite_r7", 18:32:53 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:32:53 INFO - "branch": "mozilla-central", 18:32:53 INFO - "repo_path": "mozilla-central", 18:32:53 INFO - "revision": "193989276571a5bd19bc669c6ca42828abe7b4f1", 18:32:53 INFO - "stage_platform": "macosx64", 18:32:53 INFO - "builduid": "63bd93bf70ea4a3cbda0161606103dd8", 18:32:53 INFO - "slavebuilddir": "test" 18:32:53 INFO - } 18:32:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 18:32:53 INFO - Running post-action listener: _resource_record_post_action 18:32:53 INFO - [mozharness: 2017-03-09 02:32:53.376634Z] Finished read-buildbot-config step (success) 18:32:53 INFO - [mozharness: 2017-03-09 02:32:53.376737Z] Running download-and-extract step. 18:32:53 INFO - Running pre-action listener: _resource_record_pre_action 18:32:53 INFO - Running main action method: download_and_extract 18:32:53 INFO - mkdir: /builds/slave/test/build/tests 18:32:53 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')]} 18:32:53 INFO - trying https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 18:32:53 INFO - Downloading https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/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 18:32:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/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 18:32:54 INFO - Downloaded 1199 bytes. 18:32:54 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 18:32:54 INFO - Using the following test package requirements: 18:32:54 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 18:32:54 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:32:54 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 18:32:54 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:32:54 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 18:32:54 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:32:54 INFO - u'jsshell-mac.zip'], 18:32:54 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:32:54 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 18:32:54 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 18:32:54 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:32:54 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 18:32:54 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:32:54 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 18:32:54 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:32:54 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 18:32:54 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:32:54 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 18:32:54 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:32:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 18:32:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:32:54 INFO - Fetch https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 18:32:55 INFO - Expected file size: 51787417 18:32:55 INFO - Obtained file size: 51787417 18:33:11 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 18:33:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 18:33:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:33:11 INFO - Fetch https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 18:33:14 INFO - Expected file size: 51787417 18:33:14 INFO - Obtained file size: 51787417 18:33:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 18:33:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:33:29 INFO - Fetch https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 18:33:29 INFO - Expected file size: 14404424 18:33:29 INFO - Obtained file size: 14404424 18:33:30 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')]} 18:33:30 INFO - trying https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:33:30 INFO - Downloading https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 18:33:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/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 18:33:32 INFO - Downloaded 75035123 bytes. 18:33:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:33:32 INFO - mkdir: /builds/slave/test/properties 18:33:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:33:32 INFO - Writing to file /builds/slave/test/properties/build_url 18:33:32 INFO - Contents: 18:33:32 INFO - build_url:https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:33:33 INFO - Running post-action listener: _resource_record_post_action 18:33:33 INFO - Running post-action listener: set_extra_try_arguments 18:33:33 INFO - [mozharness: 2017-03-09 02:33:33.137113Z] Finished download-and-extract step (success) 18:33:33 INFO - [mozharness: 2017-03-09 02:33:33.137232Z] Running populate-webroot step. 18:33:33 INFO - Running pre-action listener: _resource_record_pre_action 18:33:33 INFO - Running main action method: populate_webroot 18:33:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:33:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:33:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:33:33 INFO - '--tppagecycles', 18:33:33 INFO - '7'], 18:33:33 INFO - 'tests': ['tsvgm']}}, 18:33:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:33:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:33:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:33:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:33:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:33:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:33:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:33:33 INFO - 'talos_options': ['--disable-e10s'], 18:33:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:33:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:33:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:33:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:33:33 INFO - 'talos_options': ['--disable-e10s'], 18:33:33 INFO - 'tests': ['damp', 'tps']}, 18:33:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:33:33 INFO - 'tests': ['damp', 'tps']}, 18:33:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:33:33 INFO - 'tests': ['dromaeo_dom']}, 18:33:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:33:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:33:33 INFO - 'tests': ['basic_compositor_video']}, 18:33:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:33:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:33:33 INFO - 'tests': ['a11yr', 18:33:33 INFO - 'ts_paint', 18:33:33 INFO - 'tpaint', 18:33:33 INFO - 'sessionrestore', 18:33:33 INFO - 'sessionrestore_no_auto_restore', 18:33:33 INFO - 'tabpaint']}, 18:33:33 INFO - 'other-e10s': {'tests': ['a11yr', 18:33:33 INFO - 'ts_paint', 18:33:33 INFO - 'tpaint', 18:33:33 INFO - 'sessionrestore', 18:33:33 INFO - 'sessionrestore_no_auto_restore', 18:33:33 INFO - 'tabpaint']}, 18:33:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:33:33 INFO - 'ts_paint', 18:33:33 INFO - 'tpaint', 18:33:33 INFO - 'sessionrestore', 18:33:33 INFO - 'sessionrestore_no_auto_restore', 18:33:33 INFO - 'tabpaint']}, 18:33:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:33:33 INFO - 'ts_paint', 18:33:33 INFO - 'tpaint', 18:33:33 INFO - 'sessionrestore', 18:33:33 INFO - 'sessionrestore_no_auto_restore', 18:33:33 INFO - 'tabpaint']}, 18:33:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:33:33 INFO - 'tests': ['a11yr', 18:33:33 INFO - 'ts_paint', 18:33:33 INFO - 'tpaint', 18:33:33 INFO - 'sessionrestore', 18:33:33 INFO - 'sessionrestore_no_auto_restore', 18:33:33 INFO - 'tabpaint']}, 18:33:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:33:33 INFO - 'tests': ['a11yr', 18:33:33 INFO - 'ts_paint', 18:33:33 INFO - 'tpaint', 18:33:33 INFO - 'sessionrestore', 18:33:33 INFO - 'sessionrestore_no_auto_restore', 18:33:33 INFO - 'tabpaint']}, 18:33:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:33:33 INFO - 'tests': ['tsvgx', 18:33:33 INFO - 'tsvgr_opacity', 18:33:33 INFO - 'tart', 18:33:33 INFO - 'tscrollx', 18:33:33 INFO - 'cart', 18:33:33 INFO - 'tsvg_static']}, 18:33:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:33:33 INFO - 'tsvgr_opacity', 18:33:33 INFO - 'tart', 18:33:33 INFO - 'tscrollx', 18:33:33 INFO - 'cart', 18:33:33 INFO - 'tsvg_static']}, 18:33:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:33:33 INFO - 'talos_options': ['--disable-e10s'], 18:33:33 INFO - 'tests': ['tp5o']}, 18:33:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:33:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:33:33 INFO - 'talos_options': ['--disable-e10s', 18:33:33 INFO - '--xperf_path', 18:33:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:33:33 INFO - 'tests': ['tp5n']}, 18:33:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:33:33 INFO - 'talos_options': ['--xperf_path', 18:33:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:33:33 INFO - 'tests': ['tp5n']}}, 18:33:33 INFO - 'talos.zip': {'path': '', 18:33:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:33:33 INFO - Running post-action listener: _resource_record_post_action 18:33:33 INFO - [mozharness: 2017-03-09 02:33:33.155417Z] Finished populate-webroot step (success) 18:33:33 INFO - [mozharness: 2017-03-09 02:33:33.155552Z] Running create-virtualenv step. 18:33:33 INFO - Running pre-action listener: _resource_record_pre_action 18:33:33 INFO - Running main action method: create_virtualenv 18:33:33 INFO - Creating virtualenv /builds/slave/test/build/venv 18:33:33 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 18:33:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:33:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:33:33 INFO - Using real prefix '/tools/python27' 18:33:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:33:34 INFO - Installing distribute.............................................................................................................................................................................................done. 18:33:36 INFO - Installing pip.................done. 18:33:36 INFO - Return code: 0 18:33:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:33:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:33:37 INFO - Reading from file tmpfile_stdout 18:33:37 INFO - Output received: 18:33:37 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) 18:33:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:33:37 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')]} 18:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:37 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')]} 18:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:37 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 0x108081b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108084768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3e8c749f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e5fd30>, '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 0x107d86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e54be8>, '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.fbcvtfQdOR/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.vfWKdBOhTE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 18:33:37 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 18:33:37 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 18:33:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fbcvtfQdOR/Render', 18:33:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:37 INFO - 'HOME': '/Users/cltbld', 18:33:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:37 INFO - 'LOGNAME': 'cltbld', 18:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:37 INFO - 'MOZ_NO_REMOTE': '1', 18:33:37 INFO - 'NO_EM_RESTART': '1', 18:33:37 INFO - 'PAGER': '/bin/cat', 18:33:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:37 INFO - 'PWD': '/builds/slave/test', 18:33:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:37 INFO - 'SHELL': '/bin/bash', 18:33:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vfWKdBOhTE/Listeners', 18:33:37 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 18:33:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:37 INFO - 'USER': 'cltbld', 18:33:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:37 INFO - 'XPC_FLAGS': '0x0', 18:33:37 INFO - 'XPC_SERVICE_NAME': '0', 18:33:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:37 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 18:33:37 INFO - Cleaning up... 18:33:37 INFO - Return code: 0 18:33:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:33:37 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')]} 18:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:37 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')]} 18:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:37 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 0x108081b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108084768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3e8c749f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e5fd30>, '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 0x107d86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e54be8>, '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.fbcvtfQdOR/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.vfWKdBOhTE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 18:33:37 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 18:33:37 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 18:33:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fbcvtfQdOR/Render', 18:33:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:37 INFO - 'HOME': '/Users/cltbld', 18:33:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:37 INFO - 'LOGNAME': 'cltbld', 18:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:37 INFO - 'MOZ_NO_REMOTE': '1', 18:33:37 INFO - 'NO_EM_RESTART': '1', 18:33:37 INFO - 'PAGER': '/bin/cat', 18:33:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:37 INFO - 'PWD': '/builds/slave/test', 18:33:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:37 INFO - 'SHELL': '/bin/bash', 18:33:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vfWKdBOhTE/Listeners', 18:33:37 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 18:33:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:37 INFO - 'USER': 'cltbld', 18:33:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:37 INFO - 'XPC_FLAGS': '0x0', 18:33:37 INFO - 'XPC_SERVICE_NAME': '0', 18:33:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:37 INFO - Downloading/unpacking psutil>=3.1.1 18:33:37 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 18:33:37 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 18:33:37 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 18:33:37 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 18:33:37 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 18:33:37 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 18:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:33:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:33:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:33:41 INFO - Installing collected packages: psutil 18:33:41 INFO - Running setup.py install for psutil 18:33:41 INFO - building 'psutil._psutil_osx' extension 18:33:41 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 18:33:41 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 18:33:41 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 18:33:41 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 18:33:42 INFO - building 'psutil._psutil_posix' extension 18:33:42 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 18:33:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:33:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:33:42 INFO - ^ 18:33:42 INFO - 1 warning generated. 18:33:42 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 18:33:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:33:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:33:42 INFO - Successfully installed psutil 18:33:42 INFO - Cleaning up... 18:33:42 INFO - Return code: 0 18:33:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:43 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 0x108081b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108084768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3e8c749f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e5fd30>, '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 0x107d86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e54be8>, '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.fbcvtfQdOR/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.vfWKdBOhTE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 18:33:43 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 18:33:43 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 18:33:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fbcvtfQdOR/Render', 18:33:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:43 INFO - 'HOME': '/Users/cltbld', 18:33:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:43 INFO - 'LOGNAME': 'cltbld', 18:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:43 INFO - 'MOZ_NO_REMOTE': '1', 18:33:43 INFO - 'NO_EM_RESTART': '1', 18:33:43 INFO - 'PAGER': '/bin/cat', 18:33:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:43 INFO - 'PWD': '/builds/slave/test', 18:33:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:43 INFO - 'SHELL': '/bin/bash', 18:33:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vfWKdBOhTE/Listeners', 18:33:43 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 18:33:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:43 INFO - 'USER': 'cltbld', 18:33:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:43 INFO - 'XPC_FLAGS': '0x0', 18:33:43 INFO - 'XPC_SERVICE_NAME': '0', 18:33:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:33:43 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 18:33:43 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 18:33:43 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 18:33:43 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 18:33:43 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 18:33:43 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 18:33:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:33:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:33:46 INFO - Installing collected packages: mozsystemmonitor 18:33:46 INFO - Running setup.py install for mozsystemmonitor 18:33:46 INFO - Successfully installed mozsystemmonitor 18:33:46 INFO - Cleaning up... 18:33:46 INFO - Return code: 0 18:33:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108081b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108084768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3e8c749f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e5fd30>, '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 0x107d86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e54be8>, '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.fbcvtfQdOR/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.vfWKdBOhTE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 18:33:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:33:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:33:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fbcvtfQdOR/Render', 18:33:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:46 INFO - 'HOME': '/Users/cltbld', 18:33:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:46 INFO - 'LOGNAME': 'cltbld', 18:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:46 INFO - 'MOZ_NO_REMOTE': '1', 18:33:46 INFO - 'NO_EM_RESTART': '1', 18:33:46 INFO - 'PAGER': '/bin/cat', 18:33:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:46 INFO - 'PWD': '/builds/slave/test', 18:33:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:46 INFO - 'SHELL': '/bin/bash', 18:33:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vfWKdBOhTE/Listeners', 18:33:46 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 18:33:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:46 INFO - 'USER': 'cltbld', 18:33:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:46 INFO - 'XPC_FLAGS': '0x0', 18:33:46 INFO - 'XPC_SERVICE_NAME': '0', 18:33:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:46 INFO - Downloading/unpacking jsonschema==2.5.1 18:33: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 18:33: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 18:33: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 18:33: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 18:33: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 18:33: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 18:33:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:33:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:33: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 18:33: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 18:33: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 18:33: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 18:33: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 18:33: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 18:33:50 INFO - Downloading functools32-3.2.3-2.tar.gz 18:33:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:33:50 INFO - warning: no files found matching '*.txt' 18:33:50 INFO - no previously-included directories found matching 'build' 18:33:50 INFO - no previously-included directories found matching 'dist' 18:33:50 INFO - no previously-included directories found matching '.git*' 18:33:50 INFO - Installing collected packages: jsonschema, functools32 18:33:50 INFO - Running setup.py install for functools32 18:33:50 INFO - warning: no files found matching '*.txt' 18:33:50 INFO - no previously-included directories found matching 'build' 18:33:50 INFO - no previously-included directories found matching 'dist' 18:33:50 INFO - no previously-included directories found matching '.git*' 18:33:50 INFO - Successfully installed jsonschema functools32 18:33:50 INFO - Cleaning up... 18:33:50 INFO - Return code: 0 18:33:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108081b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108084768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3e8c749f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e5fd30>, '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 0x107d86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e54be8>, '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.fbcvtfQdOR/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.vfWKdBOhTE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 18:33:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:33:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:33:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fbcvtfQdOR/Render', 18:33:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:50 INFO - 'HOME': '/Users/cltbld', 18:33:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:50 INFO - 'LOGNAME': 'cltbld', 18:33:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:50 INFO - 'MOZ_NO_REMOTE': '1', 18:33:50 INFO - 'NO_EM_RESTART': '1', 18:33:50 INFO - 'PAGER': '/bin/cat', 18:33:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:50 INFO - 'PWD': '/builds/slave/test', 18:33:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:50 INFO - 'SHELL': '/bin/bash', 18:33:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vfWKdBOhTE/Listeners', 18:33:50 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 18:33:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:50 INFO - 'USER': 'cltbld', 18:33:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:50 INFO - 'XPC_FLAGS': '0x0', 18:33:50 INFO - 'XPC_SERVICE_NAME': '0', 18:33:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:33:50 INFO - Cleaning up... 18:33:50 INFO - Return code: 0 18:33:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108081b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108084768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3e8c749f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e5fd30>, '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 0x107d86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e54be8>, '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.fbcvtfQdOR/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.vfWKdBOhTE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 18:33:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:33:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:33:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fbcvtfQdOR/Render', 18:33:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:50 INFO - 'HOME': '/Users/cltbld', 18:33:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:50 INFO - 'LOGNAME': 'cltbld', 18:33:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:50 INFO - 'MOZ_NO_REMOTE': '1', 18:33:50 INFO - 'NO_EM_RESTART': '1', 18:33:50 INFO - 'PAGER': '/bin/cat', 18:33:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:50 INFO - 'PWD': '/builds/slave/test', 18:33:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:50 INFO - 'SHELL': '/bin/bash', 18:33:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vfWKdBOhTE/Listeners', 18:33:50 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 18:33:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:50 INFO - 'USER': 'cltbld', 18:33:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:50 INFO - 'XPC_FLAGS': '0x0', 18:33:50 INFO - 'XPC_SERVICE_NAME': '0', 18:33:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:50 INFO - Downloading/unpacking blobuploader==1.2.4 18:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:53 INFO - Downloading blobuploader-1.2.4.tar.gz 18:33:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:33:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:33: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 18:33: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 18:33: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 18:33: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 18:33: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 18:33: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 18:33:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:33:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:54 INFO - Downloading docopt-0.6.1.tar.gz 18:33:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:33:54 INFO - Installing collected packages: blobuploader, requests, docopt 18:33:54 INFO - Running setup.py install for blobuploader 18:33:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:33:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:33:55 INFO - Running setup.py install for requests 18:33:55 INFO - Running setup.py install for docopt 18:33:55 INFO - Successfully installed blobuploader requests docopt 18:33:55 INFO - Cleaning up... 18:33:55 INFO - Return code: 0 18:33:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:33: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')]} 18:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33: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')]} 18:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:55 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 0x108081b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108084768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3e8c749f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e5fd30>, '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 0x107d86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e54be8>, '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.fbcvtfQdOR/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.vfWKdBOhTE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 18:33:55 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 18:33:55 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 18:33:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fbcvtfQdOR/Render', 18:33:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:55 INFO - 'HOME': '/Users/cltbld', 18:33:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:55 INFO - 'LOGNAME': 'cltbld', 18:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:55 INFO - 'MOZ_NO_REMOTE': '1', 18:33:55 INFO - 'NO_EM_RESTART': '1', 18:33:55 INFO - 'PAGER': '/bin/cat', 18:33:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:55 INFO - 'PWD': '/builds/slave/test', 18:33:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:55 INFO - 'SHELL': '/bin/bash', 18:33:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vfWKdBOhTE/Listeners', 18:33:55 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 18:33:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:55 INFO - 'USER': 'cltbld', 18:33:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:55 INFO - 'XPC_FLAGS': '0x0', 18:33:55 INFO - 'XPC_SERVICE_NAME': '0', 18:33:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:33:56 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-UDN8Tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:33:56 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-jvXUTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:33:56 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-cgKLrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:33:56 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-gcJn5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:33:56 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-3wYBws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:33:56 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-obNbxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:33:56 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-6CQ0Ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:33:56 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-ssHlDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:33:56 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-i3yqAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:33:57 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-OkuYfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:33:57 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-KclUmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:33:57 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-F7kYxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:33:57 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-FLHNeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:33:57 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-GbIBef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:57 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-dcDiYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:33:57 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-FwRBfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:33:57 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-5GJcMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:33:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:33:57 INFO - Running setup.py install for manifestparser 18:33:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:33:58 INFO - Running setup.py install for mozcrash 18:33:58 INFO - Running setup.py install for mozdebug 18:33:58 INFO - Running setup.py install for mozdevice 18:33:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:33:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:33:58 INFO - Running setup.py install for mozfile 18:33:58 INFO - Running setup.py install for mozhttpd 18:33:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:33:58 INFO - Running setup.py install for mozinfo 18:33:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:33:58 INFO - Running setup.py install for mozInstall 18:33:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:33:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:33:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:33:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:33:59 INFO - Running setup.py install for mozleak 18:33:59 INFO - Running setup.py install for mozlog 18:33:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:33:59 INFO - Running setup.py install for moznetwork 18:33:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:33:59 INFO - Running setup.py install for mozprocess 18:33:59 INFO - Running setup.py install for mozprofile 18:33:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:33:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:33:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:33:59 INFO - Running setup.py install for mozrunner 18:34:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:34:00 INFO - Running setup.py install for mozscreenshot 18:34:00 INFO - Running setup.py install for moztest 18:34:00 INFO - Running setup.py install for mozversion 18:34:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:34:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:34:00 INFO - Cleaning up... 18:34:00 INFO - Return code: 0 18:34:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:34:00 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')]} 18:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:00 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')]} 18:34:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:00 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 0x108081b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108084768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3e8c749f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e5fd30>, '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 0x107d86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e54be8>, '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.fbcvtfQdOR/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.vfWKdBOhTE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 18:34:00 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 18:34:00 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 18:34:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fbcvtfQdOR/Render', 18:34:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:34:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:34:00 INFO - 'HOME': '/Users/cltbld', 18:34:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:34:00 INFO - 'LOGNAME': 'cltbld', 18:34:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:00 INFO - 'MOZ_NO_REMOTE': '1', 18:34:00 INFO - 'NO_EM_RESTART': '1', 18:34:00 INFO - 'PAGER': '/bin/cat', 18:34:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:34:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:00 INFO - 'PWD': '/builds/slave/test', 18:34:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:34:00 INFO - 'SHELL': '/bin/bash', 18:34:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vfWKdBOhTE/Listeners', 18:34:00 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 18:34:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:34:00 INFO - 'USER': 'cltbld', 18:34:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:34:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:34:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:00 INFO - 'XPC_FLAGS': '0x0', 18:34:00 INFO - 'XPC_SERVICE_NAME': '0', 18:34:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:34:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:34:00 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-zZ8rdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:34:00 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)) 18:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:34:00 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-f2oGhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:34:01 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)) 18:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:34:01 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-6H0Au1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:34:01 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)) 18:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:34:01 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-gnkE2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:34:01 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-G1BNZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:34:01 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)) 18:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:34:01 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-eoIxtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:34:01 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)) 18:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:34:01 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-gFFPXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:34:01 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)) 18:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:34:01 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-U3VLYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:34:01 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)) 18:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:34:01 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-rcKY3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:34:01 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)) 18:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:34:01 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-hk3Xvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:34:01 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)) 18:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:34:01 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Hi_4hD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:34:01 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)) 18:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:34:01 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-0f5hWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:34:02 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)) 18:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:34:02 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Nzkex4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:34:02 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)) 18:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:34:02 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-4QdGdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:34:02 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)) 18:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:34:02 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-dixMC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:34:02 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)) 18:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:34:02 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-oY3jaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:34:02 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)) 18:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:34:02 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-nwrVPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:34:02 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)) 18:34:02 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)) 18:34:02 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)) 18:34:02 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)) 18:34:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:34:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:34:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:34:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:34:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:34:05 INFO - Downloading blessings-1.6.tar.gz 18:34:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:34:05 INFO - Installing collected packages: blessings 18:34:05 INFO - Running setup.py install for blessings 18:34:05 INFO - Successfully installed blessings 18:34:05 INFO - Cleaning up... 18:34:05 INFO - Return code: 0 18:34:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:34:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:34:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:34:05 INFO - Reading from file tmpfile_stdout 18:34:05 INFO - Current package versions: 18:34:05 INFO - blessings == 1.6 18:34:05 INFO - blobuploader == 1.2.4 18:34:05 INFO - docopt == 0.6.1 18:34:05 INFO - functools32 == 3.2.3-2 18:34:05 INFO - jsonschema == 2.5.1 18:34:05 INFO - manifestparser == 1.1 18:34:05 INFO - mozInstall == 1.12 18:34:05 INFO - mozcrash == 1.0 18:34:05 INFO - mozdebug == 0.1 18:34:05 INFO - mozdevice == 0.49 18:34:05 INFO - mozfile == 1.2 18:34:05 INFO - mozhttpd == 0.7 18:34:05 INFO - mozinfo == 0.9 18:34:05 INFO - mozleak == 0.1 18:34:05 INFO - mozlog == 3.4 18:34:05 INFO - moznetwork == 0.27 18:34:05 INFO - mozprocess == 0.25 18:34:05 INFO - mozprofile == 0.28 18:34:05 INFO - mozrunner == 6.13 18:34:05 INFO - mozscreenshot == 0.1 18:34:05 INFO - mozsystemmonitor == 0.3 18:34:05 INFO - moztest == 0.8 18:34:05 INFO - mozversion == 1.4 18:34:05 INFO - psutil == 3.1.1 18:34:05 INFO - requests == 1.2.3 18:34:05 INFO - wsgiref == 0.1.2 18:34:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:34:05 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')]} 18:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:05 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')]} 18:34:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:05 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 0x108081b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108084768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3e8c749f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e5fd30>, '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 0x107d86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e54be8>, '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.fbcvtfQdOR/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.vfWKdBOhTE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 18:34:05 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 18:34:05 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 18:34:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fbcvtfQdOR/Render', 18:34:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:34:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:34:05 INFO - 'HOME': '/Users/cltbld', 18:34:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:34:05 INFO - 'LOGNAME': 'cltbld', 18:34:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:05 INFO - 'MOZ_NO_REMOTE': '1', 18:34:05 INFO - 'NO_EM_RESTART': '1', 18:34:05 INFO - 'PAGER': '/bin/cat', 18:34:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:34:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:05 INFO - 'PWD': '/builds/slave/test', 18:34:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:34:05 INFO - 'SHELL': '/bin/bash', 18:34:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vfWKdBOhTE/Listeners', 18:34:05 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 18:34:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:34:05 INFO - 'USER': 'cltbld', 18:34:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:34:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:34:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:05 INFO - 'XPC_FLAGS': '0x0', 18:34:05 INFO - 'XPC_SERVICE_NAME': '0', 18:34:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:34:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:06 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)) 18:34:06 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)) 18:34:06 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)) 18:34:06 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)) 18:34:06 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)) 18:34:06 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)) 18:34:06 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)) 18:34:06 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)) 18:34:06 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)) 18:34:06 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)) 18:34:06 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)) 18:34:06 INFO - Cleaning up... 18:34:06 INFO - Return code: 0 18:34:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:34:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108081b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108084768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3e8c749f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e5fd30>, '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 0x107d86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e54be8>, '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.fbcvtfQdOR/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.vfWKdBOhTE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 18:34:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:34:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:34:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fbcvtfQdOR/Render', 18:34:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:34:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:34:06 INFO - 'HOME': '/Users/cltbld', 18:34:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:34:06 INFO - 'LOGNAME': 'cltbld', 18:34:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:06 INFO - 'MOZ_NO_REMOTE': '1', 18:34:06 INFO - 'NO_EM_RESTART': '1', 18:34:06 INFO - 'PAGER': '/bin/cat', 18:34:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:34:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:06 INFO - 'PWD': '/builds/slave/test', 18:34:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:34:06 INFO - 'SHELL': '/bin/bash', 18:34:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vfWKdBOhTE/Listeners', 18:34:06 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 18:34:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:34:06 INFO - 'USER': 'cltbld', 18:34:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:34:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:34:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:06 INFO - 'XPC_FLAGS': '0x0', 18:34:06 INFO - 'XPC_SERVICE_NAME': '0', 18:34:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:34:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:34:06 INFO - Cleaning up... 18:34:06 INFO - Return code: 0 18:34:06 INFO - Running post-action listener: _resource_record_post_action 18:34:06 INFO - Running post-action listener: _start_resource_monitoring 18:34:06 INFO - Starting resource monitoring. 18:34:06 INFO - [mozharness: 2017-03-09 02:34:06.388336Z] Finished create-virtualenv step (success) 18:34:06 INFO - [mozharness: 2017-03-09 02:34:06.389263Z] Running install step. 18:34:06 INFO - Running pre-action listener: _resource_record_pre_action 18:34:06 INFO - Running main action method: install 18:34:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:34:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:34:06 INFO - Reading from file tmpfile_stdout 18:34:06 INFO - Detecting whether we're running mozinstall >=1.0... 18:34:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:34:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:34:06 INFO - Reading from file tmpfile_stdout 18:34:06 INFO - Output received: 18:34:06 INFO - Usage: mozinstall [options] installer 18:34:06 INFO - Options: 18:34:06 INFO - -h, --help show this help message and exit 18:34:06 INFO - -d DEST, --destination=DEST 18:34:06 INFO - Directory to install application into. [default: 18:34:06 INFO - "/builds/slave/test"] 18:34:06 INFO - --app=APP Application being installed. [default: firefox] 18:34:06 INFO - mkdir: /builds/slave/test/build/application 18:34:06 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'] 18:34:06 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 18:34:26 INFO - Reading from file tmpfile_stdout 18:34:26 INFO - Output received: 18:34:26 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:34:26 INFO - Running post-action listener: _resource_record_post_action 18:34:26 INFO - [mozharness: 2017-03-09 02:34:26.844264Z] Finished install step (success) 18:34:26 INFO - [mozharness: 2017-03-09 02:34:26.844374Z] Running run-tests step. 18:34:26 INFO - Running pre-action listener: _resource_record_pre_action 18:34:26 INFO - Running main action method: run_tests 18:34:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:34:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:34:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:34:26 INFO - 2017-03-08 18:34:26.857 screenresolution[1624:7459] starting screenresolution argv=screenresolution get 18:34:26 INFO - 2017-03-08 18:34:26.859 screenresolution[1624:7459] Display 0: 1600x1200x32@60 18:34:26 INFO - 2017-03-08 18:34:26.864 screenresolution[1625:7462] starting screenresolution argv=screenresolution list 18:34:26 INFO - Available Modes on Display 0 18:34:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:34:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:34:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:34:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:34:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:34:27 INFO - Intel Iris: 18:34:27 INFO - Chipset Model: Intel Iris 18:34:27 INFO - Type: GPU 18:34:27 INFO - Bus: Built-In 18:34:27 INFO - VRAM (Dynamic, Max): 1536 MB 18:34:27 INFO - Vendor: Intel (0x8086) 18:34:27 INFO - Device ID: 0x0a2e 18:34:27 INFO - Revision ID: 0x0009 18:34:27 INFO - Displays: 18:34:27 INFO - Display: 18:34:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:34:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:34:27 INFO - Display Serial Number: 1600x1200 60 18:34:27 INFO - Main Display: Yes 18:34:27 INFO - Mirror: Off 18:34:27 INFO - Online: Yes 18:34:27 INFO - Rotation: Supported 18:34:27 INFO - Return code: 0 18:34:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:34:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:34:27 INFO - Python 2.7.3 18:34:27 INFO - Return code: 0 18:34:27 INFO - grabbing minidump binary from tooltool 18:34:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:34:27 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 0x107e5fd30>, '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 0x107d86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e54be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:34:27 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 18:34:27 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 18:34:27 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 18:34:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:34:27 INFO - Return code: 0 18:34:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:34:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:34:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:34:27 INFO - ENV: RUST_BACKTRACE is now 1 18:34:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:34:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:34:27 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/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--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 18:34:27 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/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0191 --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 18:34:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fbcvtfQdOR/Render', 18:34:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:34:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:34:27 INFO - 'HOME': '/Users/cltbld', 18:34:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:34:27 INFO - 'LOGNAME': 'cltbld', 18:34:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:34:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:34:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:27 INFO - 'MOZ_NO_REMOTE': '1', 18:34:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:34:27 INFO - 'NO_EM_RESTART': '1', 18:34:27 INFO - 'PAGER': '/bin/cat', 18:34:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:34:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:27 INFO - 'PWD': '/builds/slave/test', 18:34:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:34:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:34:27 INFO - 'RUST_BACKTRACE': '1', 18:34:27 INFO - 'SHELL': '/bin/bash', 18:34:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vfWKdBOhTE/Listeners', 18:34:27 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 18:34:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:34:27 INFO - 'USER': 'cltbld', 18:34:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:34:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:34:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:27 INFO - 'XPC_FLAGS': '0x0', 18:34:27 INFO - 'XPC_SERVICE_NAME': '0', 18:34:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:34:27 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/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--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 18:34:27 INFO - mozversion application_buildid: 20170308164423 18:34:27 INFO - mozversion application_changeset: 193989276571a5bd19bc669c6ca42828abe7b4f1 18:34:27 INFO - mozversion application_display_name: Nightly 18:34:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:34:27 INFO - mozversion application_name: Firefox 18:34:27 INFO - mozversion application_remotingname: firefox 18:34:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:34:27 INFO - mozversion application_vendor: Mozilla 18:34:27 INFO - mozversion application_version: 55.0a1 18:34:27 INFO - mozversion platform_buildid: 20170308164423 18:34:27 INFO - mozversion platform_changeset: 193989276571a5bd19bc669c6ca42828abe7b4f1 18:34:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:34:27 INFO - mozversion platform_version: 55.0a1 18:34:27 INFO - using testdate: 1489026867 18:34:27 INFO - actual date: 1489026867 18:34:27 INFO - starting webserver on 'localhost:49243' 18:34:27 INFO - SUITE-START | Running 2 tests 18:34:27 INFO - TEST-START | dromaeo_css 18:34:27 INFO - operating with platform_type : mac_ 18:34:27 INFO - Initialising browser for dromaeo_css test... 18:34:27 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpwdlHG4/profile http://localhost:49243/getInfo.html) 18:34:29 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 18:34:29 INFO - PROCESS | 1635 | colorDepth:24 18:34:29 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 18:34:29 INFO - PROCESS | 1635 | __metrics 18:34:29 INFO - PROCESS | 1635 | 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" 18:34:29 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:34:30 INFO - TEST-INFO | 1635: exit 0 18:34:30 INFO - Browser initialized. 18:34:30 INFO - Running cycle 1/1 for dromaeo_css test... 18:34:30 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpwdlHG4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:34:42 INFO - PROCESS | 1637 | RSS: Main: 232783872 18:34:42 INFO - PROCESS | 1637 | 18:37:47 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 18:37:49 INFO - PROCESS | 1637 | RSS: Main: 376655872 18:37:49 INFO - PROCESS | 1637 | 18:39:32 INFO - PROCESS | 1637 | ************************* 18:39:32 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 18:39:32 INFO - PROCESS | 1637 | 18:39:32 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:39:32 INFO - PROCESS | 1637 | Full stack: 18:39:32 INFO - PROCESS | 1637 | ************************* 18:40:52 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 18:40:52 INFO - PROCESS | 1637 | RSS: Main: 369016832 18:40:52 INFO - PROCESS | 1637 | 18:43:55 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 18:43:56 INFO - PROCESS | 1637 | RSS: Main: 349974528 18:43:56 INFO - PROCESS | 1637 | 18:46:58 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 18:46:59 INFO - PROCESS | 1637 | RSS: Main: 356794368 18:46:59 INFO - PROCESS | 1637 | 18:50:02 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 18:50:03 INFO - PROCESS | 1637 | RSS: Main: 330776576 18:50:03 INFO - PROCESS | 1637 | 18:53:06 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 18:53:07 INFO - PROCESS | 1637 | RSS: Main: 533647360 18:53:07 INFO - PROCESS | 1637 | 18:53:07 INFO - PROCESS | 1637 | __start_tp_report 18:53:07 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 18:53:07 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 18:53:07 INFO - PROCESS | 1637 | |i|pagename|runs| 18:53:07 INFO - PROCESS | 1637 | |0;dojo.html;3371.393149233138;3386.5936087669484;3408.7954722716654;3410.096324474014;3454.4990976308436;5643.661380317184;5721.828345149652;5772.740226689799;5856.853578660531;5947.256592925884;5672.943270567293;5727.942720572793;5737.053386191274;5740.311162660476;5744.965906136894;5142.254373115896;5197.454267301936;5201.505856943584;5233.842984710445;5257.211418287249;5306.442823503535;5311.468853114677;5311.760970756306;5316.38861530925;5317;5296.364436267653;5296.973515132419;5301.655392399501;5310.362756469229;5312.57499400049;5287.418383977779;5291.708956007418;5296.09966305727;5305.7877684892555;5307.124324486455;4485.327200919888;5178.119719647669;5258.290130832327;5274.367075950872;5311.389190243133;5980;5991.730372133265;5996.400359963969;6007.819765407001;6027.367126451703;6149.385061493859;6315.557910946236;6318;6320.020396838498;6347.143135676671;5202.687838729688;6197.752089916398;6286.622802631857;6317.3366796486625;6319.210098737658;5338.145896656516;5796.855078623026;5956.731947062436;6083.209182806207;6090.665013424215;6477.57895736785;6481.09264702942;6482.740690372427;6483.222013358333;6488.708008139645;6244.65654389013;6258.624482531062;6262.1546091278005;6270;6295;6162.7226774795245;6233.594816336924;6259.2488901332135;6287.96856015717;6331.556791024676;6313;6323.494120470351;6330.968345158337;6340.048992651139;6355.3009168991375;5663.490285874291;6306.684665766693;6314.684265786692;6319.96840015797;6333.461655759312;4242.384854196124;4954.9752251238515;5078;5140.438247011953;5178.870528236825;4515.932261016087;4544.727316361029;4578.061497393026;4596.885077873013;4613.1004454131125;6022.909656355158;6032.245969253843;6038.094285857069;6038.486728628028;6038.849028774316;6218.5647004709235;6225.501959843202;6353.364663533702;6354.428101470798;6355.1738274025;5880.558958078162;5899.321578018497;5960.433758792908;5990.460858522754;5993.430624090704;5550.028744969695;5554.611177217636;5557.72211389437;5565.777368905279;5571.220029195916;6283;6426.1003459515705;6475.125858009297;6495.480361571157;6503;6265.749370025148;6266.811995640138;6274.686265686789;6285.43431091204;6289.433950944437;6468.191476065492;6497.57765745244;6509.446697030616;6510.609363438209;6514.804555863332;6318.020706790455;6319.715612797343;6328.493720502441;6334.049892515975;6338.714757835816;5532.695701736443;6220.253569571681;6236.407541283571;6247.250329960434;6276;6218.129461875432;6229.844253893508;6234.127222188807;6245;6250.656213908279;6069.605475644069;6107.083937409247;6233.688315584112;6237.844053898689;6242.843928901813;5955.076963070731;6071.453569178795;6103.701349646813;6119.204503414706;6125.938740612537;6210.503159747119;6245.9063114052415;6256;6259;6271.498280137669;6098.0852872069545;6119.969400152971;6127.816165515042;6136.754529818757;6150.938490615215 18:53:07 INFO - PROCESS | 1637 | |1;ext.html;733.6185183704474;765.5827573972186;784.1922819495919;856.0882659967134;868.8783570300155;27710;39564.80217598911;40172.99999999996;40176.59823401765;40184.79907600458;40464;40760.79619601898;40827.59172408275;40842.978925526804;40859.38710919338;7278.09023872016;9187.3109516786;9372.8594071089;9373.109554592336;9379.484128372937;7363.815904602374;11033.724156896102;11239.66281011571;11377.658670239865;11379.032782213522;11184.161187910899;11191.944040279786;11205;11205.935436133554;11252.943735281313;7288.59912704801;11112.277701949348;11147.888521114806;11182.105431565455;11189.104871610292;7336.119665640104;10671.306365086244;10946.233763636468;11040.282381645247;11057.1154307656;38889.41665875014;39106.217875642615;39111.60888391108;39130;39242.41136382957;3450.2064525159103;3858.84564617415;3883.203943191639;3899.005753532831;3933.252681990413;27124.457510849672;27998.3000424991;28117.859410702815;28157;28266.434671306666;2664.3472349274357;3109.144985129085;3160.4469217886776;3251.073444068429;3255.576775019256;323593;324281;324293;324301;325094.6103353984;50287.99424011499;50424.24363634548;50452.49547504478;50488.747556262715;50548.494515055114;52697.47302526925;52709.7364513175;52716.73641631844;52838.47161528412;52873.471265287626;14281.42874285017;14428.783568246485;14433.278336083154;14436.927815360856;14441.85558144426;10223.488825558841;10373.118284945713;11715.707107322214;11758.235714678689;11770.352630605228;11319.943400282946;12937.159084659466;13295.734085318432;13308.667283317995;13318.800217996737;4353.4122893408985;5034.823781167642;5278.656887302313;5290.550303224269;5356.866078348073;874.9781255468664;909.481595490564;909.5952301226023;951.1439704266215;954.8663187153804;27064.458710825675;27196.456070878867;27475.587866182024;27653.861730691217;27747.028853990418;994.28908330544;995.2386424385351;1033.1373303291684;1038.3562191441204;1048.8531605575226;14057.367418465989;14240.003199775916;14307.356168972421;14406.783898241534;14520.346584403727;404998;405628;406106;406472;406884;53820.73089634605;53883.73058134684;53883.73058134763;54037;54123.45876541263;1413.0250127412053;1423.59427563144;1427.2792239918774;1430.9212993285469;1431.957041288763;21722.565548689254;25911.22266332013;26430.810613522823;27096.864515677295;27115.322116947234;44774.88062798456;44812.879678008314;44893.55106448894;44928.77535612301;44976.55023449854;360883;361550;362332;362766;362922;32656.673433265365;33212;33328.50007249845;33478.497822533165;33484.665153348156;31301.217469563442;42041.1591768169;42357.15285694331;45176.87057823581;45230.54769452263;32287.869924552528;32578.674213258513;35174.472382913766;36467;36621.450678239315;30134.54798177985;35120.824395877855;35186;36507.81746091253;37215.25569488541;35464.29071418506;36241.006744629296;36256.093597659215;36329.81835090808;36354;29751.404971900873;31165.53251701181;31174.532382013833;31207.375852482368;31446.685533144377;20928.267510637055;23373;23531;23916.76083239215;24127.155549555682 18:53:07 INFO - PROCESS | 1637 | |2;jquery.html;374.0741664380657;385.5450568329372;399.9940000899986;409.2694540245662;432.7230572433643;13791.103578267419;18450.538736531595;20836.166553337865;21968;22034.559308813816;23151.421214469647;23452.765472345272;23455.1790687326;23476.06095756172;23494.942727577258;4739.526047395268;6277.763040490022;6714.462842972575;6812.420944219747;6819.795406137799;6537.052127441518;6546.8690626187445;6626.304238055007;6797.728090876359;6811.523193376465;6656.567323123982;6659.500537459709;6659.800205993828;6661;6666.266710661824;6275.529335299871;6336.081268216083;6397.26431460381;6636.303188165246;6724.529282950195;6233.657148856811;6560.704768285391;6564.442022428099;6564.507661925375;6575.145231119972;24460;27378.589321160198;27472.58791118135;27901.720982790117;27962.440751184862;2712.33547780793;2863.3986862758848;2871.253474096729;3319.751018673609;3417.3507033663523;16151.515454536382;16526.173691315387;16688.165591720364;16703.916480417643;16758.24587893548;2005.1878989009474;2054.4658388818866;2100.8109270165605;2110.461832232771;2116.2910425007485;131005.6899431003;133085.33457332748;152093.23953380162;162872;167253;21813.127474901143;21841.890790545945;21928.122875084817;21939.890300548395;22282.554348913254;36611.084722882144;36731.4490282646;36733.81633091818;36818.89543313651;36980.260394791956;10260.179185665129;10460.372377657364;10671.733206669895;10688.25182237236;10868.72828179286;7609.429292803062;8122.634481448349;8496.362772791941;8531.914680853111;8687.826243475096;10499.632512862167;10579.739595466095;10615.203859710553;10708.464576771286;10747.247692661438;3501.8774342897877;4091.672666186698;4108.144839336633;4132.628063474302;4189.581041895786;848.6562942008496;891.943047488728;978.295627148452;982.9826129955462;990.5245482168599;21247.68128478074;22401.439964000703;22579.774202258097;22656;22801;833.3333333333309;982.2829334585649;1000.1898462245605;1014.6195176808696;1015.3095894791466;8616.741497755078;11089.445527723581;11318.434078296052;11863.991560717262;11892;630264;633954;635029;654669;656831;124273;128868.3556582211;146812;147677.26161369125;148785;1172.330615101321;1182.2256422043574;1208.383724300613;1212.4362171590076;1221.9755604887853;18917.95951222696;19795;19802.90098549498;19862;19902.70145947783;59843.70078149581;59984.700076499335;60892;61320.38679613147;61403;81003.78494322472;82475.5876220615;83305.75041374263;83310;83855.580722096;11767.411629418666;11803.822942655695;11948.46231919583;12096;12299.631011069681;13370.799438008244;13590.456381745014;13799.51701690436;13905.443782249002;13931.930340348234;11467.541298347973;11539.249948753304;11811;11814.350210738492;11883;9886.901130988597;11427.142964277878;11574.594889178838;11642.53429862796;11767.941160294144;9348.953255233951;11892.405379731152;11935.045196384443;11943.701407464883;11985.700357491132;11679.007284380923;11809.645710628694;12037.458314375699;12055.21641093326;12117.697637448857;11237.662870113909;11647.883521165018;11820.70448238801;11952.940235298767;11997.16019878635 18:53:07 INFO - PROCESS | 1637 | |3;mootools.html;1543.930523126459;1573.7245981953156;1599.304302628356;1601.2074023358437;1608.7184742670029;10341.741456463593;10616.20378471614;10616.78766424672;10623.628173013945;10632.840507392395;10399.896001039988;10752.623658171966;10755.085817705505;10768.515416806244;10774.5690172393;2277.8519396239235;2340.0405833608224;2342.2387723989686;2342.6837376954063;2342.730585982617;2293.7018187635585;2328.441174118208;2337.263761915;2341.9297421077395;2345.9296221113395;1888.3862744607989;2286;2307.377008207783;2309.041747674713;2319.083961835074;1880.8683392162554;2268.3875353654585;2282.82878784091;2287.714035745532;2293.6674182243564;2201.7027701260286;2246.2475070851283;2246.539459410817;2248.4266512039326;2251.470904337479;8640.481571105754;10575.048245657928;10578.735531611694;10609.628662996834;10625.893741062568;5570.41510641385;5733.684647344395;5747.3677895431465;5752.597318187729;5757.68332741699;2622.4886147201305;3353.396388650042;3574.8927532174075;3578.2306804037257;3578.731595130376;1212.0667086343467;1215.7386161975219;1775.5206094354453;1799.8110198429108;1888.8961107139103;10961.671149865517;14519.419223231058;14545.854541454662;14547;14573.927130364385;4690.935268595499;4753.691010084333;4793;4835.347228124158;4845.394325709286;10194.847077293847;12357.443915023845;12390.876091238972;12400.255984640951;12409.131360804657;5627.887442251132;5718.628289161191;5731.369549349568;5731.8853622928145;5731.971340143356;4957.529034741694;5116.820911268088;5119.513646203604;5127.564157046693;5128.410232823273;3668.137987572918;3682.410814269704;3754.4368344748505;3775.622437756257;3777.8866634001024;879.5118709116501;997.1922742578535;998.9250806189565;1008.2790804574764;1011.8735158105237;801.2068052627857;837.417994493821;892.1301730812406;900.1268769293774;941.75985123793;6227.9377206227355;6280.874382512324;6553.967230163914;6562.67186640666;6698.296678848748;1022.555188492993;1026.1226651213105;1042.6663467690266;1045.289203341735;1088.031651829872;4334.696571239983;4418.574544150899;4424.80088396023;4555.612772914339;4620.722756634613;12574.371281435891;12809.871901281054;12832.29422381778;12980.091393602357;12984;12724.618261452171;12894;12905.161164524276;13020.088593798533;13096.607101786962;8545.658173673108;8810.779730506789;8864.42381245217;9711.3202075854;9991.550380232908;5097.362829646294;6427.228732552124;6439.645819479786;6698.2631910488835;6715.160604924385;9238.399504032217;11149.944250278697;11501.654950351503;11596.36220007874;11747.588834390755;11534.192606517463;11581.247218930743;11669.591564295548;11933.16467847277;12052.517899284281;7532.13380461232;8961.462312261025;9004.50475223869;9060.682876099305;9065.27477801761;9711.028897110233;9923;9926.454045027593;9932.652357167464;9947.651832185838;8577.228049475578;8748.65005399777;8775.42959707617;8823.250023747796;8867.512286824287;8513.74458766238;8541.87187192205;8606.698765543177;8660.870086948828;8661.956690216508;7556.319931206218;7739.419543534144;7739.4969326995815;7748.380129589732;7751.689932402641;5633.549316054788;5680.971595141998;5790.536757059509;5856.355800861987;5886.882262354815;5726.885462290814;5752.741126649227;5996.2504686914135;6003.159557662018;6099.3290738017895 18:53:07 INFO - PROCESS | 1637 | |4;prototype.html;360.9765365251258;370.7923562804829;378.4229050697687;378.8711837975088;383.4727250031206;4649.000464900046;4766.594839438648;5053.469385714502;5117.923231151536;5128.4871512848695;4667.8599642010795;4844.4913284105105;4870.342503761991;4923.483034281403;4962.87592810179;3533.805640689761;3728.986347372416;3852.903677408059;4097.262492751303;4170.061736109366;4101.569335219804;4122.711410201287;4127.463429754128;4156.293430116887;4206.957930420703;3570.357335679577;3744.584742840866;4057.6550993165615;4060.5127384713874;4171.478565179353;3299.785513941586;3665.955202767212;4011.7392369496183;4022.6178513041214;4036.091879327157;3389.017664455288;3676.1912379276782;3784.6972242220554;3796.032011836964;3804.6981576146586;4484.215262329112;4648.325992731069;4827.541383568555;4855.3734498942895;4855.757212139414;3998.4801975743258;4207.926978620432;4284.393352492815;4603.9769801151115;4668;5254.3169387979315;5320.973395133038;5329.733513324357;5349.51854333108;5371.785128594852;3732.309522738275;3812.580616132251;4164.4586203793615;4228.302330115527;4230.450041494586;5076.416212135615;5155.561777248939;5225.477452254744;5294.867628309285;5420.566354691655;3467.081223475781;3694.704423646102;3775.5469343678933;4065.8576949806616;4086.5504794472586;3971.8609848655738;4025.705347951698;4214.220369231641;4365;4390.692651514427;4271.700980931305;4526.5288781146255;4744.572988431058;4755.262934245128;4776.95223047772;4529.365888775574;4889.193283108248;4951.925721114186;4968.403791544965;5206.8437946860895;1348.5819395987276;1353.5127354152498;1456.3592019511382;1464.5899148238511;1484.5323723027211;1020.6170638784489;1110.2783190925802;1116.8771435142128;1128.3117298448103;1136.4829002803704;4547.976705241361;4808.975955120202;4832.975835120872;4847.5394837490385;4932.975335123301;5063.645544811828;5445.591580631469;5476.973519797621;5543.861403464865;5592.608517403824;4261.637760790368;4758.548642664021;4821.5178482152205;4827.637927155477;5039.042581909499;2564.423004823937;2783.4711404833015;2786.7909906756668;2806.9157925262275;2812.3812761192503;4886.363068372135;5479.917801232985;5499.872526132133;5528.6406383585745;5547.44525547442;5067.400522422744;5073.720945347967;5250.606204534675;5432.745410654534;5462.770876552744;4604.58558729716;5283.890383019609;5441.945580544144;5471.7264136793;5480.314960629921;4496.752678602708;5268.710220937885;5347.78608855657;5495.626093476631;5506.697131657797;3982.980085099556;5200.037992971313;5277.604179686462;5277.8416647500635;5324.4675532446445;4541.890373330004;4828.493008234085;4894.021195760934;5237.895242095061;5447.455254474679;3873.806309684448;4266.402703621434;4280.422143010654;4309.612134907873;4310.4180935573295;4902.411710594752;5442.4557544246845;5446;5452.645578037414;5565.415631358649;5034.848954531223;5157.742112894265;5183.766730497212;5198.558122559625;5285.471452854684;4454.732716037048;4784.330193772944;4945.480724524017;5062.038212739568;5205.828688545047;4423.8894027648275;4825.782839772149;5085.491450855033;5142.6914385137015;5171.922421163761;4513.616342610915;4514.593686568224;4944.703317800943;5150.356205474316;5206.661566998133;4552.995023284616;4854.68444551103;5055.797768089383;5076.340075790271;5093.2105523643895 18:53:07 INFO - PROCESS | 1637 | |5;yui.html;689.5793565924787;713.6574444266748;730.109266694633;782.5695867272998;815.2947700239293;14725.558233252992;14906.254687265635;15718.371265149395;16003.83996160038;16010;14820.703585928275;14939.701205975874;14945.850541494581;14952.177630230333;14957.925210373933;942.5193151492754;958.9808203835919;959.9808003839919;962.6101428921298;967.5210770668529;960.7694153403168;961.1013702188476;961.4808003678005;962.210986990668;962.2542529539628;986.2997271936933;1004.7990401919609;1015.9492025398738;1017.2980643356061;1021.6577446555376;939.7133874168376;1013.1843865688118;1016.4663551635376;1018.0684673523717;1022.1975749037008;752.1087511299128;753.284379839155;754.3286475037221;757.273017902814;757.2881491398068;15551.688966220725;15584.376624934988;15623.218839058116;15778.132202728846;16217.837821621752;13791.655208619764;14427.350769215305;14505.782413263809;14507.854921450862;14705.705885882222;11556.306621602731;11574.555274295215;11653.941730291379;11775.764484710258;11989.160758746892;3719.497867787841;3795.7532760370764;3803.5245594300713;3885.255648038033;3928.2339943710986;85290;101127;108349;110436.79126417427;111299;11301.717457063474;11394.886051139383;11433.714157145972;11622.186446948632;11689.006979695438;24537.754622453904;24909.62635560468;25034.499310014064;25344.493110138064;25380.492390152092;7672.42456815741;7709.38324934004;7789.300607177086;7836.09884863248;7899.368050555941;4156.2726522858375;4214.422513967052;4228.746275223496;4249.957500424956;4257.680673949466;3351.6480769519335;3437.6906078453057;3453.0849324928913;3460.7058400035776;3464.7228221742703;597.2743117112728;613.7790395457631;614.8708771158017;630.8990811034682;631.5673763472037;403.82029996651795;476.87601223682094;482.7200223870147;495.86363749968325;502.9899402011939;9818.852717209247;10146.847797283046;10180.694579162637;10226.386416814867;10348.806687896446;651.563452486835;675.6419097878132;692.6190595172635;694.885343918258;726.5785844210345;4261.465872285975;4307.633851122627;4588.770561471913;4616.838410655611;4704.411948506437;57629;74471.62764186144;75094.49811003859;78284.6085769579;84654.15345846463;75032.62483687655;77167.84248236282;77447;79620.60189699015;79689.60155199187;52450.73774631179;68001.29996750022;69937;70941.58116837635;72490.91263630944;10297.588096476356;10574.788504230026;10764.278763380618;10867.076298514714;10883.292585981886;45048.54951450443;45670.771646141555;46240;46516.37192698239;47188.528114718414;50318;50907.745461272454;57919.4208057914;59010.704946474994;60045.69977150086;11981.64055078349;12992.415341309852;13431;13517;13923.58229253124;14037;14224.715505690036;14258.358373873409;14299.285035747964;14791.482298119945;12617.87382126167;13376.6466707857;13779.517716879862;13996.020278580401;14580;10960.397178155277;13286.53497127596;13382.464701411835;13466.663333416744;13918;13020.544280950122;13099.148555343872;13265.403056862271;13684.863151368758;13920.234387108807;10550.525226364678;10787.406692631981;10890.346579204956;10903.618373356894;12003.63989080329;8415.915840841513;9914.752131196488;10115.443650599287;10514.316569422963;10689.839652405064 18:53:07 INFO - PROCESS | 1637 | __end_tp_report 18:53:07 INFO - PROCESS | 1637 | __start_cc_report 18:53:07 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1563 18:53:07 INFO - PROCESS | 1637 | __end_cc_report 18:53:07 INFO - PROCESS | 1637 | __startTimestamp1489027987081__endTimestamp 18:53:07 INFO - PROCESS | 1637 | 18:53:07 INFO - PROCESS | 1637 | ------- Summary: start ------- 18:53:07 INFO - PROCESS | 1637 | Number of tests: 6 18:53:07 INFO - PROCESS | 1637 | 18:53:07 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5839.70 Median:6103.70 stddev:664.94 (10.9%) stddev-sans-first:638.16 18:53:07 INFO - PROCESS | 1637 | Values: 3371.4 3386.6 3408.8 3410.1 3454.5 5643.7 5721.8 5772.7 5856.9 5947.3 5672.9 5727.9 5737.1 5740.3 5745.0 5142.3 5197.5 5201.5 5233.8 5257.2 5306.4 5311.5 5311.8 5316.4 5317.0 5296.4 5297.0 5301.7 5310.4 5312.6 5287.4 5291.7 5296.1 5305.8 5307.1 4485.3 5178.1 5258.3 5274.4 5311.4 5980.0 5991.7 5996.4 6007.8 6027.4 6149.4 6315.6 6318.0 6320.0 6347.1 5202.7 6197.8 6286.6 6317.3 6319.2 5338.1 5796.9 5956.7 6083.2 6090.7 6477.6 6481.1 6482.7 6483.2 6488.7 6244.7 6258.6 6262.2 6270.0 6295.0 6162.7 6233.6 6259.2 6288.0 6331.6 6313.0 6323.5 6331.0 6340.0 6355.3 5663.5 6306.7 6314.7 6320.0 6333.5 4242.4 4955.0 5078.0 5140.4 5178.9 4515.9 4544.7 4578.1 4596.9 4613.1 6022.9 6032.2 6038.1 6038.5 6038.8 6218.6 6225.5 6353.4 6354.4 6355.2 5880.6 5899.3 5960.4 5990.5 5993.4 5550.0 5554.6 5557.7 5565.8 5571.2 6283.0 6426.1 6475.1 6495.5 6503.0 6265.7 6266.8 6274.7 6285.4 6289.4 6468.2 6497.6 6509.4 6510.6 6514.8 6318.0 6319.7 6328.5 6334.0 6338.7 5532.7 6220.3 6236.4 6247.3 6276.0 6218.1 6229.8 6234.1 6245.0 6250.7 6069.6 6107.1 6233.7 6237.8 6242.8 5955.1 6071.5 6103.7 6119.2 6125.9 6210.5 6245.9 6256.0 6259.0 6271.5 6098.1 6120.0 6127.8 6136.8 6150.9 18:53:07 INFO - PROCESS | 1637 | 18:53:07 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:51307.90 Median:19285.52 stddev:96414.52 (499.9%) stddev-sans-first:96610.21 18:53:07 INFO - PROCESS | 1637 | Values: 733.6 765.6 784.2 856.1 868.9 27710.0 39564.8 40173.0 40176.6 40184.8 40464.0 40760.8 40827.6 40843.0 40859.4 7278.1 9187.3 9372.9 9373.1 9379.5 7363.8 11033.7 11239.7 11377.7 11379.0 11184.2 11191.9 11205.0 11205.9 11252.9 7288.6 11112.3 11147.9 11182.1 11189.1 7336.1 10671.3 10946.2 11040.3 11057.1 38889.4 39106.2 39111.6 39130.0 39242.4 3450.2 3858.8 3883.2 3899.0 3933.3 27124.5 27998.3 28117.9 28157.0 28266.4 2664.3 3109.1 3160.4 3251.1 3255.6 323593.0 324281.0 324293.0 324301.0 325094.6 50288.0 50424.2 50452.5 50488.7 50548.5 52697.5 52709.7 52716.7 52838.5 52873.5 14281.4 14428.8 14433.3 14436.9 14441.9 10223.5 10373.1 11715.7 11758.2 11770.4 11319.9 12937.2 13295.7 13308.7 13318.8 4353.4 5034.8 5278.7 5290.6 5356.9 875.0 909.5 909.6 951.1 954.9 27064.5 27196.5 27475.6 27653.9 27747.0 994.3 995.2 1033.1 1038.4 1048.9 14057.4 14240.0 14307.4 14406.8 14520.3 404998.0 405628.0 406106.0 406472.0 406884.0 53820.7 53883.7 53883.7 54037.0 54123.5 1413.0 1423.6 1427.3 1430.9 1432.0 21722.6 25911.2 26430.8 27096.9 27115.3 44774.9 44812.9 44893.6 44928.8 44976.6 360883.0 361550.0 362332.0 362766.0 362922.0 32656.7 33212.0 33328.5 33478.5 33484.7 31301.2 42041.2 42357.2 45176.9 45230.5 32287.9 32578.7 35174.5 36467.0 36621.5 30134.5 35120.8 35186.0 36507.8 37215.3 35464.3 36241.0 36256.1 36329.8 36354.0 29751.4 31165.5 31174.5 31207.4 31446.7 20928.3 23373.0 23531.0 23916.8 24127.2 18:53:07 INFO - PROCESS | 1637 | 18:53:07 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:39742.96 Median:22342.00 stddev:107602.36 (481.6%) stddev-sans-first:107863.61 18:53:07 INFO - PROCESS | 1637 | Values: 374.1 385.5 400.0 409.3 432.7 13791.1 18450.5 20836.2 21968.0 22034.6 23151.4 23452.8 23455.2 23476.1 23494.9 4739.5 6277.8 6714.5 6812.4 6819.8 6537.1 6546.9 6626.3 6797.7 6811.5 6656.6 6659.5 6659.8 6661.0 6666.3 6275.5 6336.1 6397.3 6636.3 6724.5 6233.7 6560.7 6564.4 6564.5 6575.1 24460.0 27378.6 27472.6 27901.7 27962.4 2712.3 2863.4 2871.3 3319.8 3417.4 16151.5 16526.2 16688.2 16703.9 16758.2 2005.2 2054.5 2100.8 2110.5 2116.3 131005.7 133085.3 152093.2 162872.0 167253.0 21813.1 21841.9 21928.1 21939.9 22282.6 36611.1 36731.4 36733.8 36818.9 36980.3 10260.2 10460.4 10671.7 10688.3 10868.7 7609.4 8122.6 8496.4 8531.9 8687.8 10499.6 10579.7 10615.2 10708.5 10747.2 3501.9 4091.7 4108.1 4132.6 4189.6 848.7 891.9 978.3 983.0 990.5 21247.7 22401.4 22579.8 22656.0 22801.0 833.3 982.3 1000.2 1014.6 1015.3 8616.7 11089.4 11318.4 11864.0 11892.0 630264.0 633954.0 635029.0 654669.0 656831.0 124273.0 128868.4 146812.0 147677.3 148785.0 1172.3 1182.2 1208.4 1212.4 1222.0 18918.0 19795.0 19802.9 19862.0 19902.7 59843.7 59984.7 60892.0 61320.4 61403.0 81003.8 82475.6 83305.8 83310.0 83855.6 11767.4 11803.8 11948.5 12096.0 12299.6 13370.8 13590.5 13799.5 13905.4 13931.9 11467.5 11539.2 11811.0 11814.4 11883.0 9886.9 11427.1 11574.6 11642.5 11767.9 9349.0 11892.4 11935.0 11943.7 11985.7 11679.0 11809.6 12037.5 12055.2 12117.7 11237.7 11647.9 11820.7 11952.9 11997.2 18:53:07 INFO - PROCESS | 1637 | 18:53:07 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:6481.01 Median:3675.27 stddev:3956.01 (107.6%) stddev-sans-first:3949.72 18:53:07 INFO - PROCESS | 1637 | Values: 1543.9 1573.7 1599.3 1601.2 1608.7 10341.7 10616.2 10616.8 10623.6 10632.8 10399.9 10752.6 10755.1 10768.5 10774.6 2277.9 2340.0 2342.2 2342.7 2342.7 2293.7 2328.4 2337.3 2341.9 2345.9 1888.4 2286.0 2307.4 2309.0 2319.1 1880.9 2268.4 2282.8 2287.7 2293.7 2201.7 2246.2 2246.5 2248.4 2251.5 8640.5 10575.0 10578.7 10609.6 10625.9 5570.4 5733.7 5747.4 5752.6 5757.7 2622.5 3353.4 3574.9 3578.2 3578.7 1212.1 1215.7 1775.5 1799.8 1888.9 10961.7 14519.4 14545.9 14547.0 14573.9 4690.9 4753.7 4793.0 4835.3 4845.4 10194.8 12357.4 12390.9 12400.3 12409.1 5627.9 5718.6 5731.4 5731.9 5732.0 4957.5 5116.8 5119.5 5127.6 5128.4 3668.1 3682.4 3754.4 3775.6 3777.9 879.5 997.2 998.9 1008.3 1011.9 801.2 837.4 892.1 900.1 941.8 6227.9 6280.9 6554.0 6562.7 6698.3 1022.6 1026.1 1042.7 1045.3 1088.0 4334.7 4418.6 4424.8 4555.6 4620.7 12574.4 12809.9 12832.3 12980.1 12984.0 12724.6 12894.0 12905.2 13020.1 13096.6 8545.7 8810.8 8864.4 9711.3 9991.6 5097.4 6427.2 6439.6 6698.3 6715.2 9238.4 11149.9 11501.7 11596.4 11747.6 11534.2 11581.2 11669.6 11933.2 12052.5 7532.1 8961.5 9004.5 9060.7 9065.3 9711.0 9923.0 9926.5 9932.7 9947.7 8577.2 8748.7 8775.4 8823.3 8867.5 8513.7 8541.9 8606.7 8660.9 8662.0 7556.3 7739.4 7739.5 7748.4 7751.7 5633.5 5681.0 5790.5 5856.4 5886.9 5726.9 5752.7 5996.3 6003.2 6099.3 18:53:07 INFO - PROCESS | 1637 | 18:53:07 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4348.43 Median:4762.57 stddev:1211.23 (25.4%) stddev-sans-first:1177.08 18:53:07 INFO - PROCESS | 1637 | Values: 361.0 370.8 378.4 378.9 383.5 4649.0 4766.6 5053.5 5117.9 5128.5 4667.9 4844.5 4870.3 4923.5 4962.9 3533.8 3729.0 3852.9 4097.3 4170.1 4101.6 4122.7 4127.5 4156.3 4207.0 3570.4 3744.6 4057.7 4060.5 4171.5 3299.8 3666.0 4011.7 4022.6 4036.1 3389.0 3676.2 3784.7 3796.0 3804.7 4484.2 4648.3 4827.5 4855.4 4855.8 3998.5 4207.9 4284.4 4604.0 4668.0 5254.3 5321.0 5329.7 5349.5 5371.8 3732.3 3812.6 4164.5 4228.3 4230.5 5076.4 5155.6 5225.5 5294.9 5420.6 3467.1 3694.7 3775.5 4065.9 4086.6 3971.9 4025.7 4214.2 4365.0 4390.7 4271.7 4526.5 4744.6 4755.3 4777.0 4529.4 4889.2 4951.9 4968.4 5206.8 1348.6 1353.5 1456.4 1464.6 1484.5 1020.6 1110.3 1116.9 1128.3 1136.5 4548.0 4809.0 4833.0 4847.5 4933.0 5063.6 5445.6 5477.0 5543.9 5592.6 4261.6 4758.5 4821.5 4827.6 5039.0 2564.4 2783.5 2786.8 2806.9 2812.4 4886.4 5479.9 5499.9 5528.6 5547.4 5067.4 5073.7 5250.6 5432.7 5462.8 4604.6 5283.9 5441.9 5471.7 5480.3 4496.8 5268.7 5347.8 5495.6 5506.7 3983.0 5200.0 5277.6 5277.8 5324.5 4541.9 4828.5 4894.0 5237.9 5447.5 3873.8 4266.4 4280.4 4309.6 4310.4 4902.4 5442.5 5446.0 5452.6 5565.4 5034.8 5157.7 5183.8 5198.6 5285.5 4454.7 4784.3 4945.5 5062.0 5205.8 4423.9 4825.8 5085.5 5142.7 5171.9 4513.6 4514.6 4944.7 5150.4 5206.7 4553.0 4854.7 5055.8 5076.3 5093.2 18:53:07 INFO - PROCESS | 1637 | 18:53:07 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:18687.24 Median:3445.39 stddev:25269.55 (733.4%) stddev-sans-first:25304.30 18:53:07 INFO - PROCESS | 1637 | Values: 689.6 713.7 730.1 782.6 815.3 14725.6 14906.3 15718.4 16003.8 16010.0 14820.7 14939.7 14945.9 14952.2 14957.9 942.5 959.0 960.0 962.6 967.5 960.8 961.1 961.5 962.2 962.3 986.3 1004.8 1015.9 1017.3 1021.7 939.7 1013.2 1016.5 1018.1 1022.2 752.1 753.3 754.3 757.3 757.3 15551.7 15584.4 15623.2 15778.1 16217.8 13791.7 14427.4 14505.8 14507.9 14705.7 11556.3 11574.6 11653.9 11775.8 11989.2 3719.5 3795.8 3803.5 3885.3 3928.2 85290.0 101127.0 108349.0 110436.8 111299.0 11301.7 11394.9 11433.7 11622.2 11689.0 24537.8 24909.6 25034.5 25344.5 25380.5 7672.4 7709.4 7789.3 7836.1 7899.4 4156.3 4214.4 4228.7 4250.0 4257.7 3351.6 3437.7 3453.1 3460.7 3464.7 597.3 613.8 614.9 630.9 631.6 403.8 476.9 482.7 495.9 503.0 9818.9 10146.8 10180.7 10226.4 10348.8 651.6 675.6 692.6 694.9 726.6 4261.5 4307.6 4588.8 4616.8 4704.4 57629.0 74471.6 75094.5 78284.6 84654.2 75032.6 77167.8 77447.0 79620.6 79689.6 52450.7 68001.3 69937.0 70941.6 72490.9 10297.6 10574.8 10764.3 10867.1 10883.3 45048.5 45670.8 46240.0 46516.4 47188.5 50318.0 50907.7 57919.4 59010.7 60045.7 11981.6 12992.4 13431.0 13517.0 13923.6 14037.0 14224.7 14258.4 14299.3 14791.5 12617.9 13376.6 13779.5 13996.0 14580.0 10960.4 13286.5 13382.5 13466.7 13918.0 13020.5 13099.1 13265.4 13684.9 13920.2 10550.5 10787.4 10890.3 10903.6 12003.6 8415.9 9914.8 10115.4 10514.3 10689.8 18:53:07 INFO - PROCESS | 1637 | -------- Summary: end -------- 18:53:07 INFO - PROCESS | 1637 | 18:53:07 INFO - TEST-INFO | 1637: exit 0 18:53:07 INFO - TEST-OK | dromaeo_css | took 1120296ms 18:53:07 INFO - TEST-START | kraken 18:53:07 INFO - operating with platform_type : mac_ 18:53:07 INFO - Initialising browser for kraken test... 18:53:07 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmp9AhCNh/profile http://localhost:49243/getInfo.html) 18:53:10 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 18:53:10 INFO - PROCESS | 1647 | colorDepth:24 18:53:10 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 18:53:10 INFO - PROCESS | 1647 | __metrics 18:53:10 INFO - PROCESS | 1647 | 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" 18:53:10 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:53:11 INFO - TEST-INFO | 1647: exit 0 18:53:11 INFO - Browser initialized. 18:53:11 INFO - Running cycle 1/1 for kraken test... 18:53:11 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmp9AhCNh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:53:23 INFO - PROCESS | 1648 | RSS: Main: 232841216 18:53:23 INFO - PROCESS | 1648 | 18:53:26 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 18:53:27 INFO - PROCESS | 1648 | RSS: Main: 284344320 18:53:27 INFO - PROCESS | 1648 | 18:53:29 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 18:53:30 INFO - PROCESS | 1648 | RSS: Main: 286392320 18:53:30 INFO - PROCESS | 1648 | 18:53:33 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 18:53:34 INFO - PROCESS | 1648 | RSS: Main: 379166720 18:53:34 INFO - PROCESS | 1648 | 18:53:36 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 18:53:37 INFO - PROCESS | 1648 | RSS: Main: 280559616 18:53:37 INFO - PROCESS | 1648 | 18:53:39 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:53:39 INFO - PROCESS | 1648 | RSS: Main: 283279360 18:53:39 INFO - PROCESS | 1648 | 18:53:43 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 18:53:43 INFO - PROCESS | 1648 | RSS: Main: 326238208 18:53:43 INFO - PROCESS | 1648 | 18:53:47 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 18:53:47 INFO - PROCESS | 1648 | RSS: Main: 329900032 18:53:47 INFO - PROCESS | 1648 | 18:53:50 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 18:53:51 INFO - PROCESS | 1648 | RSS: Main: 328347648 18:53:51 INFO - PROCESS | 1648 | 18:53:53 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:53:53 INFO - PROCESS | 1648 | RSS: Main: 302501888 18:53:53 INFO - PROCESS | 1648 | 18:53:55 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:53:56 INFO - PROCESS | 1648 | RSS: Main: 307048448 18:53:56 INFO - PROCESS | 1648 | 18:53:58 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:53:59 INFO - PROCESS | 1648 | RSS: Main: 308637696 18:53:59 INFO - PROCESS | 1648 | 18:54:02 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:54:02 INFO - PROCESS | 1648 | RSS: Main: 323899392 18:54:02 INFO - PROCESS | 1648 | 18:54:05 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:54:06 INFO - PROCESS | 1648 | RSS: Main: 318365696 18:54:06 INFO - PROCESS | 1648 | 18:54:08 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 18:54:08 INFO - PROCESS | 1648 | RSS: Main: 362860544 18:54:08 INFO - PROCESS | 1648 | 18:54:08 INFO - PROCESS | 1648 | __start_tp_report 18:54:08 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 18:54:08 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 18:54:08 INFO - PROCESS | 1648 | |i|pagename|runs| 18:54:08 INFO - PROCESS | 1648 | |0;ai-astar;115;116;115;115;116;115;116;116;115;115 18:54:08 INFO - PROCESS | 1648 | |1;audio-beat-detection;162;138;97;173;146;138;106;111;130;109 18:54:08 INFO - PROCESS | 1648 | |2;audio-dft;184;184;185;180;183;184;211;263;187;184 18:54:08 INFO - PROCESS | 1648 | |3;audio-fft;83;62;62;89;64;61;62;60;79;61 18:54:08 INFO - PROCESS | 1648 | |4;audio-oscillator;90;71;90;104;100;100;116;69;70;85 18:54:08 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;87;87;87;87;87;95;135;86;87;87 18:54:08 INFO - PROCESS | 1648 | |6;imaging-darkroom;94;94;95;110;151;132;96;133;123;93 18:54:08 INFO - PROCESS | 1648 | |7;imaging-desaturate;87;83;85;80;86;86;85;85;86;84 18:54:08 INFO - PROCESS | 1648 | |8;json-parse-financial;64;62;61;63;62;62;64;62;63;85 18:54:08 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;54;53;62;65;62;58;57;58;57;57 18:54:08 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;87;85;85;88;87;87;86;88;86;86 18:54:08 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;150;140;140;140;137;139;140;140;182;148 18:54:08 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;175;173;173;173;172;173;173;170;168;177 18:54:08 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;68;66;70;81;87;84;86;84;83;86 18:54:08 INFO - PROCESS | 1648 | __end_tp_report 18:54:08 INFO - PROCESS | 1648 | __start_cc_report 18:54:08 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,2146 18:54:08 INFO - PROCESS | 1648 | __end_cc_report 18:54:08 INFO - PROCESS | 1648 | __startTimestamp1489028048606__endTimestamp 18:54:08 INFO - PROCESS | 1648 | 18:54:08 INFO - PROCESS | 1648 | ------- Summary: start ------- 18:54:08 INFO - PROCESS | 1648 | Number of tests: 14 18:54:08 INFO - PROCESS | 1648 | 18:54:08 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:115.40 Median:115.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 18:54:08 INFO - PROCESS | 1648 | Values: 115.0 116.0 115.0 115.0 116.0 115.0 116.0 116.0 115.0 115.0 18:54:08 INFO - PROCESS | 1648 | 18:54:08 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:131.00 Median:142.00 stddev:25.20 (17.7%) stddev-sans-first:24.10 18:54:08 INFO - PROCESS | 1648 | Values: 162.0 138.0 97.0 173.0 146.0 138.0 106.0 111.0 130.0 109.0 18:54:08 INFO - PROCESS | 1648 | 18:54:08 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:194.50 Median:184.50 stddev:25.59 (13.9%) stddev-sans-first:26.86 18:54:08 INFO - PROCESS | 1648 | Values: 184.0 184.0 185.0 180.0 183.0 184.0 211.0 263.0 187.0 184.0 18:54:08 INFO - PROCESS | 1648 | 18:54:08 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:68.30 Median:63.00 stddev:10.91 (17.3%) stddev-sans-first:10.20 18:54:08 INFO - PROCESS | 1648 | Values: 83.0 62.0 62.0 89.0 64.0 61.0 62.0 60.0 79.0 61.0 18:54:08 INFO - PROCESS | 1648 | 18:54:08 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:70.50 stddev:15.97 (22.7%) stddev-sans-first:16.94 18:54:08 INFO - PROCESS | 1648 | Values: 90.0 71.0 90.0 104.0 100.0 100.0 116.0 69.0 70.0 85.0 18:54:08 INFO - PROCESS | 1648 | 18:54:08 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:92.50 Median:87.00 stddev:15.15 (17.4%) stddev-sans-first:15.94 18:54:08 INFO - PROCESS | 1648 | Values: 87.0 87.0 87.0 87.0 87.0 95.0 135.0 86.0 87.0 87.0 18:54:08 INFO - PROCESS | 1648 | 18:54:08 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:112.10 Median:93.50 stddev:21.19 (22.7%) stddev-sans-first:21.44 18:54:08 INFO - PROCESS | 1648 | Values: 94.0 94.0 95.0 110.0 151.0 132.0 96.0 133.0 123.0 93.0 18:54:08 INFO - PROCESS | 1648 | 18:54:08 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.50 stddev:2.00 (2.3%) stddev-sans-first:1.94 18:54:08 INFO - PROCESS | 1648 | Values: 87.0 83.0 85.0 80.0 86.0 86.0 85.0 85.0 86.0 84.0 18:54:08 INFO - PROCESS | 1648 | 18:54:08 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:63.00 stddev:7.16 (11.4%) stddev-sans-first:7.59 18:54:08 INFO - PROCESS | 1648 | Values: 64.0 62.0 61.0 63.0 62.0 62.0 64.0 62.0 63.0 85.0 18:54:08 INFO - PROCESS | 1648 | 18:54:08 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.00 stddev:3.71 (6.4%) stddev-sans-first:3.60 18:54:08 INFO - PROCESS | 1648 | Values: 54.0 53.0 62.0 65.0 62.0 58.0 57.0 58.0 57.0 57.0 18:54:08 INFO - PROCESS | 1648 | 18:54:08 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:87.00 stddev:1.08 (1.2%) stddev-sans-first:1.13 18:54:08 INFO - PROCESS | 1648 | Values: 87.0 85.0 85.0 88.0 87.0 87.0 86.0 88.0 86.0 86.0 18:54:08 INFO - PROCESS | 1648 | 18:54:08 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:145.60 Median:140.00 stddev:13.43 (9.6%) stddev-sans-first:14.15 18:54:08 INFO - PROCESS | 1648 | Values: 150.0 140.0 140.0 140.0 137.0 139.0 140.0 140.0 182.0 148.0 18:54:08 INFO - PROCESS | 1648 | 18:54:08 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:173.00 stddev:2.45 (1.4%) stddev-sans-first:2.46 18:54:08 INFO - PROCESS | 1648 | Values: 175.0 173.0 173.0 173.0 172.0 173.0 173.0 170.0 168.0 177.0 18:54:08 INFO - PROCESS | 1648 | 18:54:08 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.50 Median:84.00 stddev:8.17 (9.7%) stddev-sans-first:7.53 18:54:08 INFO - PROCESS | 1648 | Values: 68.0 66.0 70.0 81.0 87.0 84.0 86.0 84.0 83.0 86.0 18:54:08 INFO - PROCESS | 1648 | -------- Summary: end -------- 18:54:08 INFO - PROCESS | 1648 | 18:54:09 INFO - TEST-INFO | 1648: exit 0 18:54:09 INFO - TEST-OK | kraken | took 61819ms 18:54:09 INFO - SUITE-END | took 1182s 18:54:09 INFO - Completed test suite (00:19:42) 18:54:09 INFO - javascript benchmark 18:54:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7538.383555804769, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3371.393149233138, 3386.5936087669484, 3408.7954722716654, 3410.096324474014, 3454.4990976308436, 5643.661380317184, 5721.828345149652, 5772.740226689799, 5856.853578660531, 5947.256592925884, 5672.943270567293, 5727.942720572793, 5737.053386191274, 5740.311162660476, 5744.965906136894, 5142.254373115896, 5197.454267301936, 5201.505856943584, 5233.842984710445, 5257.211418287249, 5306.442823503535, 5311.468853114677, 5311.760970756306, 5316.38861530925, 5317.0, 5296.364436267653, 5296.973515132419, 5301.655392399501, 5310.362756469229, 5312.57499400049, 5287.418383977779, 5291.708956007418, 5296.09966305727, 5305.7877684892555, 5307.124324486455, 4485.327200919888, 5178.119719647669, 5258.290130832327, 5274.367075950872, 5311.389190243133, 5980.0, 5991.730372133265, 5996.400359963969, 6007.819765407001, 6027.367126451703, 6149.385061493859, 6315.557910946236, 6318.0, 6320.020396838498, 6347.143135676671, 5202.687838729688, 6197.752089916398, 6286.622802631857, 6317.3366796486625, 6319.210098737658, 5338.145896656516, 5796.855078623026, 5956.731947062436, 6083.209182806207, 6090.665013424215, 6477.57895736785, 6481.09264702942, 6482.740690372427, 6483.222013358333, 6488.708008139645, 6244.65654389013, 6258.624482531062, 6262.1546091278005, 6270.0, 6295.0, 6162.7226774795245, 6233.594816336924, 6259.2488901332135, 6287.96856015717, 6331.556791024676, 6313.0, 6323.494120470351, 6330.968345158337, 6340.048992651139, 6355.3009168991375, 5663.490285874291, 6306.684665766693, 6314.684265786692, 6319.96840015797, 6333.461655759312, 4242.384854196124, 4954.9752251238515, 5078.0, 5140.438247011953, 5178.870528236825, 4515.932261016087, 4544.727316361029, 4578.061497393026, 4596.885077873013, 4613.1004454131125, 6022.909656355158, 6032.245969253843, 6038.094285857069, 6038.486728628028, 6038.849028774316, 6218.5647004709235, 6225.501959843202, 6353.364663533702, 6354.428101470798, 6355.1738274025, 5880.558958078162, 5899.321578018497, 5960.433758792908, 5990.460858522754, 5993.430624090704, 5550.028744969695, 5554.611177217636, 5557.72211389437, 5565.777368905279, 5571.220029195916, 6283.0, 6426.1003459515705, 6475.125858009297, 6495.480361571157, 6503.0, 6265.749370025148, 6266.811995640138, 6274.686265686789, 6285.43431091204, 6289.433950944437, 6468.191476065492, 6497.57765745244, 6509.446697030616, 6510.609363438209, 6514.804555863332, 6318.020706790455, 6319.715612797343, 6328.493720502441, 6334.049892515975, 6338.714757835816, 5532.695701736443, 6220.253569571681, 6236.407541283571, 6247.250329960434, 6276.0, 6218.129461875432, 6229.844253893508, 6234.127222188807, 6245.0, 6250.656213908279, 6069.605475644069, 6107.083937409247, 6233.688315584112, 6237.844053898689, 6242.843928901813, 5955.076963070731, 6071.453569178795, 6103.701349646813, 6119.204503414706, 6125.938740612537, 6210.503159747119, 6245.9063114052415, 6256.0, 6259.0, 6271.498280137669, 6098.0852872069545, 6119.969400152971, 6127.816165515042, 6136.754529818757, 6150.938490615215], "value": 5796.840042161505, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.6185183704474, 765.5827573972186, 784.1922819495919, 856.0882659967134, 868.8783570300155, 27710.0, 39564.80217598911, 40172.99999999996, 40176.59823401765, 40184.79907600458, 40464.0, 40760.79619601898, 40827.59172408275, 40842.978925526804, 40859.38710919338, 7278.09023872016, 9187.3109516786, 9372.8594071089, 9373.109554592336, 9379.484128372937, 7363.815904602374, 11033.724156896102, 11239.66281011571, 11377.658670239865, 11379.032782213522, 11184.161187910899, 11191.944040279786, 11205.0, 11205.935436133554, 11252.943735281313, 7288.59912704801, 11112.277701949348, 11147.888521114806, 11182.105431565455, 11189.104871610292, 7336.119665640104, 10671.306365086244, 10946.233763636468, 11040.282381645247, 11057.1154307656, 38889.41665875014, 39106.217875642615, 39111.60888391108, 39130.0, 39242.41136382957, 3450.2064525159103, 3858.84564617415, 3883.203943191639, 3899.005753532831, 3933.252681990413, 27124.457510849672, 27998.3000424991, 28117.859410702815, 28157.0, 28266.434671306666, 2664.3472349274357, 3109.144985129085, 3160.4469217886776, 3251.073444068429, 3255.576775019256, 323593.0, 324281.0, 324293.0, 324301.0, 325094.6103353984, 50287.99424011499, 50424.24363634548, 50452.49547504478, 50488.747556262715, 50548.494515055114, 52697.47302526925, 52709.7364513175, 52716.73641631844, 52838.47161528412, 52873.471265287626, 14281.42874285017, 14428.783568246485, 14433.278336083154, 14436.927815360856, 14441.85558144426, 10223.488825558841, 10373.118284945713, 11715.707107322214, 11758.235714678689, 11770.352630605228, 11319.943400282946, 12937.159084659466, 13295.734085318432, 13308.667283317995, 13318.800217996737, 4353.4122893408985, 5034.823781167642, 5278.656887302313, 5290.550303224269, 5356.866078348073, 874.9781255468664, 909.481595490564, 909.5952301226023, 951.1439704266215, 954.8663187153804, 27064.458710825675, 27196.456070878867, 27475.587866182024, 27653.861730691217, 27747.028853990418, 994.28908330544, 995.2386424385351, 1033.1373303291684, 1038.3562191441204, 1048.8531605575226, 14057.367418465989, 14240.003199775916, 14307.356168972421, 14406.783898241534, 14520.346584403727, 404998.0, 405628.0, 406106.0, 406472.0, 406884.0, 53820.73089634605, 53883.73058134684, 53883.73058134763, 54037.0, 54123.45876541263, 1413.0250127412053, 1423.59427563144, 1427.2792239918774, 1430.9212993285469, 1431.957041288763, 21722.565548689254, 25911.22266332013, 26430.810613522823, 27096.864515677295, 27115.322116947234, 44774.88062798456, 44812.879678008314, 44893.55106448894, 44928.77535612301, 44976.55023449854, 360883.0, 361550.0, 362332.0, 362766.0, 362922.0, 32656.673433265365, 33212.0, 33328.50007249845, 33478.497822533165, 33484.665153348156, 31301.217469563442, 42041.1591768169, 42357.15285694331, 45176.87057823581, 45230.54769452263, 32287.869924552528, 32578.674213258513, 35174.472382913766, 36467.0, 36621.450678239315, 30134.54798177985, 35120.824395877855, 35186.0, 36507.81746091253, 37215.25569488541, 35464.29071418506, 36241.006744629296, 36256.093597659215, 36329.81835090808, 36354.0, 29751.404971900873, 31165.53251701181, 31174.532382013833, 31207.375852482368, 31446.685533144377, 20928.267510637055, 23373.0, 23531.0, 23916.76083239215, 24127.155549555682], "value": 18375.855160418745, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.0741664380657, 385.5450568329372, 399.9940000899986, 409.2694540245662, 432.7230572433643, 13791.103578267419, 18450.538736531595, 20836.166553337865, 21968.0, 22034.559308813816, 23151.421214469647, 23452.765472345272, 23455.1790687326, 23476.06095756172, 23494.942727577258, 4739.526047395268, 6277.763040490022, 6714.462842972575, 6812.420944219747, 6819.795406137799, 6537.052127441518, 6546.8690626187445, 6626.304238055007, 6797.728090876359, 6811.523193376465, 6656.567323123982, 6659.500537459709, 6659.800205993828, 6661.0, 6666.266710661824, 6275.529335299871, 6336.081268216083, 6397.26431460381, 6636.303188165246, 6724.529282950195, 6233.657148856811, 6560.704768285391, 6564.442022428099, 6564.507661925375, 6575.145231119972, 24460.0, 27378.589321160198, 27472.58791118135, 27901.720982790117, 27962.440751184862, 2712.33547780793, 2863.3986862758848, 2871.253474096729, 3319.751018673609, 3417.3507033663523, 16151.515454536382, 16526.173691315387, 16688.165591720364, 16703.916480417643, 16758.24587893548, 2005.1878989009474, 2054.4658388818866, 2100.8109270165605, 2110.461832232771, 2116.2910425007485, 131005.6899431003, 133085.33457332748, 152093.23953380162, 162872.0, 167253.0, 21813.127474901143, 21841.890790545945, 21928.122875084817, 21939.890300548395, 22282.554348913254, 36611.084722882144, 36731.4490282646, 36733.81633091818, 36818.89543313651, 36980.260394791956, 10260.179185665129, 10460.372377657364, 10671.733206669895, 10688.25182237236, 10868.72828179286, 7609.429292803062, 8122.634481448349, 8496.362772791941, 8531.914680853111, 8687.826243475096, 10499.632512862167, 10579.739595466095, 10615.203859710553, 10708.464576771286, 10747.247692661438, 3501.8774342897877, 4091.672666186698, 4108.144839336633, 4132.628063474302, 4189.581041895786, 848.6562942008496, 891.943047488728, 978.295627148452, 982.9826129955462, 990.5245482168599, 21247.68128478074, 22401.439964000703, 22579.774202258097, 22656.0, 22801.0, 833.3333333333309, 982.2829334585649, 1000.1898462245605, 1014.6195176808696, 1015.3095894791466, 8616.741497755078, 11089.445527723581, 11318.434078296052, 11863.991560717262, 11892.0, 630264.0, 633954.0, 635029.0, 654669.0, 656831.0, 124273.0, 128868.3556582211, 146812.0, 147677.26161369125, 148785.0, 1172.330615101321, 1182.2256422043574, 1208.383724300613, 1212.4362171590076, 1221.9755604887853, 18917.95951222696, 19795.0, 19802.90098549498, 19862.0, 19902.70145947783, 59843.70078149581, 59984.700076499335, 60892.0, 61320.38679613147, 61403.0, 81003.78494322472, 82475.5876220615, 83305.75041374263, 83310.0, 83855.580722096, 11767.411629418666, 11803.822942655695, 11948.46231919583, 12096.0, 12299.631011069681, 13370.799438008244, 13590.456381745014, 13799.51701690436, 13905.443782249002, 13931.930340348234, 11467.541298347973, 11539.249948753304, 11811.0, 11814.350210738492, 11883.0, 9886.901130988597, 11427.142964277878, 11574.594889178838, 11642.53429862796, 11767.941160294144, 9348.953255233951, 11892.405379731152, 11935.045196384443, 11943.701407464883, 11985.700357491132, 11679.007284380923, 11809.645710628694, 12037.458314375699, 12055.21641093326, 12117.697637448857, 11237.662870113909, 11647.883521165018, 11820.70448238801, 11952.940235298767, 11997.16019878635], "value": 11620.619258642884, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1543.930523126459, 1573.7245981953156, 1599.304302628356, 1601.2074023358437, 1608.7184742670029, 10341.741456463593, 10616.20378471614, 10616.78766424672, 10623.628173013945, 10632.840507392395, 10399.896001039988, 10752.623658171966, 10755.085817705505, 10768.515416806244, 10774.5690172393, 2277.8519396239235, 2340.0405833608224, 2342.2387723989686, 2342.6837376954063, 2342.730585982617, 2293.7018187635585, 2328.441174118208, 2337.263761915, 2341.9297421077395, 2345.9296221113395, 1888.3862744607989, 2286.0, 2307.377008207783, 2309.041747674713, 2319.083961835074, 1880.8683392162554, 2268.3875353654585, 2282.82878784091, 2287.714035745532, 2293.6674182243564, 2201.7027701260286, 2246.2475070851283, 2246.539459410817, 2248.4266512039326, 2251.470904337479, 8640.481571105754, 10575.048245657928, 10578.735531611694, 10609.628662996834, 10625.893741062568, 5570.41510641385, 5733.684647344395, 5747.3677895431465, 5752.597318187729, 5757.68332741699, 2622.4886147201305, 3353.396388650042, 3574.8927532174075, 3578.2306804037257, 3578.731595130376, 1212.0667086343467, 1215.7386161975219, 1775.5206094354453, 1799.8110198429108, 1888.8961107139103, 10961.671149865517, 14519.419223231058, 14545.854541454662, 14547.0, 14573.927130364385, 4690.935268595499, 4753.691010084333, 4793.0, 4835.347228124158, 4845.394325709286, 10194.847077293847, 12357.443915023845, 12390.876091238972, 12400.255984640951, 12409.131360804657, 5627.887442251132, 5718.628289161191, 5731.369549349568, 5731.8853622928145, 5731.971340143356, 4957.529034741694, 5116.820911268088, 5119.513646203604, 5127.564157046693, 5128.410232823273, 3668.137987572918, 3682.410814269704, 3754.4368344748505, 3775.622437756257, 3777.8866634001024, 879.5118709116501, 997.1922742578535, 998.9250806189565, 1008.2790804574764, 1011.8735158105237, 801.2068052627857, 837.417994493821, 892.1301730812406, 900.1268769293774, 941.75985123793, 6227.9377206227355, 6280.874382512324, 6553.967230163914, 6562.67186640666, 6698.296678848748, 1022.555188492993, 1026.1226651213105, 1042.6663467690266, 1045.289203341735, 1088.031651829872, 4334.696571239983, 4418.574544150899, 4424.80088396023, 4555.612772914339, 4620.722756634613, 12574.371281435891, 12809.871901281054, 12832.29422381778, 12980.091393602357, 12984.0, 12724.618261452171, 12894.0, 12905.161164524276, 13020.088593798533, 13096.607101786962, 8545.658173673108, 8810.779730506789, 8864.42381245217, 9711.3202075854, 9991.550380232908, 5097.362829646294, 6427.228732552124, 6439.645819479786, 6698.2631910488835, 6715.160604924385, 9238.399504032217, 11149.944250278697, 11501.654950351503, 11596.36220007874, 11747.588834390755, 11534.192606517463, 11581.247218930743, 11669.591564295548, 11933.16467847277, 12052.517899284281, 7532.13380461232, 8961.462312261025, 9004.50475223869, 9060.682876099305, 9065.27477801761, 9711.028897110233, 9923.0, 9926.454045027593, 9932.652357167464, 9947.651832185838, 8577.228049475578, 8748.65005399777, 8775.42959707617, 8823.250023747796, 8867.512286824287, 8513.74458766238, 8541.87187192205, 8606.698765543177, 8660.870086948828, 8661.956690216508, 7556.319931206218, 7739.419543534144, 7739.4969326995815, 7748.380129589732, 7751.689932402641, 5633.549316054788, 5680.971595141998, 5790.536757059509, 5856.355800861987, 5886.882262354815, 5726.885462290814, 5752.741126649227, 5996.2504686914135, 6003.159557662018, 6099.3290738017895], "value": 5008.322041350519, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.9765365251258, 370.7923562804829, 378.4229050697687, 378.8711837975088, 383.4727250031206, 4649.000464900046, 4766.594839438648, 5053.469385714502, 5117.923231151536, 5128.4871512848695, 4667.8599642010795, 4844.4913284105105, 4870.342503761991, 4923.483034281403, 4962.87592810179, 3533.805640689761, 3728.986347372416, 3852.903677408059, 4097.262492751303, 4170.061736109366, 4101.569335219804, 4122.711410201287, 4127.463429754128, 4156.293430116887, 4206.957930420703, 3570.357335679577, 3744.584742840866, 4057.6550993165615, 4060.5127384713874, 4171.478565179353, 3299.785513941586, 3665.955202767212, 4011.7392369496183, 4022.6178513041214, 4036.091879327157, 3389.017664455288, 3676.1912379276782, 3784.6972242220554, 3796.032011836964, 3804.6981576146586, 4484.215262329112, 4648.325992731069, 4827.541383568555, 4855.3734498942895, 4855.757212139414, 3998.4801975743258, 4207.926978620432, 4284.393352492815, 4603.9769801151115, 4668.0, 5254.3169387979315, 5320.973395133038, 5329.733513324357, 5349.51854333108, 5371.785128594852, 3732.309522738275, 3812.580616132251, 4164.4586203793615, 4228.302330115527, 4230.450041494586, 5076.416212135615, 5155.561777248939, 5225.477452254744, 5294.867628309285, 5420.566354691655, 3467.081223475781, 3694.704423646102, 3775.5469343678933, 4065.8576949806616, 4086.5504794472586, 3971.8609848655738, 4025.705347951698, 4214.220369231641, 4365.0, 4390.692651514427, 4271.700980931305, 4526.5288781146255, 4744.572988431058, 4755.262934245128, 4776.95223047772, 4529.365888775574, 4889.193283108248, 4951.925721114186, 4968.403791544965, 5206.8437946860895, 1348.5819395987276, 1353.5127354152498, 1456.3592019511382, 1464.5899148238511, 1484.5323723027211, 1020.6170638784489, 1110.2783190925802, 1116.8771435142128, 1128.3117298448103, 1136.4829002803704, 4547.976705241361, 4808.975955120202, 4832.975835120872, 4847.5394837490385, 4932.975335123301, 5063.645544811828, 5445.591580631469, 5476.973519797621, 5543.861403464865, 5592.608517403824, 4261.637760790368, 4758.548642664021, 4821.5178482152205, 4827.637927155477, 5039.042581909499, 2564.423004823937, 2783.4711404833015, 2786.7909906756668, 2806.9157925262275, 2812.3812761192503, 4886.363068372135, 5479.917801232985, 5499.872526132133, 5528.6406383585745, 5547.44525547442, 5067.400522422744, 5073.720945347967, 5250.606204534675, 5432.745410654534, 5462.770876552744, 4604.58558729716, 5283.890383019609, 5441.945580544144, 5471.7264136793, 5480.314960629921, 4496.752678602708, 5268.710220937885, 5347.78608855657, 5495.626093476631, 5506.697131657797, 3982.980085099556, 5200.037992971313, 5277.604179686462, 5277.8416647500635, 5324.4675532446445, 4541.890373330004, 4828.493008234085, 4894.021195760934, 5237.895242095061, 5447.455254474679, 3873.806309684448, 4266.402703621434, 4280.422143010654, 4309.612134907873, 4310.4180935573295, 4902.411710594752, 5442.4557544246845, 5446.0, 5452.645578037414, 5565.415631358649, 5034.848954531223, 5157.742112894265, 5183.766730497212, 5198.558122559625, 5285.471452854684, 4454.732716037048, 4784.330193772944, 4945.480724524017, 5062.038212739568, 5205.828688545047, 4423.8894027648275, 4825.782839772149, 5085.491450855033, 5142.6914385137015, 5171.922421163761, 4513.616342610915, 4514.593686568224, 4944.703317800943, 5150.356205474316, 5206.661566998133, 4552.995023284616, 4854.68444551103, 5055.797768089383, 5076.340075790271, 5093.2105523643895], "value": 3998.8161076205374, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.5793565924787, 713.6574444266748, 730.109266694633, 782.5695867272998, 815.2947700239293, 14725.558233252992, 14906.254687265635, 15718.371265149395, 16003.83996160038, 16010.0, 14820.703585928275, 14939.701205975874, 14945.850541494581, 14952.177630230333, 14957.925210373933, 942.5193151492754, 958.9808203835919, 959.9808003839919, 962.6101428921298, 967.5210770668529, 960.7694153403168, 961.1013702188476, 961.4808003678005, 962.210986990668, 962.2542529539628, 986.2997271936933, 1004.7990401919609, 1015.9492025398738, 1017.2980643356061, 1021.6577446555376, 939.7133874168376, 1013.1843865688118, 1016.4663551635376, 1018.0684673523717, 1022.1975749037008, 752.1087511299128, 753.284379839155, 754.3286475037221, 757.273017902814, 757.2881491398068, 15551.688966220725, 15584.376624934988, 15623.218839058116, 15778.132202728846, 16217.837821621752, 13791.655208619764, 14427.350769215305, 14505.782413263809, 14507.854921450862, 14705.705885882222, 11556.306621602731, 11574.555274295215, 11653.941730291379, 11775.764484710258, 11989.160758746892, 3719.497867787841, 3795.7532760370764, 3803.5245594300713, 3885.255648038033, 3928.2339943710986, 85290.0, 101127.0, 108349.0, 110436.79126417427, 111299.0, 11301.717457063474, 11394.886051139383, 11433.714157145972, 11622.186446948632, 11689.006979695438, 24537.754622453904, 24909.62635560468, 25034.499310014064, 25344.493110138064, 25380.492390152092, 7672.42456815741, 7709.38324934004, 7789.300607177086, 7836.09884863248, 7899.368050555941, 4156.2726522858375, 4214.422513967052, 4228.746275223496, 4249.957500424956, 4257.680673949466, 3351.6480769519335, 3437.6906078453057, 3453.0849324928913, 3460.7058400035776, 3464.7228221742703, 597.2743117112728, 613.7790395457631, 614.8708771158017, 630.8990811034682, 631.5673763472037, 403.82029996651795, 476.87601223682094, 482.7200223870147, 495.86363749968325, 502.9899402011939, 9818.852717209247, 10146.847797283046, 10180.694579162637, 10226.386416814867, 10348.806687896446, 651.563452486835, 675.6419097878132, 692.6190595172635, 694.885343918258, 726.5785844210345, 4261.465872285975, 4307.633851122627, 4588.770561471913, 4616.838410655611, 4704.411948506437, 57629.0, 74471.62764186144, 75094.49811003859, 78284.6085769579, 84654.15345846463, 75032.62483687655, 77167.84248236282, 77447.0, 79620.60189699015, 79689.60155199187, 52450.73774631179, 68001.29996750022, 69937.0, 70941.58116837635, 72490.91263630944, 10297.588096476356, 10574.788504230026, 10764.278763380618, 10867.076298514714, 10883.292585981886, 45048.54951450443, 45670.771646141555, 46240.0, 46516.37192698239, 47188.528114718414, 50318.0, 50907.745461272454, 57919.4208057914, 59010.704946474994, 60045.69977150086, 11981.64055078349, 12992.415341309852, 13431.0, 13517.0, 13923.58229253124, 14037.0, 14224.715505690036, 14258.358373873409, 14299.285035747964, 14791.482298119945, 12617.87382126167, 13376.6466707857, 13779.517716879862, 13996.020278580401, 14580.0, 10960.397178155277, 13286.53497127596, 13382.464701411835, 13466.663333416744, 13918.0, 13020.544280950122, 13099.148555343872, 13265.403056862271, 13684.863151368758, 13920.234387108807, 10550.525226364678, 10787.406692631981, 10890.346579204956, 10903.618373356894, 12003.63989080329, 8415.915840841513, 9914.752131196488, 10115.443650599287, 10514.316569422963, 10689.839652405064], "value": 7401.731291801817, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1495.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 115.0, 115.0, 116.0, 115.0, 116.0, 116.0, 115.0, 115.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 138.0, 97.0, 173.0, 146.0, 138.0, 106.0, 111.0, 130.0, 109.0], "value": 131.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 185.0, 180.0, 183.0, 184.0, 211.0, 263.0, 187.0, 184.0], "value": 194.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 62.0, 62.0, 89.0, 64.0, 61.0, 62.0, 60.0, 79.0, 61.0], "value": 68.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 90.0, 104.0, 100.0, 100.0, 116.0, 69.0, 70.0, 85.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 87.0, 87.0, 95.0, 135.0, 86.0, 87.0, 87.0], "value": 92.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 110.0, 151.0, 132.0, 96.0, 133.0, 123.0, 93.0], "value": 112.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 85.0, 80.0, 86.0, 86.0, 85.0, 85.0, 86.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 61.0, 63.0, 62.0, 62.0, 64.0, 62.0, 63.0, 85.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 62.0, 65.0, 62.0, 58.0, 57.0, 58.0, 57.0, 57.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 85.0, 88.0, 87.0, 87.0, 86.0, 88.0, 86.0, 86.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 140.0, 140.0, 140.0, 137.0, 139.0, 140.0, 140.0, 182.0, 148.0], "value": 145.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 173.0, 173.0, 173.0, 172.0, 173.0, 173.0, 170.0, 168.0, 177.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 70.0, 81.0, 87.0, 84.0, 86.0, 84.0, 83.0, 86.0], "value": 79.5, "unit": "score"}]}]} 18:54:09 INFO - Return code: 0 18:54:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:54:09 ERROR - # TBPL SUCCESS # 18:54:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:54:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:54:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:54:09 INFO - 2017-03-08 18:54:09.891 screenresolution[1652:10190] starting screenresolution argv=screenresolution get 18:54:09 INFO - 2017-03-08 18:54:09.893 screenresolution[1652:10190] Display 0: 1600x1200x32@60 18:54:09 INFO - 2017-03-08 18:54:09.899 screenresolution[1653:10193] starting screenresolution argv=screenresolution list 18:54:09 INFO - Available Modes on Display 0 18:54:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:54:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:54:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:54:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:54:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:54:10 INFO - Intel Iris: 18:54:10 INFO - Chipset Model: Intel Iris 18:54:10 INFO - Type: GPU 18:54:10 INFO - Bus: Built-In 18:54:10 INFO - VRAM (Dynamic, Max): 1536 MB 18:54:10 INFO - Vendor: Intel (0x8086) 18:54:10 INFO - Device ID: 0x0a2e 18:54:10 INFO - Revision ID: 0x0009 18:54:10 INFO - Displays: 18:54:10 INFO - Display: 18:54:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:54:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:54:10 INFO - Display Serial Number: 1600x1200 60 18:54:10 INFO - Main Display: Yes 18:54:10 INFO - Mirror: Off 18:54:10 INFO - Online: Yes 18:54:10 INFO - Rotation: Supported 18:54:10 INFO - Return code: 0 18:54:10 INFO - Running post-action listener: _resource_record_post_action 18:54:10 INFO - [mozharness: 2017-03-09 02:54:10.139388Z] Finished run-tests step (success) 18:54:10 INFO - Running post-run listener: _resource_record_post_run 18:54:10 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 38376448; Write bytes: 513177600; Read time: 376; Write time: 1840 18:54:10 INFO - TinderboxPrint: CPU usage
54.0% 18:54:10 INFO - TinderboxPrint: I/O read bytes / time
38,376,448 / 376 18:54:10 INFO - TinderboxPrint: I/O write bytes / time
513,177,600 / 1,840 18:54:10 INFO - TinderboxPrint: CPU idle
2,214.7 (46.0%) 18:54:10 INFO - TinderboxPrint: CPU system
961.4 (20.0%) 18:54:10 INFO - TinderboxPrint: CPU user
1,637.7 (34.0%) 18:54:10 INFO - TinderboxPrint: Swap in / out
248,365,056 / 0 18:54:10 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205943296; Write bytes: 203819008; Read time: 15706; Write time: 432 18:54:10 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 36381696; Write bytes: 298520576; Read time: 355; Write time: 1374 18:54:10 INFO - Running post-run listener: _upload_blobber_files 18:54:10 INFO - Blob upload gear active. 18:54:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:54: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 18:54: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'] 18:54: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 18:54:11 INFO - (blobuploader) - INFO - Open directory for files ... 18:54:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:54:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:54:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:54:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:54:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:54:12 INFO - (blobuploader) - INFO - Done attempting. 18:54:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:54:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:54:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:54:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:54:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:54:13 INFO - (blobuploader) - INFO - Done attempting. 18:54:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:54:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:54:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:54:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:54:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:54:14 INFO - (blobuploader) - INFO - Done attempting. 18:54:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:54:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:54:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:54:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:54:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:54:16 INFO - (blobuploader) - INFO - Done attempting. 18:54:16 INFO - (blobuploader) - INFO - Iteration through files over. 18:54:16 INFO - Return code: 0 18:54:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:54:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:54:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13a3e972c4a8ee9ebc6891634c2ddf9ac5521c0aa93267260df6713faa90a3858c3b6563945dd1527a67917de77aea653e8e1a30563c0b0004431c4a59856079", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/831542e7707a2f37b819d17dfd4fb5b0f423efb24c516af9849715580a740f7f84dd827d3d4be036bb9bcbd445414563798e42890febf4e403a9ba0a02ccdf3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b6f875d14fd51568e0617844af6451489fc66bb7de92dca9b3e7e4630f2fd9b9864a63dee19869c8dcf21fd4634ef4e1ff10adacdf1975e1664aa5f55e3bfd3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6421336d51f1f60a857eb99ef64b3aaacb7e79b373716b77af43c025ce63eb0c13582a22c271e94affccf5f26f60a7d10235926e0bf6022e292595553733d08c"} 18:54:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:54:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:54:16 INFO - Contents: 18:54:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13a3e972c4a8ee9ebc6891634c2ddf9ac5521c0aa93267260df6713faa90a3858c3b6563945dd1527a67917de77aea653e8e1a30563c0b0004431c4a59856079", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/831542e7707a2f37b819d17dfd4fb5b0f423efb24c516af9849715580a740f7f84dd827d3d4be036bb9bcbd445414563798e42890febf4e403a9ba0a02ccdf3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b6f875d14fd51568e0617844af6451489fc66bb7de92dca9b3e7e4630f2fd9b9864a63dee19869c8dcf21fd4634ef4e1ff10adacdf1975e1664aa5f55e3bfd3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6421336d51f1f60a857eb99ef64b3aaacb7e79b373716b77af43c025ce63eb0c13582a22c271e94affccf5f26f60a7d10235926e0bf6022e292595553733d08c"} 18:54:16 INFO - Running post-run listener: copy_logs_to_upload_dir 18:54:16 INFO - Copying logs to upload dir... 18:54:16 INFO - mkdir: /builds/slave/test/build/upload/logs 18:54:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.094647 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-08 18:54:16.758294) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-08 18:54:16.762237) ========= 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.fbcvtfQdOR/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.vfWKdBOhTE/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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/13a3e972c4a8ee9ebc6891634c2ddf9ac5521c0aa93267260df6713faa90a3858c3b6563945dd1527a67917de77aea653e8e1a30563c0b0004431c4a59856079", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/831542e7707a2f37b819d17dfd4fb5b0f423efb24c516af9849715580a740f7f84dd827d3d4be036bb9bcbd445414563798e42890febf4e403a9ba0a02ccdf3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b6f875d14fd51568e0617844af6451489fc66bb7de92dca9b3e7e4630f2fd9b9864a63dee19869c8dcf21fd4634ef4e1ff10adacdf1975e1664aa5f55e3bfd3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6421336d51f1f60a857eb99ef64b3aaacb7e79b373716b77af43c025ce63eb0c13582a22c271e94affccf5f26f60a7d10235926e0bf6022e292595553733d08c"} build_url:https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011006 build_url: 'https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/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/13a3e972c4a8ee9ebc6891634c2ddf9ac5521c0aa93267260df6713faa90a3858c3b6563945dd1527a67917de77aea653e8e1a30563c0b0004431c4a59856079", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/831542e7707a2f37b819d17dfd4fb5b0f423efb24c516af9849715580a740f7f84dd827d3d4be036bb9bcbd445414563798e42890febf4e403a9ba0a02ccdf3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b6f875d14fd51568e0617844af6451489fc66bb7de92dca9b3e7e4630f2fd9b9864a63dee19869c8dcf21fd4634ef4e1ff10adacdf1975e1664aa5f55e3bfd3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6421336d51f1f60a857eb99ef64b3aaacb7e79b373716b77af43c025ce63eb0c13582a22c271e94affccf5f26f60a7d10235926e0bf6022e292595553733d08c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-08 18:54:16.797980) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 18:54:16.798428) ========= 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.fbcvtfQdOR/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.vfWKdBOhTE/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.005160 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 18:54:16.848512) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-08 18:54:16.848979) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-08 18:54:16.849426) ========= ========= Total master_lag: 0.19 =========