builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0238 starttime: 1490988669.94 results: success (0) buildid: 20170331111022 builduid: f9b63e8f0b4b4d2ba699c45bbf05dfbf revision: 31810a9548fcede48be099fc9823fd2710616d64 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 12:31:09.935652) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 12:31:09.936131) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 12:31:09.936417) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 12:31:09.961541) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 12:31:09.961959) ========= 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.IFhEhbBAz0/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.FefhfuE29r/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-31 12:31:09-- 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% 8.16M=0.001s 2017-03-31 12:31:10 (8.16 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125642 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 12:31:10.111993) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 12:31:10.112536) ========= 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.IFhEhbBAz0/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.FefhfuE29r/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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.021950 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 12:31:10.163005) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-31 12:31:10.163366) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 31810a9548fcede48be099fc9823fd2710616d64 --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 31810a9548fcede48be099fc9823fd2710616d64 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IFhEhbBAz0/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.FefhfuE29r/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-31 12:31:10,259 truncating revision to first 12 chars 2017-03-31 12:31:10,259 Setting DEBUG logging. 2017-03-31 12:31:10,259 attempt 1/10 2017-03-31 12:31:10,260 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/31810a9548fc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-31 12:31:11,971 unpacking tar archive at: mozilla-central-31810a9548fc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.976096 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-31 12:31:12.163683) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 12:31:12.164039) ========= script_repo_revision: 31810a9548fcede48be099fc9823fd2710616d64 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 12:31:12.164461) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 12:31:12.164776) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 12:31:12.185743) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2017-03-31 12:31:12.186188) ========= /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.IFhEhbBAz0/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.FefhfuE29r/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 12:31:12 INFO - MultiFileLogger online at 20170331 12:31:12 in /builds/slave/test 12:31:12 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 12:31:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:31:12 INFO - {'append_to_log': False, 12:31:12 INFO - 'base_work_dir': '/builds/slave/test', 12:31:12 INFO - 'blob_upload_branch': 'Firefox', 12:31:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:31:12 INFO - 'branch': 'Firefox', 12:31:12 INFO - 'buildbot_json_path': 'buildprops.json', 12:31:12 INFO - 'config_files': ('talos/mac_config.py',), 12:31:12 INFO - 'default_actions': ('clobber', 12:31:12 INFO - 'read-buildbot-config', 12:31:12 INFO - 'download-and-extract', 12:31:12 INFO - 'populate-webroot', 12:31:12 INFO - 'create-virtualenv', 12:31:12 INFO - 'install', 12:31:12 INFO - 'run-tests'), 12:31:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:31:12 INFO - 'download_minidump_stackwalk': True, 12:31:12 INFO - 'download_symbols': 'ondemand', 12:31:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:31:12 INFO - 'tooltool.py': '/tools/tooltool.py', 12:31:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:31:12 INFO - '/tools/misc-python/virtualenv.py')}, 12:31:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:31:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:31:12 INFO - 'gecko_profile': False, 12:31:12 INFO - 'gecko_profile_interval': 0, 12:31:12 INFO - 'installer_path': 'installer.exe', 12:31:12 INFO - 'log_level': 'info', 12:31:12 INFO - 'log_name': 'talos', 12:31:12 INFO - 'log_to_console': True, 12:31:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:31:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:31:12 INFO - 'opt_config_files': (), 12:31:12 INFO - 'pip_index': False, 12:31:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:31:12 INFO - 'cmd': ('bash', 12:31:12 INFO - '-c', 12:31:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:31:12 INFO - 'enabled': True, 12:31:12 INFO - 'halt_on_failure': False, 12:31:12 INFO - 'name': 'check_screen_resolution'},), 12:31:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:31:12 INFO - 'cmd': ('bash', 12:31:12 INFO - '-c', 12:31:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:31:12 INFO - 'enabled': True, 12:31:12 INFO - 'halt_on_failure': False, 12:31:12 INFO - 'name': 'check_screen_resolution'},), 12:31:12 INFO - 'run_cmd_checks_enabled': True, 12:31:12 INFO - 'suite': 'dromaeojs', 12:31:12 INFO - 'system_bits': '32', 12:31:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:31:12 INFO - 'title': 't-yosemite-r7-0238', 12:31:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:31:12 INFO - 'use_talos_json': True, 12:31:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:31:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:31:12 INFO - 'work_dir': 'build'} 12:31:12 INFO - [mozharness: 2017-03-31 19:31:12.402765Z] Running clobber step. 12:31:12 INFO - Running pre-action listener: _resource_record_pre_action 12:31:12 INFO - Running main action method: clobber 12:31:12 INFO - rmtree: /builds/slave/test/build 12:31:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:31:14 INFO - Running post-action listener: _resource_record_post_action 12:31:14 INFO - [mozharness: 2017-03-31 19:31:14.634158Z] Finished clobber step (success) 12:31:14 INFO - [mozharness: 2017-03-31 19:31:14.634408Z] Running read-buildbot-config step. 12:31:14 INFO - Running pre-action listener: _resource_record_pre_action 12:31:14 INFO - Running main action method: read_buildbot_config 12:31:14 INFO - Using buildbot properties: 12:31:14 INFO - { 12:31:14 INFO - "project": "", 12:31:14 INFO - "product": "firefox", 12:31:14 INFO - "script_repo_revision": "production", 12:31:14 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 12:31:14 INFO - "repository": "", 12:31:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 12:31:14 INFO - "buildid": "20170331111022", 12:31:14 INFO - "pgo_build": "False", 12:31:14 INFO - "basedir": "/builds/slave/test", 12:31:14 INFO - "buildnumber": 65, 12:31:14 INFO - "slavename": "t-yosemite-r7-0238", 12:31:14 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 12:31:14 INFO - "platform": "yosemite_r7", 12:31:14 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 12:31:14 INFO - "branch": "mozilla-central", 12:31:14 INFO - "repo_path": "mozilla-central", 12:31:14 INFO - "revision": "31810a9548fcede48be099fc9823fd2710616d64", 12:31:14 INFO - "stage_platform": "macosx64", 12:31:14 INFO - "builduid": "f9b63e8f0b4b4d2ba699c45bbf05dfbf", 12:31:14 INFO - "slavebuilddir": "test" 12:31:14 INFO - } 12:31:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 12:31:14 INFO - Running post-action listener: _resource_record_post_action 12:31:14 INFO - [mozharness: 2017-03-31 19:31:14.640016Z] Finished read-buildbot-config step (success) 12:31:14 INFO - [mozharness: 2017-03-31 19:31:14.640186Z] Running download-and-extract step. 12:31:14 INFO - Running pre-action listener: _resource_record_pre_action 12:31:14 INFO - Running main action method: download_and_extract 12:31:14 INFO - mkdir: /builds/slave/test/build/tests 12:31:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:14 INFO - trying https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 12:31:14 INFO - Downloading https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/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 12:31:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/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 12:31:16 INFO - Downloaded 1325 bytes. 12:31:16 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 12:31:16 INFO - Using the following test package requirements: 12:31:16 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:31:16 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 12:31:16 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 12:31:16 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:31:16 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 12:31:16 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:31:16 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 12:31:16 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:31:16 INFO - u'jsshell-mac.zip'], 12:31:16 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:31:16 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 12:31:16 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 12:31:16 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:31:16 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 12:31:16 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:31:16 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 12:31:16 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:31:16 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 12:31:16 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:31:16 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 12:31:16 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:31:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 12:31:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:31:16 INFO - Fetch https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 12:31:17 INFO - Expected file size: 52508085 12:31:17 INFO - Obtained file size: 52508085 12:31:33 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 12:31:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 12:31:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:31:33 INFO - Fetch https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 12:31:35 INFO - Expected file size: 52508085 12:31:35 INFO - Obtained file size: 52508085 12:31:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 12:31:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:31:50 INFO - Fetch https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 12:31:51 INFO - Expected file size: 14404152 12:31:51 INFO - Obtained file size: 14404152 12:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:52 INFO - trying https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:31:52 INFO - Downloading https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 12:31:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/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 12:31:54 INFO - Downloaded 75600229 bytes. 12:31:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:31:54 INFO - mkdir: /builds/slave/test/properties 12:31:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:31:54 INFO - Writing to file /builds/slave/test/properties/build_url 12:31:54 INFO - Contents: 12:31:54 INFO - build_url:https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:31:54 INFO - Running post-action listener: _resource_record_post_action 12:31:54 INFO - Running post-action listener: set_extra_try_arguments 12:31:54 INFO - [mozharness: 2017-03-31 19:31:54.814864Z] Finished download-and-extract step (success) 12:31:54 INFO - [mozharness: 2017-03-31 19:31:54.814962Z] Running populate-webroot step. 12:31:54 INFO - Running pre-action listener: _resource_record_pre_action 12:31:54 INFO - Running main action method: populate_webroot 12:31:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:31:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:31:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:31:54 INFO - '--tppagecycles', 12:31:54 INFO - '7'], 12:31:54 INFO - 'tests': ['tsvgm']}}, 12:31:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:31:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:31:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:31:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:31:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:31:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:31:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:31:54 INFO - 'talos_options': ['--disable-e10s'], 12:31:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:31:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:31:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:31:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:31:54 INFO - 'talos_options': ['--disable-e10s'], 12:31:54 INFO - 'tests': ['damp', 'tps']}, 12:31:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:31:54 INFO - 'tests': ['damp', 'tps']}, 12:31:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:31:54 INFO - 'tests': ['dromaeo_dom']}, 12:31:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:31:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:31:54 INFO - 'tests': ['basic_compositor_video']}, 12:31:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:31:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:31:54 INFO - 'tests': ['a11yr', 12:31:54 INFO - 'ts_paint', 12:31:54 INFO - 'tpaint', 12:31:54 INFO - 'sessionrestore', 12:31:54 INFO - 'sessionrestore_no_auto_restore', 12:31:54 INFO - 'tabpaint']}, 12:31:54 INFO - 'other-e10s': {'tests': ['a11yr', 12:31:54 INFO - 'ts_paint', 12:31:54 INFO - 'tpaint', 12:31:54 INFO - 'sessionrestore', 12:31:54 INFO - 'sessionrestore_no_auto_restore', 12:31:54 INFO - 'tabpaint']}, 12:31:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:31:54 INFO - 'ts_paint', 12:31:54 INFO - 'tpaint', 12:31:54 INFO - 'sessionrestore', 12:31:54 INFO - 'sessionrestore_no_auto_restore', 12:31:54 INFO - 'tabpaint']}, 12:31:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:31:54 INFO - 'ts_paint', 12:31:54 INFO - 'tpaint', 12:31:54 INFO - 'sessionrestore', 12:31:54 INFO - 'sessionrestore_no_auto_restore', 12:31:54 INFO - 'tabpaint']}, 12:31:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:31:54 INFO - 'tests': ['a11yr', 12:31:54 INFO - 'ts_paint', 12:31:54 INFO - 'tpaint', 12:31:54 INFO - 'sessionrestore', 12:31:54 INFO - 'sessionrestore_no_auto_restore', 12:31:54 INFO - 'tabpaint']}, 12:31:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:31:54 INFO - 'tests': ['a11yr', 12:31:54 INFO - 'ts_paint', 12:31:54 INFO - 'tpaint', 12:31:54 INFO - 'sessionrestore', 12:31:54 INFO - 'sessionrestore_no_auto_restore', 12:31:54 INFO - 'tabpaint']}, 12:31:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:31:54 INFO - 'tests': ['tsvgx', 12:31:54 INFO - 'tsvgr_opacity', 12:31:54 INFO - 'tart', 12:31:54 INFO - 'tscrollx', 12:31:54 INFO - 'cart', 12:31:54 INFO - 'tsvg_static']}, 12:31:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:31:54 INFO - 'tsvgr_opacity', 12:31:54 INFO - 'tart', 12:31:54 INFO - 'tscrollx', 12:31:54 INFO - 'cart', 12:31:54 INFO - 'tsvg_static']}, 12:31:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:31:54 INFO - 'talos_options': ['--disable-e10s'], 12:31:54 INFO - 'tests': ['tp5o']}, 12:31:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:31:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:31:54 INFO - 'talos_options': ['--disable-e10s', 12:31:54 INFO - '--xperf_path', 12:31:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:31:54 INFO - 'tests': ['tp5n']}, 12:31:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:31:54 INFO - 'talos_options': ['--xperf_path', 12:31:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:31:54 INFO - 'tests': ['tp5n']}}, 12:31:54 INFO - 'talos.zip': {'path': '', 12:31:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:31:54 INFO - Running post-action listener: _resource_record_post_action 12:31:54 INFO - [mozharness: 2017-03-31 19:31:54.833150Z] Finished populate-webroot step (success) 12:31:54 INFO - [mozharness: 2017-03-31 19:31:54.833266Z] Running create-virtualenv step. 12:31:54 INFO - Running pre-action listener: _resource_record_pre_action 12:31:54 INFO - Running main action method: create_virtualenv 12:31:54 INFO - Creating virtualenv /builds/slave/test/build/venv 12:31:54 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 12:31:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:31:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:31:54 INFO - Using real prefix '/tools/python27' 12:31:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:31:55 INFO - Installing distribute.............................................................................................................................................................................................done. 12:31:58 INFO - Installing pip.................done. 12:31:58 INFO - Return code: 0 12:31:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:31:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:31:58 INFO - Reading from file tmpfile_stdout 12:31:58 INFO - Output received: 12:31:58 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) 12:31:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:58 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 0x100bc3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bc6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf10544280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009a1d30>, '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 0x1008c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100996be8>, '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.IFhEhbBAz0/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.FefhfuE29r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 12:31:58 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 12:31:58 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 12:31:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFhEhbBAz0/Render', 12:31:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:31:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:31:58 INFO - 'HOME': '/Users/cltbld', 12:31:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:31:58 INFO - 'LOGNAME': 'cltbld', 12:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:58 INFO - 'MOZ_NO_REMOTE': '1', 12:31:58 INFO - 'NO_EM_RESTART': '1', 12:31:58 INFO - 'PAGER': '/bin/cat', 12:31:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:58 INFO - 'PWD': '/builds/slave/test', 12:31:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:31:58 INFO - 'SHELL': '/bin/bash', 12:31:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FefhfuE29r/Listeners', 12:31:58 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 12:31:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:31:58 INFO - 'USER': 'cltbld', 12:31:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:31:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:58 INFO - 'XPC_FLAGS': '0x0', 12:31:58 INFO - 'XPC_SERVICE_NAME': '0', 12:31:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:59 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 12:31:59 INFO - Cleaning up... 12:31:59 INFO - Return code: 0 12:31:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100bc3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bc6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf10544280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009a1d30>, '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 0x1008c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100996be8>, '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.IFhEhbBAz0/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.FefhfuE29r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 12:31:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:31:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFhEhbBAz0/Render', 12:31:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:31:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:31:59 INFO - 'HOME': '/Users/cltbld', 12:31:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:31:59 INFO - 'LOGNAME': 'cltbld', 12:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:59 INFO - 'MOZ_NO_REMOTE': '1', 12:31:59 INFO - 'NO_EM_RESTART': '1', 12:31:59 INFO - 'PAGER': '/bin/cat', 12:31:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:59 INFO - 'PWD': '/builds/slave/test', 12:31:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:31:59 INFO - 'SHELL': '/bin/bash', 12:31:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FefhfuE29r/Listeners', 12:31:59 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 12:31:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:31:59 INFO - 'USER': 'cltbld', 12:31:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:31:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:59 INFO - 'XPC_FLAGS': '0x0', 12:31:59 INFO - 'XPC_SERVICE_NAME': '0', 12:31:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:59 INFO - Downloading/unpacking psutil>=3.1.1 12:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:32:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:32:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:32:02 INFO - Installing collected packages: psutil 12:32:02 INFO - Running setup.py install for psutil 12:32:02 INFO - building 'psutil._psutil_osx' extension 12:32:02 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 12:32:03 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 12:32:03 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 12:32:03 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 12:32:03 INFO - building 'psutil._psutil_posix' extension 12:32:03 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 12:32:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:32:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:32:03 INFO - ^ 12:32:03 INFO - 1 warning generated. 12:32:03 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 12:32:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:32:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:32:03 INFO - Successfully installed psutil 12:32:03 INFO - Cleaning up... 12:32:03 INFO - Return code: 0 12:32:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:32:03 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')]} 12:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:03 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')]} 12:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:03 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 0x100bc3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bc6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf10544280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009a1d30>, '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 0x1008c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100996be8>, '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.IFhEhbBAz0/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.FefhfuE29r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 12:32:03 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 12:32:03 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 12:32:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFhEhbBAz0/Render', 12:32:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:32:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:32:03 INFO - 'HOME': '/Users/cltbld', 12:32:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:32:03 INFO - 'LOGNAME': 'cltbld', 12:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:03 INFO - 'MOZ_NO_REMOTE': '1', 12:32:03 INFO - 'NO_EM_RESTART': '1', 12:32:03 INFO - 'PAGER': '/bin/cat', 12:32:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:03 INFO - 'PWD': '/builds/slave/test', 12:32:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:32:03 INFO - 'SHELL': '/bin/bash', 12:32:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FefhfuE29r/Listeners', 12:32:03 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 12:32:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:32:03 INFO - 'USER': 'cltbld', 12:32:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:32:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:03 INFO - 'XPC_FLAGS': '0x0', 12:32:03 INFO - 'XPC_SERVICE_NAME': '0', 12:32:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:32:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:32:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:32:06 INFO - Installing collected packages: mozsystemmonitor 12:32:06 INFO - Running setup.py install for mozsystemmonitor 12:32:06 INFO - Successfully installed mozsystemmonitor 12:32:06 INFO - Cleaning up... 12:32:07 INFO - Return code: 0 12:32:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:32:07 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')]} 12:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:07 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')]} 12:32:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:07 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 0x100bc3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bc6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf10544280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009a1d30>, '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 0x1008c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100996be8>, '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.IFhEhbBAz0/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.FefhfuE29r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 12:32:07 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 12:32:07 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 12:32:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFhEhbBAz0/Render', 12:32:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:32:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:32:07 INFO - 'HOME': '/Users/cltbld', 12:32:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:32:07 INFO - 'LOGNAME': 'cltbld', 12:32:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:07 INFO - 'MOZ_NO_REMOTE': '1', 12:32:07 INFO - 'NO_EM_RESTART': '1', 12:32:07 INFO - 'PAGER': '/bin/cat', 12:32:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:32:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:07 INFO - 'PWD': '/builds/slave/test', 12:32:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:32:07 INFO - 'SHELL': '/bin/bash', 12:32:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FefhfuE29r/Listeners', 12:32:07 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 12:32:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:32:07 INFO - 'USER': 'cltbld', 12:32:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:32:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:32:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:07 INFO - 'XPC_FLAGS': '0x0', 12:32:07 INFO - 'XPC_SERVICE_NAME': '0', 12:32:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:08 INFO - Downloading/unpacking jsonschema==2.5.1 12:32:08 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 12:32:08 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 12:32:08 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 12:32:08 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 12:32:08 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 12:32:08 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 12:32:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:32:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:11 INFO - Downloading functools32-3.2.3-2.tar.gz 12:32:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:32:11 INFO - warning: no files found matching '*.txt' 12:32:11 INFO - no previously-included directories found matching 'build' 12:32:11 INFO - no previously-included directories found matching 'dist' 12:32:11 INFO - no previously-included directories found matching '.git*' 12:32:11 INFO - Installing collected packages: jsonschema, functools32 12:32:11 INFO - Running setup.py install for functools32 12:32:11 INFO - warning: no files found matching '*.txt' 12:32:11 INFO - no previously-included directories found matching 'build' 12:32:11 INFO - no previously-included directories found matching 'dist' 12:32:11 INFO - no previously-included directories found matching '.git*' 12:32:11 INFO - Successfully installed jsonschema functools32 12:32:11 INFO - Cleaning up... 12:32:12 INFO - Return code: 0 12:32:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:32:12 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')]} 12:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:12 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')]} 12:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:12 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 0x100bc3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bc6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf10544280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009a1d30>, '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 0x1008c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100996be8>, '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.IFhEhbBAz0/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.FefhfuE29r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 12:32:12 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 12:32:12 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 12:32:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFhEhbBAz0/Render', 12:32:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:32:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:32:12 INFO - 'HOME': '/Users/cltbld', 12:32:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:32:12 INFO - 'LOGNAME': 'cltbld', 12:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:12 INFO - 'MOZ_NO_REMOTE': '1', 12:32:12 INFO - 'NO_EM_RESTART': '1', 12:32:12 INFO - 'PAGER': '/bin/cat', 12:32:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:12 INFO - 'PWD': '/builds/slave/test', 12:32:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:32:12 INFO - 'SHELL': '/bin/bash', 12:32:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FefhfuE29r/Listeners', 12:32:12 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 12:32:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:32:12 INFO - 'USER': 'cltbld', 12:32:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:32:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:12 INFO - 'XPC_FLAGS': '0x0', 12:32:12 INFO - 'XPC_SERVICE_NAME': '0', 12:32:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:32:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:32:12 INFO - Cleaning up... 12:32:12 INFO - Return code: 0 12:32:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:32:12 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')]} 12:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:12 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')]} 12:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:12 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 0x100bc3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bc6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf10544280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009a1d30>, '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 0x1008c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100996be8>, '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.IFhEhbBAz0/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.FefhfuE29r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 12:32:12 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 12:32:12 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 12:32:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFhEhbBAz0/Render', 12:32:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:32:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:32:12 INFO - 'HOME': '/Users/cltbld', 12:32:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:32:12 INFO - 'LOGNAME': 'cltbld', 12:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:12 INFO - 'MOZ_NO_REMOTE': '1', 12:32:12 INFO - 'NO_EM_RESTART': '1', 12:32:12 INFO - 'PAGER': '/bin/cat', 12:32:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:12 INFO - 'PWD': '/builds/slave/test', 12:32:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:32:12 INFO - 'SHELL': '/bin/bash', 12:32:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FefhfuE29r/Listeners', 12:32:12 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 12:32:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:32:12 INFO - 'USER': 'cltbld', 12:32:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:32:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:12 INFO - 'XPC_FLAGS': '0x0', 12:32:12 INFO - 'XPC_SERVICE_NAME': '0', 12:32:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:32:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:12 INFO - Downloading/unpacking blobuploader==1.2.4 12:32:12 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 12:32:12 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 12:32:12 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 12:32:12 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 12:32:12 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 12:32:12 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 12:32:15 INFO - Downloading blobuploader-1.2.4.tar.gz 12:32:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:32:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:32:15 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 12:32:15 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 12:32:15 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 12:32:15 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 12:32:15 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 12:32:15 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 12:32:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:32:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:32:16 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 12:32:16 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 12:32:16 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 12:32:16 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 12:32:16 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 12:32:16 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 12:32:16 INFO - Downloading docopt-0.6.1.tar.gz 12:32:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:32:16 INFO - Installing collected packages: blobuploader, requests, docopt 12:32:16 INFO - Running setup.py install for blobuploader 12:32:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:32:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:32:16 INFO - Running setup.py install for requests 12:32:17 INFO - Running setup.py install for docopt 12:32:17 INFO - Successfully installed blobuploader requests docopt 12:32:17 INFO - Cleaning up... 12:32:17 INFO - Return code: 0 12:32:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:32:17 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')]} 12:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:17 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')]} 12:32:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:17 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 0x100bc3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bc6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf10544280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009a1d30>, '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 0x1008c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100996be8>, '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.IFhEhbBAz0/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.FefhfuE29r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 12:32:17 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 12:32:17 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 12:32:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFhEhbBAz0/Render', 12:32:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:32:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:32:17 INFO - 'HOME': '/Users/cltbld', 12:32:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:32:17 INFO - 'LOGNAME': 'cltbld', 12:32:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:17 INFO - 'MOZ_NO_REMOTE': '1', 12:32:17 INFO - 'NO_EM_RESTART': '1', 12:32:17 INFO - 'PAGER': '/bin/cat', 12:32:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:32:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:17 INFO - 'PWD': '/builds/slave/test', 12:32:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:32:17 INFO - 'SHELL': '/bin/bash', 12:32:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FefhfuE29r/Listeners', 12:32:17 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 12:32:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:32:17 INFO - 'USER': 'cltbld', 12:32:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:32:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:32:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:17 INFO - 'XPC_FLAGS': '0x0', 12:32:17 INFO - 'XPC_SERVICE_NAME': '0', 12:32:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:32:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:32:17 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-Ebw0TE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:32:17 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-RZEEqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:32:17 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-u52Jcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:32:17 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-nzP_Oe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:32:18 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-ZiNMhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:32:18 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-36vSM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:32:18 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-0ZxjsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:32:18 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-Fiv7mn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:32:18 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-VAcMiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:32:18 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-EsB_LY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:32:18 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-imLXbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:32:18 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-N_i8HP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:32:18 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-kl5oQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:32:18 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-OwMXFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:32:19 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-RjEe3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:32:19 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-PQYTku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:32:19 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-cCmTNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:32:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:32:19 INFO - Running setup.py install for manifestparser 12:32:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:32:19 INFO - Running setup.py install for mozcrash 12:32:19 INFO - Running setup.py install for mozdebug 12:32:19 INFO - Running setup.py install for mozdevice 12:32:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:32:19 INFO - Running setup.py install for mozfile 12:32:20 INFO - Running setup.py install for mozhttpd 12:32:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:32:20 INFO - Running setup.py install for mozinfo 12:32:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:32:20 INFO - Running setup.py install for mozInstall 12:32:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:32:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:32:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:32:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:32:20 INFO - Running setup.py install for mozleak 12:32:20 INFO - Running setup.py install for mozlog 12:32:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:32:20 INFO - Running setup.py install for moznetwork 12:32:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:32:21 INFO - Running setup.py install for mozprocess 12:32:21 INFO - Running setup.py install for mozprofile 12:32:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:32:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:32:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:32:21 INFO - Running setup.py install for mozrunner 12:32:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:32:21 INFO - Running setup.py install for mozscreenshot 12:32:21 INFO - Running setup.py install for moztest 12:32:21 INFO - Running setup.py install for mozversion 12:32:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:32:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:32:21 INFO - Cleaning up... 12:32:21 INFO - Return code: 0 12:32:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:21 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 0x100bc3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bc6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf10544280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009a1d30>, '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 0x1008c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100996be8>, '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.IFhEhbBAz0/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.FefhfuE29r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 12:32:21 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 12:32:21 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 12:32:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFhEhbBAz0/Render', 12:32:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:32:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:32:21 INFO - 'HOME': '/Users/cltbld', 12:32:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:32:21 INFO - 'LOGNAME': 'cltbld', 12:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:21 INFO - 'MOZ_NO_REMOTE': '1', 12:32:21 INFO - 'NO_EM_RESTART': '1', 12:32:21 INFO - 'PAGER': '/bin/cat', 12:32:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:21 INFO - 'PWD': '/builds/slave/test', 12:32:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:32:21 INFO - 'SHELL': '/bin/bash', 12:32:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FefhfuE29r/Listeners', 12:32:21 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 12:32:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:32:21 INFO - 'USER': 'cltbld', 12:32:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:32:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:21 INFO - 'XPC_FLAGS': '0x0', 12:32:21 INFO - 'XPC_SERVICE_NAME': '0', 12:32:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:32:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:32:22 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-MWxn8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:32:22 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)) 12:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:32:22 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-0epfmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:32:22 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)) 12:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:32:22 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-ULa1BD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:32:22 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)) 12:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:32:22 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-uVJC34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:32:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:32:22 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-lJGRR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:32:22 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)) 12:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:32:22 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-VAntnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:32:22 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)) 12:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:32:22 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-VUeaOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:32:22 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)) 12:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:32:22 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-vJYD4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:32:23 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)) 12:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:32:23 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-GrCfhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:32:23 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)) 12:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:32:23 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-Zjr28c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:32:23 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)) 12:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:32:23 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-hOWv0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:32:23 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)) 12:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:32:23 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-Tr0CGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:32:23 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)) 12:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:32:23 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-uF81ig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:32:23 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)) 12:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:32:23 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-AaEqUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:32:23 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)) 12:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:32:23 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-fuGtZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:32:23 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)) 12:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:32:23 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-9IrgtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:32:23 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)) 12:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:32:23 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-IVEDsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:32:24 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)) 12:32:24 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)) 12:32:24 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)) 12:32:24 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)) 12:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:32:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:32:24 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 12:32:24 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 12:32:24 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 12:32:24 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 12:32:24 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 12:32:24 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 12:32:26 INFO - Downloading blessings-1.6.tar.gz 12:32:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:32:26 INFO - Installing collected packages: blessings 12:32:26 INFO - Running setup.py install for blessings 12:32:26 INFO - Successfully installed blessings 12:32:26 INFO - Cleaning up... 12:32:27 INFO - Return code: 0 12:32:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:32:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:32:27 INFO - Reading from file tmpfile_stdout 12:32:27 INFO - Current package versions: 12:32:27 INFO - blessings == 1.6 12:32:27 INFO - blobuploader == 1.2.4 12:32:27 INFO - docopt == 0.6.1 12:32:27 INFO - functools32 == 3.2.3-2 12:32:27 INFO - jsonschema == 2.5.1 12:32:27 INFO - manifestparser == 1.1 12:32:27 INFO - mozInstall == 1.12 12:32:27 INFO - mozcrash == 1.0 12:32:27 INFO - mozdebug == 0.1 12:32:27 INFO - mozdevice == 0.49 12:32:27 INFO - mozfile == 1.2 12:32:27 INFO - mozhttpd == 0.7 12:32:27 INFO - mozinfo == 0.9 12:32:27 INFO - mozleak == 0.1 12:32:27 INFO - mozlog == 3.4 12:32:27 INFO - moznetwork == 0.27 12:32:27 INFO - mozprocess == 0.25 12:32:27 INFO - mozprofile == 0.28 12:32:27 INFO - mozrunner == 6.13 12:32:27 INFO - mozscreenshot == 0.1 12:32:27 INFO - mozsystemmonitor == 0.3 12:32:27 INFO - moztest == 0.8 12:32:27 INFO - mozversion == 1.4 12:32:27 INFO - psutil == 3.1.1 12:32:27 INFO - requests == 1.2.3 12:32:27 INFO - wsgiref == 0.1.2 12:32:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:27 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 0x100bc3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bc6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf10544280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009a1d30>, '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 0x1008c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100996be8>, '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.IFhEhbBAz0/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.FefhfuE29r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 12:32:27 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 12:32:27 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 12:32:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFhEhbBAz0/Render', 12:32:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:32:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:32:27 INFO - 'HOME': '/Users/cltbld', 12:32:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:32:27 INFO - 'LOGNAME': 'cltbld', 12:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:27 INFO - 'MOZ_NO_REMOTE': '1', 12:32:27 INFO - 'NO_EM_RESTART': '1', 12:32:27 INFO - 'PAGER': '/bin/cat', 12:32:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:27 INFO - 'PWD': '/builds/slave/test', 12:32:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:32:27 INFO - 'SHELL': '/bin/bash', 12:32:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FefhfuE29r/Listeners', 12:32:27 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 12:32:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:32:27 INFO - 'USER': 'cltbld', 12:32:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:32:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:27 INFO - 'XPC_FLAGS': '0x0', 12:32:27 INFO - 'XPC_SERVICE_NAME': '0', 12:32:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:27 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)) 12:32:27 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)) 12:32:27 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)) 12:32:27 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)) 12:32:27 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)) 12:32:27 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)) 12:32:27 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)) 12:32:27 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)) 12:32:27 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)) 12:32:27 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)) 12:32:27 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)) 12:32:27 INFO - Cleaning up... 12:32:27 INFO - Return code: 0 12:32:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:27 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 0x100bc3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bc6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf10544280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009a1d30>, '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 0x1008c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100996be8>, '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.IFhEhbBAz0/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.FefhfuE29r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 12:32:27 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 12:32:27 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 12:32:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFhEhbBAz0/Render', 12:32:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:32:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:32:27 INFO - 'HOME': '/Users/cltbld', 12:32:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:32:27 INFO - 'LOGNAME': 'cltbld', 12:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:27 INFO - 'MOZ_NO_REMOTE': '1', 12:32:27 INFO - 'NO_EM_RESTART': '1', 12:32:27 INFO - 'PAGER': '/bin/cat', 12:32:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:27 INFO - 'PWD': '/builds/slave/test', 12:32:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:32:27 INFO - 'SHELL': '/bin/bash', 12:32:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FefhfuE29r/Listeners', 12:32:27 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 12:32:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:32:27 INFO - 'USER': 'cltbld', 12:32:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:32:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:27 INFO - 'XPC_FLAGS': '0x0', 12:32:27 INFO - 'XPC_SERVICE_NAME': '0', 12:32:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:32:27 INFO - Cleaning up... 12:32:27 INFO - Return code: 0 12:32:27 INFO - Running post-action listener: _resource_record_post_action 12:32:27 INFO - Running post-action listener: _start_resource_monitoring 12:32:27 INFO - Starting resource monitoring. 12:32:27 INFO - [mozharness: 2017-03-31 19:32:27.962808Z] Finished create-virtualenv step (success) 12:32:27 INFO - [mozharness: 2017-03-31 19:32:27.963756Z] Running install step. 12:32:27 INFO - Running pre-action listener: _resource_record_pre_action 12:32:27 INFO - Running main action method: install 12:32:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:32:28 INFO - Reading from file tmpfile_stdout 12:32:28 INFO - Detecting whether we're running mozinstall >=1.0... 12:32:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:32:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:32:28 INFO - Reading from file tmpfile_stdout 12:32:28 INFO - Output received: 12:32:28 INFO - Usage: mozinstall [options] installer 12:32:28 INFO - Options: 12:32:28 INFO - -h, --help show this help message and exit 12:32:28 INFO - -d DEST, --destination=DEST 12:32:28 INFO - Directory to install application into. [default: 12:32:28 INFO - "/builds/slave/test"] 12:32:28 INFO - --app=APP Application being installed. [default: firefox] 12:32:28 INFO - mkdir: /builds/slave/test/build/application 12:32:28 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'] 12:32:28 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 12:32:49 INFO - Reading from file tmpfile_stdout 12:32:49 INFO - Output received: 12:32:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:32:49 INFO - Running post-action listener: _resource_record_post_action 12:32:49 INFO - [mozharness: 2017-03-31 19:32:49.224594Z] Finished install step (success) 12:32:49 INFO - [mozharness: 2017-03-31 19:32:49.224725Z] Running run-tests step. 12:32:49 INFO - Running pre-action listener: _resource_record_pre_action 12:32:49 INFO - Running main action method: run_tests 12:32:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:32:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:32:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:32:49 INFO - 2017-03-31 12:32:49.239 screenresolution[1904:14597] starting screenresolution argv=screenresolution get 12:32:49 INFO - 2017-03-31 12:32:49.242 screenresolution[1904:14597] Display 0: 1600x1200x32@60 12:32:49 INFO - 2017-03-31 12:32:49.247 screenresolution[1905:14599] starting screenresolution argv=screenresolution list 12:32:49 INFO - Available Modes on Display 0 12:32:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:32:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:32:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:32:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:32:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:32:49 INFO - Intel Iris: 12:32:49 INFO - Chipset Model: Intel Iris 12:32:49 INFO - Type: GPU 12:32:49 INFO - Bus: Built-In 12:32:49 INFO - VRAM (Dynamic, Max): 1536 MB 12:32:49 INFO - Vendor: Intel (0x8086) 12:32:49 INFO - Device ID: 0x0a2e 12:32:49 INFO - Revision ID: 0x0009 12:32:49 INFO - Displays: 12:32:49 INFO - Display: 12:32:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:32:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:32:49 INFO - Display Serial Number: 1600x1200 60 12:32:49 INFO - Main Display: Yes 12:32:49 INFO - Mirror: Off 12:32:49 INFO - Online: Yes 12:32:49 INFO - Rotation: Supported 12:32:49 INFO - Return code: 0 12:32:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:32:49 INFO - Python 2.7.3 12:32:49 INFO - Return code: 0 12:32:49 INFO - grabbing minidump binary from tooltool 12:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:32:49 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 0x1009a1d30>, '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 0x1008c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100996be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:32:49 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 12:32:49 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 12:32:49 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 12:32:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:32:49 INFO - Return code: 0 12:32:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:32:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:32:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:32:49 INFO - ENV: RUST_BACKTRACE is now 1 12:32:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:32:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:32:49 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/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0238', '--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 12:32:49 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/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0238 --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 12:32:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFhEhbBAz0/Render', 12:32:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:32:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:32:49 INFO - 'HOME': '/Users/cltbld', 12:32:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:32:49 INFO - 'LOGNAME': 'cltbld', 12:32:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:32:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:49 INFO - 'MOZ_NO_REMOTE': '1', 12:32:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:32:49 INFO - 'NO_EM_RESTART': '1', 12:32:49 INFO - 'PAGER': '/bin/cat', 12:32:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:49 INFO - 'PWD': '/builds/slave/test', 12:32:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:32:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:32:49 INFO - 'RUST_BACKTRACE': '1', 12:32:49 INFO - 'SHELL': '/bin/bash', 12:32:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FefhfuE29r/Listeners', 12:32:49 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 12:32:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:32:49 INFO - 'USER': 'cltbld', 12:32:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:32:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:49 INFO - 'XPC_FLAGS': '0x0', 12:32:49 INFO - 'XPC_SERVICE_NAME': '0', 12:32:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:32:49 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/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0238', '--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 12:32:49 INFO - mozversion application_buildid: 20170331111022 12:32:49 INFO - mozversion application_changeset: 31810a9548fcede48be099fc9823fd2710616d64 12:32:49 INFO - mozversion application_display_name: Nightly 12:32:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:32:49 INFO - mozversion application_name: Firefox 12:32:49 INFO - mozversion application_remotingname: firefox 12:32:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:32:49 INFO - mozversion application_vendor: Mozilla 12:32:49 INFO - mozversion application_version: 55.0a1 12:32:49 INFO - mozversion platform_buildid: 20170331111022 12:32:49 INFO - mozversion platform_changeset: 31810a9548fcede48be099fc9823fd2710616d64 12:32:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:32:49 INFO - mozversion platform_version: 55.0a1 12:32:49 INFO - using testdate: 1490988769 12:32:49 INFO - actual date: 1490988769 12:32:49 INFO - starting webserver on 'localhost:49368' 12:32:49 INFO - SUITE-START | Running 2 tests 12:32:49 INFO - TEST-START | dromaeo_css 12:32:49 INFO - operating with platform_type : mac_ 12:32:49 INFO - Initialising browser for dromaeo_css test... 12:32:49 INFO - TEST-INFO | started process 1915 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpwjKQF5/profile http://localhost:49368/getInfo.html) 12:32:52 INFO - PID 1915 | __metrics Screen width/height:1600/1200 12:32:52 INFO - PID 1915 | colorDepth:24 12:32:52 INFO - PID 1915 | Browser inner width/height: 1024/689 12:32:52 INFO - PID 1915 | __metrics 12:32:52 INFO - PID 1915 | 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" 12:32:52 INFO - PID 1915 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:32:53 INFO - TEST-INFO | 1915: exit 0 12:32:53 INFO - Browser initialized. 12:32:53 INFO - Running cycle 1/1 for dromaeo_css test... 12:32:53 INFO - TEST-INFO | started process 1917 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpwjKQF5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:33:05 INFO - PID 1917 | RSS: Main: 225931264 12:33:05 INFO - PID 1917 | 12:36:10 INFO - PID 1917 | Cycle 1(1): loaded http://localhost:49368/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49368/tests/dromaeo/cssquery-ext.html) 12:36:12 INFO - PID 1917 | RSS: Main: 412921856 12:36:12 INFO - PID 1917 | 12:37:55 INFO - PID 1917 | ************************* 12:37:55 INFO - PID 1917 | A coding exception was thrown and uncaught in a Task. 12:37:55 INFO - PID 1917 | 12:37:55 ERROR - PID 1917 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:37:55 INFO - PID 1917 | Full stack: 12:37:55 INFO - PID 1917 | ************************* 12:37:55 INFO - PID 1917 | ************************* 12:37:55 INFO - PID 1917 | A coding exception was thrown and uncaught in a Task. 12:37:55 INFO - PID 1917 | 12:37:55 ERROR - PID 1917 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:37:55 INFO - PID 1917 | Full stack: 12:37:55 INFO - PID 1917 | ************************* 12:37:55 INFO - PID 1917 | ************************* 12:37:55 INFO - PID 1917 | A coding exception was thrown and uncaught in a Task. 12:37:55 INFO - PID 1917 | 12:37:55 ERROR - PID 1917 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:37:55 INFO - PID 1917 | Full stack: 12:37:55 INFO - PID 1917 | ************************* 12:37:55 INFO - PID 1917 | ************************* 12:37:55 INFO - PID 1917 | A coding exception was thrown and uncaught in a Task. 12:37:55 INFO - PID 1917 | 12:37:55 ERROR - PID 1917 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:37:55 INFO - PID 1917 | Full stack: 12:37:55 INFO - PID 1917 | ************************* 12:39:15 INFO - PID 1917 | Cycle 1(1): loaded http://localhost:49368/tests/dromaeo/cssquery-ext.html (next: http://localhost:49368/tests/dromaeo/cssquery-jquery.html) 12:39:15 INFO - PID 1917 | RSS: Main: 364802048 12:39:15 INFO - PID 1917 | 12:42:18 INFO - PID 1917 | Cycle 1(1): loaded http://localhost:49368/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49368/tests/dromaeo/cssquery-mootools.html) 12:42:19 INFO - PID 1917 | RSS: Main: 330162176 12:42:19 INFO - PID 1917 | 12:45:21 INFO - PID 1917 | Cycle 1(1): loaded http://localhost:49368/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49368/tests/dromaeo/cssquery-prototype.html) 12:45:22 INFO - PID 1917 | RSS: Main: 334303232 12:45:22 INFO - PID 1917 | 12:48:25 INFO - PID 1917 | Cycle 1(1): loaded http://localhost:49368/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49368/tests/dromaeo/cssquery-yui.html) 12:48:26 INFO - PID 1917 | RSS: Main: 335974400 12:48:26 INFO - PID 1917 | 12:51:29 INFO - PID 1917 | Cycle 1(1): loaded http://localhost:49368/tests/dromaeo/cssquery-yui.html (next: http://localhost:49368/tests/dromaeo/cssquery-dojo.html) 12:51:29 INFO - PID 1917 | RSS: Main: 509517824 12:51:29 INFO - PID 1917 | 12:51:29 INFO - PID 1917 | __start_tp_report 12:51:29 INFO - PID 1917 | _x_x_mozilla_page_load 12:51:29 INFO - PID 1917 | _x_x_mozilla_page_load_details 12:51:29 INFO - PID 1917 | |i|pagename|runs| 12:51:29 INFO - PID 1917 | |0;dojo.html;3442.1050526863014;3459.7751146175497;3499.9300013999705;3505.7545971781988;3536.3104194682032;5984.910226346608;6124.448799608034;6187.6906154692315;6194.00895856663;6210.441060304577;6120.690942950897;6137.1408002879525;6166.660833654148;6173.074038894157;6178.042403427465;5193.16909294513;5348.652337598063;5360.463953604647;5366.570674346052;5398.730063496829;5402.24368588396;5440.891182176354;5455.754491047893;5470.507654311111;5504.2018907258425;5232.3459567554055;5260.526552610283;5276.12943864262;5314.176302673091;5400.810971616014;5320.281761962125;5327.30745003151;5333.120035194188;5378.542823859977;5404.32445944257;5244.973775131138;5253.44838791929;5286.207068939651;5305.469453054702;5365.168398898177;5924.170616113747;6067;6104.328523862371;6128.38716128388;6135.846603834895;6363.649999250039;6426.839329016765;6509.153810004716;6529.412352888263;6550.344965503412;6502.057201705774;6570.244421891496;6573.671316434207;6580.045893345486;6585.242697089848;6262.373762623702;6309.936900630981;6310.716017779165;6314.052892066226;6323.20959880015;6418.614883107029;6468.967655161694;6548.1814773153355;6659.4006539411685;6814.897776533356;6374.139491168726;6384.48924086072;6395.808125756234;6401.679916004181;6407.775727849503;6436.935630643728;6541.443977261986;6549.8690026200165;6560.40956313934;6564.86870262592;6249.250089989139;6332.651704156316;6428.485721142298;6472.741090356427;6486.254080780771;6324.588901721373;6324.683765811691;6326.9683651581445;6328.367163283635;6341.714622841983;5186.144286192812;5190.325257716549;5192.376914770176;5197.792088316501;5202.323697919322;4607.424071991001;4643.233866412004;4655.674102812838;4678.6491013174145;4730.290456431563;6268.216472940882;6281.371862813773;6286;6305.873882522324;6316.336784637547;6581.670916454158;6599.8350041248395;6602.86794264112;6603.7688680895935;6609.768658096944;5600;5602.795398989156;6295.96852015737;6330.335314791881;6336.303006669263;5724.914126288109;5741.827745167651;5790.392008839011;5793.2179155814265;5799.2750906136735;6769.458443324522;6818.454523637998;6825.69284382194;6846.315368463114;6851.657417129223;6376.808695739135;6423.03654451836;6426.036094585849;6614.371634694697;6618.371254730793;6692.933070669231;6757.560758550679;6766.695498702472;6796.082528858541;6810.965945170243;6455.806325810233;6458.773942911976;6466.579672321284;6468.417842394207;6487.54587178893;6367.363263673781;6478.060681201294;6538.051982462612;6551.115599394211;6556.213254409501;4991.925121123113;6327.209098862642;6335.778247761306;6355.682215889095;6422.421982021454;6364.840878978062;6373.107764913008;6380.170577824853;6380.266269378895;6381;6274.968625156845;6309.49524038085;6327.272363678236;6349.238091429058;6372.394622510854;6263.3736626337;6291.559590828598;6303.149074875017;6311.652859092794;6357.110004599453;6340.1440805490665;6354.618722876642;6357.427831495188;6367.204099487564;6373.617582944853 12:51:29 INFO - PID 1917 | |1;ext.html;724.8985142080106;751.2675141736806;801.6673080671521;989.090037165807;1137.9374134422615;27901.720982790164;37659;38301;38319.42520862189;38352;40128;40512.392314115314;40523.594764052425;40547.39178912318;40609;6131.294901086365;8456.577171141449;8649.135086491364;8661.35039872009;8671;6186.226721659793;8383.371247156458;8551.486910785372;8557.443766155211;8563.058063612998;8570.057293697688;8635.40937718685;8643.870341944876;8657.913420865805;8701.651933922667;8543.700970466003;8601.053884072748;8608.053114157437;8613.397062205617;8621.439606425562;8479.321654267644;8551.957240213822;8562.74311770648;8575.313974881994;8586.356023298278;38143.664971725855;38411.807940960396;38415.61584384176;38443.42334864979;38567.61432385668;3023.0779612218266;3031.8332491712945;3035.6812534683763;3043.3000409905844;3046.8781248750024;23800.523989520287;27818.860905695543;27977.580336294974;28323.150305490868;28563;2750.35366688828;2790.868595775947;2792.427552351763;2792.539231026878;2805.8316501010004;331482;332397.3380133108;332892;332899;334370;50984.98030039453;51099.233511497354;51185.48814511882;51192.74403627958;51227.743861280454;53345.19982200192;53362;53499.73250133725;53614.7319263409;53620;13720.519781807589;14136.929315353358;14140.858591413955;14161.079529830527;14183.71632567343;9785.168260697921;11458.484368203452;11478.827817582744;11481;11487.597934072268;10609.787804244026;11381.439176185291;11453.427328633701;13188.0108991826;13228.206307621573;5298.966701493249;5400.270963419888;5406.810761623403;5432.320959880015;5448;884.9646014159362;989.5651305606899;992.275638783692;995.0894931137927;1035.5547114740584;22796.658050129263;23906.7609323908;23917.28248152558;23975.160869369487;23990.88004560001;1086.706589220906;1091.1979694924225;1099.7910397024539;1133.489929531714;1146.4497041419997;11610.071194304435;12067;12175.878241217475;12197.268163910194;12249.755004899853;438965;439040;440202;440810;442768;53678;53683.19475207875;53736;53860.73069634627;53965;1460.6713489464998;1477.6158198868156;1518.2788175616715;1526.0996012352543;1532.7930729351617;23327.650085248395;23455.41361465977;23483;23503.41241468977;23589.764102358757;38487.845364639106;38547.42178867375;38562.8431147066;38563.807180965036;38695;430493;432045;432143;432261;432348;33593.5706084952;34158.80444184442;34332.99172644827;34365.828170858986;34513.137171569906;42126.578734212264;42433.36349954691;43258.78370608127;43297.35053974256;43596.56403435925;27209;28779.568306475;30014.24964375821;30044;30346.39307213799;29045.85477072601;29212.853935730185;29928.850355748084;29955.400891982474;30154.159918421807;34927.12682182966;35984.28031439409;36231;36252.81873590615;36318.45522317114;28844.134675959755;29719.554206686484;30492.695073048984;30885;30942;23027;23658.52682946297;23833.04667813268;24344.75655243425;24397.75602243955 12:51:29 INFO - PID 1917 | |2;jquery.html;388.87555982085746;417.75770053369047;429.9720518166318;432.79442264924154;442.08929605013674;15973.600659983505;21711.240106596273;22065.33803985879;22680.319590412295;23013.079476820905;22348.21781237657;22898.77101228987;23246;23941;24124.552526848358;6040.063790112539;6127.264728232618;6331.113644089831;6362.459190968773;6399.26408463028;3403.9319213615713;6312.5896816707;6338.397852204033;6343.33394993526;6344.968275158618;3689.538590644487;3925.9411108833247;3931.1351502669368;6364.427201551859;6380.393862583047;6066.817995460143;6203.503719702436;6316.147320111772;6329.620222786648;6338.778142765027;5531.778728850841;5597.412271711452;5602.24369710088;5609.663420194802;5611.466910643482;28444.862205511756;28993.42013159746;29077.41845163085;29219.56170657442;29608.55587166194;1966.1250743419184;2010.396880935728;2035.521652411682;2049.9692504612444;2106.252280440437;16079.919600401923;17280.740788888175;17336.913315433343;17506.47480575572;18054;1653.9173041347885;1798.4784412520353;1891;1936.3610008697096;1939.2436949589671;147904.260478698;156427;164578;167172;168801.15599421924;11565;11857.881421185677;12190.329531875655;12335.136540442083;12589.545038717546;15429.382824686887;16127.193640317937;16134.354625814836;16617;16652.250648720837;6687.896497078025;8762.255208307237;8798.29613630908;8934.73195804127;9076.546172691338;8499.787505312417;8506.106858779864;8536.975562932364;8680.30557555394;8699.782505437415;6570.882949898433;7259.564426134449;7355.8161045974275;7382.966384706146;7864.685412583547;1709.4615196213153;1890.9527261818564;1971.9885716569306;2124.107874692633;2143.7534683511285;843.9071702112763;940.8823897012874;959.6689142245914;960.3996213904469;981.8625392445064;16565.42021029258;17870;20473.48816279575;21052.368428947157;21847.344579662637;817.3665409307833;949.6154057606681;953.2135987810084;960.986159601627;983.5918093990914;9675.12923836844;11069.114470842313;11157.442127893573;11211;11247.943760281147;695645;712110;713234;715570;726764;153941;163026;163663;164803;165047;1158.3567854158573;1158.6176561734608;1218.2203389830693;1218.5186851193905;1218.750156217991;21423.46441338979;22138.225162119248;22237.867689280793;22655.98048087873;22781;62570;63786.36213637804;64361.390965226245;65210.347896522326;65814.01278980915;92334.07322974924;92929.53535232281;93699;94344;95636.56545151689;8591.809088682347;8607;8777.51723655205;8966.103389660982;9022.503762293138;13542.322883855571;13644.181349118688;13676.384562694902;14033.228172450205;14161.858381416054;11228.217468004148;11481.483333249857;11719.707007324543;11748.941255293668;11788.174827762317;10594.682159535227;11232;11599.420028998686;11613.941930290295;11633.825492617787;11742.295462272292;11863.881361186277;12294.754104917673;12320.876791231973;12397.024714068739;7149.320814522612;8658.39391242607;8835.33734969867;9055.728328150166;9130.406523576212;10809.810920798864;11577.942110289394;11679;11985.28088314704;12015.639530814089 12:51:29 INFO - PID 1917 | |3;mootools.html;1379.482693989754;1451.5137428961298;1458.8912426555814;1475.0707054555635;1475.8966872318938;10456.790864182722;10925.399103049329;10927.071198948099;10927.726806829833;10942.343459392441;10668.253222274443;10669.733256668587;10988.945055274733;11006.669799905996;11018.39398833064;2420.854748715074;2464.7412021737728;2468.5309791139625;2470.8023358131395;2473.7402572729875;2400.72948691757;2404.8557086574774;2450.901963921441;2453.337598848319;2455.373879660693;2370.419247284418;2436.013414567103;2439.695038120235;2444.5844206484853;2452.828302018859;2344.601417758985;2414.14297924237;2423.9394015149587;2429.0769507587092;2431.039739302983;2408.0849277274697;2420.189236605739;2423.660687503751;2428.6842710447704;2436.2204094689705;10675.83986240207;10934.07060399859;10957.671269861918;10959.945200273947;10963.232573719843;6091.786787462417;6333.018382150774;6347.936520634827;6349.46029587481;6352.841178970517;3419.7264218862433;3983.701222408302;3989.960100398988;4052.1490486997764;4073.5926407359325;1196.5931583261645;1520.3994422203277;1564.702706485764;1589.2530510659972;1646.0452937296338;15116;15134.394624215018;15253.542393728096;15287;15305.6173595661;5025.39695236574;5250.921236181461;5262.526372626482;5267.341582302212;5363.410024897258;11026.944865275622;11044.33733975964;11047.944760276147;11050.392228427514;11066.059384952208;6178.6601736904;6187.102870083812;6192.566520343623;6202.503799696014;6217.222847144107;5454.863628409322;5719.456651618089;5740.741666625012;5796.1595568642315;5799.39106393831;4023.6403796788345;4150.315197992358;4156.8129434174925;4177.143685544456;4177.436046133794;1202.8676845546984;1206.7043574324346;1218.713602303458;1223.614561413152;1226.47874653272;740.2412527159704;749.2956620776453;769.1155171552759;777.8016605765494;797.3222760653514;6206.72069756862;6492.350764923564;6705.329467053256;6715.3620406061345;6754.560953538103;565.9830205093854;568.9089745640678;583.6060659055206;588.4615576747314;602.3855667219411;3562.679358857715;3972.841086356513;4089.427480152781;4203.600657937491;4244.214820258262;12837.293948832717;13371.866281337258;13379.130356526795;13407.396667150002;13421.932890335485;12258.570950016885;12749.17130386522;13235.73528529424;13308;13728.794068088986;7977.282044616012;8703.95648021756;8814.691485797966;9211.217046550984;10306.227032972558;6599.967000164968;6601.405873471411;6792.422644075309;6850.38346548813;6921.688524016331;10269.845952310572;12493.312867792358;12591.307478088427;12605.43275552584;12710.300933448749;12599.68500787451;12635;12776.297303648389;12904;12958.80561791555;8655.004674462518;8927.464352138892;9046.773830654023;9058.456492610465;9062.50156241413;9949.403035817873;9960.501974901372;10053.597856085675;10062;10071.093601575893;7951.284384405431;7980.002499687539;8016.6392512335915;8125.349972002344;8200.630971606412;7055.223925368103;8277.54473503963;8409.915900841159;8457.323414126979;8600.827983440422;7659.88510172359;7830.647620857189;7841.451098423056;7844.568548729874;7852.921470785447;5736.254286942838;5766.423357664368;5936.37668044849;5991.820245392645;6026.367231440811;5689.943100568941;5830.737616807339;5943.745447651674;5975.492083172805;6077.696115194134 12:51:29 INFO - PID 1917 | |4;prototype.html;383.9289731399691;386.07342378292105;391.37184818366524;393.0684278260523;399.42881679198734;5429.91855122173;5951.285845698522;6063.151158837761;6111.738656697023;6123.510119190465;5789.681567513785;5941.88116237675;5956.553258505608;5962.284525856903;5964.105384192373;4279.229738647043;4402.3176407656865;4425.800838962238;4446.7554284514335;4460.4647442306805;3903.8873920932538;4425.712328698641;4440.7335559866515;4453.910921781562;4458.66560007999;3635.909102272438;4381.605655491006;4407.757573333465;4413.668974826885;4439.955600444003;4216.840368898546;4357.869263922087;4424.933625995613;4431.955680443202;4433.623142032931;3166.350898065914;3780.032674350649;3791.75353602015;3799.639034291738;3802.543694756619;4887.7311747853855;5823.330317013555;5827.854303642401;5841.299044114691;5867.530597552186;4326.668465281747;5114.948850511484;5186.299849520305;5253.921191182136;5260;5595.356533998561;6346.714397852062;6362.300146983828;6379.71291291893;6395.392437718409;4297.613214810651;4301.354796780477;4304.720193187464;4308.956910430887;4317.136572685476;6515.771947981845;6615.941449368078;6744.190697116328;6773.491988100863;6784.253732089466;3786.3563194257044;4360.4767427908855;4365.9126817463475;4369.213541562485;4369.366441865912;4085.816138273785;4442.511323754385;4457.821687132543;4468.620167285817;4475.1049790042125;5034.11902916988;5152.690838549699;5224;5249.895002099936;5262.97368513155;5274.92087618686;5620.81962787811;5645.435456454322;6356.618602883842;6464.709088091047;1444.7173465924025;1517.757158854578;1520.6350475885708;1521.7260893039359;1525.862672359493;926.7673993588511;949.4398305000083;962.7881865989472;997.7328792433714;1010.6917390196061;5326.6537675050995;5789.565782566325;6050.396644889108;6068.575199736064;6102.267727872683;6363.045543168561;6610.504212184105;6620.9006864897065;6638.7676431325635;6654.866902662016;6017.819465416044;6024.337322894478;6077.3314935357075;6106;6126.540509461808;3419.897403077912;3446.6902577021074;3462.740828780614;3463.168839478507;3476.322117187124;6532.477401807844;6802.387785099365;6836.760713375008;6903.344182302673;6909.619970901548;5631.887362252732;6561.671916404161;6743.966280168568;6873.347032031949;6875.765376252738;5487;5753.769849205984;5863;6666.933330666631;6772.390484856386;4966.379202599675;5825.6795876225515;6657.4674026078765;6659.833504162435;6682.431993280431;6490.545661803817;6572.868542629025;6577.6053436793945;6582.934170658232;6589.341065893373;6829.863402732017;6912.723491060502;6926.549774264657;6942.861142777015;6949.722011119498;4209.5477060414105;4301.397804307462;4342.457192850894;4366.978165109154;4369.934450983174;5758.740856661544;6362.936370636235;6609.504287178577;6620.768273110418;6638.236602790547;5065.645404821775;5802.60737423007;5961.612495187799;6207.224096987877;6418.582792118497;4985.501449854985;5249.816256431007;5274.920876186937;6399.904001440075;6418.042497038448;5300.840974770763;5465.9726701366235;6276.9372306276355;6279.5729011048015;6304.145807727932;4800.231962885921;6149.326511850936;6370.8850951084305;6392.306038899788;6427.260865000585;6260.74957001733;6264.467520260829;6273.843153921189;6278.466330361788;6303.905441418291 12:51:29 INFO - PID 1917 | |5;yui.html;706.6396137969638;708.7838209346147;722.509602818483;726.894600282959;728.1044315491945;15493.302801373937;16574.834251657496;16578;16579.58551036223;16596.50210493684;14442.422303107864;14447.78328325076;14670.63323416915;15201.923990380034;15354.539363819076;959.9424034557932;972.2562239886493;977.6382738386772;977.8777652793401;978.2223132609557;962.1725316228038;965.2037069417759;970.7864269860619;973.6738192705452;976.3751199232497;1069.1286601419856;1079.7462596289904;1081.5781845080426;1082.648139354709;1085.636311835532;1071.571371451418;1074.9355038697663;1076.2466273608427;1076.978460430787;1077.6228320087946;799.1568894815966;799.6321692021677;799.9920000799975;800.3557136505111;801.0627565748031;15453.304601292968;17064.48806535806;17119.972801631942;17186.484405467854;17317.307307707677;14562.635934101627;14584.47008402864;14675.339609717481;14717.55847324582;14740.1248436962;10274.537645805956;11584.768304633944;11936.16446848721;11961.521539138424;12047.975922046637;2866.312085099582;2994.7454466370386;3004.309008927937;3056.694330566948;3062.2038270049725;110329;114547;114711;118785.21822172674;119249;10873.945630271955;11291.49188286529;11340.43297835105;11408.315501069963;12190.57332993341;24382.146624868044;24947.25158245219;25116.372090697514;25128.748712513006;25265.747342526338;7704.114026886979;7817.609119544114;8057.395695322874;8085.5957202140835;8089.191080891864;4016.6004872531717;4141.6065473779945;4177.728447650893;4190.476190476191;4237.894052648709;4141.130362623822;4260.936085958713;4263.467066616673;4264.232438161161;4264.722793018444;829.1708291708292;856.3406177243488;870.4733636150038;873.1792115411492;901.4230892228978;502.4222144533815;528.9312389389355;573.1832139201621;576.7750577274866;577.1806110800874;9525.095115963972;10127.98720127996;10230.897691022994;10297.794044119075;10583.947080264703;507.441814004592;542.3410556174189;549.2502733768457;576.0897781505212;578.3262499188398;4421.5578442156175;4707.6233901287815;4717.481077081518;4815.425296171054;4875.171220892456;92777.53611231901;94694.5265273683;94863;95773;96649.5167524172;79854.00364990922;82171;82552.58723706462;83705.58147209225;83778;82101;82264.58867705743;84147.31705365858;84261.57869210615;85338;9312;9342.252619790537;9407.153356197976;9444.65395073732;9501.524923753923;40008.79995600003;41113.58886411217;41204.38193427041;42011.7899410501;42197;53375;53832.461675384315;54076.729616351666;54322.7283863594;55092.72453637706;11712.648620541397;11821.440467726981;11837.644870653894;12377;12473.5010599575;12377.814332784836;12717.936410317889;12721.173123746927;12724.554640587905;13080.607581772181;11575.88424115748;11837;11963;12160.695982600506;12360.81458778137;11524;11631.709207269885;11899.46452409661;11904.642860714192;12491.437885295365;11760;12185.51257949672;12255.75488490243;12290.692732681755;13448.394822233218;9684.921342383448;9868.062534059252;9995.650152244636;10279.94860025725;10305.175585953255;7934.642941067781;8490.938632670915;9580.281478888972;11041;11042.392668403316 12:51:29 INFO - PID 1917 | __end_tp_report 12:51:29 INFO - PID 1917 | __start_cc_report 12:51:29 INFO - PID 1917 | _x_x_mozilla_cycle_collect,2091 12:51:29 INFO - PID 1917 | __end_cc_report 12:51:29 INFO - PID 1917 | __startTimestamp1490989889878__endTimestamp 12:51:29 INFO - PID 1917 | 12:51:29 INFO - PID 1917 | ------- Summary: start ------- 12:51:29 INFO - PID 1917 | Number of tests: 6 12:51:29 INFO - PID 1917 | 12:51:29 INFO - PID 1917 | [#0] dojo.html Cycles:165 Average:6036.50 Median:6324.68 stddev:699.26 (11.1%) stddev-sans-first:671.13 12:51:29 INFO - PID 1917 | Values: 3442.1 3459.8 3499.9 3505.8 3536.3 5984.9 6124.4 6187.7 6194.0 6210.4 6120.7 6137.1 6166.7 6173.1 6178.0 5193.2 5348.7 5360.5 5366.6 5398.7 5402.2 5440.9 5455.8 5470.5 5504.2 5232.3 5260.5 5276.1 5314.2 5400.8 5320.3 5327.3 5333.1 5378.5 5404.3 5245.0 5253.4 5286.2 5305.5 5365.2 5924.2 6067.0 6104.3 6128.4 6135.8 6363.6 6426.8 6509.2 6529.4 6550.3 6502.1 6570.2 6573.7 6580.0 6585.2 6262.4 6309.9 6310.7 6314.1 6323.2 6418.6 6469.0 6548.2 6659.4 6814.9 6374.1 6384.5 6395.8 6401.7 6407.8 6436.9 6541.4 6549.9 6560.4 6564.9 6249.3 6332.7 6428.5 6472.7 6486.3 6324.6 6324.7 6327.0 6328.4 6341.7 5186.1 5190.3 5192.4 5197.8 5202.3 4607.4 4643.2 4655.7 4678.6 4730.3 6268.2 6281.4 6286.0 6305.9 6316.3 6581.7 6599.8 6602.9 6603.8 6609.8 5600.0 5602.8 6296.0 6330.3 6336.3 5724.9 5741.8 5790.4 5793.2 5799.3 6769.5 6818.5 6825.7 6846.3 6851.7 6376.8 6423.0 6426.0 6614.4 6618.4 6692.9 6757.6 6766.7 6796.1 6811.0 6455.8 6458.8 6466.6 6468.4 6487.5 6367.4 6478.1 6538.1 6551.1 6556.2 4991.9 6327.2 6335.8 6355.7 6422.4 6364.8 6373.1 6380.2 6380.3 6381.0 6275.0 6309.5 6327.3 6349.2 6372.4 6263.4 6291.6 6303.1 6311.7 6357.1 6340.1 6354.6 6357.4 6367.2 6373.6 12:51:29 INFO - PID 1917 | 12:51:29 INFO - PID 1917 | [#1] ext.html Cycles:180 Average:53455.28 Median:36285.64 stddev:107407.86 (296.0%) stddev-sans-first:107636.20 12:51:29 INFO - PID 1917 | Values: 724.9 751.3 801.7 989.1 1137.9 27901.7 37659.0 38301.0 38319.4 38352.0 40128.0 40512.4 40523.6 40547.4 40609.0 6131.3 8456.6 8649.1 8661.4 8671.0 6186.2 8383.4 8551.5 8557.4 8563.1 8570.1 8635.4 8643.9 8657.9 8701.7 8543.7 8601.1 8608.1 8613.4 8621.4 8479.3 8552.0 8562.7 8575.3 8586.4 38143.7 38411.8 38415.6 38443.4 38567.6 3023.1 3031.8 3035.7 3043.3 3046.9 23800.5 27818.9 27977.6 28323.2 28563.0 2750.4 2790.9 2792.4 2792.5 2805.8 331482.0 332397.3 332892.0 332899.0 334370.0 50985.0 51099.2 51185.5 51192.7 51227.7 53345.2 53362.0 53499.7 53614.7 53620.0 13720.5 14136.9 14140.9 14161.1 14183.7 9785.2 11458.5 11478.8 11481.0 11487.6 10609.8 11381.4 11453.4 13188.0 13228.2 5299.0 5400.3 5406.8 5432.3 5448.0 885.0 989.6 992.3 995.1 1035.6 22796.7 23906.8 23917.3 23975.2 23990.9 1086.7 1091.2 1099.8 1133.5 1146.4 11610.1 12067.0 12175.9 12197.3 12249.8 438965.0 439040.0 440202.0 440810.0 442768.0 53678.0 53683.2 53736.0 53860.7 53965.0 1460.7 1477.6 1518.3 1526.1 1532.8 23327.7 23455.4 23483.0 23503.4 23589.8 38487.8 38547.4 38562.8 38563.8 38695.0 430493.0 432045.0 432143.0 432261.0 432348.0 33593.6 34158.8 34333.0 34365.8 34513.1 42126.6 42433.4 43258.8 43297.4 43596.6 27209.0 28779.6 30014.2 30044.0 30346.4 29045.9 29212.9 29928.9 29955.4 30154.2 34927.1 35984.3 36231.0 36252.8 36318.5 28844.1 29719.6 30492.7 30885.0 30942.0 23027.0 23658.5 23833.0 24344.8 24397.8 12:51:29 INFO - PID 1917 | 12:51:29 INFO - PID 1917 | [#2] jquery.html Cycles:180 Average:41826.89 Median:23129.54 stddev:119943.34 (518.6%) stddev-sans-first:120239.45 12:51:29 INFO - PID 1917 | Values: 388.9 417.8 430.0 432.8 442.1 15973.6 21711.2 22065.3 22680.3 23013.1 22348.2 22898.8 23246.0 23941.0 24124.6 6040.1 6127.3 6331.1 6362.5 6399.3 3403.9 6312.6 6338.4 6343.3 6345.0 3689.5 3925.9 3931.1 6364.4 6380.4 6066.8 6203.5 6316.1 6329.6 6338.8 5531.8 5597.4 5602.2 5609.7 5611.5 28444.9 28993.4 29077.4 29219.6 29608.6 1966.1 2010.4 2035.5 2050.0 2106.3 16079.9 17280.7 17336.9 17506.5 18054.0 1653.9 1798.5 1891.0 1936.4 1939.2 147904.3 156427.0 164578.0 167172.0 168801.2 11565.0 11857.9 12190.3 12335.1 12589.5 15429.4 16127.2 16134.4 16617.0 16652.3 6687.9 8762.3 8798.3 8934.7 9076.5 8499.8 8506.1 8537.0 8680.3 8699.8 6570.9 7259.6 7355.8 7383.0 7864.7 1709.5 1891.0 1972.0 2124.1 2143.8 843.9 940.9 959.7 960.4 981.9 16565.4 17870.0 20473.5 21052.4 21847.3 817.4 949.6 953.2 961.0 983.6 9675.1 11069.1 11157.4 11211.0 11247.9 695645.0 712110.0 713234.0 715570.0 726764.0 153941.0 163026.0 163663.0 164803.0 165047.0 1158.4 1158.6 1218.2 1218.5 1218.8 21423.5 22138.2 22237.9 22656.0 22781.0 62570.0 63786.4 64361.4 65210.3 65814.0 92334.1 92929.5 93699.0 94344.0 95636.6 8591.8 8607.0 8777.5 8966.1 9022.5 13542.3 13644.2 13676.4 14033.2 14161.9 11228.2 11481.5 11719.7 11748.9 11788.2 10594.7 11232.0 11599.4 11613.9 11633.8 11742.3 11863.9 12294.8 12320.9 12397.0 7149.3 8658.4 8835.3 9055.7 9130.4 10809.8 11577.9 11679.0 11985.3 12015.6 12:51:29 INFO - PID 1917 | 12:51:29 INFO - PID 1917 | [#3] mootools.html Cycles:180 Average:6677.40 Median:3767.76 stddev:4086.15 (108.5%) stddev-sans-first:4078.21 12:51:29 INFO - PID 1917 | Values: 1379.5 1451.5 1458.9 1475.1 1475.9 10456.8 10925.4 10927.1 10927.7 10942.3 10668.3 10669.7 10988.9 11006.7 11018.4 2420.9 2464.7 2468.5 2470.8 2473.7 2400.7 2404.9 2450.9 2453.3 2455.4 2370.4 2436.0 2439.7 2444.6 2452.8 2344.6 2414.1 2423.9 2429.1 2431.0 2408.1 2420.2 2423.7 2428.7 2436.2 10675.8 10934.1 10957.7 10959.9 10963.2 6091.8 6333.0 6347.9 6349.5 6352.8 3419.7 3983.7 3990.0 4052.1 4073.6 1196.6 1520.4 1564.7 1589.3 1646.0 15116.0 15134.4 15253.5 15287.0 15305.6 5025.4 5250.9 5262.5 5267.3 5363.4 11026.9 11044.3 11047.9 11050.4 11066.1 6178.7 6187.1 6192.6 6202.5 6217.2 5454.9 5719.5 5740.7 5796.2 5799.4 4023.6 4150.3 4156.8 4177.1 4177.4 1202.9 1206.7 1218.7 1223.6 1226.5 740.2 749.3 769.1 777.8 797.3 6206.7 6492.4 6705.3 6715.4 6754.6 566.0 568.9 583.6 588.5 602.4 3562.7 3972.8 4089.4 4203.6 4244.2 12837.3 13371.9 13379.1 13407.4 13421.9 12258.6 12749.2 13235.7 13308.0 13728.8 7977.3 8704.0 8814.7 9211.2 10306.2 6600.0 6601.4 6792.4 6850.4 6921.7 10269.8 12493.3 12591.3 12605.4 12710.3 12599.7 12635.0 12776.3 12904.0 12958.8 8655.0 8927.5 9046.8 9058.5 9062.5 9949.4 9960.5 10053.6 10062.0 10071.1 7951.3 7980.0 8016.6 8125.3 8200.6 7055.2 8277.5 8409.9 8457.3 8600.8 7659.9 7830.6 7841.5 7844.6 7852.9 5736.3 5766.4 5936.4 5991.8 6026.4 5689.9 5830.7 5943.7 5975.5 6077.7 12:51:29 INFO - PID 1917 | 12:51:29 INFO - PID 1917 | [#4] prototype.html Cycles:180 Average:5135.83 Median:5789.62 stddev:1610.07 (27.8%) stddev-sans-first:1574.59 12:51:29 INFO - PID 1917 | Values: 383.9 386.1 391.4 393.1 399.4 5429.9 5951.3 6063.2 6111.7 6123.5 5789.7 5941.9 5956.6 5962.3 5964.1 4279.2 4402.3 4425.8 4446.8 4460.5 3903.9 4425.7 4440.7 4453.9 4458.7 3635.9 4381.6 4407.8 4413.7 4440.0 4216.8 4357.9 4424.9 4432.0 4433.6 3166.4 3780.0 3791.8 3799.6 3802.5 4887.7 5823.3 5827.9 5841.3 5867.5 4326.7 5114.9 5186.3 5253.9 5260.0 5595.4 6346.7 6362.3 6379.7 6395.4 4297.6 4301.4 4304.7 4309.0 4317.1 6515.8 6615.9 6744.2 6773.5 6784.3 3786.4 4360.5 4365.9 4369.2 4369.4 4085.8 4442.5 4457.8 4468.6 4475.1 5034.1 5152.7 5224.0 5249.9 5263.0 5274.9 5620.8 5645.4 6356.6 6464.7 1444.7 1517.8 1520.6 1521.7 1525.9 926.8 949.4 962.8 997.7 1010.7 5326.7 5789.6 6050.4 6068.6 6102.3 6363.0 6610.5 6620.9 6638.8 6654.9 6017.8 6024.3 6077.3 6106.0 6126.5 3419.9 3446.7 3462.7 3463.2 3476.3 6532.5 6802.4 6836.8 6903.3 6909.6 5631.9 6561.7 6744.0 6873.3 6875.8 5487.0 5753.8 5863.0 6666.9 6772.4 4966.4 5825.7 6657.5 6659.8 6682.4 6490.5 6572.9 6577.6 6582.9 6589.3 6829.9 6912.7 6926.5 6942.9 6949.7 4209.5 4301.4 4342.5 4367.0 4369.9 5758.7 6362.9 6609.5 6620.8 6638.2 5065.6 5802.6 5961.6 6207.2 6418.6 4985.5 5249.8 5274.9 6399.9 6418.0 5300.8 5466.0 6276.9 6279.6 6304.1 4800.2 6149.3 6370.9 6392.3 6427.3 6260.7 6264.5 6273.8 6278.5 6303.9 12:51:29 INFO - PID 1917 | 12:51:29 INFO - PID 1917 | [#5] yui.html Cycles:180 Average:19845.49 Median:41158.99 stddev:28834.54 (70.1%) stddev-sans-first:28879.62 12:51:29 INFO - PID 1917 | Values: 706.6 708.8 722.5 726.9 728.1 15493.3 16574.8 16578.0 16579.6 16596.5 14442.4 14447.8 14670.6 15201.9 15354.5 959.9 972.3 977.6 977.9 978.2 962.2 965.2 970.8 973.7 976.4 1069.1 1079.7 1081.6 1082.6 1085.6 1071.6 1074.9 1076.2 1077.0 1077.6 799.2 799.6 800.0 800.4 801.1 15453.3 17064.5 17120.0 17186.5 17317.3 14562.6 14584.5 14675.3 14717.6 14740.1 10274.5 11584.8 11936.2 11961.5 12048.0 2866.3 2994.7 3004.3 3056.7 3062.2 110329.0 114547.0 114711.0 118785.2 119249.0 10873.9 11291.5 11340.4 11408.3 12190.6 24382.1 24947.3 25116.4 25128.7 25265.7 7704.1 7817.6 8057.4 8085.6 8089.2 4016.6 4141.6 4177.7 4190.5 4237.9 4141.1 4260.9 4263.5 4264.2 4264.7 829.2 856.3 870.5 873.2 901.4 502.4 528.9 573.2 576.8 577.2 9525.1 10128.0 10230.9 10297.8 10583.9 507.4 542.3 549.3 576.1 578.3 4421.6 4707.6 4717.5 4815.4 4875.2 92777.5 94694.5 94863.0 95773.0 96649.5 79854.0 82171.0 82552.6 83705.6 83778.0 82101.0 82264.6 84147.3 84261.6 85338.0 9312.0 9342.3 9407.2 9444.7 9501.5 40008.8 41113.6 41204.4 42011.8 42197.0 53375.0 53832.5 54076.7 54322.7 55092.7 11712.6 11821.4 11837.6 12377.0 12473.5 12377.8 12717.9 12721.2 12724.6 13080.6 11575.9 11837.0 11963.0 12160.7 12360.8 11524.0 11631.7 11899.5 11904.6 12491.4 11760.0 12185.5 12255.8 12290.7 13448.4 9684.9 9868.1 9995.7 10279.9 10305.2 7934.6 8490.9 9580.3 11041.0 11042.4 12:51:29 INFO - PID 1917 | -------- Summary: end -------- 12:51:29 INFO - PID 1917 | 12:51:30 INFO - TEST-INFO | 1917: exit 0 12:51:30 INFO - TEST-OK | dromaeo_css | took 1120761ms 12:51:30 INFO - TEST-START | kraken 12:51:30 INFO - operating with platform_type : mac_ 12:51:30 INFO - Initialising browser for kraken test... 12:51:30 INFO - TEST-INFO | started process 1920 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpIVDnJS/profile http://localhost:49368/getInfo.html) 12:51:33 INFO - PID 1920 | __metrics Screen width/height:1600/1200 12:51:33 INFO - PID 1920 | colorDepth:24 12:51:33 INFO - PID 1920 | Browser inner width/height: 1024/689 12:51:33 INFO - PID 1920 | __metrics 12:51:33 INFO - PID 1920 | 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" 12:51:33 INFO - PID 1920 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:51:33 INFO - TEST-INFO | 1920: exit 0 12:51:33 INFO - Browser initialized. 12:51:33 INFO - Running cycle 1/1 for kraken test... 12:51:33 INFO - TEST-INFO | started process 1921 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpIVDnJS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:51:46 INFO - PID 1921 | RSS: Main: 234332160 12:51:46 INFO - PID 1921 | 12:51:48 INFO - PID 1921 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49368/tests/kraken/driver.html?testName=audio-beat-detection) 12:51:49 INFO - PID 1921 | RSS: Main: 287232000 12:51:49 INFO - PID 1921 | 12:51:52 INFO - PID 1921 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49368/tests/kraken/driver.html?testName=audio-dft) 12:51:53 INFO - PID 1921 | RSS: Main: 287481856 12:51:53 INFO - PID 1921 | 12:51:57 INFO - PID 1921 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49368/tests/kraken/driver.html?testName=audio-fft) 12:51:57 INFO - PID 1921 | RSS: Main: 380731392 12:51:57 INFO - PID 1921 | 12:52:00 INFO - PID 1921 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49368/tests/kraken/driver.html?testName=audio-oscillator) 12:52:00 INFO - PID 1921 | RSS: Main: 283590656 12:52:00 INFO - PID 1921 | 12:52:02 INFO - PID 1921 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49368/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:52:03 INFO - PID 1921 | RSS: Main: 286720000 12:52:03 INFO - PID 1921 | 12:52:06 INFO - PID 1921 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49368/tests/kraken/driver.html?testName=imaging-darkroom) 12:52:07 INFO - PID 1921 | RSS: Main: 328380416 12:52:07 INFO - PID 1921 | 12:52:10 INFO - PID 1921 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49368/tests/kraken/driver.html?testName=imaging-desaturate) 12:52:11 INFO - PID 1921 | RSS: Main: 341864448 12:52:11 INFO - PID 1921 | 12:52:14 INFO - PID 1921 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49368/tests/kraken/driver.html?testName=json-parse-financial) 12:52:15 INFO - PID 1921 | RSS: Main: 352387072 12:52:15 INFO - PID 1921 | 12:52:16 INFO - PID 1921 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49368/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:52:17 INFO - PID 1921 | RSS: Main: 302256128 12:52:17 INFO - PID 1921 | 12:52:19 INFO - PID 1921 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:52:19 INFO - PID 1921 | RSS: Main: 307007488 12:52:19 INFO - PID 1921 | 12:52:22 INFO - PID 1921 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:52:23 INFO - PID 1921 | RSS: Main: 309354496 12:52:23 INFO - PID 1921 | 12:52:26 INFO - PID 1921 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:52:27 INFO - PID 1921 | RSS: Main: 318771200 12:52:27 INFO - PID 1921 | 12:52:30 INFO - PID 1921 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:52:31 INFO - PID 1921 | RSS: Main: 305983488 12:52:31 INFO - PID 1921 | 12:52:33 INFO - PID 1921 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49368/tests/kraken/driver.html?testName=ai-astar) 12:52:33 INFO - PID 1921 | RSS: Main: 372187136 12:52:33 INFO - PID 1921 | 12:52:33 INFO - PID 1921 | __start_tp_report 12:52:33 INFO - PID 1921 | _x_x_mozilla_page_load 12:52:33 INFO - PID 1921 | _x_x_mozilla_page_load_details 12:52:33 INFO - PID 1921 | |i|pagename|runs| 12:52:33 INFO - PID 1921 | |0;ai-astar;112;122;125;122;123;125;123;133;124;123 12:52:33 INFO - PID 1921 | |1;audio-beat-detection;160;120;120;164;121;119;122;136;182;161 12:52:33 INFO - PID 1921 | |2;audio-dft;211;219;224;186;295;280;212;230;212;188 12:52:33 INFO - PID 1921 | |3;audio-fft;84;64;63;101;65;66;63;76;80;66 12:52:33 INFO - PID 1921 | |4;audio-oscillator;89;78;94;77;74;73;89;73;76;91 12:52:33 INFO - PID 1921 | |5;imaging-gaussian-blur;94;93;94;93;94;95;138;96;121;140 12:52:33 INFO - PID 1921 | |6;imaging-darkroom;102;101;103;103;101;100;101;102;112;102 12:52:33 INFO - PID 1921 | |7;imaging-desaturate;128;160;125;162;143;103;101;102;103;101 12:52:33 INFO - PID 1921 | |8;json-parse-financial;55;53;51;51;53;53;52;52;52;51 12:52:33 INFO - PID 1921 | |9;json-stringify-tinderbox;57;57;67;70;68;70;63;63;63;63 12:52:33 INFO - PID 1921 | |10;stanford-crypto-aes;109;121;84;117;116;117;106;90;90;90 12:52:33 INFO - PID 1921 | |11;stanford-crypto-ccm;153;160;163;169;138;150;155;163;249;153 12:52:33 INFO - PID 1921 | |12;stanford-crypto-pbkdf2;203;253;248;250;203;200;226;252;202;198 12:52:33 INFO - PID 1921 | |13;stanford-crypto-sha256-iterative;72;73;75;75;76;73;72;72;77;91 12:52:33 INFO - PID 1921 | __end_tp_report 12:52:33 INFO - PID 1921 | __start_cc_report 12:52:33 INFO - PID 1921 | _x_x_mozilla_cycle_collect,2233 12:52:33 INFO - PID 1921 | __end_cc_report 12:52:33 INFO - PID 1921 | __startTimestamp1490989953460__endTimestamp 12:52:33 INFO - PID 1921 | 12:52:33 INFO - PID 1921 | ------- Summary: start ------- 12:52:33 INFO - PID 1921 | Number of tests: 14 12:52:33 INFO - PID 1921 | 12:52:33 INFO - PID 1921 | [#0] ai-astar Cycles:10 Average:123.20 Median:123.50 stddev:5.07 (4.1%) stddev-sans-first:3.40 12:52:33 INFO - PID 1921 | Values: 112.0 122.0 125.0 122.0 123.0 125.0 123.0 133.0 124.0 123.0 12:52:33 INFO - PID 1921 | 12:52:33 INFO - PID 1921 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:148.00 stddev:23.85 (16.1%) stddev-sans-first:24.23 12:52:33 INFO - PID 1921 | Values: 160.0 120.0 120.0 164.0 121.0 119.0 122.0 136.0 182.0 161.0 12:52:33 INFO - PID 1921 | 12:52:33 INFO - PID 1921 | [#2] audio-dft Cycles:10 Average:225.70 Median:221.50 stddev:35.60 (16.1%) stddev-sans-first:37.36 12:52:33 INFO - PID 1921 | Values: 211.0 219.0 224.0 186.0 295.0 280.0 212.0 230.0 212.0 188.0 12:52:33 INFO - PID 1921 | 12:52:33 INFO - PID 1921 | [#3] audio-fft Cycles:10 Average:72.80 Median:66.00 stddev:12.50 (18.9%) stddev-sans-first:12.58 12:52:33 INFO - PID 1921 | Values: 84.0 64.0 63.0 101.0 65.0 66.0 63.0 76.0 80.0 66.0 12:52:33 INFO - PID 1921 | 12:52:33 INFO - PID 1921 | [#4] audio-oscillator Cycles:10 Average:81.40 Median:83.50 stddev:8.32 (10.0%) stddev-sans-first:8.35 12:52:33 INFO - PID 1921 | Values: 89.0 78.0 94.0 77.0 74.0 73.0 89.0 73.0 76.0 91.0 12:52:33 INFO - PID 1921 | 12:52:33 INFO - PID 1921 | [#5] imaging-gaussian-blur Cycles:10 Average:105.80 Median:94.00 stddev:19.42 (20.7%) stddev-sans-first:20.13 12:52:33 INFO - PID 1921 | Values: 94.0 93.0 94.0 93.0 94.0 95.0 138.0 96.0 121.0 140.0 12:52:33 INFO - PID 1921 | 12:52:33 INFO - PID 1921 | [#6] imaging-darkroom Cycles:10 Average:102.70 Median:102.00 stddev:3.40 (3.3%) stddev-sans-first:3.60 12:52:33 INFO - PID 1921 | Values: 102.0 101.0 103.0 103.0 101.0 100.0 101.0 102.0 112.0 102.0 12:52:33 INFO - PID 1921 | 12:52:33 INFO - PID 1921 | [#7] imaging-desaturate Cycles:10 Average:122.80 Median:126.50 stddev:24.78 (19.6%) stddev-sans-first:26.21 12:52:33 INFO - PID 1921 | Values: 128.0 160.0 125.0 162.0 143.0 103.0 101.0 102.0 103.0 101.0 12:52:33 INFO - PID 1921 | 12:52:33 INFO - PID 1921 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.50 stddev:1.25 (2.4%) stddev-sans-first:0.87 12:52:33 INFO - PID 1921 | Values: 55.0 53.0 51.0 51.0 53.0 53.0 52.0 52.0 52.0 51.0 12:52:33 INFO - PID 1921 | 12:52:33 INFO - PID 1921 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:65.00 stddev:4.70 (7.2%) stddev-sans-first:4.23 12:52:33 INFO - PID 1921 | Values: 57.0 57.0 67.0 70.0 68.0 70.0 63.0 63.0 63.0 63.0 12:52:33 INFO - PID 1921 | 12:52:33 INFO - PID 1921 | [#10] stanford-crypto-aes Cycles:10 Average:104.00 Median:102.50 stddev:14.09 (13.8%) stddev-sans-first:14.83 12:52:33 INFO - PID 1921 | Values: 109.0 121.0 84.0 117.0 116.0 117.0 106.0 90.0 90.0 90.0 12:52:33 INFO - PID 1921 | 12:52:33 INFO - PID 1921 | [#11] stanford-crypto-ccm Cycles:10 Average:165.30 Median:161.50 stddev:30.63 (19.0%) stddev-sans-first:32.17 12:52:33 INFO - PID 1921 | Values: 153.0 160.0 163.0 169.0 138.0 150.0 155.0 163.0 249.0 153.0 12:52:33 INFO - PID 1921 | 12:52:33 INFO - PID 1921 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:223.50 Median:237.00 stddev:24.71 (10.4%) stddev-sans-first:25.07 12:52:33 INFO - PID 1921 | Values: 203.0 253.0 248.0 250.0 203.0 200.0 226.0 252.0 202.0 198.0 12:52:33 INFO - PID 1921 | 12:52:33 INFO - PID 1921 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.60 Median:75.00 stddev:5.70 (7.6%) stddev-sans-first:5.89 12:52:33 INFO - PID 1921 | Values: 72.0 73.0 75.0 75.0 76.0 73.0 72.0 72.0 77.0 91.0 12:52:33 INFO - PID 1921 | -------- Summary: end -------- 12:52:33 INFO - PID 1921 | 12:52:34 INFO - TEST-INFO | 1921: exit 0 12:52:34 INFO - TEST-OK | kraken | took 63777ms 12:52:34 INFO - SUITE-END | took 1184s 12:52:34 INFO - Completed test suite (00:19:44) 12:52:34 INFO - javascript benchmark 12:52:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7609.473119503169, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3442.1050526863014, 3459.7751146175497, 3499.9300013999705, 3505.7545971781988, 3536.3104194682032, 5984.910226346608, 6124.448799608034, 6187.6906154692315, 6194.00895856663, 6210.441060304577, 6120.690942950897, 6137.1408002879525, 6166.660833654148, 6173.074038894157, 6178.042403427465, 5193.16909294513, 5348.652337598063, 5360.463953604647, 5366.570674346052, 5398.730063496829, 5402.24368588396, 5440.891182176354, 5455.754491047893, 5470.507654311111, 5504.2018907258425, 5232.3459567554055, 5260.526552610283, 5276.12943864262, 5314.176302673091, 5400.810971616014, 5320.281761962125, 5327.30745003151, 5333.120035194188, 5378.542823859977, 5404.32445944257, 5244.973775131138, 5253.44838791929, 5286.207068939651, 5305.469453054702, 5365.168398898177, 5924.170616113747, 6067.0, 6104.328523862371, 6128.38716128388, 6135.846603834895, 6363.649999250039, 6426.839329016765, 6509.153810004716, 6529.412352888263, 6550.344965503412, 6502.057201705774, 6570.244421891496, 6573.671316434207, 6580.045893345486, 6585.242697089848, 6262.373762623702, 6309.936900630981, 6310.716017779165, 6314.052892066226, 6323.20959880015, 6418.614883107029, 6468.967655161694, 6548.1814773153355, 6659.4006539411685, 6814.897776533356, 6374.139491168726, 6384.48924086072, 6395.808125756234, 6401.679916004181, 6407.775727849503, 6436.935630643728, 6541.443977261986, 6549.8690026200165, 6560.40956313934, 6564.86870262592, 6249.250089989139, 6332.651704156316, 6428.485721142298, 6472.741090356427, 6486.254080780771, 6324.588901721373, 6324.683765811691, 6326.9683651581445, 6328.367163283635, 6341.714622841983, 5186.144286192812, 5190.325257716549, 5192.376914770176, 5197.792088316501, 5202.323697919322, 4607.424071991001, 4643.233866412004, 4655.674102812838, 4678.6491013174145, 4730.290456431563, 6268.216472940882, 6281.371862813773, 6286.0, 6305.873882522324, 6316.336784637547, 6581.670916454158, 6599.8350041248395, 6602.86794264112, 6603.7688680895935, 6609.768658096944, 5600.0, 5602.795398989156, 6295.96852015737, 6330.335314791881, 6336.303006669263, 5724.914126288109, 5741.827745167651, 5790.392008839011, 5793.2179155814265, 5799.2750906136735, 6769.458443324522, 6818.454523637998, 6825.69284382194, 6846.315368463114, 6851.657417129223, 6376.808695739135, 6423.03654451836, 6426.036094585849, 6614.371634694697, 6618.371254730793, 6692.933070669231, 6757.560758550679, 6766.695498702472, 6796.082528858541, 6810.965945170243, 6455.806325810233, 6458.773942911976, 6466.579672321284, 6468.417842394207, 6487.54587178893, 6367.363263673781, 6478.060681201294, 6538.051982462612, 6551.115599394211, 6556.213254409501, 4991.925121123113, 6327.209098862642, 6335.778247761306, 6355.682215889095, 6422.421982021454, 6364.840878978062, 6373.107764913008, 6380.170577824853, 6380.266269378895, 6381.0, 6274.968625156845, 6309.49524038085, 6327.272363678236, 6349.238091429058, 6372.394622510854, 6263.3736626337, 6291.559590828598, 6303.149074875017, 6311.652859092794, 6357.110004599453, 6340.1440805490665, 6354.618722876642, 6357.427831495188, 6367.204099487564, 6373.617582944853], "value": 5989.896371078519, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.8985142080106, 751.2675141736806, 801.6673080671521, 989.090037165807, 1137.9374134422615, 27901.720982790164, 37659.0, 38301.0, 38319.42520862189, 38352.0, 40128.0, 40512.392314115314, 40523.594764052425, 40547.39178912318, 40609.0, 6131.294901086365, 8456.577171141449, 8649.135086491364, 8661.35039872009, 8671.0, 6186.226721659793, 8383.371247156458, 8551.486910785372, 8557.443766155211, 8563.058063612998, 8570.057293697688, 8635.40937718685, 8643.870341944876, 8657.913420865805, 8701.651933922667, 8543.700970466003, 8601.053884072748, 8608.053114157437, 8613.397062205617, 8621.439606425562, 8479.321654267644, 8551.957240213822, 8562.74311770648, 8575.313974881994, 8586.356023298278, 38143.664971725855, 38411.807940960396, 38415.61584384176, 38443.42334864979, 38567.61432385668, 3023.0779612218266, 3031.8332491712945, 3035.6812534683763, 3043.3000409905844, 3046.8781248750024, 23800.523989520287, 27818.860905695543, 27977.580336294974, 28323.150305490868, 28563.0, 2750.35366688828, 2790.868595775947, 2792.427552351763, 2792.539231026878, 2805.8316501010004, 331482.0, 332397.3380133108, 332892.0, 332899.0, 334370.0, 50984.98030039453, 51099.233511497354, 51185.48814511882, 51192.74403627958, 51227.743861280454, 53345.19982200192, 53362.0, 53499.73250133725, 53614.7319263409, 53620.0, 13720.519781807589, 14136.929315353358, 14140.858591413955, 14161.079529830527, 14183.71632567343, 9785.168260697921, 11458.484368203452, 11478.827817582744, 11481.0, 11487.597934072268, 10609.787804244026, 11381.439176185291, 11453.427328633701, 13188.0108991826, 13228.206307621573, 5298.966701493249, 5400.270963419888, 5406.810761623403, 5432.320959880015, 5448.0, 884.9646014159362, 989.5651305606899, 992.275638783692, 995.0894931137927, 1035.5547114740584, 22796.658050129263, 23906.7609323908, 23917.28248152558, 23975.160869369487, 23990.88004560001, 1086.706589220906, 1091.1979694924225, 1099.7910397024539, 1133.489929531714, 1146.4497041419997, 11610.071194304435, 12067.0, 12175.878241217475, 12197.268163910194, 12249.755004899853, 438965.0, 439040.0, 440202.0, 440810.0, 442768.0, 53678.0, 53683.19475207875, 53736.0, 53860.73069634627, 53965.0, 1460.6713489464998, 1477.6158198868156, 1518.2788175616715, 1526.0996012352543, 1532.7930729351617, 23327.650085248395, 23455.41361465977, 23483.0, 23503.41241468977, 23589.764102358757, 38487.845364639106, 38547.42178867375, 38562.8431147066, 38563.807180965036, 38695.0, 430493.0, 432045.0, 432143.0, 432261.0, 432348.0, 33593.5706084952, 34158.80444184442, 34332.99172644827, 34365.828170858986, 34513.137171569906, 42126.578734212264, 42433.36349954691, 43258.78370608127, 43297.35053974256, 43596.56403435925, 27209.0, 28779.568306475, 30014.24964375821, 30044.0, 30346.39307213799, 29045.85477072601, 29212.853935730185, 29928.850355748084, 29955.400891982474, 30154.159918421807, 34927.12682182966, 35984.28031439409, 36231.0, 36252.81873590615, 36318.45522317114, 28844.134675959755, 29719.554206686484, 30492.695073048984, 30885.0, 30942.0, 23027.0, 23658.52682946297, 23833.04667813268, 24344.75655243425, 24397.75602243955], "value": 17553.33049799932, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.87555982085746, 417.75770053369047, 429.9720518166318, 432.79442264924154, 442.08929605013674, 15973.600659983505, 21711.240106596273, 22065.33803985879, 22680.319590412295, 23013.079476820905, 22348.21781237657, 22898.77101228987, 23246.0, 23941.0, 24124.552526848358, 6040.063790112539, 6127.264728232618, 6331.113644089831, 6362.459190968773, 6399.26408463028, 3403.9319213615713, 6312.5896816707, 6338.397852204033, 6343.33394993526, 6344.968275158618, 3689.538590644487, 3925.9411108833247, 3931.1351502669368, 6364.427201551859, 6380.393862583047, 6066.817995460143, 6203.503719702436, 6316.147320111772, 6329.620222786648, 6338.778142765027, 5531.778728850841, 5597.412271711452, 5602.24369710088, 5609.663420194802, 5611.466910643482, 28444.862205511756, 28993.42013159746, 29077.41845163085, 29219.56170657442, 29608.55587166194, 1966.1250743419184, 2010.396880935728, 2035.521652411682, 2049.9692504612444, 2106.252280440437, 16079.919600401923, 17280.740788888175, 17336.913315433343, 17506.47480575572, 18054.0, 1653.9173041347885, 1798.4784412520353, 1891.0, 1936.3610008697096, 1939.2436949589671, 147904.260478698, 156427.0, 164578.0, 167172.0, 168801.15599421924, 11565.0, 11857.881421185677, 12190.329531875655, 12335.136540442083, 12589.545038717546, 15429.382824686887, 16127.193640317937, 16134.354625814836, 16617.0, 16652.250648720837, 6687.896497078025, 8762.255208307237, 8798.29613630908, 8934.73195804127, 9076.546172691338, 8499.787505312417, 8506.106858779864, 8536.975562932364, 8680.30557555394, 8699.782505437415, 6570.882949898433, 7259.564426134449, 7355.8161045974275, 7382.966384706146, 7864.685412583547, 1709.4615196213153, 1890.9527261818564, 1971.9885716569306, 2124.107874692633, 2143.7534683511285, 843.9071702112763, 940.8823897012874, 959.6689142245914, 960.3996213904469, 981.8625392445064, 16565.42021029258, 17870.0, 20473.48816279575, 21052.368428947157, 21847.344579662637, 817.3665409307833, 949.6154057606681, 953.2135987810084, 960.986159601627, 983.5918093990914, 9675.12923836844, 11069.114470842313, 11157.442127893573, 11211.0, 11247.943760281147, 695645.0, 712110.0, 713234.0, 715570.0, 726764.0, 153941.0, 163026.0, 163663.0, 164803.0, 165047.0, 1158.3567854158573, 1158.6176561734608, 1218.2203389830693, 1218.5186851193905, 1218.750156217991, 21423.46441338979, 22138.225162119248, 22237.867689280793, 22655.98048087873, 22781.0, 62570.0, 63786.36213637804, 64361.390965226245, 65210.347896522326, 65814.01278980915, 92334.07322974924, 92929.53535232281, 93699.0, 94344.0, 95636.56545151689, 8591.809088682347, 8607.0, 8777.51723655205, 8966.103389660982, 9022.503762293138, 13542.322883855571, 13644.181349118688, 13676.384562694902, 14033.228172450205, 14161.858381416054, 11228.217468004148, 11481.483333249857, 11719.707007324543, 11748.941255293668, 11788.174827762317, 10594.682159535227, 11232.0, 11599.420028998686, 11613.941930290295, 11633.825492617787, 11742.295462272292, 11863.881361186277, 12294.754104917673, 12320.876791231973, 12397.024714068739, 7149.320814522612, 8658.39391242607, 8835.33734969867, 9055.728328150166, 9130.406523576212, 10809.810920798864, 11577.942110289394, 11679.0, 11985.28088314704, 12015.639530814089], "value": 10469.64417274366, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.482693989754, 1451.5137428961298, 1458.8912426555814, 1475.0707054555635, 1475.8966872318938, 10456.790864182722, 10925.399103049329, 10927.071198948099, 10927.726806829833, 10942.343459392441, 10668.253222274443, 10669.733256668587, 10988.945055274733, 11006.669799905996, 11018.39398833064, 2420.854748715074, 2464.7412021737728, 2468.5309791139625, 2470.8023358131395, 2473.7402572729875, 2400.72948691757, 2404.8557086574774, 2450.901963921441, 2453.337598848319, 2455.373879660693, 2370.419247284418, 2436.013414567103, 2439.695038120235, 2444.5844206484853, 2452.828302018859, 2344.601417758985, 2414.14297924237, 2423.9394015149587, 2429.0769507587092, 2431.039739302983, 2408.0849277274697, 2420.189236605739, 2423.660687503751, 2428.6842710447704, 2436.2204094689705, 10675.83986240207, 10934.07060399859, 10957.671269861918, 10959.945200273947, 10963.232573719843, 6091.786787462417, 6333.018382150774, 6347.936520634827, 6349.46029587481, 6352.841178970517, 3419.7264218862433, 3983.701222408302, 3989.960100398988, 4052.1490486997764, 4073.5926407359325, 1196.5931583261645, 1520.3994422203277, 1564.702706485764, 1589.2530510659972, 1646.0452937296338, 15116.0, 15134.394624215018, 15253.542393728096, 15287.0, 15305.6173595661, 5025.39695236574, 5250.921236181461, 5262.526372626482, 5267.341582302212, 5363.410024897258, 11026.944865275622, 11044.33733975964, 11047.944760276147, 11050.392228427514, 11066.059384952208, 6178.6601736904, 6187.102870083812, 6192.566520343623, 6202.503799696014, 6217.222847144107, 5454.863628409322, 5719.456651618089, 5740.741666625012, 5796.1595568642315, 5799.39106393831, 4023.6403796788345, 4150.315197992358, 4156.8129434174925, 4177.143685544456, 4177.436046133794, 1202.8676845546984, 1206.7043574324346, 1218.713602303458, 1223.614561413152, 1226.47874653272, 740.2412527159704, 749.2956620776453, 769.1155171552759, 777.8016605765494, 797.3222760653514, 6206.72069756862, 6492.350764923564, 6705.329467053256, 6715.3620406061345, 6754.560953538103, 565.9830205093854, 568.9089745640678, 583.6060659055206, 588.4615576747314, 602.3855667219411, 3562.679358857715, 3972.841086356513, 4089.427480152781, 4203.600657937491, 4244.214820258262, 12837.293948832717, 13371.866281337258, 13379.130356526795, 13407.396667150002, 13421.932890335485, 12258.570950016885, 12749.17130386522, 13235.73528529424, 13308.0, 13728.794068088986, 7977.282044616012, 8703.95648021756, 8814.691485797966, 9211.217046550984, 10306.227032972558, 6599.967000164968, 6601.405873471411, 6792.422644075309, 6850.38346548813, 6921.688524016331, 10269.845952310572, 12493.312867792358, 12591.307478088427, 12605.43275552584, 12710.300933448749, 12599.68500787451, 12635.0, 12776.297303648389, 12904.0, 12958.80561791555, 8655.004674462518, 8927.464352138892, 9046.773830654023, 9058.456492610465, 9062.50156241413, 9949.403035817873, 9960.501974901372, 10053.597856085675, 10062.0, 10071.093601575893, 7951.284384405431, 7980.002499687539, 8016.6392512335915, 8125.349972002344, 8200.630971606412, 7055.223925368103, 8277.54473503963, 8409.915900841159, 8457.323414126979, 8600.827983440422, 7659.88510172359, 7830.647620857189, 7841.451098423056, 7844.568548729874, 7852.921470785447, 5736.254286942838, 5766.423357664368, 5936.37668044849, 5991.820245392645, 6026.367231440811, 5689.943100568941, 5830.737616807339, 5943.745447651674, 5975.492083172805, 6077.696115194134], "value": 5092.554120509727, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.9289731399691, 386.07342378292105, 391.37184818366524, 393.0684278260523, 399.42881679198734, 5429.91855122173, 5951.285845698522, 6063.151158837761, 6111.738656697023, 6123.510119190465, 5789.681567513785, 5941.88116237675, 5956.553258505608, 5962.284525856903, 5964.105384192373, 4279.229738647043, 4402.3176407656865, 4425.800838962238, 4446.7554284514335, 4460.4647442306805, 3903.8873920932538, 4425.712328698641, 4440.7335559866515, 4453.910921781562, 4458.66560007999, 3635.909102272438, 4381.605655491006, 4407.757573333465, 4413.668974826885, 4439.955600444003, 4216.840368898546, 4357.869263922087, 4424.933625995613, 4431.955680443202, 4433.623142032931, 3166.350898065914, 3780.032674350649, 3791.75353602015, 3799.639034291738, 3802.543694756619, 4887.7311747853855, 5823.330317013555, 5827.854303642401, 5841.299044114691, 5867.530597552186, 4326.668465281747, 5114.948850511484, 5186.299849520305, 5253.921191182136, 5260.0, 5595.356533998561, 6346.714397852062, 6362.300146983828, 6379.71291291893, 6395.392437718409, 4297.613214810651, 4301.354796780477, 4304.720193187464, 4308.956910430887, 4317.136572685476, 6515.771947981845, 6615.941449368078, 6744.190697116328, 6773.491988100863, 6784.253732089466, 3786.3563194257044, 4360.4767427908855, 4365.9126817463475, 4369.213541562485, 4369.366441865912, 4085.816138273785, 4442.511323754385, 4457.821687132543, 4468.620167285817, 4475.1049790042125, 5034.11902916988, 5152.690838549699, 5224.0, 5249.895002099936, 5262.97368513155, 5274.92087618686, 5620.81962787811, 5645.435456454322, 6356.618602883842, 6464.709088091047, 1444.7173465924025, 1517.757158854578, 1520.6350475885708, 1521.7260893039359, 1525.862672359493, 926.7673993588511, 949.4398305000083, 962.7881865989472, 997.7328792433714, 1010.6917390196061, 5326.6537675050995, 5789.565782566325, 6050.396644889108, 6068.575199736064, 6102.267727872683, 6363.045543168561, 6610.504212184105, 6620.9006864897065, 6638.7676431325635, 6654.866902662016, 6017.819465416044, 6024.337322894478, 6077.3314935357075, 6106.0, 6126.540509461808, 3419.897403077912, 3446.6902577021074, 3462.740828780614, 3463.168839478507, 3476.322117187124, 6532.477401807844, 6802.387785099365, 6836.760713375008, 6903.344182302673, 6909.619970901548, 5631.887362252732, 6561.671916404161, 6743.966280168568, 6873.347032031949, 6875.765376252738, 5487.0, 5753.769849205984, 5863.0, 6666.933330666631, 6772.390484856386, 4966.379202599675, 5825.6795876225515, 6657.4674026078765, 6659.833504162435, 6682.431993280431, 6490.545661803817, 6572.868542629025, 6577.6053436793945, 6582.934170658232, 6589.341065893373, 6829.863402732017, 6912.723491060502, 6926.549774264657, 6942.861142777015, 6949.722011119498, 4209.5477060414105, 4301.397804307462, 4342.457192850894, 4366.978165109154, 4369.934450983174, 5758.740856661544, 6362.936370636235, 6609.504287178577, 6620.768273110418, 6638.236602790547, 5065.645404821775, 5802.60737423007, 5961.612495187799, 6207.224096987877, 6418.582792118497, 4985.501449854985, 5249.816256431007, 5274.920876186937, 6399.904001440075, 6418.042497038448, 5300.840974770763, 5465.9726701366235, 6276.9372306276355, 6279.5729011048015, 6304.145807727932, 4800.231962885921, 6149.326511850936, 6370.8850951084305, 6392.306038899788, 6427.260865000585, 6260.74957001733, 6264.467520260829, 6273.843153921189, 6278.466330361788, 6303.905441418291], "value": 4636.281056493449, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.6396137969638, 708.7838209346147, 722.509602818483, 726.894600282959, 728.1044315491945, 15493.302801373937, 16574.834251657496, 16578.0, 16579.58551036223, 16596.50210493684, 14442.422303107864, 14447.78328325076, 14670.63323416915, 15201.923990380034, 15354.539363819076, 959.9424034557932, 972.2562239886493, 977.6382738386772, 977.8777652793401, 978.2223132609557, 962.1725316228038, 965.2037069417759, 970.7864269860619, 973.6738192705452, 976.3751199232497, 1069.1286601419856, 1079.7462596289904, 1081.5781845080426, 1082.648139354709, 1085.636311835532, 1071.571371451418, 1074.9355038697663, 1076.2466273608427, 1076.978460430787, 1077.6228320087946, 799.1568894815966, 799.6321692021677, 799.9920000799975, 800.3557136505111, 801.0627565748031, 15453.304601292968, 17064.48806535806, 17119.972801631942, 17186.484405467854, 17317.307307707677, 14562.635934101627, 14584.47008402864, 14675.339609717481, 14717.55847324582, 14740.1248436962, 10274.537645805956, 11584.768304633944, 11936.16446848721, 11961.521539138424, 12047.975922046637, 2866.312085099582, 2994.7454466370386, 3004.309008927937, 3056.694330566948, 3062.2038270049725, 110329.0, 114547.0, 114711.0, 118785.21822172674, 119249.0, 10873.945630271955, 11291.49188286529, 11340.43297835105, 11408.315501069963, 12190.57332993341, 24382.146624868044, 24947.25158245219, 25116.372090697514, 25128.748712513006, 25265.747342526338, 7704.114026886979, 7817.609119544114, 8057.395695322874, 8085.5957202140835, 8089.191080891864, 4016.6004872531717, 4141.6065473779945, 4177.728447650893, 4190.476190476191, 4237.894052648709, 4141.130362623822, 4260.936085958713, 4263.467066616673, 4264.232438161161, 4264.722793018444, 829.1708291708292, 856.3406177243488, 870.4733636150038, 873.1792115411492, 901.4230892228978, 502.4222144533815, 528.9312389389355, 573.1832139201621, 576.7750577274866, 577.1806110800874, 9525.095115963972, 10127.98720127996, 10230.897691022994, 10297.794044119075, 10583.947080264703, 507.441814004592, 542.3410556174189, 549.2502733768457, 576.0897781505212, 578.3262499188398, 4421.5578442156175, 4707.6233901287815, 4717.481077081518, 4815.425296171054, 4875.171220892456, 92777.53611231901, 94694.5265273683, 94863.0, 95773.0, 96649.5167524172, 79854.00364990922, 82171.0, 82552.58723706462, 83705.58147209225, 83778.0, 82101.0, 82264.58867705743, 84147.31705365858, 84261.57869210615, 85338.0, 9312.0, 9342.252619790537, 9407.153356197976, 9444.65395073732, 9501.524923753923, 40008.79995600003, 41113.58886411217, 41204.38193427041, 42011.7899410501, 42197.0, 53375.0, 53832.461675384315, 54076.729616351666, 54322.7283863594, 55092.72453637706, 11712.648620541397, 11821.440467726981, 11837.644870653894, 12377.0, 12473.5010599575, 12377.814332784836, 12717.936410317889, 12721.173123746927, 12724.554640587905, 13080.607581772181, 11575.88424115748, 11837.0, 11963.0, 12160.695982600506, 12360.81458778137, 11524.0, 11631.709207269885, 11899.46452409661, 11904.642860714192, 12491.437885295365, 11760.0, 12185.51257949672, 12255.75488490243, 12290.692732681755, 13448.394822233218, 9684.921342383448, 9868.062534059252, 9995.650152244636, 10279.94860025725, 10305.175585953255, 7934.642941067781, 8490.938632670915, 9580.281478888972, 11041.0, 11042.392668403316], "value": 7469.266846759693, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1659.6999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 122.0, 125.0, 122.0, 123.0, 125.0, 123.0, 133.0, 124.0, 123.0], "value": 123.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 120.0, 120.0, 164.0, 121.0, 119.0, 122.0, 136.0, 182.0, 161.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [211.0, 219.0, 224.0, 186.0, 295.0, 280.0, 212.0, 230.0, 212.0, 188.0], "value": 225.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 64.0, 63.0, 101.0, 65.0, 66.0, 63.0, 76.0, 80.0, 66.0], "value": 72.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 78.0, 94.0, 77.0, 74.0, 73.0, 89.0, 73.0, 76.0, 91.0], "value": 81.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 93.0, 94.0, 95.0, 138.0, 96.0, 121.0, 140.0], "value": 105.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 101.0, 103.0, 103.0, 101.0, 100.0, 101.0, 102.0, 112.0, 102.0], "value": 102.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 160.0, 125.0, 162.0, 143.0, 103.0, 101.0, 102.0, 103.0, 101.0], "value": 122.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 51.0, 51.0, 53.0, 53.0, 52.0, 52.0, 52.0, 51.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 67.0, 70.0, 68.0, 70.0, 63.0, 63.0, 63.0, 63.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 121.0, 84.0, 117.0, 116.0, 117.0, 106.0, 90.0, 90.0, 90.0], "value": 104.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 160.0, 163.0, 169.0, 138.0, 150.0, 155.0, 163.0, 249.0, 153.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 253.0, 248.0, 250.0, 203.0, 200.0, 226.0, 252.0, 202.0, 198.0], "value": 223.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 75.0, 75.0, 76.0, 73.0, 72.0, 72.0, 77.0, 91.0], "value": 75.6, "unit": "score"}]}]} 12:52:34 INFO - Return code: 0 12:52:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:52:34 ERROR - # TBPL SUCCESS # 12:52:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:52:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:52:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:52:34 INFO - 2017-03-31 12:52:34.735 screenresolution[1925:16635] starting screenresolution argv=screenresolution get 12:52:34 INFO - 2017-03-31 12:52:34.737 screenresolution[1925:16635] Display 0: 1600x1200x32@60 12:52:34 INFO - 2017-03-31 12:52:34.744 screenresolution[1926:16638] starting screenresolution argv=screenresolution list 12:52:34 INFO - Available Modes on Display 0 12:52:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:52:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:52:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:52:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:52:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:52:34 INFO - Intel Iris: 12:52:34 INFO - Chipset Model: Intel Iris 12:52:34 INFO - Type: GPU 12:52:34 INFO - Bus: Built-In 12:52:34 INFO - VRAM (Dynamic, Max): 1536 MB 12:52:34 INFO - Vendor: Intel (0x8086) 12:52:34 INFO - Device ID: 0x0a2e 12:52:34 INFO - Revision ID: 0x0009 12:52:34 INFO - Displays: 12:52:34 INFO - Display: 12:52:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:52:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:52:34 INFO - Display Serial Number: 1600x1200 60 12:52:34 INFO - Main Display: Yes 12:52:34 INFO - Mirror: Off 12:52:34 INFO - Online: Yes 12:52:34 INFO - Rotation: Supported 12:52:34 INFO - Return code: 0 12:52:34 INFO - Running post-action listener: _resource_record_post_action 12:52:34 INFO - [mozharness: 2017-03-31 19:52:34.981955Z] Finished run-tests step (success) 12:52:34 INFO - Running post-run listener: _resource_record_post_run 12:52:35 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 1134592; Write bytes: 513784320; Read time: 13; Write time: 1568 12:52:35 INFO - TinderboxPrint: CPU usage
53.4% 12:52:35 INFO - TinderboxPrint: I/O read bytes / time
1,134,592 / 13 12:52:35 INFO - TinderboxPrint: I/O write bytes / time
513,784,320 / 1,568 12:52:35 INFO - TinderboxPrint: CPU idle
2,246.3 (46.5%) 12:52:35 INFO - TinderboxPrint: CPU system
967.5 (20.1%) 12:52:35 INFO - TinderboxPrint: CPU user
1,611.8 (33.4%) 12:52:35 INFO - TinderboxPrint: Swap in / out
213,512,192 / 0 12:52:35 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 209103360; Write bytes: 206149632; Read time: 16725; Write time: 447 12:52:35 INFO - run-tests - Wall time: 1186s; CPU: 53.0%; Read bytes: 1134592; Write bytes: 296985088; Read time: 13; Write time: 1085 12:52:35 INFO - Running post-run listener: _upload_blobber_files 12:52:35 INFO - Blob upload gear active. 12:52:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:52:35 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 12:52:35 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'] 12:52:35 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 12:52:35 INFO - (blobuploader) - INFO - Open directory for files ... 12:52:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:52:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:52:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:52:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:52:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:52:36 INFO - (blobuploader) - INFO - Done attempting. 12:52:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:52:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:52:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:52:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:52:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:52:37 INFO - (blobuploader) - INFO - Done attempting. 12:52:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:52:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:52:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:52:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:52:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:52:38 INFO - (blobuploader) - INFO - Done attempting. 12:52:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:52:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:52:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:52:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:52:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:52:41 INFO - (blobuploader) - INFO - Done attempting. 12:52:41 INFO - (blobuploader) - INFO - Iteration through files over. 12:52:41 INFO - Return code: 0 12:52:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:52:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:52:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cab051f64026c5dedf9aec5aed20c4c75aecdaec239176e947856939245d4c810f0bf9a3f6d5ff2f04f137addca4573fb2291cbdaccfe499f159caa42a1400bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/465e36db40b11021dc521e33ebc17c8ed4613cccc0cdf3dc2bf2ed70fa45b10ede2a9277a9845265ee0846a9f10c6b3f4e1a98d9e2cc8c2c45c4fab00d252e47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06d452558ab18dc69838c135aa0eada57b19b7b8378f8117d617f8058bd651e94e28aaf2bd5c1ece9ce3fdb5cfcf75de13fb783d08428423ec3d52f24f4feb1f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64cd5a23dc7e46eb6c5349cc3a2c8f9b8c70a3f0de774231093f1d60461c6cc1bdb4e0373844bf622cdd3d020c582dd68382648d993ec188fbaddbfbd1353cb8"} 12:52:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:52:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:52:41 INFO - Contents: 12:52:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cab051f64026c5dedf9aec5aed20c4c75aecdaec239176e947856939245d4c810f0bf9a3f6d5ff2f04f137addca4573fb2291cbdaccfe499f159caa42a1400bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/465e36db40b11021dc521e33ebc17c8ed4613cccc0cdf3dc2bf2ed70fa45b10ede2a9277a9845265ee0846a9f10c6b3f4e1a98d9e2cc8c2c45c4fab00d252e47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06d452558ab18dc69838c135aa0eada57b19b7b8378f8117d617f8058bd651e94e28aaf2bd5c1ece9ce3fdb5cfcf75de13fb783d08428423ec3d52f24f4feb1f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64cd5a23dc7e46eb6c5349cc3a2c8f9b8c70a3f0de774231093f1d60461c6cc1bdb4e0373844bf622cdd3d020c582dd68382648d993ec188fbaddbfbd1353cb8"} 12:52:41 INFO - Running post-run listener: copy_logs_to_upload_dir 12:52:41 INFO - Copying logs to upload dir... 12:52:41 INFO - mkdir: /builds/slave/test/build/upload/logs 12:52:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1289.091508 ========= master_lag: 2.56 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2017-03-31 12:52:43.833597) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 12:52:43.837391) ========= 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.IFhEhbBAz0/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.FefhfuE29r/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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/cab051f64026c5dedf9aec5aed20c4c75aecdaec239176e947856939245d4c810f0bf9a3f6d5ff2f04f137addca4573fb2291cbdaccfe499f159caa42a1400bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/465e36db40b11021dc521e33ebc17c8ed4613cccc0cdf3dc2bf2ed70fa45b10ede2a9277a9845265ee0846a9f10c6b3f4e1a98d9e2cc8c2c45c4fab00d252e47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06d452558ab18dc69838c135aa0eada57b19b7b8378f8117d617f8058bd651e94e28aaf2bd5c1ece9ce3fdb5cfcf75de13fb783d08428423ec3d52f24f4feb1f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64cd5a23dc7e46eb6c5349cc3a2c8f9b8c70a3f0de774231093f1d60461c6cc1bdb4e0373844bf622cdd3d020c582dd68382648d993ec188fbaddbfbd1353cb8"} build_url:https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011182 build_url: 'https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/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/cab051f64026c5dedf9aec5aed20c4c75aecdaec239176e947856939245d4c810f0bf9a3f6d5ff2f04f137addca4573fb2291cbdaccfe499f159caa42a1400bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/465e36db40b11021dc521e33ebc17c8ed4613cccc0cdf3dc2bf2ed70fa45b10ede2a9277a9845265ee0846a9f10c6b3f4e1a98d9e2cc8c2c45c4fab00d252e47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06d452558ab18dc69838c135aa0eada57b19b7b8378f8117d617f8058bd651e94e28aaf2bd5c1ece9ce3fdb5cfcf75de13fb783d08428423ec3d52f24f4feb1f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64cd5a23dc7e46eb6c5349cc3a2c8f9b8c70a3f0de774231093f1d60461c6cc1bdb4e0373844bf622cdd3d020c582dd68382648d993ec188fbaddbfbd1353cb8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 12:52:43.872306) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 12:52:43.872654) ========= 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.IFhEhbBAz0/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.FefhfuE29r/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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.005336 ========= master_lag: 0.67 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 12:52:44.548848) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 12:52:44.549165) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 12:52:44.549792) ========= ========= Total master_lag: 3.33 =========