builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0058 starttime: 1489169699.13 results: success (0) buildid: 20170310084422 builduid: 85e318f108f84e02a096b09d9f7e56a7 revision: edd424223fb1c336294a0cc1ca0e31cbec79ec31 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 10:14:59.130130) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 10:14:59.130546) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 10:14:59.130833) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 10:14:59.240213) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 10:14:59.240486) ========= 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.vRPjOa7mw0/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.yZrw4vBPnQ/Listeners TMPDIR=/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/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-10 10:14:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2017-03-10 10:14:59 (161 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127590 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 10:14:59.392137) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 10:14:59.392447) ========= 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.vRPjOa7mw0/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.yZrw4vBPnQ/Listeners TMPDIR=/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/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.027347 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 10:14:59.441738) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-10 10:14:59.442097) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev edd424223fb1c336294a0cc1ca0e31cbec79ec31 --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 edd424223fb1c336294a0cc1ca0e31cbec79ec31 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vRPjOa7mw0/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.yZrw4vBPnQ/Listeners TMPDIR=/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/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-10 10:14:59,552 truncating revision to first 12 chars 2017-03-10 10:14:59,552 Setting DEBUG logging. 2017-03-10 10:14:59,552 attempt 1/10 2017-03-10 10:14:59,552 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/edd424223fb1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-10 10:15:00,493 unpacking tar archive at: mozilla-central-edd424223fb1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.227018 ========= master_lag: 0.50 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-10 10:15:01.165414) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 10:15:01.165695) ========= script_repo_revision: edd424223fb1c336294a0cc1ca0e31cbec79ec31 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 10:15:01.166083) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 10:15:01.166349) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 10:15:01.189586) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-03-10 10:15:01.189889) ========= /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.vRPjOa7mw0/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.yZrw4vBPnQ/Listeners TMPDIR=/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/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 10:15:01 INFO - MultiFileLogger online at 20170310 10:15:01 in /builds/slave/test 10:15:01 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 10:15:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:15:01 INFO - {'append_to_log': False, 10:15:01 INFO - 'base_work_dir': '/builds/slave/test', 10:15:01 INFO - 'blob_upload_branch': 'Firefox', 10:15:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:15:01 INFO - 'branch': 'Firefox', 10:15:01 INFO - 'buildbot_json_path': 'buildprops.json', 10:15:01 INFO - 'config_files': ('talos/mac_config.py',), 10:15:01 INFO - 'default_actions': ('clobber', 10:15:01 INFO - 'read-buildbot-config', 10:15:01 INFO - 'download-and-extract', 10:15:01 INFO - 'populate-webroot', 10:15:01 INFO - 'create-virtualenv', 10:15:01 INFO - 'install', 10:15:01 INFO - 'run-tests'), 10:15:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:15:01 INFO - 'download_minidump_stackwalk': True, 10:15:01 INFO - 'download_symbols': 'ondemand', 10:15:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:15:01 INFO - 'tooltool.py': '/tools/tooltool.py', 10:15:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:15:01 INFO - '/tools/misc-python/virtualenv.py')}, 10:15:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:15:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:15:01 INFO - 'gecko_profile': False, 10:15:01 INFO - 'gecko_profile_interval': 0, 10:15:01 INFO - 'installer_path': 'installer.exe', 10:15:01 INFO - 'log_level': 'info', 10:15:01 INFO - 'log_name': 'talos', 10:15:01 INFO - 'log_to_console': True, 10:15:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:15:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:15:01 INFO - 'opt_config_files': (), 10:15:01 INFO - 'pip_index': False, 10:15:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:15:01 INFO - 'cmd': ('bash', 10:15:01 INFO - '-c', 10:15:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:15:01 INFO - 'enabled': True, 10:15:01 INFO - 'halt_on_failure': False, 10:15:01 INFO - 'name': 'check_screen_resolution'},), 10:15:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:15:01 INFO - 'cmd': ('bash', 10:15:01 INFO - '-c', 10:15:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:15:01 INFO - 'enabled': True, 10:15:01 INFO - 'halt_on_failure': False, 10:15:01 INFO - 'name': 'check_screen_resolution'},), 10:15:01 INFO - 'run_cmd_checks_enabled': True, 10:15:01 INFO - 'suite': 'dromaeojs', 10:15:01 INFO - 'system_bits': '32', 10:15:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:15:01 INFO - 'title': 't-yosemite-r7-0058', 10:15:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:15:01 INFO - 'use_talos_json': True, 10:15:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:15:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:15:01 INFO - 'work_dir': 'build'} 10:15:01 INFO - [mozharness: 2017-03-10 18:15:01.403496Z] Running clobber step. 10:15:01 INFO - Running pre-action listener: _resource_record_pre_action 10:15:01 INFO - Running main action method: clobber 10:15:01 INFO - rmtree: /builds/slave/test/build 10:15:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:15:04 INFO - Running post-action listener: _resource_record_post_action 10:15:04 INFO - [mozharness: 2017-03-10 18:15:04.073038Z] Finished clobber step (success) 10:15:04 INFO - [mozharness: 2017-03-10 18:15:04.073166Z] Running read-buildbot-config step. 10:15:04 INFO - Running pre-action listener: _resource_record_pre_action 10:15:04 INFO - Running main action method: read_buildbot_config 10:15:04 INFO - Using buildbot properties: 10:15:04 INFO - { 10:15:04 INFO - "project": "", 10:15:04 INFO - "product": "firefox", 10:15:04 INFO - "script_repo_revision": "production", 10:15:04 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 10:15:04 INFO - "repository": "", 10:15:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 10:15:04 INFO - "buildid": "20170310084422", 10:15:04 INFO - "pgo_build": "False", 10:15:04 INFO - "basedir": "/builds/slave/test", 10:15:04 INFO - "buildnumber": 5, 10:15:04 INFO - "slavename": "t-yosemite-r7-0058", 10:15:04 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 10:15:04 INFO - "platform": "yosemite_r7", 10:15:04 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:15:04 INFO - "branch": "mozilla-central", 10:15:04 INFO - "repo_path": "mozilla-central", 10:15:04 INFO - "revision": "edd424223fb1c336294a0cc1ca0e31cbec79ec31", 10:15:04 INFO - "stage_platform": "macosx64", 10:15:04 INFO - "builduid": "85e318f108f84e02a096b09d9f7e56a7", 10:15:04 INFO - "slavebuilddir": "test" 10:15:04 INFO - } 10:15:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 10:15:04 INFO - Running post-action listener: _resource_record_post_action 10:15:04 INFO - [mozharness: 2017-03-10 18:15:04.076715Z] Finished read-buildbot-config step (success) 10:15:04 INFO - [mozharness: 2017-03-10 18:15:04.076827Z] Running download-and-extract step. 10:15:04 INFO - Running pre-action listener: _resource_record_pre_action 10:15:04 INFO - Running main action method: download_and_extract 10:15:04 INFO - mkdir: /builds/slave/test/build/tests 10:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:04 INFO - trying https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 10:15:04 INFO - Downloading https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/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 10:15:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/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 10:15:04 INFO - Downloaded 1199 bytes. 10:15:04 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:15:04 INFO - Using the following test package requirements: 10:15:04 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:15:04 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:15:04 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 10:15:04 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:15:04 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 10:15:04 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:15:04 INFO - u'jsshell-mac.zip'], 10:15:04 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:15:04 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 10:15:04 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:15:04 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:15:04 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 10:15:04 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:15:04 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 10:15:04 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:15:04 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 10:15:04 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:15:04 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 10:15:04 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:15:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:15:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:15:04 INFO - Fetch https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:15:06 INFO - Expected file size: 51789467 10:15:06 INFO - Obtained file size: 51789467 10:15:23 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 10:15:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:15:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:15:23 INFO - Fetch https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:15:25 INFO - Expected file size: 51789467 10:15:25 INFO - Obtained file size: 51789467 10:15:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 10:15:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:15:40 INFO - Fetch https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 10:15:41 INFO - Expected file size: 14404424 10:15:41 INFO - Obtained file size: 14404424 10:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:42 INFO - trying https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:15:42 INFO - Downloading https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 10:15:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/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 10:15:44 INFO - Downloaded 74939291 bytes. 10:15:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:15:44 INFO - mkdir: /builds/slave/test/properties 10:15:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:15:44 INFO - Writing to file /builds/slave/test/properties/build_url 10:15:44 INFO - Contents: 10:15:44 INFO - build_url:https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:15:45 INFO - Running post-action listener: _resource_record_post_action 10:15:45 INFO - Running post-action listener: set_extra_try_arguments 10:15:45 INFO - [mozharness: 2017-03-10 18:15:45.015719Z] Finished download-and-extract step (success) 10:15:45 INFO - [mozharness: 2017-03-10 18:15:45.015864Z] Running populate-webroot step. 10:15:45 INFO - Running pre-action listener: _resource_record_pre_action 10:15:45 INFO - Running main action method: populate_webroot 10:15:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:15:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:15:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:15:45 INFO - '--tppagecycles', 10:15:45 INFO - '7'], 10:15:45 INFO - 'tests': ['tsvgm']}}, 10:15:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:15:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:15:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:15:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:15:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:15:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:15:45 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:15:45 INFO - 'talos_options': ['--disable-e10s'], 10:15:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:15:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:45 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:15:45 INFO - 'talos_options': ['--disable-e10s'], 10:15:45 INFO - 'tests': ['damp', 'tps']}, 10:15:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:15:45 INFO - 'tests': ['damp', 'tps']}, 10:15:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:15:45 INFO - 'tests': ['dromaeo_dom']}, 10:15:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:15:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:15:45 INFO - 'tests': ['basic_compositor_video']}, 10:15:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:15:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:15:45 INFO - 'tests': ['a11yr', 10:15:45 INFO - 'ts_paint', 10:15:45 INFO - 'tpaint', 10:15:45 INFO - 'sessionrestore', 10:15:45 INFO - 'sessionrestore_no_auto_restore', 10:15:45 INFO - 'tabpaint']}, 10:15:45 INFO - 'other-e10s': {'tests': ['a11yr', 10:15:45 INFO - 'ts_paint', 10:15:45 INFO - 'tpaint', 10:15:45 INFO - 'sessionrestore', 10:15:45 INFO - 'sessionrestore_no_auto_restore', 10:15:45 INFO - 'tabpaint']}, 10:15:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:15:45 INFO - 'ts_paint', 10:15:45 INFO - 'tpaint', 10:15:45 INFO - 'sessionrestore', 10:15:45 INFO - 'sessionrestore_no_auto_restore', 10:15:45 INFO - 'tabpaint']}, 10:15:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:15:45 INFO - 'ts_paint', 10:15:45 INFO - 'tpaint', 10:15:45 INFO - 'sessionrestore', 10:15:45 INFO - 'sessionrestore_no_auto_restore', 10:15:45 INFO - 'tabpaint']}, 10:15:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:15:45 INFO - 'tests': ['a11yr', 10:15:45 INFO - 'ts_paint', 10:15:45 INFO - 'tpaint', 10:15:45 INFO - 'sessionrestore', 10:15:45 INFO - 'sessionrestore_no_auto_restore', 10:15:45 INFO - 'tabpaint']}, 10:15:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:15:45 INFO - 'tests': ['a11yr', 10:15:45 INFO - 'ts_paint', 10:15:45 INFO - 'tpaint', 10:15:45 INFO - 'sessionrestore', 10:15:45 INFO - 'sessionrestore_no_auto_restore', 10:15:45 INFO - 'tabpaint']}, 10:15:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:15:45 INFO - 'tests': ['tsvgx', 10:15:45 INFO - 'tsvgr_opacity', 10:15:45 INFO - 'tart', 10:15:45 INFO - 'tscrollx', 10:15:45 INFO - 'cart', 10:15:45 INFO - 'tsvg_static']}, 10:15:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:15:45 INFO - 'tsvgr_opacity', 10:15:45 INFO - 'tart', 10:15:45 INFO - 'tscrollx', 10:15:45 INFO - 'cart', 10:15:45 INFO - 'tsvg_static']}, 10:15:45 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:15:45 INFO - 'talos_options': ['--disable-e10s'], 10:15:45 INFO - 'tests': ['tp5o']}, 10:15:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:15:45 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:15:45 INFO - 'talos_options': ['--disable-e10s', 10:15:45 INFO - '--xperf_path', 10:15:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:45 INFO - 'tests': ['tp5n']}, 10:15:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:15:45 INFO - 'talos_options': ['--xperf_path', 10:15:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:45 INFO - 'tests': ['tp5n']}}, 10:15:45 INFO - 'talos.zip': {'path': '', 10:15:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:15:45 INFO - Running post-action listener: _resource_record_post_action 10:15:45 INFO - [mozharness: 2017-03-10 18:15:45.034795Z] Finished populate-webroot step (success) 10:15:45 INFO - [mozharness: 2017-03-10 18:15:45.034930Z] Running create-virtualenv step. 10:15:45 INFO - Running pre-action listener: _resource_record_pre_action 10:15:45 INFO - Running main action method: create_virtualenv 10:15:45 INFO - Creating virtualenv /builds/slave/test/build/venv 10:15:45 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 10:15:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:15:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:15:45 INFO - Using real prefix '/tools/python27' 10:15:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:15:45 INFO - Installing distribute.............................................................................................................................................................................................done. 10:15:48 INFO - Installing pip.................done. 10:15:48 INFO - Return code: 0 10:15:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:15:49 INFO - Reading from file tmpfile_stdout 10:15:49 INFO - Output received: 10:15:49 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) 10:15:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:15: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')]} 10:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15: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')]} 10:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105d68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd37bdbc6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b46d30>, '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 0x105a6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3bbe8>, '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.vRPjOa7mw0/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.yZrw4vBPnQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/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 10:15:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:15:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vRPjOa7mw0/Render', 10:15:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:49 INFO - 'HOME': '/Users/cltbld', 10:15:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:49 INFO - 'LOGNAME': 'cltbld', 10:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:49 INFO - 'MOZ_NO_REMOTE': '1', 10:15:49 INFO - 'NO_EM_RESTART': '1', 10:15:49 INFO - 'PAGER': '/bin/cat', 10:15:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:49 INFO - 'PWD': '/builds/slave/test', 10:15:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:49 INFO - 'SHELL': '/bin/bash', 10:15:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yZrw4vBPnQ/Listeners', 10:15:49 INFO - 'TMPDIR': '/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/', 10:15:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:49 INFO - 'USER': 'cltbld', 10:15:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:49 INFO - 'XPC_FLAGS': '0x0', 10:15:49 INFO - 'XPC_SERVICE_NAME': '0', 10:15:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:49 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 10:15:49 INFO - Cleaning up... 10:15:49 INFO - Return code: 0 10:15:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:15: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')]} 10:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15: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')]} 10:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105d68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd37bdbc6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b46d30>, '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 0x105a6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3bbe8>, '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.vRPjOa7mw0/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.yZrw4vBPnQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/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 10:15:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:15:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vRPjOa7mw0/Render', 10:15:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:49 INFO - 'HOME': '/Users/cltbld', 10:15:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:49 INFO - 'LOGNAME': 'cltbld', 10:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:49 INFO - 'MOZ_NO_REMOTE': '1', 10:15:49 INFO - 'NO_EM_RESTART': '1', 10:15:49 INFO - 'PAGER': '/bin/cat', 10:15:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:49 INFO - 'PWD': '/builds/slave/test', 10:15:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:49 INFO - 'SHELL': '/bin/bash', 10:15:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yZrw4vBPnQ/Listeners', 10:15:49 INFO - 'TMPDIR': '/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/', 10:15:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:49 INFO - 'USER': 'cltbld', 10:15:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:49 INFO - 'XPC_FLAGS': '0x0', 10:15:49 INFO - 'XPC_SERVICE_NAME': '0', 10:15:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:49 INFO - Downloading/unpacking psutil>=3.1.1 10:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:15:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:53 INFO - Installing collected packages: psutil 10:15:53 INFO - Running setup.py install for psutil 10:15:53 INFO - building 'psutil._psutil_osx' extension 10:15:53 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 10:15:53 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 10:15:53 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 10:15:54 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 10:15:54 INFO - building 'psutil._psutil_posix' extension 10:15:54 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 10:15:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:15:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:15:54 INFO - ^ 10:15:54 INFO - 1 warning generated. 10:15:54 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 10:15:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:54 INFO - Successfully installed psutil 10:15:54 INFO - Cleaning up... 10:15:54 INFO - Return code: 0 10:15:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:55 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 0x105d68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd37bdbc6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b46d30>, '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 0x105a6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3bbe8>, '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.vRPjOa7mw0/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.yZrw4vBPnQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/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 10:15:55 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 10:15:55 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 10:15:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vRPjOa7mw0/Render', 10:15:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:55 INFO - 'HOME': '/Users/cltbld', 10:15:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:55 INFO - 'LOGNAME': 'cltbld', 10:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:55 INFO - 'MOZ_NO_REMOTE': '1', 10:15:55 INFO - 'NO_EM_RESTART': '1', 10:15:55 INFO - 'PAGER': '/bin/cat', 10:15:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:55 INFO - 'PWD': '/builds/slave/test', 10:15:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:55 INFO - 'SHELL': '/bin/bash', 10:15:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yZrw4vBPnQ/Listeners', 10:15:55 INFO - 'TMPDIR': '/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/', 10:15:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:55 INFO - 'USER': 'cltbld', 10:15:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:55 INFO - 'XPC_FLAGS': '0x0', 10:15:55 INFO - 'XPC_SERVICE_NAME': '0', 10:15:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:15:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:15:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:15:58 INFO - Installing collected packages: mozsystemmonitor 10:15:58 INFO - Running setup.py install for mozsystemmonitor 10:15:58 INFO - Successfully installed mozsystemmonitor 10:15:58 INFO - Cleaning up... 10:15:58 INFO - Return code: 0 10:15:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:15: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')]} 10:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15: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')]} 10:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15: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', '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 0x105d68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd37bdbc6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b46d30>, '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 0x105a6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3bbe8>, '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.vRPjOa7mw0/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.yZrw4vBPnQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/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 10:15: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:15: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 jsonschema==2.5.1 10:15:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vRPjOa7mw0/Render', 10:15:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:58 INFO - 'HOME': '/Users/cltbld', 10:15:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:58 INFO - 'LOGNAME': 'cltbld', 10:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:58 INFO - 'MOZ_NO_REMOTE': '1', 10:15:58 INFO - 'NO_EM_RESTART': '1', 10:15:58 INFO - 'PAGER': '/bin/cat', 10:15:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:58 INFO - 'PWD': '/builds/slave/test', 10:15:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:58 INFO - 'SHELL': '/bin/bash', 10:15:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yZrw4vBPnQ/Listeners', 10:15:58 INFO - 'TMPDIR': '/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/', 10:15:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:58 INFO - 'USER': 'cltbld', 10:15:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:58 INFO - 'XPC_FLAGS': '0x0', 10:15:58 INFO - 'XPC_SERVICE_NAME': '0', 10:15:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:58 INFO - Downloading/unpacking jsonschema==2.5.1 10:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:16:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:16:01 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 10:16:01 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 10:16:01 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 10:16:01 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 10:16:01 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 10:16:01 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 10:16:02 INFO - Downloading functools32-3.2.3-2.tar.gz 10:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:16:02 INFO - warning: no files found matching '*.txt' 10:16:02 INFO - no previously-included directories found matching 'build' 10:16:02 INFO - no previously-included directories found matching 'dist' 10:16:02 INFO - no previously-included directories found matching '.git*' 10:16:02 INFO - Installing collected packages: jsonschema, functools32 10:16:02 INFO - Running setup.py install for functools32 10:16:02 INFO - warning: no files found matching '*.txt' 10:16:02 INFO - no previously-included directories found matching 'build' 10:16:02 INFO - no previously-included directories found matching 'dist' 10:16:02 INFO - no previously-included directories found matching '.git*' 10:16:02 INFO - Successfully installed jsonschema functools32 10:16:02 INFO - Cleaning up... 10:16:02 INFO - Return code: 0 10:16:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:02 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 0x105d68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd37bdbc6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b46d30>, '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 0x105a6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3bbe8>, '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.vRPjOa7mw0/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.yZrw4vBPnQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/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 10:16:02 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 10:16:02 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 10:16:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vRPjOa7mw0/Render', 10:16:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:02 INFO - 'HOME': '/Users/cltbld', 10:16:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:02 INFO - 'LOGNAME': 'cltbld', 10:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:02 INFO - 'MOZ_NO_REMOTE': '1', 10:16:02 INFO - 'NO_EM_RESTART': '1', 10:16:02 INFO - 'PAGER': '/bin/cat', 10:16:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:02 INFO - 'PWD': '/builds/slave/test', 10:16:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:02 INFO - 'SHELL': '/bin/bash', 10:16:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yZrw4vBPnQ/Listeners', 10:16:02 INFO - 'TMPDIR': '/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/', 10:16:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:02 INFO - 'USER': 'cltbld', 10:16:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:02 INFO - 'XPC_FLAGS': '0x0', 10:16:02 INFO - 'XPC_SERVICE_NAME': '0', 10:16:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:16:02 INFO - Cleaning up... 10:16:02 INFO - Return code: 0 10:16:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:02 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 0x105d68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd37bdbc6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b46d30>, '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 0x105a6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3bbe8>, '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.vRPjOa7mw0/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.yZrw4vBPnQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/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 10:16:02 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 10:16:02 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 10:16:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vRPjOa7mw0/Render', 10:16:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:02 INFO - 'HOME': '/Users/cltbld', 10:16:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:02 INFO - 'LOGNAME': 'cltbld', 10:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:02 INFO - 'MOZ_NO_REMOTE': '1', 10:16:02 INFO - 'NO_EM_RESTART': '1', 10:16:02 INFO - 'PAGER': '/bin/cat', 10:16:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:02 INFO - 'PWD': '/builds/slave/test', 10:16:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:02 INFO - 'SHELL': '/bin/bash', 10:16:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yZrw4vBPnQ/Listeners', 10:16:02 INFO - 'TMPDIR': '/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/', 10:16:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:02 INFO - 'USER': 'cltbld', 10:16:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:02 INFO - 'XPC_FLAGS': '0x0', 10:16:02 INFO - 'XPC_SERVICE_NAME': '0', 10:16:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:02 INFO - Downloading/unpacking blobuploader==1.2.4 10:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:05 INFO - Downloading blobuploader-1.2.4.tar.gz 10:16:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:16:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:16:05 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 10:16:05 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 10:16:05 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 10:16:05 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 10:16:05 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 10:16:05 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 10:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:16:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:06 INFO - Downloading docopt-0.6.1.tar.gz 10:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:16:06 INFO - Installing collected packages: blobuploader, requests, docopt 10:16:06 INFO - Running setup.py install for blobuploader 10:16:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:16:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:16:07 INFO - Running setup.py install for requests 10:16:07 INFO - Running setup.py install for docopt 10:16:07 INFO - Successfully installed blobuploader requests docopt 10:16:07 INFO - Cleaning up... 10:16:07 INFO - Return code: 0 10:16:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16: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')]} 10:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16: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')]} 10:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:07 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 0x105d68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd37bdbc6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b46d30>, '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 0x105a6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3bbe8>, '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.vRPjOa7mw0/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.yZrw4vBPnQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/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 10:16:07 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 10:16:07 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 10:16:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vRPjOa7mw0/Render', 10:16:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:07 INFO - 'HOME': '/Users/cltbld', 10:16:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:07 INFO - 'LOGNAME': 'cltbld', 10:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:07 INFO - 'MOZ_NO_REMOTE': '1', 10:16:07 INFO - 'NO_EM_RESTART': '1', 10:16:07 INFO - 'PAGER': '/bin/cat', 10:16:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:07 INFO - 'PWD': '/builds/slave/test', 10:16:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:07 INFO - 'SHELL': '/bin/bash', 10:16:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yZrw4vBPnQ/Listeners', 10:16:07 INFO - 'TMPDIR': '/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/', 10:16:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:07 INFO - 'USER': 'cltbld', 10:16:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:07 INFO - 'XPC_FLAGS': '0x0', 10:16:07 INFO - 'XPC_SERVICE_NAME': '0', 10:16:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:16:08 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-7WbrsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:16:08 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-sI6c7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:16:08 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-NDBIzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:16:08 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-WhmWBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:16:08 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-3HeH9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:16:08 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-RZAhAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:16:08 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-E3n7NX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:16:08 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-Xf4Pff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:16:08 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-PgDHgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:16:09 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-Kqqt5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:16:09 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-FNFsLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:16:09 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-EFdEZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:16:09 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-PBlILS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:16:09 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-PbHMyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:09 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-bJahQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:16:09 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-zEUImK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:16:09 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-uLNOnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:16:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:16:09 INFO - Running setup.py install for manifestparser 10:16:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Running setup.py install for mozcrash 10:16:10 INFO - Running setup.py install for mozdebug 10:16:10 INFO - Running setup.py install for mozdevice 10:16:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Running setup.py install for mozfile 10:16:10 INFO - Running setup.py install for mozhttpd 10:16:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Running setup.py install for mozinfo 10:16:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Running setup.py install for mozInstall 10:16:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:16:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:16:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:16:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:16:11 INFO - Running setup.py install for mozleak 10:16:11 INFO - Running setup.py install for mozlog 10:16:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:16:11 INFO - Running setup.py install for moznetwork 10:16:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:16:11 INFO - Running setup.py install for mozprocess 10:16:11 INFO - Running setup.py install for mozprofile 10:16:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:16:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:16:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:16:11 INFO - Running setup.py install for mozrunner 10:16:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:16:12 INFO - Running setup.py install for mozscreenshot 10:16:12 INFO - Running setup.py install for moztest 10:16:12 INFO - Running setup.py install for mozversion 10:16:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:16:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:16:12 INFO - Cleaning up... 10:16:12 INFO - Return code: 0 10:16:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16: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')]} 10:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16: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')]} 10:16:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:12 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 0x105d68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd37bdbc6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b46d30>, '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 0x105a6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3bbe8>, '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.vRPjOa7mw0/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.yZrw4vBPnQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/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 10:16:12 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 10:16:12 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 10:16:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vRPjOa7mw0/Render', 10:16:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:12 INFO - 'HOME': '/Users/cltbld', 10:16:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:12 INFO - 'LOGNAME': 'cltbld', 10:16:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:12 INFO - 'MOZ_NO_REMOTE': '1', 10:16:12 INFO - 'NO_EM_RESTART': '1', 10:16:12 INFO - 'PAGER': '/bin/cat', 10:16:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:12 INFO - 'PWD': '/builds/slave/test', 10:16:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:12 INFO - 'SHELL': '/bin/bash', 10:16:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yZrw4vBPnQ/Listeners', 10:16:12 INFO - 'TMPDIR': '/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/', 10:16:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:12 INFO - 'USER': 'cltbld', 10:16:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:12 INFO - 'XPC_FLAGS': '0x0', 10:16:12 INFO - 'XPC_SERVICE_NAME': '0', 10:16:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:16:12 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-MwprFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:16:12 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-q0To56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:16:13 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)) 10:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:16:13 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-2dhgHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:16:13 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)) 10:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:16:13 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-R2oY0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:16:13 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)) 10:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:16:13 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-zeI83P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:16:13 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)) 10:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:16:13 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-SU0GBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:16:13 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)) 10:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:16:13 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-l2fu3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:16:13 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)) 10:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:16:13 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-XTYDzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:16:13 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)) 10:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:16:13 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-AHjN2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:16:13 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)) 10:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:16:13 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-U7FBj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:16:13 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)) 10:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:16:13 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-tvm4yS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:16:13 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)) 10:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:16:13 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-mN5wQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:16:14 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)) 10:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:16:14 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-vk8_q_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:16:14 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)) 10:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:16:14 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-Y0U32a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:16:14 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)) 10:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:14 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-sFmf02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:14 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)) 10:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:16:14 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-yGpxWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:16:14 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)) 10:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:16:14 INFO - Running setup.py (path:/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/pip-545G2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:16:14 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)) 10:16:14 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)) 10:16:14 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)) 10:16:14 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)) 10:16:14 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)) 10:16:14 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)) 10:16:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:16:14 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 10:16:14 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 10:16:14 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 10:16:14 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 10:16:14 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 10:16:14 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 10:16:17 INFO - Downloading blessings-1.6.tar.gz 10:16:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:16:17 INFO - Installing collected packages: blessings 10:16:17 INFO - Running setup.py install for blessings 10:16:17 INFO - Successfully installed blessings 10:16:17 INFO - Cleaning up... 10:16:17 INFO - Return code: 0 10:16:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:16:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:16:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:16:18 INFO - Reading from file tmpfile_stdout 10:16:18 INFO - Current package versions: 10:16:18 INFO - blessings == 1.6 10:16:18 INFO - blobuploader == 1.2.4 10:16:18 INFO - docopt == 0.6.1 10:16:18 INFO - functools32 == 3.2.3-2 10:16:18 INFO - jsonschema == 2.5.1 10:16:18 INFO - manifestparser == 1.1 10:16:18 INFO - mozInstall == 1.12 10:16:18 INFO - mozcrash == 1.0 10:16:18 INFO - mozdebug == 0.1 10:16:18 INFO - mozdevice == 0.49 10:16:18 INFO - mozfile == 1.2 10:16:18 INFO - mozhttpd == 0.7 10:16:18 INFO - mozinfo == 0.9 10:16:18 INFO - mozleak == 0.1 10:16:18 INFO - mozlog == 3.4 10:16:18 INFO - moznetwork == 0.27 10:16:18 INFO - mozprocess == 0.25 10:16:18 INFO - mozprofile == 0.28 10:16:18 INFO - mozrunner == 6.13 10:16:18 INFO - mozscreenshot == 0.1 10:16:18 INFO - mozsystemmonitor == 0.3 10:16:18 INFO - moztest == 0.8 10:16:18 INFO - mozversion == 1.4 10:16:18 INFO - psutil == 3.1.1 10:16:18 INFO - requests == 1.2.3 10:16:18 INFO - wsgiref == 0.1.2 10:16:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:18 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 0x105d68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd37bdbc6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b46d30>, '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 0x105a6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3bbe8>, '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.vRPjOa7mw0/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.yZrw4vBPnQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/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 10:16:18 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 10:16:18 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 10:16:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vRPjOa7mw0/Render', 10:16:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:18 INFO - 'HOME': '/Users/cltbld', 10:16:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:18 INFO - 'LOGNAME': 'cltbld', 10:16:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:18 INFO - 'MOZ_NO_REMOTE': '1', 10:16:18 INFO - 'NO_EM_RESTART': '1', 10:16:18 INFO - 'PAGER': '/bin/cat', 10:16:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:18 INFO - 'PWD': '/builds/slave/test', 10:16:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:18 INFO - 'SHELL': '/bin/bash', 10:16:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yZrw4vBPnQ/Listeners', 10:16:18 INFO - 'TMPDIR': '/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/', 10:16:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:18 INFO - 'USER': 'cltbld', 10:16:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:18 INFO - 'XPC_FLAGS': '0x0', 10:16:18 INFO - 'XPC_SERVICE_NAME': '0', 10:16:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:18 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)) 10:16:18 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)) 10:16:18 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)) 10:16:18 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)) 10:16:18 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)) 10:16:18 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)) 10:16:18 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)) 10:16:18 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)) 10:16:18 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)) 10:16:18 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)) 10:16:18 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)) 10:16:18 INFO - Cleaning up... 10:16:18 INFO - Return code: 0 10:16:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:18 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 0x105d68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd37bdbc6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b46d30>, '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 0x105a6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3bbe8>, '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.vRPjOa7mw0/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.yZrw4vBPnQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/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 10:16:18 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 10:16:18 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 10:16:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vRPjOa7mw0/Render', 10:16:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:18 INFO - 'HOME': '/Users/cltbld', 10:16:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:18 INFO - 'LOGNAME': 'cltbld', 10:16:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:18 INFO - 'MOZ_NO_REMOTE': '1', 10:16:18 INFO - 'NO_EM_RESTART': '1', 10:16:18 INFO - 'PAGER': '/bin/cat', 10:16:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:18 INFO - 'PWD': '/builds/slave/test', 10:16:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:18 INFO - 'SHELL': '/bin/bash', 10:16:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yZrw4vBPnQ/Listeners', 10:16:18 INFO - 'TMPDIR': '/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/', 10:16:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:18 INFO - 'USER': 'cltbld', 10:16:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:18 INFO - 'XPC_FLAGS': '0x0', 10:16:18 INFO - 'XPC_SERVICE_NAME': '0', 10:16:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:16:18 INFO - Cleaning up... 10:16:18 INFO - Return code: 0 10:16:18 INFO - Running post-action listener: _resource_record_post_action 10:16:18 INFO - Running post-action listener: _start_resource_monitoring 10:16:18 INFO - Starting resource monitoring. 10:16:18 INFO - [mozharness: 2017-03-10 18:16:18.600630Z] Finished create-virtualenv step (success) 10:16:18 INFO - [mozharness: 2017-03-10 18:16:18.601600Z] Running install step. 10:16:18 INFO - Running pre-action listener: _resource_record_pre_action 10:16:18 INFO - Running main action method: install 10:16:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:16:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:16:18 INFO - Reading from file tmpfile_stdout 10:16:18 INFO - Detecting whether we're running mozinstall >=1.0... 10:16:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:16:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:16:18 INFO - Reading from file tmpfile_stdout 10:16:18 INFO - Output received: 10:16:18 INFO - Usage: mozinstall [options] installer 10:16:18 INFO - Options: 10:16:18 INFO - -h, --help show this help message and exit 10:16:18 INFO - -d DEST, --destination=DEST 10:16:18 INFO - Directory to install application into. [default: 10:16:18 INFO - "/builds/slave/test"] 10:16:18 INFO - --app=APP Application being installed. [default: firefox] 10:16:18 INFO - mkdir: /builds/slave/test/build/application 10:16:18 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'] 10:16:18 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 10:16:39 INFO - Reading from file tmpfile_stdout 10:16:39 INFO - Output received: 10:16:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:16:39 INFO - Running post-action listener: _resource_record_post_action 10:16:39 INFO - [mozharness: 2017-03-10 18:16:39.327002Z] Finished install step (success) 10:16:39 INFO - [mozharness: 2017-03-10 18:16:39.327159Z] Running run-tests step. 10:16:39 INFO - Running pre-action listener: _resource_record_pre_action 10:16:39 INFO - Running main action method: run_tests 10:16:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:16:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:16:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:16:39 INFO - 2017-03-10 10:16:39.341 screenresolution[1622:7369] starting screenresolution argv=screenresolution get 10:16:39 INFO - 2017-03-10 10:16:39.344 screenresolution[1622:7369] Display 0: 1600x1200x32@60 10:16:39 INFO - 2017-03-10 10:16:39.350 screenresolution[1623:7371] starting screenresolution argv=screenresolution list 10:16:39 INFO - Available Modes on Display 0 10:16:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:16:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:16:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:16:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:16:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:16:39 INFO - Intel Iris: 10:16:39 INFO - Chipset Model: Intel Iris 10:16:39 INFO - Type: GPU 10:16:39 INFO - Bus: Built-In 10:16:39 INFO - VRAM (Dynamic, Max): 1536 MB 10:16:39 INFO - Vendor: Intel (0x8086) 10:16:39 INFO - Device ID: 0x0a2e 10:16:39 INFO - Revision ID: 0x0009 10:16:39 INFO - Displays: 10:16:39 INFO - Display: 10:16:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:16:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:16:39 INFO - Display Serial Number: 1600x1200 60 10:16:39 INFO - Main Display: Yes 10:16:39 INFO - Mirror: Off 10:16:39 INFO - Online: Yes 10:16:39 INFO - Rotation: Supported 10:16:39 INFO - Return code: 0 10:16:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:16:39 INFO - Python 2.7.3 10:16:39 INFO - Return code: 0 10:16:39 INFO - grabbing minidump binary from tooltool 10:16:39 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')]} 10:16:39 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 0x105b46d30>, '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 0x105a6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:16:39 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 10:16:39 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 10:16:39 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 10:16:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:16:39 INFO - Return code: 0 10:16:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:16:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:16:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:16:39 INFO - ENV: RUST_BACKTRACE is now 1 10:16:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:16:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:16:39 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/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0058', '--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 10:16:39 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/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0058 --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 10:16:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vRPjOa7mw0/Render', 10:16:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:39 INFO - 'HOME': '/Users/cltbld', 10:16:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:39 INFO - 'LOGNAME': 'cltbld', 10:16:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:16:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:39 INFO - 'MOZ_NO_REMOTE': '1', 10:16:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:16:39 INFO - 'NO_EM_RESTART': '1', 10:16:39 INFO - 'PAGER': '/bin/cat', 10:16:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:39 INFO - 'PWD': '/builds/slave/test', 10:16:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:16:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:39 INFO - 'RUST_BACKTRACE': '1', 10:16:39 INFO - 'SHELL': '/bin/bash', 10:16:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yZrw4vBPnQ/Listeners', 10:16:39 INFO - 'TMPDIR': '/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/', 10:16:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:39 INFO - 'USER': 'cltbld', 10:16:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:39 INFO - 'XPC_FLAGS': '0x0', 10:16:39 INFO - 'XPC_SERVICE_NAME': '0', 10:16:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:39 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/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0058', '--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 10:16:39 INFO - mozversion application_buildid: 20170310084422 10:16:39 INFO - mozversion application_changeset: edd424223fb1c336294a0cc1ca0e31cbec79ec31 10:16:39 INFO - mozversion application_display_name: Nightly 10:16:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:16:39 INFO - mozversion application_name: Firefox 10:16:39 INFO - mozversion application_remotingname: firefox 10:16:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:16:39 INFO - mozversion application_vendor: Mozilla 10:16:39 INFO - mozversion application_version: 55.0a1 10:16:39 INFO - mozversion platform_buildid: 20170310084422 10:16:39 INFO - mozversion platform_changeset: edd424223fb1c336294a0cc1ca0e31cbec79ec31 10:16:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:16:39 INFO - mozversion platform_version: 55.0a1 10:16:39 INFO - using testdate: 1489169799 10:16:39 INFO - actual date: 1489169799 10:16:39 INFO - starting webserver on 'localhost:49240' 10:16:39 INFO - SUITE-START | Running 2 tests 10:16:39 INFO - TEST-START | dromaeo_css 10:16:39 INFO - operating with platform_type : mac_ 10:16:39 INFO - Initialising browser for dromaeo_css test... 10:16:39 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/tmpCf0w97/profile http://localhost:49240/getInfo.html) 10:16:42 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 10:16:42 INFO - PROCESS | 1633 | colorDepth:24 10:16:42 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 10:16:42 INFO - PROCESS | 1633 | __metrics 10:16:42 INFO - PROCESS | 1633 | 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" 10:16:42 INFO - PROCESS | 1633 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:16:43 INFO - TEST-INFO | 1633: exit 0 10:16:43 INFO - Browser initialized. 10:16:43 INFO - Running cycle 1/1 for dromaeo_css test... 10:16:43 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/tmpCf0w97/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:16:55 INFO - PROCESS | 1635 | RSS: Main: 232919040 10:16:55 INFO - PROCESS | 1635 | 10:19:59 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 10:20:03 INFO - PROCESS | 1635 | RSS: Main: 458858496 10:20:03 INFO - PROCESS | 1635 | 10:21:45 INFO - PROCESS | 1635 | ************************* 10:21:45 INFO - PROCESS | 1635 | A coding exception was thrown and uncaught in a Task. 10:21:45 INFO - PROCESS | 1635 | 10:21:45 ERROR - PROCESS | 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:21:45 INFO - PROCESS | 1635 | Full stack: 10:21:45 INFO - PROCESS | 1635 | ************************* 10:23:06 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 10:23:07 INFO - PROCESS | 1635 | RSS: Main: 371404800 10:23:07 INFO - PROCESS | 1635 | 10:26:09 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 10:26:10 INFO - PROCESS | 1635 | RSS: Main: 342380544 10:26:10 INFO - PROCESS | 1635 | 10:29:12 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 10:29:13 INFO - PROCESS | 1635 | RSS: Main: 330166272 10:29:13 INFO - PROCESS | 1635 | 10:32:17 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 10:32:18 INFO - PROCESS | 1635 | RSS: Main: 339406848 10:32:18 INFO - PROCESS | 1635 | 10:35:21 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 10:35:21 INFO - PROCESS | 1635 | RSS: Main: 529854464 10:35:21 INFO - PROCESS | 1635 | 10:35:21 INFO - PROCESS | 1635 | __start_tp_report 10:35:21 INFO - PROCESS | 1635 | _x_x_mozilla_page_load 10:35:21 INFO - PROCESS | 1635 | _x_x_mozilla_page_load_details 10:35:21 INFO - PROCESS | 1635 | |i|pagename|runs| 10:35:21 INFO - PROCESS | 1635 | |0;dojo.html;3281.7210537104347;3328;3355.9496607550877;3392.474166504193;3407.2674375009383;5610.4670056344685;5710.77156913724;5722.341930677968;5837.9124313135335;5853.765849366031;5768.653880767157;5845.181674565553;5906.852328691785;5914.9112763308585;5933.3176684681275;5179.792808287664;5217.087009773274;5230.843074707765;5244.475552444763;5256.763445644955;5321.787128514855;5380.596455265852;5388.137897936331;5391.514763671269;5443.346798384199;5110.667806592597;5165.328507294065;5247.790088396498;5247.973760131213;5283.709395983219;4414.602685758297;5246.8688282792855;5250.159974404077;5252.474752524755;5262.500062494057;5128.9230661540105;5183.377994640668;5201.115810312256;5209.505097015777;5212.139996900507;5718.142278658193;5723.112917497794;5731.656100633933;5732;5736.426357364272;6150.8769824603705;6153.107799369066;6156.56904016719;6157.876842463171;6161.476274516672;6042.395760423967;6117.644716737952;6146.385361463817;6152.953997820381;6174.444300012976;5884.941150588482;5903.734331955073;5912.290525137011;5917.704114794243;5932.58471906971;6347.016212487072;6385.2656944451055;6418.326075762071;6431.517636177306;6434.7104380303;6066.393360663898;6110.205673262536;6112.1995365628145;6162.445379915829;6167.321594624587;6140.657627863787;6140.762873617279;6160.537959652955;6174.598651087665;6187.876242475125;6163.952128138228;6168.35232300602;6177.289611694712;6181.134641150243;6185.350538193515;5524.392316845224;6109.877802443926;6146.7706458708435;6160.8767824643255;6165.229346331708;4880.926786098212;4994.950050499521;5003.649744517922;5016.749162541858;5017.57350625201;4342.934855977162;4433.800478978454;4435.756033418193;4438.134563760101;4511.436070491189;5731.885362292731;5748.45389687979;5840.2991641003355;5858;5909.084091965752;5510.870271594394;6263.029230469285;6275.780347687809;6281.968590157111;6287.49700023997;5663.575231857627;5725.51333136688;5800.477956983807;5806.274215723035;5833.270841144857;5457.672539647554;5468.398476167618;5473.124300111963;5477.233187353773;5494.983428065821;4980.740812519702;5389.865253368697;6211.503079753609;6252.468540174045;6309.589876658186;6231.813045608639;6279.780207692709;6282.654454005074;6289.779857704958;6300.149479820349;6411.96794016027;6415.775447859302;6444.581102228341;6445.581037232565;6449.419552240321;6073.939260607337;6287.779927702509;6304.117423560797;6306.148669929501;6331.493480521455;4756.548127927841;6114.0236562776045;6200.472959798287;6203.937960620517;6218.098375735583;6039;6043.063325184604;6050.21347224858;6053.667048312385;6054.576179667381;5950.375210602824;6050.334463209131;6057.878842423215;6066.514678825595;6080.847978800565;5841.591088623755;5891.94108058931;5895.528357731286;5896.793612223723;5911.290645122613;5971.761129554943;6093.512518998558;6139.338817383189;6168.876622467616;6212.751489940351;6048.334683184934;6051.183090282755;6054.117576759427;6071.392860713893;6128.233970753656 10:35:21 INFO - PROCESS | 1635 | |1;ext.html;703.1807943745537;738.6639079218955;937.8452555328371;956.9521523923802;961.3318743473288;29590.556141657864;37989.24021519568;37996.43005354922;38004.23991520168;38199.80900095499;36565.63434365656;36874.44688329677;36920.44619330712;37045.444318335176;37261.81369093157;7299.744508942188;7463.552186868778;7621.199774023731;7772.183920688331;7777.455578109534;7302.379297759697;7401.333879950804;10635.57457701691;10966.725831854188;11074.557017719282;10994.065504432132;11009.83485247722;11011.944940275327;11054;11101.888981110167;10978.835317470244;10989.890101099047;11018.39398833064;11022;11041.889581104208;7222.638868056629;7381.11426628808;10577.576896924114;10658.62694805678;10818.513166907507;36924.815375923215;36971.815140924125;37058.81470592657;37078.25843483142;37129;3709.4806727058235;3715.9071023224365;3717.5724791649036;3734.9066273343383;3778.5465744110606;26739.197824065115;27768.58347124795;27843.443131137265;28248;29177.41645167106;3097.519884417919;3118.3607360491274;3121.266502371941;3234.094453553009;3236.01301603011;339089;341068;344516;346251;346656;39781;39944;41771.582284176766;48437.757811210715;48915.26627100597;51574;51892.740536297075;52090.739546302786;52115;52221.7388913053;13394.196348219139;13436.193828370133;13439.798403023962;13464.057515973787;13479.663008424868;10662.466876656135;10681.092107170978;10681.57273709043;10692.62575809843;10746.032857042903;13319.66700832487;13329;13423.463061477627;13453.856422204026;13572.660683482794;5822.438127224008;5842.298924129132;5863.648181109147;5878.441548052928;5884.47039766423;1101.2786624760795;1123.2530367305812;1123.455124264731;1142.9713258067638;1156.2816364610742;26045.088421905144;26080.60879086815;26163.607545886825;26492.205233843015;26606.733932660813;1206.6802297391198;1214.3442541027746;1218.524775337619;1252.4927404401233;1255.3723138430785;12109.273443593413;12330;13640.727185456235;13826.585202443943;13894;491768.54115729907;492932.21203363955;493016;493381;493721;53732.731336343066;54134;54159;54289;54364.912701746536;1369.8493165751759;1409.4150927365029;1410.781328894023;1412.5974097382607;1413.809135766679;24693;25574;25767.871160644077;25773;25774.87112564425;43925.12149757051;44005.55994440015;44014.55985440104;44024.339634906144;44079.11841763211;424426.80158784625;428375;428699;429296;430130;26560.335991599593;28106.2973425666;31807.681923180473;32461.35077298488;33510.832445837616;39767.60232397639;42228.57771422246;43408.34887476754;43447.565524344354;43471.13057738891;25604.871975640002;29590.28907023129;31898;35628.10929726777;35840;28542.42915141644;34510.7921222756;34555.827220863735;35912.640873591976;36036.01801900816;34626;35173.94478165659;35527;35577.1105722359;35632.46551301784;25024.74975250224;27472.901083956418;28418.857905710338;28819.711802881702;31265.531017035217;23168.53662926766;23567.64648530239;24148.87925560361;24694.629580555946;25761.613575796753 10:35:21 INFO - PROCESS | 1635 | |2;jquery.html;379.2490868081197;394.7296102170014;411.9732217405867;418.428844627084;436.8034384526962;11750.823737643932;21222.681659775095;21792.45518862027;22728.204512842054;22758.31725048247;21913;21917.671234931488;22571.77428225717;22985.4253643659;23210.3036908893;6325.209348831396;6502.2197336319705;6648.833779155536;6796.184457865063;6819.590824550518;5699.971500142494;6805.047293378906;6810.080639113706;6812.4550035997;6825.6587170641515;6606.1412016438035;6670.3329667033395;6702.966485167567;6758.9662051689675;6806.761763338284;6475.773347932847;6619.404253617149;6753.628550429725;6788.355106264897;6832.897506537406;6533.18335208099;6534.705938232743;6540.803775886731;6541.313162118005;6547.9672601636685;25926.351841203934;25971;25971.961121555116;26093.347666308495;26432.942682292683;2874.9712502874913;2876.6548014238215;2924.38587896542;2937.515309973852;2944.190347654412;15515;16001.519954401387;16006.359745610162;16572;16905.661886762195;1992.3823614679495;2031.1570698160247;2187.0049127646885;2193.802557769792;2214.070090561952;138760;165665;166234;168522.1573892135;170793;15379.923100384427;16999.130095689463;21162.153513859583;21187.576248474943;21418.571628567654;35183.12042198965;35368.46947295793;35458;35610.28779424397;35630.643693562735;7659.578723170168;9932.453715045598;9988.700338989842;10032.899671003343;10206.846897296546;7643.273888980538;7845.137034926153;7992.840143197103;8199.344052475788;8206.83586328282;8438.185790055168;10293.53679084443;10367.16414926482;10378.42918639482;10492.108170805566;3539.124658498991;4063.327173750152;4123.443465051627;4124.340105583093;4135.276326642826;1044.2898828796492;1053.262716098734;1053.3890343600692;1053.7365658585354;1107.385401102396;22353;22877.428064298194;22884.65673014906;22904.427389315402;22952.885235573714;1005.8139244239838;1057.5928267616869;1064.5369264370024;1097.2154909239932;1103.3104309806372;10740.550025746425;11013.2841365311;11789.567898165149;11911.332413462122;11932.463039163258;577987;682271;706624;711241.4437927881;722170;139408.1798957148;140980.2950985259;147170.4701334331;148844;150550;1180.0795379603924;1194.5759255464186;1212.3271584270815;1223.46167686216;1224.7244370016854;19693.40919772409;19943.501412464226;19958;20011.299604513773;20073.899630501754;52154.956900862526;52751;59737.70131149316;60098.69950650219;60944.695276525104;65279.34720652923;66169;70517.29482705107;73112.63443682747;86371.90666043537;11711.765764684487;11841.348725819818;12192.75614487723;12256.816147757969;12373.381330933596;13590.320483975564;13593.796093058414;13677;14072.577822665336;14142.43430262778;11618.5352585899;11944.462499187384;11974.341411222118;12072.577459788865;12106.455209515769;11343.48954297075;11550;11573.132015098732;11944.761104777683;11961.983231425427;11567.305961642329;11637.650870473899;12102.219623248591;12155.027597792332;12329.321887296284;11856.229345092886;11969.982551483221;12115.970142537983;12192.817107743569;12216.511339546318;11720.648380548597;11784.941075294912;11942.641720748392;12047.156699031335;12106.576269830513 10:35:21 INFO - PROCESS | 1635 | |3;mootools.html;1544.55980045687;1552.906825590464;1574.4174655377512;1595.186454907997;1601.0153755440404;10627.096696780773;11309.717257068578;11322.26405283656;11328.207025508218;11375.943120284386;10675.946620266906;10923.071538919201;11064.889351106487;11210.495527701252;11214.158938079656;2325.5813953488364;2361.3860396297;2368.917087901924;2370.798482129021;2370.8577485350934;2304.4008557775014;2333.7199536055614;2342.3792694935855;2343.414146463384;2349.718033835942;2321.872297023663;2340.6372012338115;2342.2387723989686;2348.7416384197722;2354.6350315701093;2290.9656355154684;2313.6760853480528;2317.5017371265258;2319.7564255753073;2320.4662927526597;2278.293728944033;2347.4248809041724;2351.976480235193;2353.8352315337934;2354.0701422938014;11028.834567481494;11120.833187502112;11127.499262533205;11135.99776020162;11145.665630031112;5546.69493177875;5689.061304884689;5880.764769409218;5887.087501437241;5892.410758924116;3373.2072962853954;3561.12752375667;3624.800635965021;3642.7267954903486;3646.8723594674325;1071.8499410082595;1110.566878917223;1145.6963904565298;1202.0744027099086;1221.9938900305442;13553.322333883267;14028.649283767783;14037.438502459889;15079.321430535652;15096.924515377463;3971.940420893689;4646.512116227815;4663.48701642819;4665.300204969214;4672.859814205579;11327;11327.433628318551;11332;11334.603288885015;11337.43312834355;4873.878153046131;5045.217991211368;5083.517065878736;5644.125160600113;5664.716764161858;4337.50118736343;5251;5267.631265811433;5272.947270527322;5291.523762861361;3683.4106542953;3773.056735816046;3778.678812300985;3841.3085644583684;3860.82626281818;994.9253805964581;1001.2940876681922;1011.0950699124243;1011.7723512209694;1034.13132968307;917.1837065012145;940.4592359393376;944.976375590602;959.1367769007949;995.9004099590128;6326.588771729823;6410.8076757697345;6621.801345959629;6638.269790323061;6747.089142965735;970.9951450242703;977.6187286958092;999.1557134221571;1022.2588623248085;1032.4734385463319;4259.574042595716;4271.440924062695;4299.290617048152;4384.934225986613;4398.340248962617;13515.189088654712;13956.72086558263;13970.231637260049;13991.370388332549;14002.929985350213;12449.315287659265;12980.15628984113;13523.985701072459;13893.930530347487;13918.56425125599;9570;9851.901480985098;9895.55470003866;10130.848037279447;10160.33957792741;5945.64326140433;6594.901076483952;6772.966135169293;6870.381665649916;6987.0567473392475;11799.17405781587;11964.401779911144;12025.158238923192;12145.271283723005;12241;9440.339176257596;11647.825282620597;12320.322382269062;12418.00655947504;12435.751284974069;8674.392792504465;8829.072947340437;9266.768330791785;9418.529073546433;9419.811603768023;10366.844497332697;10484.370937743455;10569.207309451976;10578.682639520826;10597.523111460157;9177.908220917705;9181.449113053239;9222.354435189472;9335.206507446672;9455.385399948982;8928.285737140883;8999.10008999121;9060.592273347584;9244.583993720164;9248.537573121452;7807.531548107132;7854.567998760123;7868.291853733192;7947.642356094106;7978.601069946363;5919.4080591940465;5940.3168635605725;5940.495057920125;5953.523718102455;6050.969745151422;5950.404959504015;6003.729832157476;6004.517379919724;6024.1265016573225;6056.66688332146 10:35:21 INFO - PROCESS | 1635 | |4;prototype.html;369.5048634829328;372.1663473818647;375.24013871909386;379.69055219995687;385.6779589043149;4134.4625198724125;4299.699021068526;4629.513901040385;4780.681369535772;4781.784819683114;4298.763568003758;4338.418640908662;4346.218050599255;4390.100029493954;4548.385967894342;3548.5209496718;3829.961700383002;3911.6088391160797;4025.423728813562;4040.545403654682;3859.4982652255308;4006.3389540725743;4013.8795836124964;4030.355143177092;4041.3937909313545;4029.959700402988;4048.2915489789316;4053.29067413203;4053.695972802037;4058.269511487931;3350.4974253861874;3824.8661296854616;3900.2004589059175;4013;4105.527864295615;3365.175531994677;3679.6688298053305;3687.907802304937;3733.4213196954242;3755.6902504959526;4329.783510824478;4390.990072283393;4421.867343979686;4678.836240731592;4779.80880764769;4639.837605683819;4641.466231383367;4642.837500687459;4658.557437043475;4678.929816052762;4204.159168166379;4332.501762297345;4852.757362131879;5114.820981265675;5119.10415677255;3581.606023337431;3804.2011177652726;3837.6354246346555;4095.7507960072166;4138.813753381105;4604.700694454849;5101.795928162869;5313.203019547061;5353.858456617345;5408.621396502246;3841.3469710149343;4081.7346872453195;4148.170365926827;4195.8671158787565;4230.661547076226;3771.264603402365;4243.745375277432;4277.935830962538;4306.82772689089;4337.37108119321;4449.221386257392;4493.483249426293;4607.6083532900075;4620.722756634613;4649.349091127245;4645.883852903705;4810.518948105231;4951.455339912607;5047.621428392885;5109.259157422153;1308.6074177746639;1415.9221242831536;1446.7124259409134;1455.4396557325506;1470.5882352941194;1004.3622299839508;1016.5222345497605;1019.9490025498844;1088.9455527223606;1097.434821067151;4465.151621192028;4484.529124441952;4634.281686338623;4771;4780.163471392562;4421.911561768747;5164.04465173944;5304.628675992721;5319.760610772524;5335.359756829128;4388.545914745502;4396.450443694538;4629.213033784265;4737.242041273448;4821.710697358169;2513.258588716333;2514.0013689117195;2521.205820166642;2543.910963116319;2642.757903785218;4833.564979151823;5177.689338639693;5265.656308244293;5447.319085114361;5458.962797068544;4800.06398752247;5082.847514574569;5372.791121997598;5385.299911011543;5404.189371594292;4551.453825540956;4841.917975270668;4985.950140498621;5223.242629818655;5392.7573259202645;4927.704337739747;5188.818391356435;5201.895962080813;5239.554637855825;5285.8678533035445;4480.887977800581;4756.574452310592;4845.927311090266;5038.193888977746;5078.619103567321;4543.772811359485;5000.199968005102;5154.433012368711;5220.112580861187;5234.377343023675;3934.390169523728;4067.9796601016806;4155.044339801802;4213.831446742096;4218.957810421856;4866.975665121652;5269.683818970874;5272.472752724697;5291.100512912737;5304.204369344475;4717.994852187738;5009.949900500948;5091.6181286402925;5107.463716309734;5141.845744627667;4457.955420445754;5080.593552515716;5091.490850914879;5109.540141387293;5119.078565858182;4421.447319085114;5010.8246211383885;5042.344495215745;5048;5090.26191202281;4757.168490131256;4873.195922672861;5082.567981721595;5118.74406279692;5151.1881207905135;4229.661627069766;4379.802908869045;4852.369192005158;5021.824236151717;5074.517920797518 10:35:21 INFO - PROCESS | 1635 | |5;yui.html;706.2344139650872;717.2863001313693;755.765712629085;814.7026335387584;824.4742860261032;14830.77753833692;15608.843911560882;15680.215989200522;15682.92158539207;15704.293306801193;13780.966427517926;14217;14327.570172894804;14329.570112896603;14715;934.7709811096274;966.1787480641434;967.641972470187;968.0174622757906;972.4214092614883;929.1034152043277;950.3205208276081;952.9380590261645;954.1555723184962;959.4243453927622;1010.1413798271484;1020.5152552537522;1022.0086516079391;1023.0434543701663;1023.698009087321;1009.2329829329689;1011.6610935336671;1012.3571532077148;1013.2248829645328;1014.5535964175739;756.6405957170355;756.6859753202415;757.0839284465748;757.5151902782223;758.6396461680713;14919.403223871032;15208.923955380153;15262.31319590621;15286.923565382102;15352.539423817303;14595;14844.78819822912;14965.7755133672;14974;15017.023893447;11283.943580282046;11501.42492875353;11670.883291167065;12130.696732581668;12168.2699038058;3653.598104208535;3707.610700876396;3713.4801127842125;3772.75477093988;3889.3388124018984;97363;99025.50487247518;99483.0051699481;100280.49859750728;100466.4976675112;11358.148138889452;11386.487608057658;11401.258918170292;11581.363025033705;11790.587329443428;23983.640245396335;24487;24515.632265516033;24547.15896307784;24576.508469830504;7457.664405101784;7532.698692052257;7535.924640753632;7622.352100071556;7718.189590092959;4017.397390391465;4072.837086516506;4132.214879172948;4292.098659281586;4341.196878577473;3462.117160124152;3558.2349794794245;3558.5729712434154;3559.8786382289495;3560.6973407260157;636.0522820996682;660.6960798032862;662.0797092042066;663.0783211336246;667.6861874918781;564.7938502446577;660.3627499463041;667.5393978155155;673.5958424944994;708.4474110194056;9999.851000531466;10003.633160301908;10062.849057264148;10122.785265768154;10266.486675666187;642.2274522318435;687.3950923187563;718.3786025088261;719.8668246374438;730.6091241186047;4554.43069616298;4723.551262630044;4827.951720482821;4854.635902307341;4865.9026819463415;94027;98781.50609246908;99264;100152.49923750335;100450.49324260141;52454.688632784484;60056.798864023345;61261;74695;83496.16503835005;72254.1358570935;72650.63674681593;74118;74310.62844685742;74920.87618685725;10468;10568.260221784401;10880.782384352111;10903.29128606638;11020.5040773167;45070.0985980272;46499.535004650876;47466.76266618783;48131;48912.51087489222;67722;67896.32103679098;67927;68335;69238.3076169252;13317;13363.799543007057;13481.730365392834;13666.248356340497;14018.779668751578;14267.143971361751;14267.357968891218;14487.420503179756;14565.126092434488;14697.265136743334;13592.79610805819;13729.176249425067;13836.654083647989;13921.860781392057;14030.29848507591;13312.933435332761;13418.93290533541;13514.662133446742;13557.457701691821;13591;13251.271180085188;13410.956650899694;13435.798463023259;13511.932440337736;13524.256165910969;10721.839172412576;10728.946355268174;10836.67489975302;10885.782284354427;11195.328280303207;8500.61747221389;9440.669576564787;10766.284477827057;11168.66494005181;11260.88739112631 10:35:21 INFO - PROCESS | 1635 | __end_tp_report 10:35:21 INFO - PROCESS | 1635 | __start_cc_report 10:35:21 INFO - PROCESS | 1635 | _x_x_mozilla_cycle_collect,3806 10:35:21 INFO - PROCESS | 1635 | __end_cc_report 10:35:21 INFO - PROCESS | 1635 | __startTimestamp1489170921600__endTimestamp 10:35:21 INFO - PROCESS | 1635 | 10:35:21 INFO - PROCESS | 1635 | ------- Summary: start ------- 10:35:21 INFO - PROCESS | 1635 | Number of tests: 6 10:35:21 INFO - PROCESS | 1635 | 10:35:21 INFO - PROCESS | 1635 | [#0] dojo.html Cycles:165 Average:5737.39 Median:5917.70 stddev:641.43 (10.8%) stddev-sans-first:613.78 10:35:21 INFO - PROCESS | 1635 | Values: 3281.7 3328.0 3355.9 3392.5 3407.3 5610.5 5710.8 5722.3 5837.9 5853.8 5768.7 5845.2 5906.9 5914.9 5933.3 5179.8 5217.1 5230.8 5244.5 5256.8 5321.8 5380.6 5388.1 5391.5 5443.3 5110.7 5165.3 5247.8 5248.0 5283.7 4414.6 5246.9 5250.2 5252.5 5262.5 5128.9 5183.4 5201.1 5209.5 5212.1 5718.1 5723.1 5731.7 5732.0 5736.4 6150.9 6153.1 6156.6 6157.9 6161.5 6042.4 6117.6 6146.4 6153.0 6174.4 5884.9 5903.7 5912.3 5917.7 5932.6 6347.0 6385.3 6418.3 6431.5 6434.7 6066.4 6110.2 6112.2 6162.4 6167.3 6140.7 6140.8 6160.5 6174.6 6187.9 6164.0 6168.4 6177.3 6181.1 6185.4 5524.4 6109.9 6146.8 6160.9 6165.2 4880.9 4995.0 5003.6 5016.7 5017.6 4342.9 4433.8 4435.8 4438.1 4511.4 5731.9 5748.5 5840.3 5858.0 5909.1 5510.9 6263.0 6275.8 6282.0 6287.5 5663.6 5725.5 5800.5 5806.3 5833.3 5457.7 5468.4 5473.1 5477.2 5495.0 4980.7 5389.9 6211.5 6252.5 6309.6 6231.8 6279.8 6282.7 6289.8 6300.1 6412.0 6415.8 6444.6 6445.6 6449.4 6073.9 6287.8 6304.1 6306.1 6331.5 4756.5 6114.0 6200.5 6203.9 6218.1 6039.0 6043.1 6050.2 6053.7 6054.6 5950.4 6050.3 6057.9 6066.5 6080.8 5841.6 5891.9 5895.5 5896.8 5911.3 5971.8 6093.5 6139.3 6168.9 6212.8 6048.3 6051.2 6054.1 6071.4 6128.2 10:35:21 INFO - PROCESS | 1635 | 10:35:21 INFO - PROCESS | 1635 | [#1] ext.html Cycles:180 Average:55319.78 Median:186299.92 stddev:113187.54 (60.8%) stddev-sans-first:113430.78 10:35:21 INFO - PROCESS | 1635 | Values: 703.2 738.7 937.8 957.0 961.3 29590.6 37989.2 37996.4 38004.2 38199.8 36565.6 36874.4 36920.4 37045.4 37261.8 7299.7 7463.6 7621.2 7772.2 7777.5 7302.4 7401.3 10635.6 10966.7 11074.6 10994.1 11009.8 11011.9 11054.0 11101.9 10978.8 10989.9 11018.4 11022.0 11041.9 7222.6 7381.1 10577.6 10658.6 10818.5 36924.8 36971.8 37058.8 37078.3 37129.0 3709.5 3715.9 3717.6 3734.9 3778.5 26739.2 27768.6 27843.4 28248.0 29177.4 3097.5 3118.4 3121.3 3234.1 3236.0 339089.0 341068.0 344516.0 346251.0 346656.0 39781.0 39944.0 41771.6 48437.8 48915.3 51574.0 51892.7 52090.7 52115.0 52221.7 13394.2 13436.2 13439.8 13464.1 13479.7 10662.5 10681.1 10681.6 10692.6 10746.0 13319.7 13329.0 13423.5 13453.9 13572.7 5822.4 5842.3 5863.6 5878.4 5884.5 1101.3 1123.3 1123.5 1143.0 1156.3 26045.1 26080.6 26163.6 26492.2 26606.7 1206.7 1214.3 1218.5 1252.5 1255.4 12109.3 12330.0 13640.7 13826.6 13894.0 491768.5 492932.2 493016.0 493381.0 493721.0 53732.7 54134.0 54159.0 54289.0 54364.9 1369.8 1409.4 1410.8 1412.6 1413.8 24693.0 25574.0 25767.9 25773.0 25774.9 43925.1 44005.6 44014.6 44024.3 44079.1 424426.8 428375.0 428699.0 429296.0 430130.0 26560.3 28106.3 31807.7 32461.4 33510.8 39767.6 42228.6 43408.3 43447.6 43471.1 25604.9 29590.3 31898.0 35628.1 35840.0 28542.4 34510.8 34555.8 35912.6 36036.0 34626.0 35173.9 35527.0 35577.1 35632.5 25024.7 27472.9 28418.9 28819.7 31265.5 23168.5 23567.6 24148.9 24694.6 25761.6 10:35:21 INFO - PROCESS | 1635 | 10:35:21 INFO - PROCESS | 1635 | [#2] jquery.html Cycles:180 Average:40820.24 Median:11989.73 stddev:114271.80 (953.1%) stddev-sans-first:114552.01 10:35:21 INFO - PROCESS | 1635 | Values: 379.2 394.7 412.0 418.4 436.8 11750.8 21222.7 21792.5 22728.2 22758.3 21913.0 21917.7 22571.8 22985.4 23210.3 6325.2 6502.2 6648.8 6796.2 6819.6 5700.0 6805.0 6810.1 6812.5 6825.7 6606.1 6670.3 6703.0 6759.0 6806.8 6475.8 6619.4 6753.6 6788.4 6832.9 6533.2 6534.7 6540.8 6541.3 6548.0 25926.4 25971.0 25972.0 26093.3 26432.9 2875.0 2876.7 2924.4 2937.5 2944.2 15515.0 16001.5 16006.4 16572.0 16905.7 1992.4 2031.2 2187.0 2193.8 2214.1 138760.0 165665.0 166234.0 168522.2 170793.0 15379.9 16999.1 21162.2 21187.6 21418.6 35183.1 35368.5 35458.0 35610.3 35630.6 7659.6 9932.5 9988.7 10032.9 10206.8 7643.3 7845.1 7992.8 8199.3 8206.8 8438.2 10293.5 10367.2 10378.4 10492.1 3539.1 4063.3 4123.4 4124.3 4135.3 1044.3 1053.3 1053.4 1053.7 1107.4 22353.0 22877.4 22884.7 22904.4 22952.9 1005.8 1057.6 1064.5 1097.2 1103.3 10740.6 11013.3 11789.6 11911.3 11932.5 577987.0 682271.0 706624.0 711241.4 722170.0 139408.2 140980.3 147170.5 148844.0 150550.0 1180.1 1194.6 1212.3 1223.5 1224.7 19693.4 19943.5 19958.0 20011.3 20073.9 52155.0 52751.0 59737.7 60098.7 60944.7 65279.3 66169.0 70517.3 73112.6 86371.9 11711.8 11841.3 12192.8 12256.8 12373.4 13590.3 13593.8 13677.0 14072.6 14142.4 11618.5 11944.5 11974.3 12072.6 12106.5 11343.5 11550.0 11573.1 11944.8 11962.0 11567.3 11637.7 12102.2 12155.0 12329.3 11856.2 11970.0 12116.0 12192.8 12216.5 11720.6 11784.9 11942.6 12047.2 12106.6 10:35:21 INFO - PROCESS | 1635 | 10:35:21 INFO - PROCESS | 1635 | [#3] mootools.html Cycles:180 Average:6683.87 Median:2370.83 stddev:4162.31 (175.6%) stddev-sans-first:4156.08 10:35:21 INFO - PROCESS | 1635 | Values: 1544.6 1552.9 1574.4 1595.2 1601.0 10627.1 11309.7 11322.3 11328.2 11375.9 10675.9 10923.1 11064.9 11210.5 11214.2 2325.6 2361.4 2368.9 2370.8 2370.9 2304.4 2333.7 2342.4 2343.4 2349.7 2321.9 2340.6 2342.2 2348.7 2354.6 2291.0 2313.7 2317.5 2319.8 2320.5 2278.3 2347.4 2352.0 2353.8 2354.1 11028.8 11120.8 11127.5 11136.0 11145.7 5546.7 5689.1 5880.8 5887.1 5892.4 3373.2 3561.1 3624.8 3642.7 3646.9 1071.8 1110.6 1145.7 1202.1 1222.0 13553.3 14028.6 14037.4 15079.3 15096.9 3971.9 4646.5 4663.5 4665.3 4672.9 11327.0 11327.4 11332.0 11334.6 11337.4 4873.9 5045.2 5083.5 5644.1 5664.7 4337.5 5251.0 5267.6 5272.9 5291.5 3683.4 3773.1 3778.7 3841.3 3860.8 994.9 1001.3 1011.1 1011.8 1034.1 917.2 940.5 945.0 959.1 995.9 6326.6 6410.8 6621.8 6638.3 6747.1 971.0 977.6 999.2 1022.3 1032.5 4259.6 4271.4 4299.3 4384.9 4398.3 13515.2 13956.7 13970.2 13991.4 14002.9 12449.3 12980.2 13524.0 13893.9 13918.6 9570.0 9851.9 9895.6 10130.8 10160.3 5945.6 6594.9 6773.0 6870.4 6987.1 11799.2 11964.4 12025.2 12145.3 12241.0 9440.3 11647.8 12320.3 12418.0 12435.8 8674.4 8829.1 9266.8 9418.5 9419.8 10366.8 10484.4 10569.2 10578.7 10597.5 9177.9 9181.4 9222.4 9335.2 9455.4 8928.3 8999.1 9060.6 9244.6 9248.5 7807.5 7854.6 7868.3 7947.6 7978.6 5919.4 5940.3 5940.5 5953.5 6051.0 5950.4 6003.7 6004.5 6024.1 6056.7 10:35:21 INFO - PROCESS | 1635 | 10:35:21 INFO - PROCESS | 1635 | [#4] prototype.html Cycles:180 Average:4254.19 Median:4578.08 stddev:1169.80 (25.6%) stddev-sans-first:1136.16 10:35:21 INFO - PROCESS | 1635 | Values: 369.5 372.2 375.2 379.7 385.7 4134.5 4299.7 4629.5 4780.7 4781.8 4298.8 4338.4 4346.2 4390.1 4548.4 3548.5 3830.0 3911.6 4025.4 4040.5 3859.5 4006.3 4013.9 4030.4 4041.4 4030.0 4048.3 4053.3 4053.7 4058.3 3350.5 3824.9 3900.2 4013.0 4105.5 3365.2 3679.7 3687.9 3733.4 3755.7 4329.8 4391.0 4421.9 4678.8 4779.8 4639.8 4641.5 4642.8 4658.6 4678.9 4204.2 4332.5 4852.8 5114.8 5119.1 3581.6 3804.2 3837.6 4095.8 4138.8 4604.7 5101.8 5313.2 5353.9 5408.6 3841.3 4081.7 4148.2 4195.9 4230.7 3771.3 4243.7 4277.9 4306.8 4337.4 4449.2 4493.5 4607.6 4620.7 4649.3 4645.9 4810.5 4951.5 5047.6 5109.3 1308.6 1415.9 1446.7 1455.4 1470.6 1004.4 1016.5 1019.9 1088.9 1097.4 4465.2 4484.5 4634.3 4771.0 4780.2 4421.9 5164.0 5304.6 5319.8 5335.4 4388.5 4396.5 4629.2 4737.2 4821.7 2513.3 2514.0 2521.2 2543.9 2642.8 4833.6 5177.7 5265.7 5447.3 5459.0 4800.1 5082.8 5372.8 5385.3 5404.2 4551.5 4841.9 4986.0 5223.2 5392.8 4927.7 5188.8 5201.9 5239.6 5285.9 4480.9 4756.6 4845.9 5038.2 5078.6 4543.8 5000.2 5154.4 5220.1 5234.4 3934.4 4068.0 4155.0 4213.8 4219.0 4867.0 5269.7 5272.5 5291.1 5304.2 4718.0 5009.9 5091.6 5107.5 5141.8 4458.0 5080.6 5091.5 5109.5 5119.1 4421.4 5010.8 5042.3 5048.0 5090.3 4757.2 4873.2 5082.6 5118.7 5151.2 4229.7 4379.8 4852.4 5021.8 5074.5 10:35:21 INFO - PROCESS | 1635 | 10:35:21 INFO - PROCESS | 1635 | [#5] yui.html Cycles:180 Average:19524.11 Median:14019.31 stddev:26941.17 (192.2%) stddev-sans-first:26979.70 10:35:21 INFO - PROCESS | 1635 | Values: 706.2 717.3 755.8 814.7 824.5 14830.8 15608.8 15680.2 15682.9 15704.3 13781.0 14217.0 14327.6 14329.6 14715.0 934.8 966.2 967.6 968.0 972.4 929.1 950.3 952.9 954.2 959.4 1010.1 1020.5 1022.0 1023.0 1023.7 1009.2 1011.7 1012.4 1013.2 1014.6 756.6 756.7 757.1 757.5 758.6 14919.4 15208.9 15262.3 15286.9 15352.5 14595.0 14844.8 14965.8 14974.0 15017.0 11283.9 11501.4 11670.9 12130.7 12168.3 3653.6 3707.6 3713.5 3772.8 3889.3 97363.0 99025.5 99483.0 100280.5 100466.5 11358.1 11386.5 11401.3 11581.4 11790.6 23983.6 24487.0 24515.6 24547.2 24576.5 7457.7 7532.7 7535.9 7622.4 7718.2 4017.4 4072.8 4132.2 4292.1 4341.2 3462.1 3558.2 3558.6 3559.9 3560.7 636.1 660.7 662.1 663.1 667.7 564.8 660.4 667.5 673.6 708.4 9999.9 10003.6 10062.8 10122.8 10266.5 642.2 687.4 718.4 719.9 730.6 4554.4 4723.6 4828.0 4854.6 4865.9 94027.0 98781.5 99264.0 100152.5 100450.5 52454.7 60056.8 61261.0 74695.0 83496.2 72254.1 72650.6 74118.0 74310.6 74920.9 10468.0 10568.3 10880.8 10903.3 11020.5 45070.1 46499.5 47466.8 48131.0 48912.5 67722.0 67896.3 67927.0 68335.0 69238.3 13317.0 13363.8 13481.7 13666.2 14018.8 14267.1 14267.4 14487.4 14565.1 14697.3 13592.8 13729.2 13836.7 13921.9 14030.3 13312.9 13418.9 13514.7 13557.5 13591.0 13251.3 13411.0 13435.8 13511.9 13524.3 10721.8 10728.9 10836.7 10885.8 11195.3 8500.6 9440.7 10766.3 11168.7 11260.9 10:35:21 INFO - PROCESS | 1635 | -------- Summary: end -------- 10:35:21 INFO - PROCESS | 1635 | 10:35:22 INFO - TEST-INFO | 1635: exit 0 10:35:22 INFO - TEST-OK | dromaeo_css | took 1122384ms 10:35:22 INFO - TEST-START | kraken 10:35:22 INFO - operating with platform_type : mac_ 10:35:22 INFO - Initialising browser for kraken test... 10:35:22 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/tmp4QAXDo/profile http://localhost:49240/getInfo.html) 10:35:24 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 10:35:24 INFO - PROCESS | 1646 | colorDepth:24 10:35:24 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 10:35:24 INFO - PROCESS | 1646 | __metrics 10:35:24 INFO - PROCESS | 1646 | 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" 10:35:24 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:35:25 INFO - TEST-INFO | 1646: exit 0 10:35:25 INFO - Browser initialized. 10:35:25 INFO - Running cycle 1/1 for kraken test... 10:35:25 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/T/tmp4QAXDo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:35:37 INFO - PROCESS | 1647 | RSS: Main: 232640512 10:35:37 INFO - PROCESS | 1647 | 10:35:40 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 10:35:41 INFO - PROCESS | 1647 | RSS: Main: 284692480 10:35:41 INFO - PROCESS | 1647 | 10:35:44 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 10:35:45 INFO - PROCESS | 1647 | RSS: Main: 286777344 10:35:45 INFO - PROCESS | 1647 | 10:35:48 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 10:35:49 INFO - PROCESS | 1647 | RSS: Main: 380776448 10:35:49 INFO - PROCESS | 1647 | 10:35:51 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 10:35:51 INFO - PROCESS | 1647 | RSS: Main: 284172288 10:35:51 INFO - PROCESS | 1647 | 10:35:53 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:35:54 INFO - PROCESS | 1647 | RSS: Main: 285794304 10:35:54 INFO - PROCESS | 1647 | 10:35:57 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 10:35:57 INFO - PROCESS | 1647 | RSS: Main: 329572352 10:35:57 INFO - PROCESS | 1647 | 10:36:00 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 10:36:01 INFO - PROCESS | 1647 | RSS: Main: 332161024 10:36:01 INFO - PROCESS | 1647 | 10:36:04 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 10:36:04 INFO - PROCESS | 1647 | RSS: Main: 330326016 10:36:04 INFO - PROCESS | 1647 | 10:36:06 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:36:07 INFO - PROCESS | 1647 | RSS: Main: 303026176 10:36:07 INFO - PROCESS | 1647 | 10:36:08 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:36:09 INFO - PROCESS | 1647 | RSS: Main: 305938432 10:36:09 INFO - PROCESS | 1647 | 10:36:11 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:36:12 INFO - PROCESS | 1647 | RSS: Main: 308088832 10:36:12 INFO - PROCESS | 1647 | 10:36:15 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:36:16 INFO - PROCESS | 1647 | RSS: Main: 325853184 10:36:16 INFO - PROCESS | 1647 | 10:36:19 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:36:19 INFO - PROCESS | 1647 | RSS: Main: 320241664 10:36:19 INFO - PROCESS | 1647 | 10:36:21 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 10:36:21 INFO - PROCESS | 1647 | RSS: Main: 364998656 10:36:21 INFO - PROCESS | 1647 | 10:36:21 INFO - PROCESS | 1647 | __start_tp_report 10:36:21 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 10:36:21 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 10:36:21 INFO - PROCESS | 1647 | |i|pagename|runs| 10:36:21 INFO - PROCESS | 1647 | |0;ai-astar;116;115;115;116;118;167;170;115;115;113 10:36:21 INFO - PROCESS | 1647 | |1;audio-beat-detection;142;110;111;151;138;123;108;127;158;135 10:36:21 INFO - PROCESS | 1647 | |2;audio-dft;187;183;184;180;180;184;186;184;187;186 10:36:21 INFO - PROCESS | 1647 | |3;audio-fft;81;60;60;90;63;61;62;59;80;61 10:36:21 INFO - PROCESS | 1647 | |4;audio-oscillator;80;78;95;73;69;68;84;69;69;84 10:36:21 INFO - PROCESS | 1647 | |5;imaging-gaussian-blur;87;86;88;87;88;87;87;87;87;87 10:36:21 INFO - PROCESS | 1647 | |6;imaging-darkroom;94;96;95;94;94;95;96;95;94;94 10:36:21 INFO - PROCESS | 1647 | |7;imaging-desaturate;85;82;86;83;82;83;84;90;115;83 10:36:21 INFO - PROCESS | 1647 | |8;json-parse-financial;66;62;61;61;61;64;62;63;62;62 10:36:21 INFO - PROCESS | 1647 | |9;json-stringify-tinderbox;56;63;71;63;62;60;59;57;58;58 10:36:21 INFO - PROCESS | 1647 | |10;stanford-crypto-aes;87;87;88;84;87;85;80;82;86;86 10:36:21 INFO - PROCESS | 1647 | |11;stanford-crypto-ccm;138;141;139;136;137;140;136;141;178;144 10:36:21 INFO - PROCESS | 1647 | |12;stanford-crypto-pbkdf2;170;170;167;182;247;181;169;168;172;173 10:36:21 INFO - PROCESS | 1647 | |13;stanford-crypto-sha256-iterative;65;67;66;74;80;82;78;81;68;64 10:36:21 INFO - PROCESS | 1647 | __end_tp_report 10:36:21 INFO - PROCESS | 1647 | __start_cc_report 10:36:21 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,2105 10:36:21 INFO - PROCESS | 1647 | __end_cc_report 10:36:21 INFO - PROCESS | 1647 | __startTimestamp1489170981843__endTimestamp 10:36:21 INFO - PROCESS | 1647 | 10:36:21 INFO - PROCESS | 1647 | ------- Summary: start ------- 10:36:21 INFO - PROCESS | 1647 | Number of tests: 14 10:36:21 INFO - PROCESS | 1647 | 10:36:21 INFO - PROCESS | 1647 | [#0] ai-astar Cycles:10 Average:126.00 Median:116.00 stddev:22.44 (19.3%) stddev-sans-first:23.51 10:36:21 INFO - PROCESS | 1647 | Values: 116.0 115.0 115.0 116.0 118.0 167.0 170.0 115.0 115.0 113.0 10:36:21 INFO - PROCESS | 1647 | 10:36:21 INFO - PROCESS | 1647 | [#1] audio-beat-detection Cycles:10 Average:130.30 Median:136.50 stddev:17.51 (12.8%) stddev-sans-first:18.06 10:36:21 INFO - PROCESS | 1647 | Values: 142.0 110.0 111.0 151.0 138.0 123.0 108.0 127.0 158.0 135.0 10:36:21 INFO - PROCESS | 1647 | 10:36:21 INFO - PROCESS | 1647 | [#2] audio-dft Cycles:10 Average:184.10 Median:185.00 stddev:2.56 (1.4%) stddev-sans-first:2.49 10:36:21 INFO - PROCESS | 1647 | Values: 187.0 183.0 184.0 180.0 180.0 184.0 186.0 184.0 187.0 186.0 10:36:21 INFO - PROCESS | 1647 | 10:36:21 INFO - PROCESS | 1647 | [#3] audio-fft Cycles:10 Average:67.70 Median:62.50 stddev:11.37 (18.2%) stddev-sans-first:11.00 10:36:21 INFO - PROCESS | 1647 | Values: 81.0 60.0 60.0 90.0 63.0 61.0 62.0 59.0 80.0 61.0 10:36:21 INFO - PROCESS | 1647 | 10:36:21 INFO - PROCESS | 1647 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:79.00 stddev:8.95 (11.3%) stddev-sans-first:9.42 10:36:21 INFO - PROCESS | 1647 | Values: 80.0 78.0 95.0 73.0 69.0 68.0 84.0 69.0 69.0 84.0 10:36:21 INFO - PROCESS | 1647 | 10:36:21 INFO - PROCESS | 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:87.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 10:36:21 INFO - PROCESS | 1647 | Values: 87.0 86.0 88.0 87.0 88.0 87.0 87.0 87.0 87.0 87.0 10:36:21 INFO - PROCESS | 1647 | 10:36:21 INFO - PROCESS | 1647 | [#6] imaging-darkroom Cycles:10 Average:94.70 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 10:36:21 INFO - PROCESS | 1647 | Values: 94.0 96.0 95.0 94.0 94.0 95.0 96.0 95.0 94.0 94.0 10:36:21 INFO - PROCESS | 1647 | 10:36:21 INFO - PROCESS | 1647 | [#7] imaging-desaturate Cycles:10 Average:87.30 Median:83.50 stddev:10.02 (12.0%) stddev-sans-first:10.60 10:36:21 INFO - PROCESS | 1647 | Values: 85.0 82.0 86.0 83.0 82.0 83.0 84.0 90.0 115.0 83.0 10:36:21 INFO - PROCESS | 1647 | 10:36:21 INFO - PROCESS | 1647 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:62.00 stddev:1.58 (2.5%) stddev-sans-first:1.00 10:36:21 INFO - PROCESS | 1647 | Values: 66.0 62.0 61.0 61.0 61.0 64.0 62.0 63.0 62.0 62.0 10:36:21 INFO - PROCESS | 1647 | 10:36:21 INFO - PROCESS | 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:4.37 (7.2%) stddev-sans-first:4.29 10:36:21 INFO - PROCESS | 1647 | Values: 56.0 63.0 71.0 63.0 62.0 60.0 59.0 57.0 58.0 58.0 10:36:21 INFO - PROCESS | 1647 | 10:36:21 INFO - PROCESS | 1647 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:86.50 stddev:2.53 (2.9%) stddev-sans-first:2.60 10:36:21 INFO - PROCESS | 1647 | Values: 87.0 87.0 88.0 84.0 87.0 85.0 80.0 82.0 86.0 86.0 10:36:21 INFO - PROCESS | 1647 | 10:36:21 INFO - PROCESS | 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:143.00 Median:140.50 stddev:12.55 (8.9%) stddev-sans-first:13.18 10:36:21 INFO - PROCESS | 1647 | Values: 138.0 141.0 139.0 136.0 137.0 140.0 136.0 141.0 178.0 144.0 10:36:21 INFO - PROCESS | 1647 | 10:36:21 INFO - PROCESS | 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.90 Median:172.50 stddev:24.13 (14.0%) stddev-sans-first:25.33 10:36:21 INFO - PROCESS | 1647 | Values: 170.0 170.0 167.0 182.0 247.0 181.0 169.0 168.0 172.0 173.0 10:36:21 INFO - PROCESS | 1647 | 10:36:21 INFO - PROCESS | 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:76.00 stddev:7.25 (9.5%) stddev-sans-first:7.16 10:36:21 INFO - PROCESS | 1647 | Values: 65.0 67.0 66.0 74.0 80.0 82.0 78.0 81.0 68.0 64.0 10:36:21 INFO - PROCESS | 1647 | -------- Summary: end -------- 10:36:21 INFO - PROCESS | 1647 | 10:36:22 INFO - TEST-INFO | 1647: exit 0 10:36:22 INFO - TEST-OK | kraken | took 60404ms 10:36:22 INFO - SUITE-END | took 1182s 10:36:22 INFO - Completed test suite (00:19:43) 10:36:22 INFO - javascript benchmark 10:36:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7543.7097525446625, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3281.7210537104347, 3328.0, 3355.9496607550877, 3392.474166504193, 3407.2674375009383, 5610.4670056344685, 5710.77156913724, 5722.341930677968, 5837.9124313135335, 5853.765849366031, 5768.653880767157, 5845.181674565553, 5906.852328691785, 5914.9112763308585, 5933.3176684681275, 5179.792808287664, 5217.087009773274, 5230.843074707765, 5244.475552444763, 5256.763445644955, 5321.787128514855, 5380.596455265852, 5388.137897936331, 5391.514763671269, 5443.346798384199, 5110.667806592597, 5165.328507294065, 5247.790088396498, 5247.973760131213, 5283.709395983219, 4414.602685758297, 5246.8688282792855, 5250.159974404077, 5252.474752524755, 5262.500062494057, 5128.9230661540105, 5183.377994640668, 5201.115810312256, 5209.505097015777, 5212.139996900507, 5718.142278658193, 5723.112917497794, 5731.656100633933, 5732.0, 5736.426357364272, 6150.8769824603705, 6153.107799369066, 6156.56904016719, 6157.876842463171, 6161.476274516672, 6042.395760423967, 6117.644716737952, 6146.385361463817, 6152.953997820381, 6174.444300012976, 5884.941150588482, 5903.734331955073, 5912.290525137011, 5917.704114794243, 5932.58471906971, 6347.016212487072, 6385.2656944451055, 6418.326075762071, 6431.517636177306, 6434.7104380303, 6066.393360663898, 6110.205673262536, 6112.1995365628145, 6162.445379915829, 6167.321594624587, 6140.657627863787, 6140.762873617279, 6160.537959652955, 6174.598651087665, 6187.876242475125, 6163.952128138228, 6168.35232300602, 6177.289611694712, 6181.134641150243, 6185.350538193515, 5524.392316845224, 6109.877802443926, 6146.7706458708435, 6160.8767824643255, 6165.229346331708, 4880.926786098212, 4994.950050499521, 5003.649744517922, 5016.749162541858, 5017.57350625201, 4342.934855977162, 4433.800478978454, 4435.756033418193, 4438.134563760101, 4511.436070491189, 5731.885362292731, 5748.45389687979, 5840.2991641003355, 5858.0, 5909.084091965752, 5510.870271594394, 6263.029230469285, 6275.780347687809, 6281.968590157111, 6287.49700023997, 5663.575231857627, 5725.51333136688, 5800.477956983807, 5806.274215723035, 5833.270841144857, 5457.672539647554, 5468.398476167618, 5473.124300111963, 5477.233187353773, 5494.983428065821, 4980.740812519702, 5389.865253368697, 6211.503079753609, 6252.468540174045, 6309.589876658186, 6231.813045608639, 6279.780207692709, 6282.654454005074, 6289.779857704958, 6300.149479820349, 6411.96794016027, 6415.775447859302, 6444.581102228341, 6445.581037232565, 6449.419552240321, 6073.939260607337, 6287.779927702509, 6304.117423560797, 6306.148669929501, 6331.493480521455, 4756.548127927841, 6114.0236562776045, 6200.472959798287, 6203.937960620517, 6218.098375735583, 6039.0, 6043.063325184604, 6050.21347224858, 6053.667048312385, 6054.576179667381, 5950.375210602824, 6050.334463209131, 6057.878842423215, 6066.514678825595, 6080.847978800565, 5841.591088623755, 5891.94108058931, 5895.528357731286, 5896.793612223723, 5911.290645122613, 5971.761129554943, 6093.512518998558, 6139.338817383189, 6168.876622467616, 6212.751489940351, 6048.334683184934, 6051.183090282755, 6054.117576759427, 6071.392860713893, 6128.233970753656], "value": 5697.496730510255, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.1807943745537, 738.6639079218955, 937.8452555328371, 956.9521523923802, 961.3318743473288, 29590.556141657864, 37989.24021519568, 37996.43005354922, 38004.23991520168, 38199.80900095499, 36565.63434365656, 36874.44688329677, 36920.44619330712, 37045.444318335176, 37261.81369093157, 7299.744508942188, 7463.552186868778, 7621.199774023731, 7772.183920688331, 7777.455578109534, 7302.379297759697, 7401.333879950804, 10635.57457701691, 10966.725831854188, 11074.557017719282, 10994.065504432132, 11009.83485247722, 11011.944940275327, 11054.0, 11101.888981110167, 10978.835317470244, 10989.890101099047, 11018.39398833064, 11022.0, 11041.889581104208, 7222.638868056629, 7381.11426628808, 10577.576896924114, 10658.62694805678, 10818.513166907507, 36924.815375923215, 36971.815140924125, 37058.81470592657, 37078.25843483142, 37129.0, 3709.4806727058235, 3715.9071023224365, 3717.5724791649036, 3734.9066273343383, 3778.5465744110606, 26739.197824065115, 27768.58347124795, 27843.443131137265, 28248.0, 29177.41645167106, 3097.519884417919, 3118.3607360491274, 3121.266502371941, 3234.094453553009, 3236.01301603011, 339089.0, 341068.0, 344516.0, 346251.0, 346656.0, 39781.0, 39944.0, 41771.582284176766, 48437.757811210715, 48915.26627100597, 51574.0, 51892.740536297075, 52090.739546302786, 52115.0, 52221.7388913053, 13394.196348219139, 13436.193828370133, 13439.798403023962, 13464.057515973787, 13479.663008424868, 10662.466876656135, 10681.092107170978, 10681.57273709043, 10692.62575809843, 10746.032857042903, 13319.66700832487, 13329.0, 13423.463061477627, 13453.856422204026, 13572.660683482794, 5822.438127224008, 5842.298924129132, 5863.648181109147, 5878.441548052928, 5884.47039766423, 1101.2786624760795, 1123.2530367305812, 1123.455124264731, 1142.9713258067638, 1156.2816364610742, 26045.088421905144, 26080.60879086815, 26163.607545886825, 26492.205233843015, 26606.733932660813, 1206.6802297391198, 1214.3442541027746, 1218.524775337619, 1252.4927404401233, 1255.3723138430785, 12109.273443593413, 12330.0, 13640.727185456235, 13826.585202443943, 13894.0, 491768.54115729907, 492932.21203363955, 493016.0, 493381.0, 493721.0, 53732.731336343066, 54134.0, 54159.0, 54289.0, 54364.912701746536, 1369.8493165751759, 1409.4150927365029, 1410.781328894023, 1412.5974097382607, 1413.809135766679, 24693.0, 25574.0, 25767.871160644077, 25773.0, 25774.87112564425, 43925.12149757051, 44005.55994440015, 44014.55985440104, 44024.339634906144, 44079.11841763211, 424426.80158784625, 428375.0, 428699.0, 429296.0, 430130.0, 26560.335991599593, 28106.2973425666, 31807.681923180473, 32461.35077298488, 33510.832445837616, 39767.60232397639, 42228.57771422246, 43408.34887476754, 43447.565524344354, 43471.13057738891, 25604.871975640002, 29590.28907023129, 31898.0, 35628.10929726777, 35840.0, 28542.42915141644, 34510.7921222756, 34555.827220863735, 35912.640873591976, 36036.01801900816, 34626.0, 35173.94478165659, 35527.0, 35577.1105722359, 35632.46551301784, 25024.74975250224, 27472.901083956418, 28418.857905710338, 28819.711802881702, 31265.531017035217, 23168.53662926766, 23567.64648530239, 24148.87925560361, 24694.629580555946, 25761.613575796753], "value": 18327.50967489797, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.2490868081197, 394.7296102170014, 411.9732217405867, 418.428844627084, 436.8034384526962, 11750.823737643932, 21222.681659775095, 21792.45518862027, 22728.204512842054, 22758.31725048247, 21913.0, 21917.671234931488, 22571.77428225717, 22985.4253643659, 23210.3036908893, 6325.209348831396, 6502.2197336319705, 6648.833779155536, 6796.184457865063, 6819.590824550518, 5699.971500142494, 6805.047293378906, 6810.080639113706, 6812.4550035997, 6825.6587170641515, 6606.1412016438035, 6670.3329667033395, 6702.966485167567, 6758.9662051689675, 6806.761763338284, 6475.773347932847, 6619.404253617149, 6753.628550429725, 6788.355106264897, 6832.897506537406, 6533.18335208099, 6534.705938232743, 6540.803775886731, 6541.313162118005, 6547.9672601636685, 25926.351841203934, 25971.0, 25971.961121555116, 26093.347666308495, 26432.942682292683, 2874.9712502874913, 2876.6548014238215, 2924.38587896542, 2937.515309973852, 2944.190347654412, 15515.0, 16001.519954401387, 16006.359745610162, 16572.0, 16905.661886762195, 1992.3823614679495, 2031.1570698160247, 2187.0049127646885, 2193.802557769792, 2214.070090561952, 138760.0, 165665.0, 166234.0, 168522.1573892135, 170793.0, 15379.923100384427, 16999.130095689463, 21162.153513859583, 21187.576248474943, 21418.571628567654, 35183.12042198965, 35368.46947295793, 35458.0, 35610.28779424397, 35630.643693562735, 7659.578723170168, 9932.453715045598, 9988.700338989842, 10032.899671003343, 10206.846897296546, 7643.273888980538, 7845.137034926153, 7992.840143197103, 8199.344052475788, 8206.83586328282, 8438.185790055168, 10293.53679084443, 10367.16414926482, 10378.42918639482, 10492.108170805566, 3539.124658498991, 4063.327173750152, 4123.443465051627, 4124.340105583093, 4135.276326642826, 1044.2898828796492, 1053.262716098734, 1053.3890343600692, 1053.7365658585354, 1107.385401102396, 22353.0, 22877.428064298194, 22884.65673014906, 22904.427389315402, 22952.885235573714, 1005.8139244239838, 1057.5928267616869, 1064.5369264370024, 1097.2154909239932, 1103.3104309806372, 10740.550025746425, 11013.2841365311, 11789.567898165149, 11911.332413462122, 11932.463039163258, 577987.0, 682271.0, 706624.0, 711241.4437927881, 722170.0, 139408.1798957148, 140980.2950985259, 147170.4701334331, 148844.0, 150550.0, 1180.0795379603924, 1194.5759255464186, 1212.3271584270815, 1223.46167686216, 1224.7244370016854, 19693.40919772409, 19943.501412464226, 19958.0, 20011.299604513773, 20073.899630501754, 52154.956900862526, 52751.0, 59737.70131149316, 60098.69950650219, 60944.695276525104, 65279.34720652923, 66169.0, 70517.29482705107, 73112.63443682747, 86371.90666043537, 11711.765764684487, 11841.348725819818, 12192.75614487723, 12256.816147757969, 12373.381330933596, 13590.320483975564, 13593.796093058414, 13677.0, 14072.577822665336, 14142.43430262778, 11618.5352585899, 11944.462499187384, 11974.341411222118, 12072.577459788865, 12106.455209515769, 11343.48954297075, 11550.0, 11573.132015098732, 11944.761104777683, 11961.983231425427, 11567.305961642329, 11637.650870473899, 12102.219623248591, 12155.027597792332, 12329.321887296284, 11856.229345092886, 11969.982551483221, 12115.970142537983, 12192.817107743569, 12216.511339546318, 11720.648380548597, 11784.941075294912, 11942.641720748392, 12047.156699031335, 12106.576269830513], "value": 11648.643395913641, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1544.55980045687, 1552.906825590464, 1574.4174655377512, 1595.186454907997, 1601.0153755440404, 10627.096696780773, 11309.717257068578, 11322.26405283656, 11328.207025508218, 11375.943120284386, 10675.946620266906, 10923.071538919201, 11064.889351106487, 11210.495527701252, 11214.158938079656, 2325.5813953488364, 2361.3860396297, 2368.917087901924, 2370.798482129021, 2370.8577485350934, 2304.4008557775014, 2333.7199536055614, 2342.3792694935855, 2343.414146463384, 2349.718033835942, 2321.872297023663, 2340.6372012338115, 2342.2387723989686, 2348.7416384197722, 2354.6350315701093, 2290.9656355154684, 2313.6760853480528, 2317.5017371265258, 2319.7564255753073, 2320.4662927526597, 2278.293728944033, 2347.4248809041724, 2351.976480235193, 2353.8352315337934, 2354.0701422938014, 11028.834567481494, 11120.833187502112, 11127.499262533205, 11135.99776020162, 11145.665630031112, 5546.69493177875, 5689.061304884689, 5880.764769409218, 5887.087501437241, 5892.410758924116, 3373.2072962853954, 3561.12752375667, 3624.800635965021, 3642.7267954903486, 3646.8723594674325, 1071.8499410082595, 1110.566878917223, 1145.6963904565298, 1202.0744027099086, 1221.9938900305442, 13553.322333883267, 14028.649283767783, 14037.438502459889, 15079.321430535652, 15096.924515377463, 3971.940420893689, 4646.512116227815, 4663.48701642819, 4665.300204969214, 4672.859814205579, 11327.0, 11327.433628318551, 11332.0, 11334.603288885015, 11337.43312834355, 4873.878153046131, 5045.217991211368, 5083.517065878736, 5644.125160600113, 5664.716764161858, 4337.50118736343, 5251.0, 5267.631265811433, 5272.947270527322, 5291.523762861361, 3683.4106542953, 3773.056735816046, 3778.678812300985, 3841.3085644583684, 3860.82626281818, 994.9253805964581, 1001.2940876681922, 1011.0950699124243, 1011.7723512209694, 1034.13132968307, 917.1837065012145, 940.4592359393376, 944.976375590602, 959.1367769007949, 995.9004099590128, 6326.588771729823, 6410.8076757697345, 6621.801345959629, 6638.269790323061, 6747.089142965735, 970.9951450242703, 977.6187286958092, 999.1557134221571, 1022.2588623248085, 1032.4734385463319, 4259.574042595716, 4271.440924062695, 4299.290617048152, 4384.934225986613, 4398.340248962617, 13515.189088654712, 13956.72086558263, 13970.231637260049, 13991.370388332549, 14002.929985350213, 12449.315287659265, 12980.15628984113, 13523.985701072459, 13893.930530347487, 13918.56425125599, 9570.0, 9851.901480985098, 9895.55470003866, 10130.848037279447, 10160.33957792741, 5945.64326140433, 6594.901076483952, 6772.966135169293, 6870.381665649916, 6987.0567473392475, 11799.17405781587, 11964.401779911144, 12025.158238923192, 12145.271283723005, 12241.0, 9440.339176257596, 11647.825282620597, 12320.322382269062, 12418.00655947504, 12435.751284974069, 8674.392792504465, 8829.072947340437, 9266.768330791785, 9418.529073546433, 9419.811603768023, 10366.844497332697, 10484.370937743455, 10569.207309451976, 10578.682639520826, 10597.523111460157, 9177.908220917705, 9181.449113053239, 9222.354435189472, 9335.206507446672, 9455.385399948982, 8928.285737140883, 8999.10008999121, 9060.592273347584, 9244.583993720164, 9248.537573121452, 7807.531548107132, 7854.567998760123, 7868.291853733192, 7947.642356094106, 7978.601069946363, 5919.4080591940465, 5940.3168635605725, 5940.495057920125, 5953.523718102455, 6050.969745151422, 5950.404959504015, 6003.729832157476, 6004.517379919724, 6024.1265016573225, 6056.66688332146], "value": 5094.119911500194, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.5048634829328, 372.1663473818647, 375.24013871909386, 379.69055219995687, 385.6779589043149, 4134.4625198724125, 4299.699021068526, 4629.513901040385, 4780.681369535772, 4781.784819683114, 4298.763568003758, 4338.418640908662, 4346.218050599255, 4390.100029493954, 4548.385967894342, 3548.5209496718, 3829.961700383002, 3911.6088391160797, 4025.423728813562, 4040.545403654682, 3859.4982652255308, 4006.3389540725743, 4013.8795836124964, 4030.355143177092, 4041.3937909313545, 4029.959700402988, 4048.2915489789316, 4053.29067413203, 4053.695972802037, 4058.269511487931, 3350.4974253861874, 3824.8661296854616, 3900.2004589059175, 4013.0, 4105.527864295615, 3365.175531994677, 3679.6688298053305, 3687.907802304937, 3733.4213196954242, 3755.6902504959526, 4329.783510824478, 4390.990072283393, 4421.867343979686, 4678.836240731592, 4779.80880764769, 4639.837605683819, 4641.466231383367, 4642.837500687459, 4658.557437043475, 4678.929816052762, 4204.159168166379, 4332.501762297345, 4852.757362131879, 5114.820981265675, 5119.10415677255, 3581.606023337431, 3804.2011177652726, 3837.6354246346555, 4095.7507960072166, 4138.813753381105, 4604.700694454849, 5101.795928162869, 5313.203019547061, 5353.858456617345, 5408.621396502246, 3841.3469710149343, 4081.7346872453195, 4148.170365926827, 4195.8671158787565, 4230.661547076226, 3771.264603402365, 4243.745375277432, 4277.935830962538, 4306.82772689089, 4337.37108119321, 4449.221386257392, 4493.483249426293, 4607.6083532900075, 4620.722756634613, 4649.349091127245, 4645.883852903705, 4810.518948105231, 4951.455339912607, 5047.621428392885, 5109.259157422153, 1308.6074177746639, 1415.9221242831536, 1446.7124259409134, 1455.4396557325506, 1470.5882352941194, 1004.3622299839508, 1016.5222345497605, 1019.9490025498844, 1088.9455527223606, 1097.434821067151, 4465.151621192028, 4484.529124441952, 4634.281686338623, 4771.0, 4780.163471392562, 4421.911561768747, 5164.04465173944, 5304.628675992721, 5319.760610772524, 5335.359756829128, 4388.545914745502, 4396.450443694538, 4629.213033784265, 4737.242041273448, 4821.710697358169, 2513.258588716333, 2514.0013689117195, 2521.205820166642, 2543.910963116319, 2642.757903785218, 4833.564979151823, 5177.689338639693, 5265.656308244293, 5447.319085114361, 5458.962797068544, 4800.06398752247, 5082.847514574569, 5372.791121997598, 5385.299911011543, 5404.189371594292, 4551.453825540956, 4841.917975270668, 4985.950140498621, 5223.242629818655, 5392.7573259202645, 4927.704337739747, 5188.818391356435, 5201.895962080813, 5239.554637855825, 5285.8678533035445, 4480.887977800581, 4756.574452310592, 4845.927311090266, 5038.193888977746, 5078.619103567321, 4543.772811359485, 5000.199968005102, 5154.433012368711, 5220.112580861187, 5234.377343023675, 3934.390169523728, 4067.9796601016806, 4155.044339801802, 4213.831446742096, 4218.957810421856, 4866.975665121652, 5269.683818970874, 5272.472752724697, 5291.100512912737, 5304.204369344475, 4717.994852187738, 5009.949900500948, 5091.6181286402925, 5107.463716309734, 5141.845744627667, 4457.955420445754, 5080.593552515716, 5091.490850914879, 5109.540141387293, 5119.078565858182, 4421.447319085114, 5010.8246211383885, 5042.344495215745, 5048.0, 5090.26191202281, 4757.168490131256, 4873.195922672861, 5082.567981721595, 5118.74406279692, 5151.1881207905135, 4229.661627069766, 4379.802908869045, 4852.369192005158, 5021.824236151717, 5074.517920797518], "value": 3915.613078732501, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.2344139650872, 717.2863001313693, 755.765712629085, 814.7026335387584, 824.4742860261032, 14830.77753833692, 15608.843911560882, 15680.215989200522, 15682.92158539207, 15704.293306801193, 13780.966427517926, 14217.0, 14327.570172894804, 14329.570112896603, 14715.0, 934.7709811096274, 966.1787480641434, 967.641972470187, 968.0174622757906, 972.4214092614883, 929.1034152043277, 950.3205208276081, 952.9380590261645, 954.1555723184962, 959.4243453927622, 1010.1413798271484, 1020.5152552537522, 1022.0086516079391, 1023.0434543701663, 1023.698009087321, 1009.2329829329689, 1011.6610935336671, 1012.3571532077148, 1013.2248829645328, 1014.5535964175739, 756.6405957170355, 756.6859753202415, 757.0839284465748, 757.5151902782223, 758.6396461680713, 14919.403223871032, 15208.923955380153, 15262.31319590621, 15286.923565382102, 15352.539423817303, 14595.0, 14844.78819822912, 14965.7755133672, 14974.0, 15017.023893447, 11283.943580282046, 11501.42492875353, 11670.883291167065, 12130.696732581668, 12168.2699038058, 3653.598104208535, 3707.610700876396, 3713.4801127842125, 3772.75477093988, 3889.3388124018984, 97363.0, 99025.50487247518, 99483.0051699481, 100280.49859750728, 100466.4976675112, 11358.148138889452, 11386.487608057658, 11401.258918170292, 11581.363025033705, 11790.587329443428, 23983.640245396335, 24487.0, 24515.632265516033, 24547.15896307784, 24576.508469830504, 7457.664405101784, 7532.698692052257, 7535.924640753632, 7622.352100071556, 7718.189590092959, 4017.397390391465, 4072.837086516506, 4132.214879172948, 4292.098659281586, 4341.196878577473, 3462.117160124152, 3558.2349794794245, 3558.5729712434154, 3559.8786382289495, 3560.6973407260157, 636.0522820996682, 660.6960798032862, 662.0797092042066, 663.0783211336246, 667.6861874918781, 564.7938502446577, 660.3627499463041, 667.5393978155155, 673.5958424944994, 708.4474110194056, 9999.851000531466, 10003.633160301908, 10062.849057264148, 10122.785265768154, 10266.486675666187, 642.2274522318435, 687.3950923187563, 718.3786025088261, 719.8668246374438, 730.6091241186047, 4554.43069616298, 4723.551262630044, 4827.951720482821, 4854.635902307341, 4865.9026819463415, 94027.0, 98781.50609246908, 99264.0, 100152.49923750335, 100450.49324260141, 52454.688632784484, 60056.798864023345, 61261.0, 74695.0, 83496.16503835005, 72254.1358570935, 72650.63674681593, 74118.0, 74310.62844685742, 74920.87618685725, 10468.0, 10568.260221784401, 10880.782384352111, 10903.29128606638, 11020.5040773167, 45070.0985980272, 46499.535004650876, 47466.76266618783, 48131.0, 48912.51087489222, 67722.0, 67896.32103679098, 67927.0, 68335.0, 69238.3076169252, 13317.0, 13363.799543007057, 13481.730365392834, 13666.248356340497, 14018.779668751578, 14267.143971361751, 14267.357968891218, 14487.420503179756, 14565.126092434488, 14697.265136743334, 13592.79610805819, 13729.176249425067, 13836.654083647989, 13921.860781392057, 14030.29848507591, 13312.933435332761, 13418.93290533541, 13514.662133446742, 13557.457701691821, 13591.0, 13251.271180085188, 13410.956650899694, 13435.798463023259, 13511.932440337736, 13524.256165910969, 10721.839172412576, 10728.946355268174, 10836.67489975302, 10885.782284354427, 11195.328280303207, 8500.61747221389, 9440.669576564787, 10766.284477827057, 11168.66494005181, 11260.88739112631], "value": 7595.089176719837, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1457.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 115.0, 116.0, 118.0, 167.0, 170.0, 115.0, 115.0, 113.0], "value": 126.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 110.0, 111.0, 151.0, 138.0, 123.0, 108.0, 127.0, 158.0, 135.0], "value": 130.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 183.0, 184.0, 180.0, 180.0, 184.0, 186.0, 184.0, 187.0, 186.0], "value": 184.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 60.0, 90.0, 63.0, 61.0, 62.0, 59.0, 80.0, 61.0], "value": 67.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 95.0, 73.0, 69.0, 68.0, 84.0, 69.0, 69.0, 84.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 88.0, 87.0, 88.0, 87.0, 87.0, 87.0, 87.0, 87.0], "value": 87.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 94.0, 94.0, 95.0, 96.0, 95.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 86.0, 83.0, 82.0, 83.0, 84.0, 90.0, 115.0, 83.0], "value": 87.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 62.0, 61.0, 61.0, 61.0, 64.0, 62.0, 63.0, 62.0, 62.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 63.0, 71.0, 63.0, 62.0, 60.0, 59.0, 57.0, 58.0, 58.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 88.0, 84.0, 87.0, 85.0, 80.0, 82.0, 86.0, 86.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 141.0, 139.0, 136.0, 137.0, 140.0, 136.0, 141.0, 178.0, 144.0], "value": 143.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 167.0, 182.0, 247.0, 181.0, 169.0, 168.0, 172.0, 173.0], "value": 179.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 74.0, 80.0, 82.0, 78.0, 81.0, 68.0, 64.0], "value": 72.5, "unit": "score"}]}]} 10:36:23 INFO - Return code: 0 10:36:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:36:23 ERROR - # TBPL SUCCESS # 10:36:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:36:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:36:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:36:23 INFO - 2017-03-10 10:36:23.185 screenresolution[1651:10022] starting screenresolution argv=screenresolution get 10:36:23 INFO - 2017-03-10 10:36:23.188 screenresolution[1651:10022] Display 0: 1600x1200x32@60 10:36:23 INFO - 2017-03-10 10:36:23.194 screenresolution[1652:10025] starting screenresolution argv=screenresolution list 10:36:23 INFO - Available Modes on Display 0 10:36:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:36:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:36:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:36:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:36:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:36:23 INFO - Intel Iris: 10:36:23 INFO - Chipset Model: Intel Iris 10:36:23 INFO - Type: GPU 10:36:23 INFO - Bus: Built-In 10:36:23 INFO - VRAM (Dynamic, Max): 1536 MB 10:36:23 INFO - Vendor: Intel (0x8086) 10:36:23 INFO - Device ID: 0x0a2e 10:36:23 INFO - Revision ID: 0x0009 10:36:23 INFO - Displays: 10:36:23 INFO - Display: 10:36:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:36:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:36:23 INFO - Display Serial Number: 1600x1200 60 10:36:23 INFO - Main Display: Yes 10:36:23 INFO - Mirror: Off 10:36:23 INFO - Online: Yes 10:36:23 INFO - Rotation: Supported 10:36:23 INFO - Return code: 0 10:36:23 INFO - Running post-action listener: _resource_record_post_action 10:36:23 INFO - [mozharness: 2017-03-10 18:36:23.429491Z] Finished run-tests step (success) 10:36:23 INFO - Running post-run listener: _resource_record_post_run 10:36:23 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 36652032; Write bytes: 512483328; Read time: 383; Write time: 1748 10:36:23 INFO - TinderboxPrint: CPU usage
54.2% 10:36:23 INFO - TinderboxPrint: I/O read bytes / time
36,652,032 / 383 10:36:23 INFO - TinderboxPrint: I/O write bytes / time
512,483,328 / 1,748 10:36:23 INFO - TinderboxPrint: CPU idle
2,205.1 (45.8%) 10:36:23 INFO - TinderboxPrint: CPU system
963.5 (20.0%) 10:36:23 INFO - TinderboxPrint: CPU user
1,649.0 (34.2%) 10:36:23 INFO - TinderboxPrint: Swap in / out
246,308,864 / 0 10:36:23 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203336192; Write bytes: 203323392; Read time: 15893; Write time: 442 10:36:23 INFO - run-tests - Wall time: 1184s; CPU: 54.0%; Read bytes: 35697664; Write bytes: 299251712; Read time: 368; Write time: 1273 10:36:23 INFO - Running post-run listener: _upload_blobber_files 10:36:23 INFO - Blob upload gear active. 10:36:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:36:23 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 10:36:23 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'] 10:36:23 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 10:36:24 INFO - (blobuploader) - INFO - Open directory for files ... 10:36:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:36:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:36:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:25 INFO - (blobuploader) - INFO - Done attempting. 10:36:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:36:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:36:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:25 INFO - (blobuploader) - INFO - Done attempting. 10:36:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:36:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:36:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:26 INFO - (blobuploader) - INFO - Done attempting. 10:36:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:36:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:36:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:28 INFO - (blobuploader) - INFO - Done attempting. 10:36:28 INFO - (blobuploader) - INFO - Iteration through files over. 10:36:28 INFO - Return code: 0 10:36:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:36:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:36:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5fba4342bcb37800ff4845f26259f60f8ef3fe3e2cef33da6e7164eb579e147812eb25cbe723007ce51fd5c8fbd988033307ff226051eb286c31b6e5a8835d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e8bf9f6b38f59328231af1a8c452c175ffcfbd65c96a4346ffc33309858285f86e5e4dbb38c2bdda84bdc8f216778902812a179a7128a151ea5f5bfeeb4ef18", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac681705c60bfaadadbe9bc1aabf88b39dbb4a50ce40910a62224215abfbd33d03ed47735ef0016a51842c1841b48049ec32a58450f41baff93feb1d2ab106ae", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0e09121798708990c56303c3873efc5417098514d3c87e826e3c2896f48c6f19eb167441590373481b3ec58f085205008b4117f701ef4dcc4b924df155f1851"} 10:36:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:36:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:36:28 INFO - Contents: 10:36:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5fba4342bcb37800ff4845f26259f60f8ef3fe3e2cef33da6e7164eb579e147812eb25cbe723007ce51fd5c8fbd988033307ff226051eb286c31b6e5a8835d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e8bf9f6b38f59328231af1a8c452c175ffcfbd65c96a4346ffc33309858285f86e5e4dbb38c2bdda84bdc8f216778902812a179a7128a151ea5f5bfeeb4ef18", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac681705c60bfaadadbe9bc1aabf88b39dbb4a50ce40910a62224215abfbd33d03ed47735ef0016a51842c1841b48049ec32a58450f41baff93feb1d2ab106ae", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0e09121798708990c56303c3873efc5417098514d3c87e826e3c2896f48c6f19eb167441590373481b3ec58f085205008b4117f701ef4dcc4b924df155f1851"} 10:36:28 INFO - Running post-run listener: copy_logs_to_upload_dir 10:36:28 INFO - Copying logs to upload dir... 10:36:28 INFO - mkdir: /builds/slave/test/build/upload/logs 10:36:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.821766 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-03-10 10:36:29.054338) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 10:36:29.058186) ========= 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.vRPjOa7mw0/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.yZrw4vBPnQ/Listeners TMPDIR=/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/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/c5fba4342bcb37800ff4845f26259f60f8ef3fe3e2cef33da6e7164eb579e147812eb25cbe723007ce51fd5c8fbd988033307ff226051eb286c31b6e5a8835d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e8bf9f6b38f59328231af1a8c452c175ffcfbd65c96a4346ffc33309858285f86e5e4dbb38c2bdda84bdc8f216778902812a179a7128a151ea5f5bfeeb4ef18", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac681705c60bfaadadbe9bc1aabf88b39dbb4a50ce40910a62224215abfbd33d03ed47735ef0016a51842c1841b48049ec32a58450f41baff93feb1d2ab106ae", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0e09121798708990c56303c3873efc5417098514d3c87e826e3c2896f48c6f19eb167441590373481b3ec58f085205008b4117f701ef4dcc4b924df155f1851"} build_url:https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010753 build_url: 'https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/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/c5fba4342bcb37800ff4845f26259f60f8ef3fe3e2cef33da6e7164eb579e147812eb25cbe723007ce51fd5c8fbd988033307ff226051eb286c31b6e5a8835d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e8bf9f6b38f59328231af1a8c452c175ffcfbd65c96a4346ffc33309858285f86e5e4dbb38c2bdda84bdc8f216778902812a179a7128a151ea5f5bfeeb4ef18", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac681705c60bfaadadbe9bc1aabf88b39dbb4a50ce40910a62224215abfbd33d03ed47735ef0016a51842c1841b48049ec32a58450f41baff93feb1d2ab106ae", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0e09121798708990c56303c3873efc5417098514d3c87e826e3c2896f48c6f19eb167441590373481b3ec58f085205008b4117f701ef4dcc4b924df155f1851"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 10:36:29.092246) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 10:36:29.092571) ========= 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.vRPjOa7mw0/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.yZrw4vBPnQ/Listeners TMPDIR=/var/folders/x_/xg8n3yp971j_g50kc_rtsl4w00000w/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.005228 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 10:36:29.141694) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 10:36:29.142016) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 10:36:29.142342) ========= ========= Total master_lag: 0.65 =========