builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0185 starttime: 1493223507.56 results: success (0) buildid: 20170426080225 builduid: 7bf14681b199442ead82c89c4617f651 revision: a477e80f03b61be9961bc61770a2b55cce139b91 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-26 09:18:27.559290) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-26 09:18:27.559741) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-26 09:18:27.560036) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-26 09:18:27.587942) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 09:18:27.588213) ========= 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.rehP1z2xSh/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.4w6O6VQ62G/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-26 09:18:27-- 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.5M=0.001s 2017-04-26 09:18:27 (13.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.169866 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 09:18:27.783170) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 09:18:27.783482) ========= 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.rehP1z2xSh/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.4w6O6VQ62G/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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.028258 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 09:18:27.834627) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-26 09:18:27.834978) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a477e80f03b61be9961bc61770a2b55cce139b91 --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 a477e80f03b61be9961bc61770a2b55cce139b91 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rehP1z2xSh/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.4w6O6VQ62G/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-26 09:18:27,930 truncating revision to first 12 chars 2017-04-26 09:18:27,930 Setting DEBUG logging. 2017-04-26 09:18:27,930 attempt 1/10 2017-04-26 09:18:27,930 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a477e80f03b6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-26 09:18:30,428 unpacking tar archive at: mozilla-central-a477e80f03b6/testing/mozharness/ program finished with exit code 0 elapsedTime=3.033180 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-26 09:18:30.894631) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-26 09:18:30.895185) ========= script_repo_revision: a477e80f03b61be9961bc61770a2b55cce139b91 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-26 09:18:30.895806) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-26 09:18:30.896213) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-26 09:18:30.918685) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-26 09:18:30.919298) ========= /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.rehP1z2xSh/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.4w6O6VQ62G/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 09:18:31 INFO - MultiFileLogger online at 20170426 09:18:31 in /builds/slave/test 09:18:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:18:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:18:31 INFO - {'append_to_log': False, 09:18:31 INFO - 'base_work_dir': '/builds/slave/test', 09:18:31 INFO - 'blob_upload_branch': 'Firefox', 09:18:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:18:31 INFO - 'branch': 'Firefox', 09:18:31 INFO - 'buildbot_json_path': 'buildprops.json', 09:18:31 INFO - 'config_files': ('talos/mac_config.py',), 09:18:31 INFO - 'default_actions': ('clobber', 09:18:31 INFO - 'read-buildbot-config', 09:18:31 INFO - 'download-and-extract', 09:18:31 INFO - 'populate-webroot', 09:18:31 INFO - 'create-virtualenv', 09:18:31 INFO - 'install', 09:18:31 INFO - 'run-tests'), 09:18:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:18:31 INFO - 'download_minidump_stackwalk': True, 09:18:31 INFO - 'download_symbols': 'ondemand', 09:18:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:18:31 INFO - 'tooltool.py': '/tools/tooltool.py', 09:18:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:18:31 INFO - '/tools/misc-python/virtualenv.py')}, 09:18:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:18:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:18:31 INFO - 'gecko_profile': False, 09:18:31 INFO - 'gecko_profile_interval': 0, 09:18:31 INFO - 'installer_path': 'installer.exe', 09:18:31 INFO - 'log_level': 'info', 09:18:31 INFO - 'log_name': 'talos', 09:18:31 INFO - 'log_to_console': True, 09:18:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:18:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:18:31 INFO - 'opt_config_files': (), 09:18:31 INFO - 'pip_index': False, 09:18:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:18:31 INFO - 'cmd': ('bash', 09:18:31 INFO - '-c', 09:18:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:18:31 INFO - 'enabled': True, 09:18:31 INFO - 'halt_on_failure': False, 09:18:31 INFO - 'name': 'check_screen_resolution'},), 09:18:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:18:31 INFO - 'cmd': ('bash', 09:18:31 INFO - '-c', 09:18:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:18:31 INFO - 'enabled': True, 09:18:31 INFO - 'halt_on_failure': False, 09:18:31 INFO - 'name': 'check_screen_resolution'},), 09:18:31 INFO - 'run_cmd_checks_enabled': True, 09:18:31 INFO - 'suite': 'dromaeojs', 09:18:31 INFO - 'system_bits': '32', 09:18:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:18:31 INFO - 'title': 't-yosemite-r7-0185', 09:18:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:18:31 INFO - 'use_talos_json': True, 09:18:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:18:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:18:31 INFO - 'work_dir': 'build'} 09:18:31 INFO - [mozharness: 2017-04-26 16:18:31.131941Z] Running clobber step. 09:18:31 INFO - Running pre-action listener: _resource_record_pre_action 09:18:31 INFO - Running main action method: clobber 09:18:31 INFO - rmtree: /builds/slave/test/build 09:18:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:18:33 INFO - Running post-action listener: _resource_record_post_action 09:18:33 INFO - [mozharness: 2017-04-26 16:18:33.783164Z] Finished clobber step (success) 09:18:33 INFO - [mozharness: 2017-04-26 16:18:33.783320Z] Running read-buildbot-config step. 09:18:33 INFO - Running pre-action listener: _resource_record_pre_action 09:18:33 INFO - Running main action method: read_buildbot_config 09:18:33 INFO - Using buildbot properties: 09:18:33 INFO - { 09:18:33 INFO - "project": "", 09:18:33 INFO - "product": "firefox", 09:18:33 INFO - "script_repo_revision": "production", 09:18:33 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:18:33 INFO - "repository": "", 09:18:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:18:33 INFO - "buildid": "20170426080225", 09:18:33 INFO - "pgo_build": "False", 09:18:33 INFO - "basedir": "/builds/slave/test", 09:18:33 INFO - "buildnumber": 45, 09:18:33 INFO - "slavename": "t-yosemite-r7-0185", 09:18:33 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:18:33 INFO - "platform": "yosemite_r7", 09:18:33 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:18:33 INFO - "branch": "mozilla-central", 09:18:33 INFO - "repo_path": "mozilla-central", 09:18:33 INFO - "revision": "a477e80f03b61be9961bc61770a2b55cce139b91", 09:18:33 INFO - "stage_platform": "macosx64", 09:18:33 INFO - "builduid": "7bf14681b199442ead82c89c4617f651", 09:18:33 INFO - "slavebuilddir": "test" 09:18:33 INFO - } 09:18:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 09:18:33 INFO - Running post-action listener: _resource_record_post_action 09:18:33 INFO - [mozharness: 2017-04-26 16:18:33.786621Z] Finished read-buildbot-config step (success) 09:18:33 INFO - [mozharness: 2017-04-26 16:18:33.786762Z] Running download-and-extract step. 09:18:33 INFO - Running pre-action listener: _resource_record_pre_action 09:18:33 INFO - Running main action method: download_and_extract 09:18:33 INFO - mkdir: /builds/slave/test/build/tests 09:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:33 INFO - trying https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 09:18:33 INFO - Downloading https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/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 09:18:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/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 09:18:35 INFO - Downloaded 1325 bytes. 09:18:35 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:18:35 INFO - Using the following test package requirements: 09:18:35 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:18:35 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 09:18:35 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:18:35 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:18:35 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 09:18:35 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:18:35 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 09:18:35 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:18:35 INFO - u'jsshell-mac.zip'], 09:18:35 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:18:35 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 09:18:35 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:18:35 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:18:35 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 09:18:35 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:18:35 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 09:18:35 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:18:35 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 09:18:35 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:18:35 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 09:18:35 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:18:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:18:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:18:35 INFO - Fetch https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:18:36 INFO - Content-Length response header: 52527133 09:18:36 INFO - Bytes received: 52527133 09:18:52 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 09:18:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:18:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:18:52 INFO - Fetch https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:18:54 INFO - Content-Length response header: 52527133 09:18:54 INFO - Bytes received: 52527133 09:19:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 09:19:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:19:09 INFO - Fetch https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 09:19:10 INFO - Content-Length response header: 14408809 09:19:10 INFO - Bytes received: 14408809 09:19:11 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')]} 09:19:11 INFO - trying https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:19:11 INFO - Downloading https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 09:19:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/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 09:19:13 INFO - Downloaded 71207359 bytes. 09:19:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:19:13 INFO - mkdir: /builds/slave/test/properties 09:19:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:19:13 INFO - Writing to file /builds/slave/test/properties/build_url 09:19:13 INFO - Contents: 09:19:13 INFO - build_url:https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:19:14 INFO - Running post-action listener: _resource_record_post_action 09:19:14 INFO - Running post-action listener: set_extra_try_arguments 09:19:14 INFO - [mozharness: 2017-04-26 16:19:14.712609Z] Finished download-and-extract step (success) 09:19:14 INFO - [mozharness: 2017-04-26 16:19:14.712738Z] Running populate-webroot step. 09:19:14 INFO - Running pre-action listener: _resource_record_pre_action 09:19:14 INFO - Running main action method: populate_webroot 09:19:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:19:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:19:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:19:14 INFO - '--tppagecycles', 09:19:14 INFO - '7'], 09:19:14 INFO - 'tests': ['tsvgm']}}, 09:19:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:19:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:19:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:19:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:19:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:19:14 INFO - 'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:19:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:19:14 INFO - 'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['damp', 'tps']}, 09:19:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:19:14 INFO - 'tests': ['damp', 'tps']}, 09:19:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['dromaeo_dom']}, 09:19:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:19:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:19:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:19:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['a11yr', 09:19:14 INFO - 'ts_paint', 09:19:14 INFO - 'tpaint', 09:19:14 INFO - 'sessionrestore', 09:19:14 INFO - 'sessionrestore_no_auto_restore', 09:19:14 INFO - 'tabpaint']}, 09:19:14 INFO - 'other-e10s': {'tests': ['a11yr', 09:19:14 INFO - 'ts_paint', 09:19:14 INFO - 'tpaint', 09:19:14 INFO - 'sessionrestore', 09:19:14 INFO - 'sessionrestore_no_auto_restore', 09:19:14 INFO - 'tabpaint']}, 09:19:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:19:14 INFO - 'ts_paint', 09:19:14 INFO - 'tpaint', 09:19:14 INFO - 'sessionrestore', 09:19:14 INFO - 'sessionrestore_no_auto_restore', 09:19:14 INFO - 'tabpaint']}, 09:19:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:19:14 INFO - 'ts_paint', 09:19:14 INFO - 'tpaint', 09:19:14 INFO - 'sessionrestore', 09:19:14 INFO - 'sessionrestore_no_auto_restore', 09:19:14 INFO - 'tabpaint']}, 09:19:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['a11yr', 09:19:14 INFO - 'ts_paint', 09:19:14 INFO - 'tpaint', 09:19:14 INFO - 'sessionrestore', 09:19:14 INFO - 'sessionrestore_no_auto_restore', 09:19:14 INFO - 'tabpaint']}, 09:19:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['a11yr', 09:19:14 INFO - 'ts_paint', 09:19:14 INFO - 'tpaint', 09:19:14 INFO - 'sessionrestore', 09:19:14 INFO - 'sessionrestore_no_auto_restore', 09:19:14 INFO - 'tabpaint']}, 09:19:14 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:19:14 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:19:14 INFO - 'bloom_basic_ref']}, 09:19:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['tsvgx', 09:19:14 INFO - 'tsvgr_opacity', 09:19:14 INFO - 'tart', 09:19:14 INFO - 'tscrollx', 09:19:14 INFO - 'cart', 09:19:14 INFO - 'tsvg_static']}, 09:19:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:19:14 INFO - 'tsvgr_opacity', 09:19:14 INFO - 'tart', 09:19:14 INFO - 'tscrollx', 09:19:14 INFO - 'cart', 09:19:14 INFO - 'tsvg_static']}, 09:19:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:19:14 INFO - 'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['tp5o']}, 09:19:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:19:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:19:14 INFO - 'talos_options': ['--disable-e10s', 09:19:14 INFO - '--xperf_path', 09:19:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:14 INFO - 'tests': ['tp5n']}, 09:19:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:19:14 INFO - 'talos_options': ['--xperf_path', 09:19:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:14 INFO - 'tests': ['tp5n']}}, 09:19:14 INFO - 'talos.zip': {'path': '', 09:19:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:19:14 INFO - Running post-action listener: _resource_record_post_action 09:19:14 INFO - [mozharness: 2017-04-26 16:19:14.731845Z] Finished populate-webroot step (success) 09:19:14 INFO - [mozharness: 2017-04-26 16:19:14.731969Z] Running create-virtualenv step. 09:19:14 INFO - Running pre-action listener: _resource_record_pre_action 09:19:14 INFO - Running main action method: create_virtualenv 09:19:14 INFO - Creating virtualenv /builds/slave/test/build/venv 09:19:14 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 09:19:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:19:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:19:14 INFO - Using real prefix '/tools/python27' 09:19:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:19:15 INFO - Installing distribute.............................................................................................................................................................................................done. 09:19:18 INFO - Installing pip.................done. 09:19:18 INFO - Return code: 0 09:19:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:19:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:19:18 INFO - Reading from file tmpfile_stdout 09:19:18 INFO - Output received: 09:19:18 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) 09:19:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:19:18 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')]} 09:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:19 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 0x109d7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb56bccc870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b5ad30>, '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 0x109a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b4fbe8>, '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.rehP1z2xSh/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.4w6O6VQ62G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 09:19:19 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 09:19:19 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 09:19:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rehP1z2xSh/Render', 09:19:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:19 INFO - 'HOME': '/Users/cltbld', 09:19:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:19 INFO - 'LOGNAME': 'cltbld', 09:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:19 INFO - 'MOZ_NO_REMOTE': '1', 09:19:19 INFO - 'NO_EM_RESTART': '1', 09:19:19 INFO - 'PAGER': '/bin/cat', 09:19:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:19 INFO - 'PWD': '/builds/slave/test', 09:19:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:19 INFO - 'SHELL': '/bin/bash', 09:19:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4w6O6VQ62G/Listeners', 09:19:19 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 09:19:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:19 INFO - 'USER': 'cltbld', 09:19:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:19 INFO - 'XPC_FLAGS': '0x0', 09:19:19 INFO - 'XPC_SERVICE_NAME': '0', 09:19:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:19 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 09:19:19 INFO - Cleaning up... 09:19:19 INFO - Return code: 0 09:19:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:20 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 0x109d7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb56bccc870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b5ad30>, '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 0x109a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b4fbe8>, '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.rehP1z2xSh/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.4w6O6VQ62G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 09:19:20 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 09:19:20 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 09:19:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rehP1z2xSh/Render', 09:19:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:20 INFO - 'HOME': '/Users/cltbld', 09:19:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:20 INFO - 'LOGNAME': 'cltbld', 09:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:20 INFO - 'MOZ_NO_REMOTE': '1', 09:19:20 INFO - 'NO_EM_RESTART': '1', 09:19:20 INFO - 'PAGER': '/bin/cat', 09:19:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:20 INFO - 'PWD': '/builds/slave/test', 09:19:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:20 INFO - 'SHELL': '/bin/bash', 09:19:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4w6O6VQ62G/Listeners', 09:19:20 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 09:19:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:20 INFO - 'USER': 'cltbld', 09:19:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:20 INFO - 'XPC_FLAGS': '0x0', 09:19:20 INFO - 'XPC_SERVICE_NAME': '0', 09:19:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:20 INFO - Downloading/unpacking psutil>=3.1.1 09:19:20 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 09:19:20 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 09:19:20 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 09:19:20 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 09:19:20 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 09:19:20 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 09:19:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:19:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:24 INFO - Installing collected packages: psutil 09:19:24 INFO - Running setup.py install for psutil 09:19:24 INFO - building 'psutil._psutil_osx' extension 09:19:24 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 09:19:25 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 09:19:25 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 09:19:25 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 09:19:25 INFO - building 'psutil._psutil_posix' extension 09:19:25 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 09:19:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:19:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:19:25 INFO - ^ 09:19:25 INFO - 1 warning generated. 09:19:25 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 09:19:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:25 INFO - Successfully installed psutil 09:19:25 INFO - Cleaning up... 09:19:25 INFO - Return code: 0 09:19:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109d7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb56bccc870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b5ad30>, '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 0x109a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b4fbe8>, '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.rehP1z2xSh/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.4w6O6VQ62G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 09:19:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:19:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rehP1z2xSh/Render', 09:19:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:25 INFO - 'HOME': '/Users/cltbld', 09:19:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:25 INFO - 'LOGNAME': 'cltbld', 09:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:25 INFO - 'MOZ_NO_REMOTE': '1', 09:19:25 INFO - 'NO_EM_RESTART': '1', 09:19:25 INFO - 'PAGER': '/bin/cat', 09:19:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:25 INFO - 'PWD': '/builds/slave/test', 09:19:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:25 INFO - 'SHELL': '/bin/bash', 09:19:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4w6O6VQ62G/Listeners', 09:19:25 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 09:19:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:25 INFO - 'USER': 'cltbld', 09:19:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:25 INFO - 'XPC_FLAGS': '0x0', 09:19:25 INFO - 'XPC_SERVICE_NAME': '0', 09:19:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:19:25 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 09:19:25 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 09:19:25 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 09:19:25 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 09:19:25 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 09:19:25 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 09:19:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:19:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:19:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:19:28 INFO - Installing collected packages: mozsystemmonitor 09:19:28 INFO - Running setup.py install for mozsystemmonitor 09:19:28 INFO - Successfully installed mozsystemmonitor 09:19:28 INFO - Cleaning up... 09:19:28 INFO - Return code: 0 09:19:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:19:28 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')]} 09:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:28 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')]} 09:19:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:28 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 0x109d7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb56bccc870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b5ad30>, '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 0x109a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b4fbe8>, '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.rehP1z2xSh/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.4w6O6VQ62G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 09:19:28 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 09:19:28 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 09:19:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rehP1z2xSh/Render', 09:19:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:28 INFO - 'HOME': '/Users/cltbld', 09:19:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:28 INFO - 'LOGNAME': 'cltbld', 09:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:28 INFO - 'MOZ_NO_REMOTE': '1', 09:19:28 INFO - 'NO_EM_RESTART': '1', 09:19:28 INFO - 'PAGER': '/bin/cat', 09:19:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:28 INFO - 'PWD': '/builds/slave/test', 09:19:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:28 INFO - 'SHELL': '/bin/bash', 09:19:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4w6O6VQ62G/Listeners', 09:19:28 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 09:19:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:28 INFO - 'USER': 'cltbld', 09:19:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:28 INFO - 'XPC_FLAGS': '0x0', 09:19:28 INFO - 'XPC_SERVICE_NAME': '0', 09:19:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:29 INFO - Downloading/unpacking jsonschema==2.5.1 09:19:29 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 09:19:29 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 09:19:29 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 09:19:29 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 09:19:29 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 09:19:29 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 09:19:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:19:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:19:31 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 09:19:31 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 09:19:31 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 09:19:31 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 09:19:31 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 09:19:31 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 09:19:32 INFO - Downloading functools32-3.2.3-2.tar.gz 09:19:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:19:32 INFO - warning: no files found matching '*.txt' 09:19:32 INFO - no previously-included directories found matching 'build' 09:19:32 INFO - no previously-included directories found matching 'dist' 09:19:32 INFO - no previously-included directories found matching '.git*' 09:19:32 INFO - Installing collected packages: jsonschema, functools32 09:19:32 INFO - Running setup.py install for functools32 09:19:32 INFO - warning: no files found matching '*.txt' 09:19:32 INFO - no previously-included directories found matching 'build' 09:19:32 INFO - no previously-included directories found matching 'dist' 09:19:32 INFO - no previously-included directories found matching '.git*' 09:19:32 INFO - Successfully installed jsonschema functools32 09:19:32 INFO - Cleaning up... 09:19:32 INFO - Return code: 0 09:19:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:19:32 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')]} 09:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:32 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')]} 09:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:32 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 0x109d7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb56bccc870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b5ad30>, '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 0x109a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b4fbe8>, '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.rehP1z2xSh/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.4w6O6VQ62G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 09:19:32 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 09:19:32 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 09:19:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rehP1z2xSh/Render', 09:19:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:32 INFO - 'HOME': '/Users/cltbld', 09:19:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:32 INFO - 'LOGNAME': 'cltbld', 09:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:32 INFO - 'MOZ_NO_REMOTE': '1', 09:19:32 INFO - 'NO_EM_RESTART': '1', 09:19:32 INFO - 'PAGER': '/bin/cat', 09:19:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:32 INFO - 'PWD': '/builds/slave/test', 09:19:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:32 INFO - 'SHELL': '/bin/bash', 09:19:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4w6O6VQ62G/Listeners', 09:19:32 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 09:19:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:32 INFO - 'USER': 'cltbld', 09:19:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:32 INFO - 'XPC_FLAGS': '0x0', 09:19:32 INFO - 'XPC_SERVICE_NAME': '0', 09:19:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:19:32 INFO - Cleaning up... 09:19:32 INFO - Return code: 0 09:19:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:19:32 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')]} 09:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:32 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')]} 09:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:32 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 0x109d7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb56bccc870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b5ad30>, '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 0x109a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b4fbe8>, '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.rehP1z2xSh/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.4w6O6VQ62G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 09:19:32 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 09:19:32 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 09:19:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rehP1z2xSh/Render', 09:19:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:32 INFO - 'HOME': '/Users/cltbld', 09:19:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:32 INFO - 'LOGNAME': 'cltbld', 09:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:32 INFO - 'MOZ_NO_REMOTE': '1', 09:19:32 INFO - 'NO_EM_RESTART': '1', 09:19:32 INFO - 'PAGER': '/bin/cat', 09:19:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:32 INFO - 'PWD': '/builds/slave/test', 09:19:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:32 INFO - 'SHELL': '/bin/bash', 09:19:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4w6O6VQ62G/Listeners', 09:19:32 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 09:19:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:32 INFO - 'USER': 'cltbld', 09:19:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:32 INFO - 'XPC_FLAGS': '0x0', 09:19:32 INFO - 'XPC_SERVICE_NAME': '0', 09:19:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:33 INFO - Downloading/unpacking blobuploader==1.2.4 09:19:33 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 09:19:33 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 09:19:33 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 09:19:33 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 09:19:33 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 09:19:33 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 09:19:35 INFO - Downloading blobuploader-1.2.4.tar.gz 09:19:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:19:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:19:35 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 09:19:35 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 09:19:35 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 09:19:35 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 09:19:35 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 09:19:35 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 09:19:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:19:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:19:36 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 09:19:36 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 09:19:36 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 09:19:36 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 09:19:36 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 09:19:36 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 09:19:36 INFO - Downloading docopt-0.6.1.tar.gz 09:19:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:19:36 INFO - Installing collected packages: blobuploader, requests, docopt 09:19:36 INFO - Running setup.py install for blobuploader 09:19:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:19:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:19:37 INFO - Running setup.py install for requests 09:19:37 INFO - Running setup.py install for docopt 09:19:37 INFO - Successfully installed blobuploader requests docopt 09:19:37 INFO - Cleaning up... 09:19:37 INFO - Return code: 0 09:19:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19: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')]} 09:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19: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')]} 09:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:37 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 0x109d7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb56bccc870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b5ad30>, '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 0x109a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b4fbe8>, '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.rehP1z2xSh/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.4w6O6VQ62G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 09:19:37 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 09:19:37 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 09:19:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rehP1z2xSh/Render', 09:19:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:37 INFO - 'HOME': '/Users/cltbld', 09:19:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:37 INFO - 'LOGNAME': 'cltbld', 09:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:37 INFO - 'MOZ_NO_REMOTE': '1', 09:19:37 INFO - 'NO_EM_RESTART': '1', 09:19:37 INFO - 'PAGER': '/bin/cat', 09:19:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:37 INFO - 'PWD': '/builds/slave/test', 09:19:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:37 INFO - 'SHELL': '/bin/bash', 09:19:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4w6O6VQ62G/Listeners', 09:19:37 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 09:19:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:37 INFO - 'USER': 'cltbld', 09:19:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:37 INFO - 'XPC_FLAGS': '0x0', 09:19:37 INFO - 'XPC_SERVICE_NAME': '0', 09:19:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:38 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-JipbEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:38 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-Oo4ymI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:38 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-ezLYu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:38 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-A6JZZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:38 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-KW3g1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:38 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-iUWvkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:38 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-N18FUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:38 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-O4Xx6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:38 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-cUve2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:39 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-CgalJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:39 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-TYUStl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:39 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-YwMRDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:39 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-WDcSog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:39 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-qodfgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:39 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-mlZQw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:39 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-hiB8T6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:39 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-Z3pTgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:19:39 INFO - Running setup.py install for manifestparser 09:19:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:19:40 INFO - Running setup.py install for mozcrash 09:19:40 INFO - Running setup.py install for mozdebug 09:19:40 INFO - Running setup.py install for mozdevice 09:19:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:19:40 INFO - Running setup.py install for mozfile 09:19:40 INFO - Running setup.py install for mozhttpd 09:19:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:19:40 INFO - Running setup.py install for mozinfo 09:19:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:19:40 INFO - Running setup.py install for mozInstall 09:19:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:19:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:19:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:19:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:19:41 INFO - Running setup.py install for mozleak 09:19:41 INFO - Running setup.py install for mozlog 09:19:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:19:41 INFO - Running setup.py install for moznetwork 09:19:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:19:41 INFO - Running setup.py install for mozprocess 09:19:41 INFO - Running setup.py install for mozprofile 09:19:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:19:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:19:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:19:41 INFO - Running setup.py install for mozrunner 09:19:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:19:42 INFO - Running setup.py install for mozscreenshot 09:19:42 INFO - Running setup.py install for moztest 09:19:42 INFO - Running setup.py install for mozversion 09:19:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:19:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:19:42 INFO - Cleaning up... 09:19:42 INFO - Return code: 0 09:19:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19: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')]} 09:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19: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')]} 09:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:42 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 0x109d7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb56bccc870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b5ad30>, '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 0x109a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b4fbe8>, '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.rehP1z2xSh/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.4w6O6VQ62G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 09:19:42 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 09:19:42 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 09:19:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rehP1z2xSh/Render', 09:19:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:42 INFO - 'HOME': '/Users/cltbld', 09:19:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:42 INFO - 'LOGNAME': 'cltbld', 09:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:42 INFO - 'MOZ_NO_REMOTE': '1', 09:19:42 INFO - 'NO_EM_RESTART': '1', 09:19:42 INFO - 'PAGER': '/bin/cat', 09:19:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:42 INFO - 'PWD': '/builds/slave/test', 09:19:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:42 INFO - 'SHELL': '/bin/bash', 09:19:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4w6O6VQ62G/Listeners', 09:19:42 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 09:19:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:42 INFO - 'USER': 'cltbld', 09:19:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:42 INFO - 'XPC_FLAGS': '0x0', 09:19:42 INFO - 'XPC_SERVICE_NAME': '0', 09:19:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:42 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-k2IaZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:42 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)) 09:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:42 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-SqPepn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:42 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)) 09:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:42 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-JDzZTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:43 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)) 09:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:43 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-zVM2Rx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:43 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-RpZGZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:43 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)) 09:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:43 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-hUajtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:43 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)) 09:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:43 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-aNFxeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:43 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)) 09:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:43 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-WikA_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:43 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)) 09:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:43 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-ujgOt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:43 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)) 09:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:43 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-6mFRKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:43 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)) 09:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:43 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-5ZX3Um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:43 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)) 09:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:43 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-QrMH69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:44 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)) 09:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:44 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-VhZojS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:44 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)) 09:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:44 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-blGaj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:44 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)) 09:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:44 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-2BBJDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:44 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)) 09:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:44 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-kDMdN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:44 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)) 09:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:44 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-EL__4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:44 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)) 09:19:44 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)) 09:19:44 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)) 09:19:44 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)) 09:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:19:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:19:44 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 09:19:44 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 09:19:44 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 09:19:44 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 09:19:44 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 09:19:44 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 09:19:47 INFO - Downloading blessings-1.6.tar.gz 09:19:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:19:47 INFO - Installing collected packages: blessings 09:19:47 INFO - Running setup.py install for blessings 09:19:47 INFO - Successfully installed blessings 09:19:47 INFO - Cleaning up... 09:19:47 INFO - Return code: 0 09:19:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:19:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:47 INFO - Reading from file tmpfile_stdout 09:19:47 INFO - Current package versions: 09:19:47 INFO - blessings == 1.6 09:19:47 INFO - blobuploader == 1.2.4 09:19:47 INFO - docopt == 0.6.1 09:19:47 INFO - functools32 == 3.2.3-2 09:19:47 INFO - jsonschema == 2.5.1 09:19:47 INFO - manifestparser == 1.1 09:19:47 INFO - mozInstall == 1.12 09:19:47 INFO - mozcrash == 1.0 09:19:47 INFO - mozdebug == 0.1 09:19:47 INFO - mozdevice == 0.50 09:19:47 INFO - mozfile == 1.2 09:19:47 INFO - mozhttpd == 0.7 09:19:47 INFO - mozinfo == 0.9 09:19:47 INFO - mozleak == 0.1 09:19:47 INFO - mozlog == 3.4 09:19:47 INFO - moznetwork == 0.27 09:19:47 INFO - mozprocess == 0.25 09:19:47 INFO - mozprofile == 0.28 09:19:47 INFO - mozrunner == 6.13 09:19:47 INFO - mozscreenshot == 0.1 09:19:47 INFO - mozsystemmonitor == 0.3 09:19:47 INFO - moztest == 0.8 09:19:47 INFO - mozversion == 1.4 09:19:47 INFO - psutil == 3.1.1 09:19:47 INFO - requests == 1.2.3 09:19:47 INFO - wsgiref == 0.1.2 09:19:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:47 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 0x109d7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb56bccc870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b5ad30>, '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 0x109a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b4fbe8>, '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.rehP1z2xSh/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.4w6O6VQ62G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 09:19:47 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 09:19:47 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 09:19:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rehP1z2xSh/Render', 09:19:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:47 INFO - 'HOME': '/Users/cltbld', 09:19:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:47 INFO - 'LOGNAME': 'cltbld', 09:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:47 INFO - 'MOZ_NO_REMOTE': '1', 09:19:47 INFO - 'NO_EM_RESTART': '1', 09:19:47 INFO - 'PAGER': '/bin/cat', 09:19:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:47 INFO - 'PWD': '/builds/slave/test', 09:19:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:47 INFO - 'SHELL': '/bin/bash', 09:19:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4w6O6VQ62G/Listeners', 09:19:47 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 09:19:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:47 INFO - 'USER': 'cltbld', 09:19:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:47 INFO - 'XPC_FLAGS': '0x0', 09:19:47 INFO - 'XPC_SERVICE_NAME': '0', 09:19:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:48 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)) 09:19:48 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)) 09:19:48 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)) 09:19:48 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)) 09:19:48 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)) 09:19:48 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)) 09:19:48 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)) 09:19:48 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)) 09:19:48 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)) 09:19:48 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)) 09:19:48 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)) 09:19:48 INFO - Cleaning up... 09:19:48 INFO - Return code: 0 09:19:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:19:48 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')]} 09:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:48 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')]} 09:19:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:48 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 0x109d7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb56bccc870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b5ad30>, '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 0x109a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b4fbe8>, '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.rehP1z2xSh/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.4w6O6VQ62G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 09:19:48 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 09:19:48 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 09:19:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rehP1z2xSh/Render', 09:19:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:48 INFO - 'HOME': '/Users/cltbld', 09:19:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:48 INFO - 'LOGNAME': 'cltbld', 09:19:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:48 INFO - 'MOZ_NO_REMOTE': '1', 09:19:48 INFO - 'NO_EM_RESTART': '1', 09:19:48 INFO - 'PAGER': '/bin/cat', 09:19:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:48 INFO - 'PWD': '/builds/slave/test', 09:19:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:48 INFO - 'SHELL': '/bin/bash', 09:19:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4w6O6VQ62G/Listeners', 09:19:48 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 09:19:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:48 INFO - 'USER': 'cltbld', 09:19:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:48 INFO - 'XPC_FLAGS': '0x0', 09:19:48 INFO - 'XPC_SERVICE_NAME': '0', 09:19:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:19:48 INFO - Cleaning up... 09:19:48 INFO - Return code: 0 09:19:48 INFO - Running post-action listener: _resource_record_post_action 09:19:48 INFO - Running post-action listener: _start_resource_monitoring 09:19:48 INFO - Starting resource monitoring. 09:19:48 INFO - [mozharness: 2017-04-26 16:19:48.470510Z] Finished create-virtualenv step (success) 09:19:48 INFO - [mozharness: 2017-04-26 16:19:48.471568Z] Running install step. 09:19:48 INFO - Running pre-action listener: _resource_record_pre_action 09:19:48 INFO - Running main action method: install 09:19:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:48 INFO - Reading from file tmpfile_stdout 09:19:48 INFO - Detecting whether we're running mozinstall >=1.0... 09:19:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:19:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:19:48 INFO - Reading from file tmpfile_stdout 09:19:48 INFO - Output received: 09:19:48 INFO - Usage: mozinstall [options] installer 09:19:48 INFO - Options: 09:19:48 INFO - -h, --help show this help message and exit 09:19:48 INFO - -d DEST, --destination=DEST 09:19:48 INFO - Directory to install application into. [default: 09:19:48 INFO - "/builds/slave/test"] 09:19:48 INFO - --app=APP Application being installed. [default: firefox] 09:19:48 INFO - mkdir: /builds/slave/test/build/application 09:19:48 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'] 09:19:48 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 09:20:08 INFO - Reading from file tmpfile_stdout 09:20:08 INFO - Output received: 09:20:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:20:08 INFO - Running post-action listener: _resource_record_post_action 09:20:08 INFO - [mozharness: 2017-04-26 16:20:08.416207Z] Finished install step (success) 09:20:08 INFO - [mozharness: 2017-04-26 16:20:08.416362Z] Running run-tests step. 09:20:08 INFO - Running pre-action listener: _resource_record_pre_action 09:20:08 INFO - Running main action method: run_tests 09:20:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:20:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:20:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:20:08 INFO - 2017-04-26 09:20:08.431 screenresolution[1627:7572] starting screenresolution argv=screenresolution get 09:20:08 INFO - 2017-04-26 09:20:08.434 screenresolution[1627:7572] Display 0: 1600x1200x32@60 09:20:08 INFO - 2017-04-26 09:20:08.439 screenresolution[1628:7575] starting screenresolution argv=screenresolution list 09:20:08 INFO - Available Modes on Display 0 09:20:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:20:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:20:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:20:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:20:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:20:08 INFO - Intel Iris: 09:20:08 INFO - Chipset Model: Intel Iris 09:20:08 INFO - Type: GPU 09:20:08 INFO - Bus: Built-In 09:20:08 INFO - VRAM (Dynamic, Max): 1536 MB 09:20:08 INFO - Vendor: Intel (0x8086) 09:20:08 INFO - Device ID: 0x0a2e 09:20:08 INFO - Revision ID: 0x0009 09:20:08 INFO - Displays: 09:20:08 INFO - Display: 09:20:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:20:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:20:08 INFO - Display Serial Number: 1600x1200 60 09:20:08 INFO - Main Display: Yes 09:20:08 INFO - Mirror: Off 09:20:08 INFO - Online: Yes 09:20:08 INFO - Rotation: Supported 09:20:08 INFO - Return code: 0 09:20:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:20:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:20:08 INFO - Python 2.7.3 09:20:08 INFO - Return code: 0 09:20:08 INFO - grabbing minidump binary from tooltool 09:20:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:08 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 0x109b5ad30>, '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 0x109a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b4fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:20:08 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 09:20:08 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 09:20:08 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 09:20:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:20:08 INFO - Return code: 0 09:20:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:20:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:20:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:20:08 INFO - ENV: RUST_BACKTRACE is now 1 09:20:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:20:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:20:08 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/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0185', '--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 09:20:08 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/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0185 --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 09:20:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rehP1z2xSh/Render', 09:20:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:08 INFO - 'HOME': '/Users/cltbld', 09:20:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:08 INFO - 'LOGNAME': 'cltbld', 09:20:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:20:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:08 INFO - 'MOZ_NO_REMOTE': '1', 09:20:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:20:08 INFO - 'NO_EM_RESTART': '1', 09:20:08 INFO - 'PAGER': '/bin/cat', 09:20:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:08 INFO - 'PWD': '/builds/slave/test', 09:20:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:20:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:08 INFO - 'RUST_BACKTRACE': '1', 09:20:08 INFO - 'SHELL': '/bin/bash', 09:20:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4w6O6VQ62G/Listeners', 09:20:08 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 09:20:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:08 INFO - 'USER': 'cltbld', 09:20:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:08 INFO - 'XPC_FLAGS': '0x0', 09:20:08 INFO - 'XPC_SERVICE_NAME': '0', 09:20:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:08 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/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0185', '--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 09:20:09 INFO - mozversion application_buildid: 20170426080225 09:20:09 INFO - mozversion application_changeset: a477e80f03b61be9961bc61770a2b55cce139b91 09:20:09 INFO - mozversion application_display_name: Nightly 09:20:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:20:09 INFO - mozversion application_name: Firefox 09:20:09 INFO - mozversion application_remotingname: firefox 09:20:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:20:09 INFO - mozversion application_vendor: Mozilla 09:20:09 INFO - mozversion application_version: 55.0a1 09:20:09 INFO - mozversion platform_buildid: 20170426080225 09:20:09 INFO - mozversion platform_changeset: a477e80f03b61be9961bc61770a2b55cce139b91 09:20:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:20:09 INFO - mozversion platform_version: 55.0a1 09:20:09 INFO - using testdate: 1493223609 09:20:09 INFO - actual date: 1493223609 09:20:09 INFO - starting webserver on 'localhost:49240' 09:20:09 INFO - SUITE-START | Running 2 tests 09:20:09 INFO - TEST-START | dromaeo_css 09:20:09 INFO - operating with platform_type : mac_ 09:20:09 INFO - Initialising browser for dromaeo_css test... 09:20:09 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpxd3Bcs/profile http://localhost:49240/getInfo.html) 09:20:11 INFO - PID 1638 | __metrics Screen width/height:1600/1200 09:20:11 INFO - PID 1638 | colorDepth:24 09:20:11 INFO - PID 1638 | Browser inner width/height: 1024/689 09:20:11 INFO - PID 1638 | __metrics 09:20:12 INFO - PID 1638 | 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" 09:20:12 INFO - PID 1638 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:20:12 INFO - TEST-INFO | 1638: exit 0 09:20:12 INFO - Browser initialized. 09:20:12 INFO - Running cycle 1/1 for dromaeo_css test... 09:20:12 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpxd3Bcs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:20:25 INFO - PID 1643 | RSS: Main: 243822592 09:20:25 INFO - PID 1643 | 09:23:29 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 09:23:31 INFO - PID 1643 | RSS: Main: 384884736 09:23:31 INFO - PID 1643 | 09:25:14 INFO - PID 1643 | ************************* 09:25:14 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 09:25:14 INFO - PID 1643 | 09:25:14 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:25:14 INFO - PID 1643 | Full stack: 09:25:14 INFO - PID 1643 | ************************* 09:25:14 INFO - PID 1643 | ************************* 09:25:14 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 09:25:14 INFO - PID 1643 | 09:25:14 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:25:14 INFO - PID 1643 | Full stack: 09:25:14 INFO - PID 1643 | ************************* 09:25:14 INFO - PID 1643 | ************************* 09:25:14 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 09:25:14 INFO - PID 1643 | 09:25:14 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:25:14 INFO - PID 1643 | Full stack: 09:25:14 INFO - PID 1643 | ************************* 09:25:14 INFO - PID 1643 | ************************* 09:25:14 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 09:25:14 INFO - PID 1643 | 09:25:14 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:25:14 INFO - PID 1643 | Full stack: 09:25:14 INFO - PID 1643 | ************************* 09:26:33 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 09:26:34 INFO - PID 1643 | RSS: Main: 364675072 09:26:34 INFO - PID 1643 | 09:29:36 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 09:29:36 INFO - PID 1643 | RSS: Main: 329601024 09:29:36 INFO - PID 1643 | 09:32:39 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 09:32:40 INFO - PID 1643 | RSS: Main: 323899392 09:32:40 INFO - PID 1643 | 09:35:43 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 09:35:44 INFO - PID 1643 | RSS: Main: 337166336 09:35:44 INFO - PID 1643 | 09:38:46 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 09:38:46 INFO - PID 1643 | RSS: Main: 377389056 09:38:46 INFO - PID 1643 | 09:38:46 INFO - PID 1643 | __start_tp_report 09:38:46 INFO - PID 1643 | _x_x_mozilla_page_load 09:38:46 INFO - PID 1643 | _x_x_mozilla_page_load_details 09:38:46 INFO - PID 1643 | |i|pagename|runs| 09:38:46 INFO - PID 1643 | |0;dojo.html;3458.7405944554134;3460.117669994151;3508.561429821272;3517.630648781878;3549.929001419972;5980.88038239235;6106.633601983873;6114.602550834198;6134.202553668022;6164.845878853031;6055.666938318391;6070.2412198475195;6148.047052706826;6163;6209.689515524228;4529.094181163764;5139.408967968694;5220.243064755608;5256.342957130359;5323.60072994525;5238.266642670029;5307.25698402222;5344.331958505187;5353.652012619187;5467.097928841737;5259.184826351921;5276.841694749144;5333.49331813481;5367.81212657559;5394.703291318976;5334.91997620036;5351.839444816662;5364.222187782789;5389.757460914268;5413.485718856702;5314.4951229633125;5324.068288049576;5340.91988620171;5349.037173308803;5388.622796404254;5993.430624090704;6047.697615119227;6088;6166.1983942087245;6195.628262304231;6300.117983482316;6455.61266324022;6493.285738568754;6504.1869766279215;6504.869902601921;6471.935280647181;6574.539782215247;6575.276719560845;6585.374389432996;6589.703463344161;6218.253809542839;6257.342978987186;6259;6262.436380725757;6276.435120839146;6378.617282963037;6455.515836312202;6687.498437617198;6714.160729908762;6761.121054262914;6295.559310848196;6326.557141000086;6351.079093531504;6355;6356.237251529754;6418.133551970518;6500.122483464766;6537.509686773511;6553.082568440422;6554.377334153248;6214.098955651405;6282.4974002079725;6298.716557754912;6416.7754128605275;6419.261784894704;6298.307186209513;6308.684565771693;6312.43188113072;6312.621242725451;6334.239891213084;5194.7922083116255;5217.191335343028;5223.895522089537;5238.92141617876;5246.265522826808;4525;4533.9319910201375;4610.515895830957;4737.763111844394;4770.165221086296;6201.0388389799655;6206.379362063757;6210.882041232531;6224;6233.719482623293;6339.587926784744;6405.391487808651;6431.678416079178;6597.208334999831;6607.405333520006;6199.132121502993;6209.627422354582;6226.470749986212;6234.906476402857;6240.7503699851495;5728.455796699307;5733.655980641175;5749.88500229993;5750.424957504216;5751.4536119068625;5576.888462230814;6494.4804415645685;6594.802155935329;6790.626515541692;6797.048413222054;5265.947340526545;6374.107624932421;6491.026346048131;6627.204735431779;6628;5831.804480081489;6790.490713196431;6807.183138023469;6808.28513006147;6814.250432452327;6240.5319601031015;6404.263509696259;6428.228612566522;6451.935480645134;6453.677316134268;4781.569658730731;6358.968205158944;6431.163948686828;6566.0479230510355;6583.111279977334;6337.6197428154455;6338.714757835816;6340.1440805490665;6348.301686814354;6348.492120630431;6286.8428289291305;6307.243130824147;6324.146240257506;6340.4927605792345;6363.3000369958345;6157.476614487819;6187.319394866471;6234.501239900887;6254.437100660963;6256.874862502816;6361.045843123384;6369.681515924278;6382.297947225708;6385.584936979081;6401.071844582416;5164.767585458739;6254.468370188585;6263.96868015657;6264.373562643699;6266.154069200599 09:38:46 INFO - PID 1643 | |1;ext.html;724.8405350822819;772.6445834915938;807.3097501636101;1145.3585991844568;1155.809291466908;27552.311192220204;38383.616163838386;38641.806790966075;38648.03379915503;38943.610563894355;41667;42071.78964105175;42137.57862421375;42142.57857421425;42212.94467638311;8907.643694252221;9091.363604547685;9100.499472529009;9109.635614575409;9110.362274640745;6190.50475961922;6322.968385158068;8807.911920880773;8966.193042626162;8973.327000474957;8991.550422478882;9056.320775941798;9083.364164508486;9105.180533751962;9117.49853758043;8976.910230897705;9047.773805654846;9055.909440905572;9058.501782401965;9099.772505687377;8944.195022447946;8986.955065224698;8991.865122023175;8997.730068097968;9001.18989290967;39009.41485877714;39205;39210.607893920984;39240.803795981126;39422.80288598567;3573.338932297533;3657.8536858525626;3683.631636836295;3686.944695829565;3687.1703866630064;26329.21012369632;30908.53637195444;31282.530762038587;31708.84145579257;32019.679803201903;3151.936961260762;3176.7935084219453;3211.7912335698106;3219.935601287961;3220.484722444421;228567;294657;301543;302414;304238;50200.246996295085;50277.24584131241;50294.24558631623;50326.49673503218;50418.747906260236;52726;52949.735251324266;53046;53053.204201937;53148.01389895773;14219.431222750974;14311.856881431053;14330.068545544505;14344.426222951173;14344.641383965485;11533.884661153448;11539.653810385702;11562.248453850472;11575.710607234887;11579.363135027486;11062.944685276683;11077.723056923642;11131.276467029616;12615.684607884876;12640.55758048464;5173.896522069537;5178.663386879841;5183.377994640668;5196.610254230948;5331.626786124934;1009.9444530550891;1032.6798692405378;1036.7563622548696;1036.8237399642078;1065.5631191211567;23161.073557057865;24597.754022459903;24622.507549848902;24647.630285545732;24680;1004.3421558878946;1028.8836612275766;1062.910516720368;1120.6301920366259;1131.2759833706434;12458.626241212778;12564.87435125637;12569.371531423392;12606.306653134166;12643.114981951176;307302.4634876811;308557;309569;309878;311531.44234279136;43829.780851095544;54455.18317225245;54526;54643.45356546463;54799;1479.8150231221098;1522.0791421190243;1575.763635454691;1578.6448049188841;1587.6983373159062;23928.162514311916;24013.879930600237;24145.637815433132;24182;24256.93816025587;38866.4170037444;38883;38886.6111338883;38906.22187556289;38992;284677;285272;286111;286193;286595;33848.3230335387;34412.82793586016;34552;34637.13407164841;34646;36082.09794755152;37272.44091338578;37316.88049358524;37375.878723638336;37618.43572346362;25771;28251.858740706164;29678.70321296846;29861.95483158079;30376.088717338516;29979.402933221183;30092.24769380783;30111;30208.697913021468;30299.242518937204;36225.818870905474;36257.45613815848;36271.818640906626;36420.81789591035;38134.42798358083;30839.2290192747;31188.37623247568;31701.524477133324;31732;31735.84132079325;23073.653895191248;24637.507249854545;24667.25998220056;25061.87469062643;25113 09:38:46 INFO - PID 1643 | |2;jquery.html;407.855211399953;417.2302102620666;419.20769745181593;431.8466944234797;439.5384845911794;20160.19359225629;21794.564108717837;22602.77397226027;22687.319380418572;22705.886470567624;22159.667604985938;22351.329460116183;22607.660885086738;22924.8853755731;23187.652185217194;6113.541484388656;6374.521910856681;6377.13908622337;6377.362263773632;6383.425491705745;5916.3787802280785;6207;6209.844753881167;6279.497640188774;6283.8114856554375;6169.767545400126;6227;6235.251769787632;6243.1883855099;6247.875042499148;5996.790112346069;6265;6274.466670333027;6284.340144284853;6301.621902685831;5387.0841956867425;5468.808591699271;5471;5537.473939975695;5552.056150454432;25870.353241168934;25874.6118808218;25952.740472595222;26109.216723498324;26196.21411357662;2195.9780402195934;2261.31030035839;2261.9095236190533;2265.184533567914;2265.5468906218657;16838.24227909747;17106.31574737009;17129.65740685192;17192.398266060627;17322.740158897628;2126.9787302126933;2178.586068646952;2205.691203231549;2211.2150186683816;2211.734591848988;137581;137930;138582;138988;139550;11522.884771152181;11866.576010878578;11884.465199066062;11913.22564033335;11999.940000299943;15775.526734197763;15777.763333549776;15801.13093779853;15812.525624231292;15838.9208053959;8497.575121244037;8677.305815534743;8718.128187181232;8759.824803503894;8807.251383632334;8200.58997050145;8202.712905048415;8213.480506106389;8225.79435514105;8501.532415717194;6035.336113027563;6194.9690251549355;7295.854082918312;7299.270072992765;7310.378617817545;2058.464799152231;2072.989635051815;2077.6468000439963;2080.9687854682193;2089.8746075235535;871.6687658689657;884.7699598104539;975.7804493988938;988.4168340679034;1018.511114664965;20456.386308410772;20708.482287942923;20752;20754.377368678965;21121.68317475239;912.8585069314267;1000.5997600959674;1022.5245260953543;1045.2474218562622;1059.2214722179192;9356.485393303434;10065.043820837009;10194.388336699674;10499.68500944973;10641.893581064245;550115;551917;557246;559407;559589;122678;135806;137349;137697;142038;1151.648747132116;1162.0993729859258;1181.8759030301694;1194.1695840326076;1239.702471406856;20453.59092818165;20740.377788666363;20756.481087972923;20874.582508350053;20939.37181884546;55323.51044203101;59468;61517;61871.690641546506;62484.687576561824;78856.81714774398;79712.60143699244;79895;81714.59142704248;83831;8639.352048596505;8741.475511469333;8754.649814007369;8765.334586428558;8775.385722999585;10594.629187978384;13987.720245595234;14054.086484378482;14186.787198192242;14236.857631423552;11236.662900112682;11752.353620550952;11775.997120734159;11779.234349767237;11879.58421455245;11216.775664486502;11325.660230193107;11504.424778761197;11819.940900295443;11848.822267666164;11995.820062698893;12118.93940530327;12322.938385308016;12499.312537810507;12510.434526160001;12666.366681666064;13009.934950325187;13274.867251327363;13299.20204787716;13300.800487992881;11639.59261425846;12018.098642602015;12079.57721479744;12138.696532586757;12155.209911355734 09:38:46 INFO - PID 1643 | |3;mootools.html;1216.5073145376125;1407.5706909392638;1436.8922330825192;1455.4905782975952;1461.736887360275;9766.853497197539;10251.231157663176;11289.717757056078;11676.941615291911;11732.882671173285;10344.172466202705;10744.677659670222;11288.379139147344;11503.539858405675;11547.13396495262;2504.84970901746;2564.3460917466114;2564.358910272432;2564.384547708555;2565.6664633597607;1752.4041825779232;2180.9781902180935;2224.088123869214;2497.213377786001;2567.8844451999703;2491.1281051631872;2491.4394261291245;2495.962560561593;2496.425822060927;2496.4757400945823;2418.4921166555046;2451.7793398594035;2452.043702955849;2454.1655837015323;2456.47185855042;2430.86630235337;2437.427204606916;2450.15469662966;2453.4111813164714;2454.4232105455203;11367.317960922372;11464.598739044177;11491.2530685506;11493.310401375944;11503.367314797682;6520.93479065208;6795.558288711218;6797.082393876863;6802;6806.897896531556;4084.1691476139413;4134.896627584304;4332.761698106603;4388.868333949987;4397.538258482845;1263.728298415845;1264.9430775615028;1294.9935250323688;1314.309987256698;1321.7224382879606;13235;16173.676526469404;16570.254338554674;16584.004959702455;16596.58508537296;4818.927716084261;5854.326752423441;6006.6696331701305;6108.267007958984;6132.712130452565;13818.792718109236;13829.585112446643;13834.861651383357;13836.30818459073;13848.376823042987;6865.210500792373;6867.519273650796;6869.347411995853;6869.622170780555;6873.759418420432;5284.128118860345;6130.724117414727;6194.132821405007;6278.183836101278;6286.277078135981;4179.080602267557;4294.592013758688;4651.651126165551;4708.81164753406;4736.905261894812;1420.4460260498413;1464.7290251303543;1465.6042868425466;1488.3971991343524;1492.9029613075115;776.0067114093969;776.1074764021421;793.7261644732558;799.0611032037333;802.0976401548259;5490.286262785812;6468.870622587522;6562.917118675365;6940.479464040116;7008;806.5201205282847;918.3938600523622;945.7138291922979;964.2286171063122;971.5433746139303;3918.2555314490155;4108.958910410917;4239.936400953989;4261.936070958938;4297.699161058758;14495.347709353104;14720.969532132647;14879;14900.925495372454;15030.774538381715;14408.783868241984;14792.964492485638;14808.481703140338;14827.851721482863;15132.394704211929;8496.320294376435;8682.91317086821;8688.956555217184;8712.69505567302;8721.127887211229;6725.226598940989;6893.519212511707;6940.028396024662;7018.75434359795;7032.894506582303;10566.524506397383;13241.735165296834;13250.204987700768;13313.866861331262;13353.933230333787;11823.586174483851;12722.300273485047;13054.34728263602;13705.657358566115;14060.859391406364;7691.923080769345;9194.402363846328;9270.72187834366;9281.67514137002;9308.627654893999;9689.854652180364;9910.75223119399;9923.65267215644;10453.477326133814;10489.842652360068;8456.365772566958;8948.105189481;9178.082191780768;9185;9284.628614855601;7053.788386348418;8705.998810136914;8955.641774328953;8990.730278091667;9032.90967090347;8022.237887400687;8140.796480088045;8143.633536490991;8151.266386025049;8155.79610509742;5855.7364918579615;5861.853453663522;5958.1658567801405;6054.303755068047;6070.48400885912;5889.705514724333;6038.818835434944;6087.239095113111;6135;6240.063990401476 09:38:46 INFO - PID 1643 | |4;prototype.html;403.26001786721366;407.97756123413217;409.7275311917575;413.4728221517565;416.5979829464564;5154.201098829678;5798.24622799036;5818.243628328317;5825.126231065342;5826.242588463504;5473.261109750182;5528;5633.802816901399;5660.490555849972;5701.515371193454;4352.999999999992;4358.5423530529315;4372;4378.956210437903;4392.29723244281;4414.514403415622;4415.88960275994;4417.42573465449;4431.844885429011;4449.176902273073;3461.740369472287;3469.4795780632853;4138.151678905832;4213.43118678979;4218;4142.97928510357;4150.149219410014;4159.542450330461;4160.687948403882;4165.479315085614;2709.2684975056823;3494.196334842975;3592.3533763922483;3608.711303095772;3625.583057948343;5119.10415677255;5425.7287135643455;5472.808451704172;5490.313710786152;5535.059039963216;4260.339647354665;4777.904441911142;4882.853514394538;4912.484189160158;4915.5821755150855;6012.068129439944;6040.48655864252;6045.758169673208;6049.909251361233;6063.272407311107;3365.2596428785628;3957.6042395760483;4082.4080508326424;4084.244414783275;4107.890869465257;5520.641158324696;5767.942320576824;6256.902833097601;6289.245290565115;6363.331850155713;4014.538328092307;4130.339145736728;4152.418661387348;4161.812718427617;4162.500499940026;4003.559608443069;4086.734362266443;4198.433211516406;4206.348016057516;4225.556171720038;4451.59935605797;4783.856484305476;4799.856004319876;4821.734804585712;4859.615009722213;5226.947730522722;5834.708264586754;5999.70001499932;6017.676111255604;6036.245469316335;1175.2478413815165;1413.3286688822932;1432.9283535823167;1439.7480440922798;1439.9560318769018;808.5997431271559;814.368864130292;926.4070994563485;935.4995077633433;948.2603569215885;5724.599278050579;5741.19623252745;5746.310442746897;5749;5751.971240143773;5255.237990491358;5506.311711036121;6232.130360891714;6251.156093927261;6278.372162783777;5244.344456942882;5585.916211256835;5641.971790141105;5688.8862222755315;5732.77068917247;3046.6800985896607;3148.0241125251246;3251;3278.6885245901603;3285.1458620758776;5438.688557363105;6295.905561416583;6453.1610890583925;6529.444997175198;6538.705758240891;6457.741690332428;6470.4823614110755;6493.805185844432;6505;6506;6440.484761219185;6508.837279068061;6510.837229069311;6520.47836173105;6593.769218077345;5533.391326953952;5587.804426845041;5749.9712501437225;6325.481884347815;6330.588511746721;5923.5853490256995;6046.583680220661;6163.506919446344;6211.751529938932;6231.22109736283;5738.254026976467;6077.9942618934765;6381.744730210925;6478.190226221723;6493.383128602775;3907.5115610548683;3942;4147.605977432139;4157.230912281238;4171.791410429527;6156.569040167145;6247.437730604267;6295.496360291258;6300.306966233619;6360.96449136272;6037.516998640011;6041.969790151021;6057.485113765203;6062.6665533394325;6073.605215660968;5960.225170727777;5984.611000284967;6042.728077236447;6070.484008859296;6145.631262124287;5985.341612422717;6018.668973206516;6030.879382412415;6034.2155519782145;6054.8183554493435;5914.526837852875;6041.154238406714;6138.877222455615;6139.662318572521;6206.658633775186;5921.3190483094995;5989.1615173874825;5992.820215393545;6002.219711437485;6007.8197654070445 09:38:46 INFO - PID 1643 | |5;yui.html;719.5179229915956;872.7818045488627;873.7815546113476;874.2350443362059;884.4958373726975;13426.597202083942;18078.63842723148;18206.998615076165;18621.44135675932;18643.813561864376;17612.647747045085;17865.821341786577;18097.728534072;18111.90944045281;18186.727199092024;952.6856137474651;1031.5048776587244;1032.375412875211;1033.101201954301;1036.0882423467338;676.0400231671039;685.8902575587907;687.9896801547981;689.407109885498;701.6982697440098;1034.120997152418;1052.7052425320885;1059.4861492176287;1059.6450189186594;1096.6161843354841;1052.279188755697;1053.552240297878;1055.3404122423485;1055.7993981143559;1088.2110469909333;775.9340456061242;777.7705576854842;777.9614215022951;783.5377127494805;809.4859764049871;16391.67216655672;16522.42171523991;16716.83283167177;17008.914955425145;17274.481765547054;16226;16236.51290461288;16512.25694843735;16636.50090497287;16739.16304184786;14023.368948397347;14185.503507377296;14224.715505689932;14597.6350591235;14848.851511484854;3538.380783362927;3544.167120726627;3553;3556.644335566423;3558.733095017884;113582;125824;126272.37810361832;129602;139733.99999999898;11314.830277545843;11613.245139065933;13579.45682172702;13579.864201358057;13667.794983075262;20047;24842;25023.62464563033;25280.74719252784;25420.364490887874;7859.803504912308;7867.055953285528;8029.8394032120195;8044.597770111471;8046.959765201136;3787.299349620329;3802;3866.130120722815;3867.7872717000837;3868.651821336037;4374.27824408969;4384.991451966066;4414.139242847614;4424.469063712375;4426.9778651106535;958.2286259560981;959.2613687460616;962.9518524073768;975.9463229522303;976.1263669016191;618.4464903910974;618.6473709985265;644.8231976642646;654.6039646014189;668.8729141463203;11269.267497612629;11320.320780753182;11924.523019079139;11933;12006.639800805815;661.444386715152;671.2683175338904;671.7010930136042;672.4721093941232;681.6469308422777;5569.248151499577;5637.661740295595;5684.232628595169;5723.771049157987;5742.511886489695;102589.48705256426;103844.48077759714;104044;104859;107709;89530;92299.53850230706;92565.53717231506;93555.53222233846;95886.56170157454;82680;84190.15809841946;84852;85090.57454712811;86015.99999999875;10055.648052318134;10958.890411096107;10974.506147223234;11113.499247736938;11359.659210223706;42461.57538424576;42840.78579607082;43270.134597308504;43349.78325108354;43995.34006989834;52424;53389.73305133605;53473.46526534685;53489;53582.196267055246;14068.788968165281;14218.857811421753;14239.715205696035;14247.287635618384;14480.855191448372;15619.375224990874;15713.450029248921;15819.683606327579;15820.68358632798;15977.600559986093;14294.142351458946;14525.273736313353;14573.198474084027;14616.853831461549;14756.967012309466;14444.783328250294;14519.34662940149;14757.926210369309;14775.630609234855;14778.18719970412;10782.353058816496;12291.508339666314;12378.690532736753;12420.937895310466;12627.558035468715;9580.712578622653;10864;10923.563057477611;11037.337759734442;11132.109431245643;11646.534138634359;11727.296362218294;11764.411779411166;11786.705332366759;11996.220245684002 09:38:46 INFO - PID 1643 | __end_tp_report 09:38:46 INFO - PID 1643 | __start_cc_report 09:38:46 INFO - PID 1643 | _x_x_mozilla_cycle_collect,1461 09:38:46 INFO - PID 1643 | __end_cc_report 09:38:46 INFO - PID 1643 | __startTimestamp1493224726962__endTimestamp 09:38:46 INFO - PID 1643 | 09:38:46 INFO - PID 1643 | ------- Summary: start ------- 09:38:46 INFO - PID 1643 | Number of tests: 6 09:38:46 INFO - PID 1643 | 09:38:46 INFO - PID 1643 | [#0] dojo.html Cycles:165 Average:5980.60 Median:6254.47 stddev:696.22 (11.1%) stddev-sans-first:669.66 09:38:46 INFO - PID 1643 | Values: 3458.7 3460.1 3508.6 3517.6 3549.9 5980.9 6106.6 6114.6 6134.2 6164.8 6055.7 6070.2 6148.0 6163.0 6209.7 4529.1 5139.4 5220.2 5256.3 5323.6 5238.3 5307.3 5344.3 5353.7 5467.1 5259.2 5276.8 5333.5 5367.8 5394.7 5334.9 5351.8 5364.2 5389.8 5413.5 5314.5 5324.1 5340.9 5349.0 5388.6 5993.4 6047.7 6088.0 6166.2 6195.6 6300.1 6455.6 6493.3 6504.2 6504.9 6471.9 6574.5 6575.3 6585.4 6589.7 6218.3 6257.3 6259.0 6262.4 6276.4 6378.6 6455.5 6687.5 6714.2 6761.1 6295.6 6326.6 6351.1 6355.0 6356.2 6418.1 6500.1 6537.5 6553.1 6554.4 6214.1 6282.5 6298.7 6416.8 6419.3 6298.3 6308.7 6312.4 6312.6 6334.2 5194.8 5217.2 5223.9 5238.9 5246.3 4525.0 4533.9 4610.5 4737.8 4770.2 6201.0 6206.4 6210.9 6224.0 6233.7 6339.6 6405.4 6431.7 6597.2 6607.4 6199.1 6209.6 6226.5 6234.9 6240.8 5728.5 5733.7 5749.9 5750.4 5751.5 5576.9 6494.5 6594.8 6790.6 6797.0 5265.9 6374.1 6491.0 6627.2 6628.0 5831.8 6790.5 6807.2 6808.3 6814.3 6240.5 6404.3 6428.2 6451.9 6453.7 4781.6 6359.0 6431.2 6566.0 6583.1 6337.6 6338.7 6340.1 6348.3 6348.5 6286.8 6307.2 6324.1 6340.5 6363.3 6157.5 6187.3 6234.5 6254.4 6256.9 6361.0 6369.7 6382.3 6385.6 6401.1 5164.8 6254.5 6264.0 6264.4 6266.2 09:38:46 INFO - PID 1643 | 09:38:46 INFO - PID 1643 | [#1] ext.html Cycles:180 Average:44626.56 Median:3215.86 stddev:77167.12 (2399.6%) stddev-sans-first:77313.19 09:38:46 INFO - PID 1643 | Values: 724.8 772.6 807.3 1145.4 1155.8 27552.3 38383.6 38641.8 38648.0 38943.6 41667.0 42071.8 42137.6 42142.6 42212.9 8907.6 9091.4 9100.5 9109.6 9110.4 6190.5 6323.0 8807.9 8966.2 8973.3 8991.6 9056.3 9083.4 9105.2 9117.5 8976.9 9047.8 9055.9 9058.5 9099.8 8944.2 8987.0 8991.9 8997.7 9001.2 39009.4 39205.0 39210.6 39240.8 39422.8 3573.3 3657.9 3683.6 3686.9 3687.2 26329.2 30908.5 31282.5 31708.8 32019.7 3151.9 3176.8 3211.8 3219.9 3220.5 228567.0 294657.0 301543.0 302414.0 304238.0 50200.2 50277.2 50294.2 50326.5 50418.7 52726.0 52949.7 53046.0 53053.2 53148.0 14219.4 14311.9 14330.1 14344.4 14344.6 11533.9 11539.7 11562.2 11575.7 11579.4 11062.9 11077.7 11131.3 12615.7 12640.6 5173.9 5178.7 5183.4 5196.6 5331.6 1009.9 1032.7 1036.8 1036.8 1065.6 23161.1 24597.8 24622.5 24647.6 24680.0 1004.3 1028.9 1062.9 1120.6 1131.3 12458.6 12564.9 12569.4 12606.3 12643.1 307302.5 308557.0 309569.0 309878.0 311531.4 43829.8 54455.2 54526.0 54643.5 54799.0 1479.8 1522.1 1575.8 1578.6 1587.7 23928.2 24013.9 24145.6 24182.0 24256.9 38866.4 38883.0 38886.6 38906.2 38992.0 284677.0 285272.0 286111.0 286193.0 286595.0 33848.3 34412.8 34552.0 34637.1 34646.0 36082.1 37272.4 37316.9 37375.9 37618.4 25771.0 28251.9 29678.7 29862.0 30376.1 29979.4 30092.2 30111.0 30208.7 30299.2 36225.8 36257.5 36271.8 36420.8 38134.4 30839.2 31188.4 31701.5 31732.0 31735.8 23073.7 24637.5 24667.3 25061.9 25113.0 09:38:46 INFO - PID 1643 | 09:38:46 INFO - PID 1643 | [#2] jquery.html Cycles:180 Average:35676.94 Median:2211.47 stddev:93846.98 (4243.6%) stddev-sans-first:94072.89 09:38:46 INFO - PID 1643 | Values: 407.9 417.2 419.2 431.8 439.5 20160.2 21794.6 22602.8 22687.3 22705.9 22159.7 22351.3 22607.7 22924.9 23187.7 6113.5 6374.5 6377.1 6377.4 6383.4 5916.4 6207.0 6209.8 6279.5 6283.8 6169.8 6227.0 6235.3 6243.2 6247.9 5996.8 6265.0 6274.5 6284.3 6301.6 5387.1 5468.8 5471.0 5537.5 5552.1 25870.4 25874.6 25952.7 26109.2 26196.2 2196.0 2261.3 2261.9 2265.2 2265.5 16838.2 17106.3 17129.7 17192.4 17322.7 2127.0 2178.6 2205.7 2211.2 2211.7 137581.0 137930.0 138582.0 138988.0 139550.0 11522.9 11866.6 11884.5 11913.2 11999.9 15775.5 15777.8 15801.1 15812.5 15838.9 8497.6 8677.3 8718.1 8759.8 8807.3 8200.6 8202.7 8213.5 8225.8 8501.5 6035.3 6195.0 7295.9 7299.3 7310.4 2058.5 2073.0 2077.6 2081.0 2089.9 871.7 884.8 975.8 988.4 1018.5 20456.4 20708.5 20752.0 20754.4 21121.7 912.9 1000.6 1022.5 1045.2 1059.2 9356.5 10065.0 10194.4 10499.7 10641.9 550115.0 551917.0 557246.0 559407.0 559589.0 122678.0 135806.0 137349.0 137697.0 142038.0 1151.6 1162.1 1181.9 1194.2 1239.7 20453.6 20740.4 20756.5 20874.6 20939.4 55323.5 59468.0 61517.0 61871.7 62484.7 78856.8 79712.6 79895.0 81714.6 83831.0 8639.4 8741.5 8754.6 8765.3 8775.4 10594.6 13987.7 14054.1 14186.8 14236.9 11236.7 11752.4 11776.0 11779.2 11879.6 11216.8 11325.7 11504.4 11819.9 11848.8 11995.8 12118.9 12322.9 12499.3 12510.4 12666.4 13009.9 13274.9 13299.2 13300.8 11639.6 12018.1 12079.6 12138.7 12155.2 09:38:46 INFO - PID 1643 | 09:38:46 INFO - PID 1643 | [#3] mootools.html Cycles:180 Average:7051.20 Median:4209.51 stddev:4419.91 (105.0%) stddev-sans-first:4410.56 09:38:46 INFO - PID 1643 | Values: 1216.5 1407.6 1436.9 1455.5 1461.7 9766.9 10251.2 11289.7 11676.9 11732.9 10344.2 10744.7 11288.4 11503.5 11547.1 2504.8 2564.3 2564.4 2564.4 2565.7 1752.4 2181.0 2224.1 2497.2 2567.9 2491.1 2491.4 2496.0 2496.4 2496.5 2418.5 2451.8 2452.0 2454.2 2456.5 2430.9 2437.4 2450.2 2453.4 2454.4 11367.3 11464.6 11491.3 11493.3 11503.4 6520.9 6795.6 6797.1 6802.0 6806.9 4084.2 4134.9 4332.8 4388.9 4397.5 1263.7 1264.9 1295.0 1314.3 1321.7 13235.0 16173.7 16570.3 16584.0 16596.6 4818.9 5854.3 6006.7 6108.3 6132.7 13818.8 13829.6 13834.9 13836.3 13848.4 6865.2 6867.5 6869.3 6869.6 6873.8 5284.1 6130.7 6194.1 6278.2 6286.3 4179.1 4294.6 4651.7 4708.8 4736.9 1420.4 1464.7 1465.6 1488.4 1492.9 776.0 776.1 793.7 799.1 802.1 5490.3 6468.9 6562.9 6940.5 7008.0 806.5 918.4 945.7 964.2 971.5 3918.3 4109.0 4239.9 4261.9 4297.7 14495.3 14721.0 14879.0 14900.9 15030.8 14408.8 14793.0 14808.5 14827.9 15132.4 8496.3 8682.9 8689.0 8712.7 8721.1 6725.2 6893.5 6940.0 7018.8 7032.9 10566.5 13241.7 13250.2 13313.9 13353.9 11823.6 12722.3 13054.3 13705.7 14060.9 7691.9 9194.4 9270.7 9281.7 9308.6 9689.9 9910.8 9923.7 10453.5 10489.8 8456.4 8948.1 9178.1 9185.0 9284.6 7053.8 8706.0 8955.6 8990.7 9032.9 8022.2 8140.8 8143.6 8151.3 8155.8 5855.7 5861.9 5958.2 6054.3 6070.5 5889.7 6038.8 6087.2 6135.0 6240.1 09:38:46 INFO - PID 1643 | 09:38:46 INFO - PID 1643 | [#4] prototype.html Cycles:180 Average:4935.50 Median:5695.20 stddev:1555.75 (27.3%) stddev-sans-first:1522.47 09:38:46 INFO - PID 1643 | Values: 403.3 408.0 409.7 413.5 416.6 5154.2 5798.2 5818.2 5825.1 5826.2 5473.3 5528.0 5633.8 5660.5 5701.5 4353.0 4358.5 4372.0 4379.0 4392.3 4414.5 4415.9 4417.4 4431.8 4449.2 3461.7 3469.5 4138.2 4213.4 4218.0 4143.0 4150.1 4159.5 4160.7 4165.5 2709.3 3494.2 3592.4 3608.7 3625.6 5119.1 5425.7 5472.8 5490.3 5535.1 4260.3 4777.9 4882.9 4912.5 4915.6 6012.1 6040.5 6045.8 6049.9 6063.3 3365.3 3957.6 4082.4 4084.2 4107.9 5520.6 5767.9 6256.9 6289.2 6363.3 4014.5 4130.3 4152.4 4161.8 4162.5 4003.6 4086.7 4198.4 4206.3 4225.6 4451.6 4783.9 4799.9 4821.7 4859.6 5226.9 5834.7 5999.7 6017.7 6036.2 1175.2 1413.3 1432.9 1439.7 1440.0 808.6 814.4 926.4 935.5 948.3 5724.6 5741.2 5746.3 5749.0 5752.0 5255.2 5506.3 6232.1 6251.2 6278.4 5244.3 5585.9 5642.0 5688.9 5732.8 3046.7 3148.0 3251.0 3278.7 3285.1 5438.7 6295.9 6453.2 6529.4 6538.7 6457.7 6470.5 6493.8 6505.0 6506.0 6440.5 6508.8 6510.8 6520.5 6593.8 5533.4 5587.8 5750.0 6325.5 6330.6 5923.6 6046.6 6163.5 6211.8 6231.2 5738.3 6078.0 6381.7 6478.2 6493.4 3907.5 3942.0 4147.6 4157.2 4171.8 6156.6 6247.4 6295.5 6300.3 6361.0 6037.5 6042.0 6057.5 6062.7 6073.6 5960.2 5984.6 6042.7 6070.5 6145.6 5985.3 6018.7 6030.9 6034.2 6054.8 5914.5 6041.2 6138.9 6139.7 6206.7 5921.3 5989.2 5992.8 6002.2 6007.8 09:38:46 INFO - PID 1643 | 09:38:46 INFO - PID 1643 | [#5] yui.html Cycles:180 Average:21524.15 Median:17972.23 stddev:31158.89 (173.4%) stddev-sans-first:31207.14 09:38:46 INFO - PID 1643 | Values: 719.5 872.8 873.8 874.2 884.5 13426.6 18078.6 18207.0 18621.4 18643.8 17612.6 17865.8 18097.7 18111.9 18186.7 952.7 1031.5 1032.4 1033.1 1036.1 676.0 685.9 688.0 689.4 701.7 1034.1 1052.7 1059.5 1059.6 1096.6 1052.3 1053.6 1055.3 1055.8 1088.2 775.9 777.8 778.0 783.5 809.5 16391.7 16522.4 16716.8 17008.9 17274.5 16226.0 16236.5 16512.3 16636.5 16739.2 14023.4 14185.5 14224.7 14597.6 14848.9 3538.4 3544.2 3553.0 3556.6 3558.7 113582.0 125824.0 126272.4 129602.0 139734.0 11314.8 11613.2 13579.5 13579.9 13667.8 20047.0 24842.0 25023.6 25280.7 25420.4 7859.8 7867.1 8029.8 8044.6 8047.0 3787.3 3802.0 3866.1 3867.8 3868.7 4374.3 4385.0 4414.1 4424.5 4427.0 958.2 959.3 963.0 975.9 976.1 618.4 618.6 644.8 654.6 668.9 11269.3 11320.3 11924.5 11933.0 12006.6 661.4 671.3 671.7 672.5 681.6 5569.2 5637.7 5684.2 5723.8 5742.5 102589.5 103844.5 104044.0 104859.0 107709.0 89530.0 92299.5 92565.5 93555.5 95886.6 82680.0 84190.2 84852.0 85090.6 86016.0 10055.6 10958.9 10974.5 11113.5 11359.7 42461.6 42840.8 43270.1 43349.8 43995.3 52424.0 53389.7 53473.5 53489.0 53582.2 14068.8 14218.9 14239.7 14247.3 14480.9 15619.4 15713.5 15819.7 15820.7 15977.6 14294.1 14525.3 14573.2 14616.9 14757.0 14444.8 14519.3 14757.9 14775.6 14778.2 10782.4 12291.5 12378.7 12420.9 12627.6 9580.7 10864.0 10923.6 11037.3 11132.1 11646.5 11727.3 11764.4 11786.7 11996.2 09:38:46 INFO - PID 1643 | -------- Summary: end -------- 09:38:46 INFO - PID 1643 | 09:38:47 INFO - TEST-INFO | 1643: exit 0 09:38:47 INFO - TEST-OK | dromaeo_css | took 1118604ms 09:38:47 INFO - TEST-START | kraken 09:38:47 INFO - operating with platform_type : mac_ 09:38:47 INFO - Initialising browser for kraken test... 09:38:47 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpJArVpE/profile http://localhost:49240/getInfo.html) 09:38:50 INFO - PID 1652 | __metrics Screen width/height:1600/1200 09:38:50 INFO - PID 1652 | colorDepth:24 09:38:50 INFO - PID 1652 | Browser inner width/height: 1024/689 09:38:50 INFO - PID 1652 | __metrics 09:38:50 INFO - PID 1652 | 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" 09:38:50 INFO - PID 1652 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:38:50 INFO - TEST-INFO | 1652: exit 0 09:38:50 INFO - Browser initialized. 09:38:50 INFO - Running cycle 1/1 for kraken test... 09:38:50 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpJArVpE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:39:03 INFO - PID 1653 | RSS: Main: 242302976 09:39:03 INFO - PID 1653 | 09:39:05 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 09:39:06 INFO - PID 1653 | RSS: Main: 311902208 09:39:06 INFO - PID 1653 | 09:39:09 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 09:39:09 INFO - PID 1653 | RSS: Main: 293376000 09:39:09 INFO - PID 1653 | 09:39:13 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 09:39:13 INFO - PID 1653 | RSS: Main: 385327104 09:39:13 INFO - PID 1653 | 09:39:15 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 09:39:16 INFO - PID 1653 | RSS: Main: 287920128 09:39:16 INFO - PID 1653 | 09:39:18 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:39:18 INFO - PID 1653 | RSS: Main: 291905536 09:39:18 INFO - PID 1653 | 09:39:21 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 09:39:22 INFO - PID 1653 | RSS: Main: 355368960 09:39:22 INFO - PID 1653 | 09:39:25 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 09:39:26 INFO - PID 1653 | RSS: Main: 369311744 09:39:26 INFO - PID 1653 | 09:39:28 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 09:39:29 INFO - PID 1653 | RSS: Main: 372903936 09:39:29 INFO - PID 1653 | 09:39:30 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:39:31 INFO - PID 1653 | RSS: Main: 332734464 09:39:31 INFO - PID 1653 | 09:39:33 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:39:33 INFO - PID 1653 | RSS: Main: 332525568 09:39:33 INFO - PID 1653 | 09:39:36 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:39:36 INFO - PID 1653 | RSS: Main: 334065664 09:39:36 INFO - PID 1653 | 09:39:39 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:39:40 INFO - PID 1653 | RSS: Main: 352227328 09:39:40 INFO - PID 1653 | 09:39:43 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:39:44 INFO - PID 1653 | RSS: Main: 343973888 09:39:44 INFO - PID 1653 | 09:39:45 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 09:39:46 INFO - PID 1653 | RSS: Main: 386736128 09:39:46 INFO - PID 1653 | 09:39:46 INFO - PID 1653 | __start_tp_report 09:39:46 INFO - PID 1653 | _x_x_mozilla_page_load 09:39:46 INFO - PID 1653 | _x_x_mozilla_page_load_details 09:39:46 INFO - PID 1653 | |i|pagename|runs| 09:39:46 INFO - PID 1653 | |0;ai-astar;110;111;111;112;110;111;112;111;114;160 09:39:46 INFO - PID 1653 | |1;audio-beat-detection;140;106;104;148;110;109;105;109;135;109 09:39:46 INFO - PID 1653 | |2;audio-dft;184;184;182;185;185;183;183;182;186;181 09:39:46 INFO - PID 1653 | |3;audio-fft;81;57;59;88;58;58;57;62;93;56 09:39:46 INFO - PID 1653 | |4;audio-oscillator;93;68;84;69;68;68;86;69;68;95 09:39:46 INFO - PID 1653 | |5;imaging-gaussian-blur;119;87;87;88;88;88;87;86;88;94 09:39:46 INFO - PID 1653 | |6;imaging-darkroom;94;94;94;95;95;94;95;95;102;110 09:39:46 INFO - PID 1653 | |7;imaging-desaturate;84;85;86;82;83;84;83;84;85;82 09:39:46 INFO - PID 1653 | |8;json-parse-financial;49;47;48;47;50;49;47;50;50;48 09:39:46 INFO - PID 1653 | |9;json-stringify-tinderbox;54;55;62;68;63;58;57;57;57;57 09:39:46 INFO - PID 1653 | |10;stanford-crypto-aes;83;80;82;81;80;75;98;96;103;104 09:39:46 INFO - PID 1653 | |11;stanford-crypto-ccm;145;137;138;140;145;146;135;136;176;151 09:39:46 INFO - PID 1653 | |12;stanford-crypto-pbkdf2;185;187;186;183;182;183;184;184;183;218 09:39:46 INFO - PID 1653 | |13;stanford-crypto-sha256-iterative;67;69;67;67;68;69;68;68;67;68 09:39:46 INFO - PID 1653 | __end_tp_report 09:39:46 INFO - PID 1653 | __start_cc_report 09:39:46 INFO - PID 1653 | _x_x_mozilla_cycle_collect,2153 09:39:46 INFO - PID 1653 | __end_cc_report 09:39:46 INFO - PID 1653 | __startTimestamp1493224786039__endTimestamp 09:39:46 INFO - PID 1653 | 09:39:46 INFO - PID 1653 | ------- Summary: start ------- 09:39:46 INFO - PID 1653 | Number of tests: 14 09:39:46 INFO - PID 1653 | 09:39:46 INFO - PID 1653 | [#0] ai-astar Cycles:10 Average:116.20 Median:111.50 stddev:15.43 (13.8%) stddev-sans-first:16.21 09:39:46 INFO - PID 1653 | Values: 110.0 111.0 111.0 112.0 110.0 111.0 112.0 111.0 114.0 160.0 09:39:46 INFO - PID 1653 | 09:39:46 INFO - PID 1653 | [#1] audio-beat-detection Cycles:10 Average:117.50 Median:109.50 stddev:16.62 (15.2%) stddev-sans-first:15.51 09:39:46 INFO - PID 1653 | Values: 140.0 106.0 104.0 148.0 110.0 109.0 105.0 109.0 135.0 109.0 09:39:46 INFO - PID 1653 | 09:39:46 INFO - PID 1653 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.00 stddev:1.58 (0.9%) stddev-sans-first:1.67 09:39:46 INFO - PID 1653 | Values: 184.0 184.0 182.0 185.0 185.0 183.0 183.0 182.0 186.0 181.0 09:39:46 INFO - PID 1653 | 09:39:46 INFO - PID 1653 | [#3] audio-fft Cycles:10 Average:66.90 Median:60.50 stddev:14.47 (23.9%) stddev-sans-first:14.42 09:39:46 INFO - PID 1653 | Values: 81.0 57.0 59.0 88.0 58.0 58.0 57.0 62.0 93.0 56.0 09:39:46 INFO - PID 1653 | 09:39:46 INFO - PID 1653 | [#4] audio-oscillator Cycles:10 Average:76.80 Median:76.50 stddev:11.36 (14.9%) stddev-sans-first:10.43 09:39:46 INFO - PID 1653 | Values: 93.0 68.0 84.0 69.0 68.0 68.0 86.0 69.0 68.0 95.0 09:39:46 INFO - PID 1653 | 09:39:46 INFO - PID 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:91.20 Median:88.00 stddev:10.01 (11.4%) stddev-sans-first:2.32 09:39:46 INFO - PID 1653 | Values: 119.0 87.0 87.0 88.0 88.0 88.0 87.0 86.0 88.0 94.0 09:39:46 INFO - PID 1653 | 09:39:46 INFO - PID 1653 | [#6] imaging-darkroom Cycles:10 Average:96.80 Median:94.50 stddev:5.22 (5.5%) stddev-sans-first:5.44 09:39:46 INFO - PID 1653 | Values: 94.0 94.0 94.0 95.0 95.0 94.0 95.0 95.0 102.0 110.0 09:39:46 INFO - PID 1653 | 09:39:46 INFO - PID 1653 | [#7] imaging-desaturate Cycles:10 Average:83.80 Median:84.00 stddev:1.32 (1.6%) stddev-sans-first:1.39 09:39:46 INFO - PID 1653 | Values: 84.0 85.0 86.0 82.0 83.0 84.0 83.0 84.0 85.0 82.0 09:39:46 INFO - PID 1653 | 09:39:46 INFO - PID 1653 | [#8] json-parse-financial Cycles:10 Average:48.50 Median:49.00 stddev:1.27 (2.6%) stddev-sans-first:1.33 09:39:46 INFO - PID 1653 | Values: 49.0 47.0 48.0 47.0 50.0 49.0 47.0 50.0 50.0 48.0 09:39:46 INFO - PID 1653 | 09:39:46 INFO - PID 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:57.50 stddev:4.26 (7.4%) stddev-sans-first:4.15 09:39:46 INFO - PID 1653 | Values: 54.0 55.0 62.0 68.0 63.0 58.0 57.0 57.0 57.0 57.0 09:39:46 INFO - PID 1653 | 09:39:46 INFO - PID 1653 | [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:81.50 stddev:10.81 (13.3%) stddev-sans-first:11.30 09:39:46 INFO - PID 1653 | Values: 83.0 80.0 82.0 81.0 80.0 75.0 98.0 96.0 103.0 104.0 09:39:46 INFO - PID 1653 | 09:39:46 INFO - PID 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:144.90 Median:145.00 stddev:12.10 (8.3%) stddev-sans-first:12.83 09:39:46 INFO - PID 1653 | Values: 145.0 137.0 138.0 140.0 145.0 146.0 135.0 136.0 176.0 151.0 09:39:46 INFO - PID 1653 | 09:39:46 INFO - PID 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.50 Median:184.50 stddev:10.82 (5.9%) stddev-sans-first:11.44 09:39:46 INFO - PID 1653 | Values: 185.0 187.0 186.0 183.0 182.0 183.0 184.0 184.0 183.0 218.0 09:39:46 INFO - PID 1653 | 09:39:46 INFO - PID 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 09:39:46 INFO - PID 1653 | Values: 67.0 69.0 67.0 67.0 68.0 69.0 68.0 68.0 67.0 68.0 09:39:46 INFO - PID 1653 | -------- Summary: end -------- 09:39:46 INFO - PID 1653 | 09:39:47 INFO - TEST-INFO | 1653: exit 0 09:39:47 INFO - TEST-OK | kraken | took 59486ms 09:39:47 INFO - SUITE-END | took 1178s 09:39:47 INFO - Completed test suite (00:19:38) 09:39:47 INFO - javascript benchmark 09:39:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7716.319805821008, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3458.7405944554134, 3460.117669994151, 3508.561429821272, 3517.630648781878, 3549.929001419972, 5980.88038239235, 6106.633601983873, 6114.602550834198, 6134.202553668022, 6164.845878853031, 6055.666938318391, 6070.2412198475195, 6148.047052706826, 6163.0, 6209.689515524228, 4529.094181163764, 5139.408967968694, 5220.243064755608, 5256.342957130359, 5323.60072994525, 5238.266642670029, 5307.25698402222, 5344.331958505187, 5353.652012619187, 5467.097928841737, 5259.184826351921, 5276.841694749144, 5333.49331813481, 5367.81212657559, 5394.703291318976, 5334.91997620036, 5351.839444816662, 5364.222187782789, 5389.757460914268, 5413.485718856702, 5314.4951229633125, 5324.068288049576, 5340.91988620171, 5349.037173308803, 5388.622796404254, 5993.430624090704, 6047.697615119227, 6088.0, 6166.1983942087245, 6195.628262304231, 6300.117983482316, 6455.61266324022, 6493.285738568754, 6504.1869766279215, 6504.869902601921, 6471.935280647181, 6574.539782215247, 6575.276719560845, 6585.374389432996, 6589.703463344161, 6218.253809542839, 6257.342978987186, 6259.0, 6262.436380725757, 6276.435120839146, 6378.617282963037, 6455.515836312202, 6687.498437617198, 6714.160729908762, 6761.121054262914, 6295.559310848196, 6326.557141000086, 6351.079093531504, 6355.0, 6356.237251529754, 6418.133551970518, 6500.122483464766, 6537.509686773511, 6553.082568440422, 6554.377334153248, 6214.098955651405, 6282.4974002079725, 6298.716557754912, 6416.7754128605275, 6419.261784894704, 6298.307186209513, 6308.684565771693, 6312.43188113072, 6312.621242725451, 6334.239891213084, 5194.7922083116255, 5217.191335343028, 5223.895522089537, 5238.92141617876, 5246.265522826808, 4525.0, 4533.9319910201375, 4610.515895830957, 4737.763111844394, 4770.165221086296, 6201.0388389799655, 6206.379362063757, 6210.882041232531, 6224.0, 6233.719482623293, 6339.587926784744, 6405.391487808651, 6431.678416079178, 6597.208334999831, 6607.405333520006, 6199.132121502993, 6209.627422354582, 6226.470749986212, 6234.906476402857, 6240.7503699851495, 5728.455796699307, 5733.655980641175, 5749.88500229993, 5750.424957504216, 5751.4536119068625, 5576.888462230814, 6494.4804415645685, 6594.802155935329, 6790.626515541692, 6797.048413222054, 5265.947340526545, 6374.107624932421, 6491.026346048131, 6627.204735431779, 6628.0, 5831.804480081489, 6790.490713196431, 6807.183138023469, 6808.28513006147, 6814.250432452327, 6240.5319601031015, 6404.263509696259, 6428.228612566522, 6451.935480645134, 6453.677316134268, 4781.569658730731, 6358.968205158944, 6431.163948686828, 6566.0479230510355, 6583.111279977334, 6337.6197428154455, 6338.714757835816, 6340.1440805490665, 6348.301686814354, 6348.492120630431, 6286.8428289291305, 6307.243130824147, 6324.146240257506, 6340.4927605792345, 6363.3000369958345, 6157.476614487819, 6187.319394866471, 6234.501239900887, 6254.437100660963, 6256.874862502816, 6361.045843123384, 6369.681515924278, 6382.297947225708, 6385.584936979081, 6401.071844582416, 5164.767585458739, 6254.468370188585, 6263.96868015657, 6264.373562643699, 6266.154069200599], "value": 5936.774871471092, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.8405350822819, 772.6445834915938, 807.3097501636101, 1145.3585991844568, 1155.809291466908, 27552.311192220204, 38383.616163838386, 38641.806790966075, 38648.03379915503, 38943.610563894355, 41667.0, 42071.78964105175, 42137.57862421375, 42142.57857421425, 42212.94467638311, 8907.643694252221, 9091.363604547685, 9100.499472529009, 9109.635614575409, 9110.362274640745, 6190.50475961922, 6322.968385158068, 8807.911920880773, 8966.193042626162, 8973.327000474957, 8991.550422478882, 9056.320775941798, 9083.364164508486, 9105.180533751962, 9117.49853758043, 8976.910230897705, 9047.773805654846, 9055.909440905572, 9058.501782401965, 9099.772505687377, 8944.195022447946, 8986.955065224698, 8991.865122023175, 8997.730068097968, 9001.18989290967, 39009.41485877714, 39205.0, 39210.607893920984, 39240.803795981126, 39422.80288598567, 3573.338932297533, 3657.8536858525626, 3683.631636836295, 3686.944695829565, 3687.1703866630064, 26329.21012369632, 30908.53637195444, 31282.530762038587, 31708.84145579257, 32019.679803201903, 3151.936961260762, 3176.7935084219453, 3211.7912335698106, 3219.935601287961, 3220.484722444421, 228567.0, 294657.0, 301543.0, 302414.0, 304238.0, 50200.246996295085, 50277.24584131241, 50294.24558631623, 50326.49673503218, 50418.747906260236, 52726.0, 52949.735251324266, 53046.0, 53053.204201937, 53148.01389895773, 14219.431222750974, 14311.856881431053, 14330.068545544505, 14344.426222951173, 14344.641383965485, 11533.884661153448, 11539.653810385702, 11562.248453850472, 11575.710607234887, 11579.363135027486, 11062.944685276683, 11077.723056923642, 11131.276467029616, 12615.684607884876, 12640.55758048464, 5173.896522069537, 5178.663386879841, 5183.377994640668, 5196.610254230948, 5331.626786124934, 1009.9444530550891, 1032.6798692405378, 1036.7563622548696, 1036.8237399642078, 1065.5631191211567, 23161.073557057865, 24597.754022459903, 24622.507549848902, 24647.630285545732, 24680.0, 1004.3421558878946, 1028.8836612275766, 1062.910516720368, 1120.6301920366259, 1131.2759833706434, 12458.626241212778, 12564.87435125637, 12569.371531423392, 12606.306653134166, 12643.114981951176, 307302.4634876811, 308557.0, 309569.0, 309878.0, 311531.44234279136, 43829.780851095544, 54455.18317225245, 54526.0, 54643.45356546463, 54799.0, 1479.8150231221098, 1522.0791421190243, 1575.763635454691, 1578.6448049188841, 1587.6983373159062, 23928.162514311916, 24013.879930600237, 24145.637815433132, 24182.0, 24256.93816025587, 38866.4170037444, 38883.0, 38886.6111338883, 38906.22187556289, 38992.0, 284677.0, 285272.0, 286111.0, 286193.0, 286595.0, 33848.3230335387, 34412.82793586016, 34552.0, 34637.13407164841, 34646.0, 36082.09794755152, 37272.44091338578, 37316.88049358524, 37375.878723638336, 37618.43572346362, 25771.0, 28251.858740706164, 29678.70321296846, 29861.95483158079, 30376.088717338516, 29979.402933221183, 30092.24769380783, 30111.0, 30208.697913021468, 30299.242518937204, 36225.818870905474, 36257.45613815848, 36271.818640906626, 36420.81789591035, 38134.42798358083, 30839.2290192747, 31188.37623247568, 31701.524477133324, 31732.0, 31735.84132079325, 23073.653895191248, 24637.507249854545, 24667.25998220056, 25061.87469062643, 25113.0], "value": 17508.917974315573, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.855211399953, 417.2302102620666, 419.20769745181593, 431.8466944234797, 439.5384845911794, 20160.19359225629, 21794.564108717837, 22602.77397226027, 22687.319380418572, 22705.886470567624, 22159.667604985938, 22351.329460116183, 22607.660885086738, 22924.8853755731, 23187.652185217194, 6113.541484388656, 6374.521910856681, 6377.13908622337, 6377.362263773632, 6383.425491705745, 5916.3787802280785, 6207.0, 6209.844753881167, 6279.497640188774, 6283.8114856554375, 6169.767545400126, 6227.0, 6235.251769787632, 6243.1883855099, 6247.875042499148, 5996.790112346069, 6265.0, 6274.466670333027, 6284.340144284853, 6301.621902685831, 5387.0841956867425, 5468.808591699271, 5471.0, 5537.473939975695, 5552.056150454432, 25870.353241168934, 25874.6118808218, 25952.740472595222, 26109.216723498324, 26196.21411357662, 2195.9780402195934, 2261.31030035839, 2261.9095236190533, 2265.184533567914, 2265.5468906218657, 16838.24227909747, 17106.31574737009, 17129.65740685192, 17192.398266060627, 17322.740158897628, 2126.9787302126933, 2178.586068646952, 2205.691203231549, 2211.2150186683816, 2211.734591848988, 137581.0, 137930.0, 138582.0, 138988.0, 139550.0, 11522.884771152181, 11866.576010878578, 11884.465199066062, 11913.22564033335, 11999.940000299943, 15775.526734197763, 15777.763333549776, 15801.13093779853, 15812.525624231292, 15838.9208053959, 8497.575121244037, 8677.305815534743, 8718.128187181232, 8759.824803503894, 8807.251383632334, 8200.58997050145, 8202.712905048415, 8213.480506106389, 8225.79435514105, 8501.532415717194, 6035.336113027563, 6194.9690251549355, 7295.854082918312, 7299.270072992765, 7310.378617817545, 2058.464799152231, 2072.989635051815, 2077.6468000439963, 2080.9687854682193, 2089.8746075235535, 871.6687658689657, 884.7699598104539, 975.7804493988938, 988.4168340679034, 1018.511114664965, 20456.386308410772, 20708.482287942923, 20752.0, 20754.377368678965, 21121.68317475239, 912.8585069314267, 1000.5997600959674, 1022.5245260953543, 1045.2474218562622, 1059.2214722179192, 9356.485393303434, 10065.043820837009, 10194.388336699674, 10499.68500944973, 10641.893581064245, 550115.0, 551917.0, 557246.0, 559407.0, 559589.0, 122678.0, 135806.0, 137349.0, 137697.0, 142038.0, 1151.648747132116, 1162.0993729859258, 1181.8759030301694, 1194.1695840326076, 1239.702471406856, 20453.59092818165, 20740.377788666363, 20756.481087972923, 20874.582508350053, 20939.37181884546, 55323.51044203101, 59468.0, 61517.0, 61871.690641546506, 62484.687576561824, 78856.81714774398, 79712.60143699244, 79895.0, 81714.59142704248, 83831.0, 8639.352048596505, 8741.475511469333, 8754.649814007369, 8765.334586428558, 8775.385722999585, 10594.629187978384, 13987.720245595234, 14054.086484378482, 14186.787198192242, 14236.857631423552, 11236.662900112682, 11752.353620550952, 11775.997120734159, 11779.234349767237, 11879.58421455245, 11216.775664486502, 11325.660230193107, 11504.424778761197, 11819.940900295443, 11848.822267666164, 11995.820062698893, 12118.93940530327, 12322.938385308016, 12499.312537810507, 12510.434526160001, 12666.366681666064, 13009.934950325187, 13274.867251327363, 13299.20204787716, 13300.800487992881, 11639.59261425846, 12018.098642602015, 12079.57721479744, 12138.696532586757, 12155.209911355734], "value": 10491.210174278343, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1216.5073145376125, 1407.5706909392638, 1436.8922330825192, 1455.4905782975952, 1461.736887360275, 9766.853497197539, 10251.231157663176, 11289.717757056078, 11676.941615291911, 11732.882671173285, 10344.172466202705, 10744.677659670222, 11288.379139147344, 11503.539858405675, 11547.13396495262, 2504.84970901746, 2564.3460917466114, 2564.358910272432, 2564.384547708555, 2565.6664633597607, 1752.4041825779232, 2180.9781902180935, 2224.088123869214, 2497.213377786001, 2567.8844451999703, 2491.1281051631872, 2491.4394261291245, 2495.962560561593, 2496.425822060927, 2496.4757400945823, 2418.4921166555046, 2451.7793398594035, 2452.043702955849, 2454.1655837015323, 2456.47185855042, 2430.86630235337, 2437.427204606916, 2450.15469662966, 2453.4111813164714, 2454.4232105455203, 11367.317960922372, 11464.598739044177, 11491.2530685506, 11493.310401375944, 11503.367314797682, 6520.93479065208, 6795.558288711218, 6797.082393876863, 6802.0, 6806.897896531556, 4084.1691476139413, 4134.896627584304, 4332.761698106603, 4388.868333949987, 4397.538258482845, 1263.728298415845, 1264.9430775615028, 1294.9935250323688, 1314.309987256698, 1321.7224382879606, 13235.0, 16173.676526469404, 16570.254338554674, 16584.004959702455, 16596.58508537296, 4818.927716084261, 5854.326752423441, 6006.6696331701305, 6108.267007958984, 6132.712130452565, 13818.792718109236, 13829.585112446643, 13834.861651383357, 13836.30818459073, 13848.376823042987, 6865.210500792373, 6867.519273650796, 6869.347411995853, 6869.622170780555, 6873.759418420432, 5284.128118860345, 6130.724117414727, 6194.132821405007, 6278.183836101278, 6286.277078135981, 4179.080602267557, 4294.592013758688, 4651.651126165551, 4708.81164753406, 4736.905261894812, 1420.4460260498413, 1464.7290251303543, 1465.6042868425466, 1488.3971991343524, 1492.9029613075115, 776.0067114093969, 776.1074764021421, 793.7261644732558, 799.0611032037333, 802.0976401548259, 5490.286262785812, 6468.870622587522, 6562.917118675365, 6940.479464040116, 7008.0, 806.5201205282847, 918.3938600523622, 945.7138291922979, 964.2286171063122, 971.5433746139303, 3918.2555314490155, 4108.958910410917, 4239.936400953989, 4261.936070958938, 4297.699161058758, 14495.347709353104, 14720.969532132647, 14879.0, 14900.925495372454, 15030.774538381715, 14408.783868241984, 14792.964492485638, 14808.481703140338, 14827.851721482863, 15132.394704211929, 8496.320294376435, 8682.91317086821, 8688.956555217184, 8712.69505567302, 8721.127887211229, 6725.226598940989, 6893.519212511707, 6940.028396024662, 7018.75434359795, 7032.894506582303, 10566.524506397383, 13241.735165296834, 13250.204987700768, 13313.866861331262, 13353.933230333787, 11823.586174483851, 12722.300273485047, 13054.34728263602, 13705.657358566115, 14060.859391406364, 7691.923080769345, 9194.402363846328, 9270.72187834366, 9281.67514137002, 9308.627654893999, 9689.854652180364, 9910.75223119399, 9923.65267215644, 10453.477326133814, 10489.842652360068, 8456.365772566958, 8948.105189481, 9178.082191780768, 9185.0, 9284.628614855601, 7053.788386348418, 8705.998810136914, 8955.641774328953, 8990.730278091667, 9032.90967090347, 8022.237887400687, 8140.796480088045, 8143.633536490991, 8151.266386025049, 8155.79610509742, 5855.7364918579615, 5861.853453663522, 5958.1658567801405, 6054.303755068047, 6070.48400885912, 5889.705514724333, 6038.818835434944, 6087.239095113111, 6135.0, 6240.063990401476], "value": 5369.598756282857, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.26001786721366, 407.97756123413217, 409.7275311917575, 413.4728221517565, 416.5979829464564, 5154.201098829678, 5798.24622799036, 5818.243628328317, 5825.126231065342, 5826.242588463504, 5473.261109750182, 5528.0, 5633.802816901399, 5660.490555849972, 5701.515371193454, 4352.999999999992, 4358.5423530529315, 4372.0, 4378.956210437903, 4392.29723244281, 4414.514403415622, 4415.88960275994, 4417.42573465449, 4431.844885429011, 4449.176902273073, 3461.740369472287, 3469.4795780632853, 4138.151678905832, 4213.43118678979, 4218.0, 4142.97928510357, 4150.149219410014, 4159.542450330461, 4160.687948403882, 4165.479315085614, 2709.2684975056823, 3494.196334842975, 3592.3533763922483, 3608.711303095772, 3625.583057948343, 5119.10415677255, 5425.7287135643455, 5472.808451704172, 5490.313710786152, 5535.059039963216, 4260.339647354665, 4777.904441911142, 4882.853514394538, 4912.484189160158, 4915.5821755150855, 6012.068129439944, 6040.48655864252, 6045.758169673208, 6049.909251361233, 6063.272407311107, 3365.2596428785628, 3957.6042395760483, 4082.4080508326424, 4084.244414783275, 4107.890869465257, 5520.641158324696, 5767.942320576824, 6256.902833097601, 6289.245290565115, 6363.331850155713, 4014.538328092307, 4130.339145736728, 4152.418661387348, 4161.812718427617, 4162.500499940026, 4003.559608443069, 4086.734362266443, 4198.433211516406, 4206.348016057516, 4225.556171720038, 4451.59935605797, 4783.856484305476, 4799.856004319876, 4821.734804585712, 4859.615009722213, 5226.947730522722, 5834.708264586754, 5999.70001499932, 6017.676111255604, 6036.245469316335, 1175.2478413815165, 1413.3286688822932, 1432.9283535823167, 1439.7480440922798, 1439.9560318769018, 808.5997431271559, 814.368864130292, 926.4070994563485, 935.4995077633433, 948.2603569215885, 5724.599278050579, 5741.19623252745, 5746.310442746897, 5749.0, 5751.971240143773, 5255.237990491358, 5506.311711036121, 6232.130360891714, 6251.156093927261, 6278.372162783777, 5244.344456942882, 5585.916211256835, 5641.971790141105, 5688.8862222755315, 5732.77068917247, 3046.6800985896607, 3148.0241125251246, 3251.0, 3278.6885245901603, 3285.1458620758776, 5438.688557363105, 6295.905561416583, 6453.1610890583925, 6529.444997175198, 6538.705758240891, 6457.741690332428, 6470.4823614110755, 6493.805185844432, 6505.0, 6506.0, 6440.484761219185, 6508.837279068061, 6510.837229069311, 6520.47836173105, 6593.769218077345, 5533.391326953952, 5587.804426845041, 5749.9712501437225, 6325.481884347815, 6330.588511746721, 5923.5853490256995, 6046.583680220661, 6163.506919446344, 6211.751529938932, 6231.22109736283, 5738.254026976467, 6077.9942618934765, 6381.744730210925, 6478.190226221723, 6493.383128602775, 3907.5115610548683, 3942.0, 4147.605977432139, 4157.230912281238, 4171.791410429527, 6156.569040167145, 6247.437730604267, 6295.496360291258, 6300.306966233619, 6360.96449136272, 6037.516998640011, 6041.969790151021, 6057.485113765203, 6062.6665533394325, 6073.605215660968, 5960.225170727777, 5984.611000284967, 6042.728077236447, 6070.484008859296, 6145.631262124287, 5985.341612422717, 6018.668973206516, 6030.879382412415, 6034.2155519782145, 6054.8183554493435, 5914.526837852875, 6041.154238406714, 6138.877222455615, 6139.662318572521, 6206.658633775186, 5921.3190483094995, 5989.1615173874825, 5992.820215393545, 6002.219711437485, 6007.8197654070445], "value": 4449.736242043398, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.5179229915956, 872.7818045488627, 873.7815546113476, 874.2350443362059, 884.4958373726975, 13426.597202083942, 18078.63842723148, 18206.998615076165, 18621.44135675932, 18643.813561864376, 17612.647747045085, 17865.821341786577, 18097.728534072, 18111.90944045281, 18186.727199092024, 952.6856137474651, 1031.5048776587244, 1032.375412875211, 1033.101201954301, 1036.0882423467338, 676.0400231671039, 685.8902575587907, 687.9896801547981, 689.407109885498, 701.6982697440098, 1034.120997152418, 1052.7052425320885, 1059.4861492176287, 1059.6450189186594, 1096.6161843354841, 1052.279188755697, 1053.552240297878, 1055.3404122423485, 1055.7993981143559, 1088.2110469909333, 775.9340456061242, 777.7705576854842, 777.9614215022951, 783.5377127494805, 809.4859764049871, 16391.67216655672, 16522.42171523991, 16716.83283167177, 17008.914955425145, 17274.481765547054, 16226.0, 16236.51290461288, 16512.25694843735, 16636.50090497287, 16739.16304184786, 14023.368948397347, 14185.503507377296, 14224.715505689932, 14597.6350591235, 14848.851511484854, 3538.380783362927, 3544.167120726627, 3553.0, 3556.644335566423, 3558.733095017884, 113582.0, 125824.0, 126272.37810361832, 129602.0, 139733.99999999898, 11314.830277545843, 11613.245139065933, 13579.45682172702, 13579.864201358057, 13667.794983075262, 20047.0, 24842.0, 25023.62464563033, 25280.74719252784, 25420.364490887874, 7859.803504912308, 7867.055953285528, 8029.8394032120195, 8044.597770111471, 8046.959765201136, 3787.299349620329, 3802.0, 3866.130120722815, 3867.7872717000837, 3868.651821336037, 4374.27824408969, 4384.991451966066, 4414.139242847614, 4424.469063712375, 4426.9778651106535, 958.2286259560981, 959.2613687460616, 962.9518524073768, 975.9463229522303, 976.1263669016191, 618.4464903910974, 618.6473709985265, 644.8231976642646, 654.6039646014189, 668.8729141463203, 11269.267497612629, 11320.320780753182, 11924.523019079139, 11933.0, 12006.639800805815, 661.444386715152, 671.2683175338904, 671.7010930136042, 672.4721093941232, 681.6469308422777, 5569.248151499577, 5637.661740295595, 5684.232628595169, 5723.771049157987, 5742.511886489695, 102589.48705256426, 103844.48077759714, 104044.0, 104859.0, 107709.0, 89530.0, 92299.53850230706, 92565.53717231506, 93555.53222233846, 95886.56170157454, 82680.0, 84190.15809841946, 84852.0, 85090.57454712811, 86015.99999999875, 10055.648052318134, 10958.890411096107, 10974.506147223234, 11113.499247736938, 11359.659210223706, 42461.57538424576, 42840.78579607082, 43270.134597308504, 43349.78325108354, 43995.34006989834, 52424.0, 53389.73305133605, 53473.46526534685, 53489.0, 53582.196267055246, 14068.788968165281, 14218.857811421753, 14239.715205696035, 14247.287635618384, 14480.855191448372, 15619.375224990874, 15713.450029248921, 15819.683606327579, 15820.68358632798, 15977.600559986093, 14294.142351458946, 14525.273736313353, 14573.198474084027, 14616.853831461549, 14756.967012309466, 14444.783328250294, 14519.34662940149, 14757.926210369309, 14775.630609234855, 14778.18719970412, 10782.353058816496, 12291.508339666314, 12378.690532736753, 12420.937895310466, 12627.558035468715, 9580.712578622653, 10864.0, 10923.563057477611, 11037.337759734442, 11132.109431245643, 11646.534138634359, 11727.296362218294, 11764.411779411166, 11786.705332366759, 11996.220245684002], "value": 8100.577692051248, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1428.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 111.0, 112.0, 110.0, 111.0, 112.0, 111.0, 114.0, 160.0], "value": 116.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 106.0, 104.0, 148.0, 110.0, 109.0, 105.0, 109.0, 135.0, 109.0], "value": 117.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 182.0, 185.0, 185.0, 183.0, 183.0, 182.0, 186.0, 181.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 57.0, 59.0, 88.0, 58.0, 58.0, 57.0, 62.0, 93.0, 56.0], "value": 66.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 68.0, 84.0, 69.0, 68.0, 68.0, 86.0, 69.0, 68.0, 95.0], "value": 76.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 87.0, 87.0, 88.0, 88.0, 88.0, 87.0, 86.0, 88.0, 94.0], "value": 91.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 102.0, 110.0], "value": 96.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 86.0, 82.0, 83.0, 84.0, 83.0, 84.0, 85.0, 82.0], "value": 83.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 47.0, 48.0, 47.0, 50.0, 49.0, 47.0, 50.0, 50.0, 48.0], "value": 48.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 62.0, 68.0, 63.0, 58.0, 57.0, 57.0, 57.0, 57.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 82.0, 81.0, 80.0, 75.0, 98.0, 96.0, 103.0, 104.0], "value": 88.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 137.0, 138.0, 140.0, 145.0, 146.0, 135.0, 136.0, 176.0, 151.0], "value": 144.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 187.0, 186.0, 183.0, 182.0, 183.0, 184.0, 184.0, 183.0, 218.0], "value": 187.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 67.0, 67.0, 68.0, 69.0, 68.0, 68.0, 67.0, 68.0], "value": 67.8, "unit": "score"}]}]} 09:39:47 INFO - Return code: 0 09:39:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:39:47 ERROR - # TBPL SUCCESS # 09:39:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:39:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:39:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:39:47 INFO - 2017-04-26 09:39:47.345 screenresolution[1657:9959] starting screenresolution argv=screenresolution get 09:39:47 INFO - 2017-04-26 09:39:47.349 screenresolution[1657:9959] Display 0: 1600x1200x32@60 09:39:47 INFO - 2017-04-26 09:39:47.355 screenresolution[1658:9962] starting screenresolution argv=screenresolution list 09:39:47 INFO - Available Modes on Display 0 09:39:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:39:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:39:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:39:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:39:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:39:47 INFO - Intel Iris: 09:39:47 INFO - Chipset Model: Intel Iris 09:39:47 INFO - Type: GPU 09:39:47 INFO - Bus: Built-In 09:39:47 INFO - VRAM (Dynamic, Max): 1536 MB 09:39:47 INFO - Vendor: Intel (0x8086) 09:39:47 INFO - Device ID: 0x0a2e 09:39:47 INFO - Revision ID: 0x0009 09:39:47 INFO - Displays: 09:39:47 INFO - Display: 09:39:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:39:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:39:47 INFO - Display Serial Number: 1600x1200 60 09:39:47 INFO - Main Display: Yes 09:39:47 INFO - Mirror: Off 09:39:47 INFO - Online: Yes 09:39:47 INFO - Rotation: Supported 09:39:47 INFO - Return code: 0 09:39:47 INFO - Running post-action listener: _resource_record_post_action 09:39:47 INFO - [mozharness: 2017-04-26 16:39:47.602263Z] Finished run-tests step (success) 09:39:47 INFO - Running post-run listener: _resource_record_post_run 09:39:47 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 40150016; Write bytes: 507408384; Read time: 405; Write time: 1635 09:39:47 INFO - TinderboxPrint: CPU usage
53.5% 09:39:47 INFO - TinderboxPrint: I/O read bytes / time
40,150,016 / 405 09:39:47 INFO - TinderboxPrint: I/O write bytes / time
507,408,384 / 1,635 09:39:47 INFO - TinderboxPrint: CPU idle
2,228.0 (46.5%) 09:39:47 INFO - TinderboxPrint: CPU system
956.1 (19.9%) 09:39:47 INFO - TinderboxPrint: CPU user
1,609.5 (33.6%) 09:39:47 INFO - TinderboxPrint: Swap in / out
246,738,944 / 0 09:39:47 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 195082752; Write bytes: 192589824; Read time: 15021; Write time: 360 09:39:47 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 39150592; Write bytes: 297979904; Read time: 390; Write time: 1225 09:39:48 INFO - Running post-run listener: _upload_blobber_files 09:39:48 INFO - Blob upload gear active. 09:39:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:39:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:39:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:39:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:39:48 INFO - (blobuploader) - INFO - Open directory for files ... 09:39:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:39:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:39:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:49 INFO - (blobuploader) - INFO - Done attempting. 09:39:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:39:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:39:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:50 INFO - (blobuploader) - INFO - Done attempting. 09:39:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:39:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:39:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:51 INFO - (blobuploader) - INFO - Done attempting. 09:39:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:39:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:39:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:54 INFO - (blobuploader) - INFO - Done attempting. 09:39:54 INFO - (blobuploader) - INFO - Iteration through files over. 09:39:54 INFO - Return code: 0 09:39:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:39:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:39:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d72932be8740d8555197a41518f20a4b9042757a6bf7f250cbec28ab7577b8960eb5347fa45d4dac3a25ae0dfe9452acf625b610575ad3ddbe8b34df98f71b24", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31e890778c3c9d84665938ad841894c3558357118edd40e6216a9473b374c15a15d2bb66cc240e74a6479c15ed09e524dca5d0dcb7b12374efa7d5f097956191", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ac03ad5aff653ada85e5e89082f7a5f3f3eb68b460fa20df68cbc85e78b467f0cdca96442ec01dd86c18f50e4c66e6cbda4426239d6a04cc919b1039a786f4d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db1cafbc9d858719ed33dd494576b83e2932758d11da925729ce6e6e4a856fe4dac43b00d75f527b5d5979ecdda612badfe732b674a167f28e8063995d62e8e0"} 09:39:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:39:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:39:54 INFO - Contents: 09:39:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d72932be8740d8555197a41518f20a4b9042757a6bf7f250cbec28ab7577b8960eb5347fa45d4dac3a25ae0dfe9452acf625b610575ad3ddbe8b34df98f71b24", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31e890778c3c9d84665938ad841894c3558357118edd40e6216a9473b374c15a15d2bb66cc240e74a6479c15ed09e524dca5d0dcb7b12374efa7d5f097956191", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ac03ad5aff653ada85e5e89082f7a5f3f3eb68b460fa20df68cbc85e78b467f0cdca96442ec01dd86c18f50e4c66e6cbda4426239d6a04cc919b1039a786f4d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db1cafbc9d858719ed33dd494576b83e2932758d11da925729ce6e6e4a856fe4dac43b00d75f527b5d5979ecdda612badfe732b674a167f28e8063995d62e8e0"} 09:39:54 INFO - Running post-run listener: copy_logs_to_upload_dir 09:39:54 INFO - Copying logs to upload dir... 09:39:54 INFO - mkdir: /builds/slave/test/build/upload/logs 09:39:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.198595 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-26 09:39:54.158401) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-26 09:39:54.162164) ========= 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.rehP1z2xSh/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.4w6O6VQ62G/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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/d72932be8740d8555197a41518f20a4b9042757a6bf7f250cbec28ab7577b8960eb5347fa45d4dac3a25ae0dfe9452acf625b610575ad3ddbe8b34df98f71b24", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31e890778c3c9d84665938ad841894c3558357118edd40e6216a9473b374c15a15d2bb66cc240e74a6479c15ed09e524dca5d0dcb7b12374efa7d5f097956191", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ac03ad5aff653ada85e5e89082f7a5f3f3eb68b460fa20df68cbc85e78b467f0cdca96442ec01dd86c18f50e4c66e6cbda4426239d6a04cc919b1039a786f4d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db1cafbc9d858719ed33dd494576b83e2932758d11da925729ce6e6e4a856fe4dac43b00d75f527b5d5979ecdda612badfe732b674a167f28e8063995d62e8e0"} build_url:https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010991 build_url: 'https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/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/d72932be8740d8555197a41518f20a4b9042757a6bf7f250cbec28ab7577b8960eb5347fa45d4dac3a25ae0dfe9452acf625b610575ad3ddbe8b34df98f71b24", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31e890778c3c9d84665938ad841894c3558357118edd40e6216a9473b374c15a15d2bb66cc240e74a6479c15ed09e524dca5d0dcb7b12374efa7d5f097956191", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ac03ad5aff653ada85e5e89082f7a5f3f3eb68b460fa20df68cbc85e78b467f0cdca96442ec01dd86c18f50e4c66e6cbda4426239d6a04cc919b1039a786f4d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db1cafbc9d858719ed33dd494576b83e2932758d11da925729ce6e6e4a856fe4dac43b00d75f527b5d5979ecdda612badfe732b674a167f28e8063995d62e8e0"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-26 09:39:54.200199) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 09:39:54.200695) ========= 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.rehP1z2xSh/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.4w6O6VQ62G/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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.005150 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 09:39:54.252263) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-26 09:39:54.252838) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-26 09:39:54.253303) ========= ========= Total master_lag: 0.19 =========