builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0002 starttime: 1485317050.69 results: success (0) buildid: 20170124185348 builduid: af3567db84f64562b15c218d0cad203d revision: 6dccae211ae5fec6a1c1244b878ce0b93860154f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 20:04:10.693402) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 20:04:10.693827) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 20:04:10.694099) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 20:04:10.721478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 20:04:10.721774) ========= 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.ixEhpXmFmR/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.0lnVZU4Z95/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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-01-24 20:04:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 176M=0s 2017-01-24 20:04:10 (176 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.155189 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 20:04:10.901495) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 20:04:10.904853) ========= 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.ixEhpXmFmR/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.0lnVZU4Z95/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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.026246 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 20:04:10.953591) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-24 20:04:10.953948) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6dccae211ae5fec6a1c1244b878ce0b93860154f --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 6dccae211ae5fec6a1c1244b878ce0b93860154f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ixEhpXmFmR/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.0lnVZU4Z95/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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-01-24 20:04:11,059 truncating revision to first 12 chars 2017-01-24 20:04:11,059 Setting DEBUG logging. 2017-01-24 20:04:11,059 attempt 1/10 2017-01-24 20:04:11,059 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6dccae211ae5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-24 20:04:12,428 unpacking tar archive at: mozilla-central-6dccae211ae5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.622779 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-24 20:04:12.603925) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 20:04:12.604230) ========= script_repo_revision: 6dccae211ae5fec6a1c1244b878ce0b93860154f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 20:04:12.604619) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 20:04:12.604901) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 20:04:12.625584) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-24 20:04:12.625993) ========= /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.ixEhpXmFmR/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.0lnVZU4Z95/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 20:04:12 INFO - MultiFileLogger online at 20170124 20:04:12 in /builds/slave/test 20:04:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 20:04:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:04:12 INFO - {'append_to_log': False, 20:04:12 INFO - 'base_work_dir': '/builds/slave/test', 20:04:12 INFO - 'blob_upload_branch': 'Firefox', 20:04:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:04:12 INFO - 'branch': 'Firefox', 20:04:12 INFO - 'buildbot_json_path': 'buildprops.json', 20:04:12 INFO - 'config_files': ('talos/mac_config.py',), 20:04:12 INFO - 'default_actions': ('clobber', 20:04:12 INFO - 'read-buildbot-config', 20:04:12 INFO - 'download-and-extract', 20:04:12 INFO - 'populate-webroot', 20:04:12 INFO - 'create-virtualenv', 20:04:12 INFO - 'install', 20:04:12 INFO - 'run-tests'), 20:04:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:04:12 INFO - 'download_minidump_stackwalk': True, 20:04:12 INFO - 'download_symbols': 'ondemand', 20:04:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:04:12 INFO - 'tooltool.py': '/tools/tooltool.py', 20:04:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:04:12 INFO - '/tools/misc-python/virtualenv.py')}, 20:04:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:04:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:04:12 INFO - 'installer_path': 'installer.exe', 20:04:12 INFO - 'log_level': 'info', 20:04:12 INFO - 'log_name': 'talos', 20:04:12 INFO - 'log_to_console': True, 20:04:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:04:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:04:12 INFO - 'opt_config_files': (), 20:04:12 INFO - 'pip_index': False, 20:04:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:04:12 INFO - 'cmd': ('bash', 20:04:12 INFO - '-c', 20:04:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:04:12 INFO - 'enabled': True, 20:04:12 INFO - 'halt_on_failure': False, 20:04:12 INFO - 'name': 'check_screen_resolution'},), 20:04:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:04:12 INFO - 'cmd': ('bash', 20:04:12 INFO - '-c', 20:04:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:04:12 INFO - 'enabled': True, 20:04:12 INFO - 'halt_on_failure': False, 20:04:12 INFO - 'name': 'check_screen_resolution'},), 20:04:12 INFO - 'run_cmd_checks_enabled': True, 20:04:12 INFO - 'sps_profile': False, 20:04:12 INFO - 'sps_profile_interval': 0, 20:04:12 INFO - 'suite': 'dromaeojs', 20:04:12 INFO - 'system_bits': '32', 20:04:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:04:12 INFO - 'title': 't-yosemite-r7-0002', 20:04:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:04:12 INFO - 'use_talos_json': True, 20:04:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:04:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:04:12 INFO - 'work_dir': 'build'} 20:04:12 INFO - [mozharness: 2017-01-25 04:04:12.843528Z] Running clobber step. 20:04:12 INFO - Running pre-action listener: _resource_record_pre_action 20:04:12 INFO - Running main action method: clobber 20:04:12 INFO - rmtree: /builds/slave/test/build 20:04:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:04:15 INFO - Running post-action listener: _resource_record_post_action 20:04:15 INFO - [mozharness: 2017-01-25 04:04:15.370475Z] Finished clobber step (success) 20:04:15 INFO - [mozharness: 2017-01-25 04:04:15.370599Z] Running read-buildbot-config step. 20:04:15 INFO - Running pre-action listener: _resource_record_pre_action 20:04:15 INFO - Running main action method: read_buildbot_config 20:04:15 INFO - Using buildbot properties: 20:04:15 INFO - { 20:04:15 INFO - "project": "", 20:04:15 INFO - "product": "firefox", 20:04:15 INFO - "script_repo_revision": "production", 20:04:15 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 20:04:15 INFO - "repository": "", 20:04:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 20:04:15 INFO - "buildid": "20170124185348", 20:04:15 INFO - "pgo_build": "False", 20:04:15 INFO - "basedir": "/builds/slave/test", 20:04:15 INFO - "buildnumber": 32, 20:04:15 INFO - "slavename": "t-yosemite-r7-0002", 20:04:15 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 20:04:15 INFO - "platform": "yosemite_r7", 20:04:15 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 20:04:15 INFO - "branch": "mozilla-central", 20:04:15 INFO - "repo_path": "mozilla-central", 20:04:15 INFO - "revision": "6dccae211ae5fec6a1c1244b878ce0b93860154f", 20:04:15 INFO - "stage_platform": "macosx64", 20:04:15 INFO - "builduid": "af3567db84f64562b15c218d0cad203d", 20:04:15 INFO - "slavebuilddir": "test" 20:04:15 INFO - } 20:04:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/TXOH-VD3TPenXJkpn0GB0g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 20:04:15 INFO - Running post-action listener: _resource_record_post_action 20:04:15 INFO - [mozharness: 2017-01-25 04:04:15.373888Z] Finished read-buildbot-config step (success) 20:04:15 INFO - [mozharness: 2017-01-25 04:04:15.373973Z] Running download-and-extract step. 20:04:15 INFO - Running pre-action listener: _resource_record_pre_action 20:04:15 INFO - Running main action method: download_and_extract 20:04:15 INFO - mkdir: /builds/slave/test/build/tests 20:04:15 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')]} 20:04:15 INFO - trying https://queue.taskcluster.net/v1/task/TXOH-VD3TPenXJkpn0GB0g/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 20:04:15 INFO - Downloading https://queue.taskcluster.net/v1/task/TXOH-VD3TPenXJkpn0GB0g/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 20:04:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TXOH-VD3TPenXJkpn0GB0g/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 20:04:16 INFO - Downloaded 1199 bytes. 20:04:16 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 20:04:16 INFO - Using the following test package requirements: 20:04:16 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 20:04:16 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:04:16 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 20:04:16 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:04:16 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 20:04:16 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:04:16 INFO - u'jsshell-mac.zip'], 20:04:16 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:04:16 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 20:04:16 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 20:04:16 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:04:16 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 20:04:16 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:04:16 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 20:04:16 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:04:16 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 20:04:16 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:04:16 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 20:04:16 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:04:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TXOH-VD3TPenXJkpn0GB0g/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 20:04:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TXOH-VD3TPenXJkpn0GB0g/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:04:16 INFO - Fetch https://queue.taskcluster.net/v1/task/TXOH-VD3TPenXJkpn0GB0g/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 20:04:17 INFO - Expected file size: 16351665 20:04:17 INFO - Obtained file size: 16351665 20:04:24 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 20:04:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TXOH-VD3TPenXJkpn0GB0g/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 20:04:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TXOH-VD3TPenXJkpn0GB0g/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:04:24 INFO - Fetch https://queue.taskcluster.net/v1/task/TXOH-VD3TPenXJkpn0GB0g/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 20:04:25 INFO - Expected file size: 16351665 20:04:25 INFO - Obtained file size: 16351665 20:04:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TXOH-VD3TPenXJkpn0GB0g/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 20:04:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TXOH-VD3TPenXJkpn0GB0g/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:04:31 INFO - Fetch https://queue.taskcluster.net/v1/task/TXOH-VD3TPenXJkpn0GB0g/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 20:04:32 INFO - Expected file size: 14403431 20:04:32 INFO - Obtained file size: 14403431 20:04:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:33 INFO - trying https://queue.taskcluster.net/v1/task/TXOH-VD3TPenXJkpn0GB0g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 20:04:33 INFO - Downloading https://queue.taskcluster.net/v1/task/TXOH-VD3TPenXJkpn0GB0g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 20:04:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TXOH-VD3TPenXJkpn0GB0g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 20:04:35 INFO - Downloaded 69881253 bytes. 20:04:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TXOH-VD3TPenXJkpn0GB0g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 20:04:35 INFO - mkdir: /builds/slave/test/properties 20:04:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:04:35 INFO - Writing to file /builds/slave/test/properties/build_url 20:04:35 INFO - Contents: 20:04:35 INFO - build_url:https://queue.taskcluster.net/v1/task/TXOH-VD3TPenXJkpn0GB0g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 20:04:35 INFO - Running post-action listener: _resource_record_post_action 20:04:35 INFO - Running post-action listener: set_extra_try_arguments 20:04:35 INFO - [mozharness: 2017-01-25 04:04:35.693389Z] Finished download-and-extract step (success) 20:04:35 INFO - [mozharness: 2017-01-25 04:04:35.693546Z] Running populate-webroot step. 20:04:35 INFO - Running pre-action listener: _resource_record_pre_action 20:04:35 INFO - Running main action method: populate_webroot 20:04:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:04:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:04:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:04:35 INFO - '--tppagecycles', 20:04:35 INFO - '7'], 20:04:35 INFO - 'tests': ['tsvgm']}}, 20:04:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:04:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:04:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:04:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:04:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:04:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:04:35 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:04:35 INFO - 'talos_options': ['--disable-e10s'], 20:04:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:04:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:04:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:04:35 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:04:35 INFO - 'talos_options': ['--disable-e10s'], 20:04:35 INFO - 'tests': ['damp', 'tps']}, 20:04:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:04:35 INFO - 'tests': ['damp', 'tps']}, 20:04:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:04:35 INFO - 'tests': ['dromaeo_dom']}, 20:04:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:04:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:04:35 INFO - 'tests': ['basic_compositor_video']}, 20:04:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:04:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:04:35 INFO - 'tests': ['a11yr', 20:04:35 INFO - 'ts_paint', 20:04:35 INFO - 'tpaint', 20:04:35 INFO - 'sessionrestore', 20:04:35 INFO - 'sessionrestore_no_auto_restore', 20:04:35 INFO - 'tabpaint']}, 20:04:35 INFO - 'other-e10s': {'tests': ['a11yr', 20:04:35 INFO - 'ts_paint', 20:04:35 INFO - 'tpaint', 20:04:35 INFO - 'sessionrestore', 20:04:35 INFO - 'sessionrestore_no_auto_restore', 20:04:35 INFO - 'tabpaint']}, 20:04:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:04:35 INFO - 'ts_paint', 20:04:35 INFO - 'tpaint', 20:04:35 INFO - 'sessionrestore', 20:04:35 INFO - 'sessionrestore_no_auto_restore', 20:04:35 INFO - 'tabpaint']}, 20:04:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:04:35 INFO - 'ts_paint', 20:04:35 INFO - 'tpaint', 20:04:35 INFO - 'sessionrestore', 20:04:35 INFO - 'sessionrestore_no_auto_restore', 20:04:35 INFO - 'tabpaint']}, 20:04:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:04:35 INFO - 'tests': ['a11yr', 20:04:35 INFO - 'ts_paint', 20:04:35 INFO - 'tpaint', 20:04:35 INFO - 'sessionrestore', 20:04:35 INFO - 'sessionrestore_no_auto_restore', 20:04:35 INFO - 'tabpaint']}, 20:04:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:04:35 INFO - 'tests': ['a11yr', 20:04:35 INFO - 'ts_paint', 20:04:35 INFO - 'tpaint', 20:04:35 INFO - 'sessionrestore', 20:04:35 INFO - 'sessionrestore_no_auto_restore', 20:04:35 INFO - 'tabpaint']}, 20:04:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:04:35 INFO - 'tests': ['tsvgx', 20:04:35 INFO - 'tsvgr_opacity', 20:04:35 INFO - 'tart', 20:04:35 INFO - 'tscrollx', 20:04:35 INFO - 'cart', 20:04:35 INFO - 'tsvg_static']}, 20:04:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:04:35 INFO - 'tsvgr_opacity', 20:04:35 INFO - 'tart', 20:04:35 INFO - 'tscrollx', 20:04:35 INFO - 'cart', 20:04:35 INFO - 'tsvg_static']}, 20:04:35 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:04:35 INFO - 'talos_options': ['--disable-e10s'], 20:04:35 INFO - 'tests': ['tp5o']}, 20:04:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:04:35 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:04:35 INFO - 'talos_options': ['--disable-e10s', 20:04:35 INFO - '--xperf_path', 20:04:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:04:35 INFO - 'tests': ['tp5n']}, 20:04:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:04:35 INFO - 'talos_options': ['--xperf_path', 20:04:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:04:35 INFO - 'tests': ['tp5n']}}, 20:04:35 INFO - 'talos.zip': {'path': '', 20:04:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:04:35 INFO - Running post-action listener: _resource_record_post_action 20:04:35 INFO - [mozharness: 2017-01-25 04:04:35.711934Z] Finished populate-webroot step (success) 20:04:35 INFO - [mozharness: 2017-01-25 04:04:35.712065Z] Running create-virtualenv step. 20:04:35 INFO - Running pre-action listener: _resource_record_pre_action 20:04:35 INFO - Running main action method: create_virtualenv 20:04:35 INFO - Creating virtualenv /builds/slave/test/build/venv 20:04:35 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 20:04:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:04:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:04:35 INFO - Using real prefix '/tools/python27' 20:04:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:04:36 INFO - Installing distribute.............................................................................................................................................................................................done. 20:04:39 INFO - Installing pip.................done. 20:04:39 INFO - Return code: 0 20:04:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:04:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:04:39 INFO - Reading from file tmpfile_stdout 20:04:39 INFO - Output received: 20:04:39 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) 20:04:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:04: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')]} 20:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04: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')]} 20:04:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:39 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 0x10789db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef3bcb93c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10767bd30>, '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 0x1075a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107670be8>, '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.ixEhpXmFmR/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.0lnVZU4Z95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 20:04:39 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 20:04:39 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 20:04:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ixEhpXmFmR/Render', 20:04:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:39 INFO - 'HOME': '/Users/cltbld', 20:04:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:39 INFO - 'LOGNAME': 'cltbld', 20:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:39 INFO - 'MOZ_NO_REMOTE': '1', 20:04:39 INFO - 'NO_EM_RESTART': '1', 20:04:39 INFO - 'PAGER': '/bin/cat', 20:04:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:39 INFO - 'PWD': '/builds/slave/test', 20:04:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:39 INFO - 'SHELL': '/bin/bash', 20:04:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0lnVZU4Z95/Listeners', 20:04:39 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 20:04:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:39 INFO - 'USER': 'cltbld', 20:04:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:39 INFO - 'XPC_FLAGS': '0x0', 20:04:39 INFO - 'XPC_SERVICE_NAME': '0', 20:04:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:39 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 20:04:39 INFO - Cleaning up... 20:04:39 INFO - Return code: 0 20:04:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:04: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')]} 20:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04: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')]} 20:04:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:39 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 0x10789db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef3bcb93c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10767bd30>, '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 0x1075a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107670be8>, '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.ixEhpXmFmR/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.0lnVZU4Z95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 20:04:39 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 20:04:39 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 20:04:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ixEhpXmFmR/Render', 20:04:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:39 INFO - 'HOME': '/Users/cltbld', 20:04:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:39 INFO - 'LOGNAME': 'cltbld', 20:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:39 INFO - 'MOZ_NO_REMOTE': '1', 20:04:39 INFO - 'NO_EM_RESTART': '1', 20:04:39 INFO - 'PAGER': '/bin/cat', 20:04:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:39 INFO - 'PWD': '/builds/slave/test', 20:04:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:39 INFO - 'SHELL': '/bin/bash', 20:04:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0lnVZU4Z95/Listeners', 20:04:39 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 20:04:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:39 INFO - 'USER': 'cltbld', 20:04:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:39 INFO - 'XPC_FLAGS': '0x0', 20:04:39 INFO - 'XPC_SERVICE_NAME': '0', 20:04:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:40 INFO - Downloading/unpacking psutil>=3.1.1 20:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:04:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:04:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:04:43 INFO - Installing collected packages: psutil 20:04:43 INFO - Running setup.py install for psutil 20:04:43 INFO - building 'psutil._psutil_osx' extension 20:04:43 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 20:04:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 20:04:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 20:04:44 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 20:04:44 INFO - building 'psutil._psutil_posix' extension 20:04:44 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 20:04:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:04:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:04:44 INFO - ^ 20:04:44 INFO - 1 warning generated. 20:04:44 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 20:04:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:04:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:04:44 INFO - Successfully installed psutil 20:04:44 INFO - Cleaning up... 20:04:44 INFO - Return code: 0 20:04:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:04:44 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')]} 20:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:44 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')]} 20:04:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:44 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 0x10789db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef3bcb93c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10767bd30>, '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 0x1075a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107670be8>, '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.ixEhpXmFmR/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.0lnVZU4Z95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 20:04:44 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 20:04:44 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 20:04:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ixEhpXmFmR/Render', 20:04:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:44 INFO - 'HOME': '/Users/cltbld', 20:04:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:44 INFO - 'LOGNAME': 'cltbld', 20:04:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:44 INFO - 'MOZ_NO_REMOTE': '1', 20:04:44 INFO - 'NO_EM_RESTART': '1', 20:04:44 INFO - 'PAGER': '/bin/cat', 20:04:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:44 INFO - 'PWD': '/builds/slave/test', 20:04:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:44 INFO - 'SHELL': '/bin/bash', 20:04:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0lnVZU4Z95/Listeners', 20:04:44 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 20:04:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:44 INFO - 'USER': 'cltbld', 20:04:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:44 INFO - 'XPC_FLAGS': '0x0', 20:04:44 INFO - 'XPC_SERVICE_NAME': '0', 20:04:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:04:45 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 20:04:45 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 20:04:45 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 20:04:45 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 20:04:45 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 20:04:45 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 20:04:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:04:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:04:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:04:47 INFO - Installing collected packages: mozsystemmonitor 20:04:47 INFO - Running setup.py install for mozsystemmonitor 20:04:47 INFO - Successfully installed mozsystemmonitor 20:04:47 INFO - Cleaning up... 20:04:48 INFO - Return code: 0 20:04:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10789db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef3bcb93c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10767bd30>, '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 0x1075a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107670be8>, '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.ixEhpXmFmR/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.0lnVZU4Z95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 20:04:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:04:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:04:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ixEhpXmFmR/Render', 20:04:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:48 INFO - 'HOME': '/Users/cltbld', 20:04:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:48 INFO - 'LOGNAME': 'cltbld', 20:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:48 INFO - 'MOZ_NO_REMOTE': '1', 20:04:48 INFO - 'NO_EM_RESTART': '1', 20:04:48 INFO - 'PAGER': '/bin/cat', 20:04:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:48 INFO - 'PWD': '/builds/slave/test', 20:04:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:48 INFO - 'SHELL': '/bin/bash', 20:04:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0lnVZU4Z95/Listeners', 20:04:48 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 20:04:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:48 INFO - 'USER': 'cltbld', 20:04:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:48 INFO - 'XPC_FLAGS': '0x0', 20:04:48 INFO - 'XPC_SERVICE_NAME': '0', 20:04:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:48 INFO - Downloading/unpacking jsonschema==2.5.1 20:04:48 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 20:04:48 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 20:04:48 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 20:04:48 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 20:04:48 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 20:04:48 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 20:04:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:04:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:51 INFO - Downloading functools32-3.2.3-2.tar.gz 20:04:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:04:51 INFO - warning: no files found matching '*.txt' 20:04:51 INFO - no previously-included directories found matching 'build' 20:04:51 INFO - no previously-included directories found matching 'dist' 20:04:51 INFO - no previously-included directories found matching '.git*' 20:04:51 INFO - Installing collected packages: jsonschema, functools32 20:04:51 INFO - Running setup.py install for functools32 20:04:51 INFO - warning: no files found matching '*.txt' 20:04:51 INFO - no previously-included directories found matching 'build' 20:04:51 INFO - no previously-included directories found matching 'dist' 20:04:51 INFO - no previously-included directories found matching '.git*' 20:04:51 INFO - Successfully installed jsonschema functools32 20:04:51 INFO - Cleaning up... 20:04:51 INFO - Return code: 0 20:04:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:04:51 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')]} 20:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:51 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')]} 20:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:51 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 0x10789db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef3bcb93c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10767bd30>, '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 0x1075a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107670be8>, '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.ixEhpXmFmR/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.0lnVZU4Z95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 20:04:51 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 20:04:51 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 20:04:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ixEhpXmFmR/Render', 20:04:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:51 INFO - 'HOME': '/Users/cltbld', 20:04:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:51 INFO - 'LOGNAME': 'cltbld', 20:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:51 INFO - 'MOZ_NO_REMOTE': '1', 20:04:51 INFO - 'NO_EM_RESTART': '1', 20:04:51 INFO - 'PAGER': '/bin/cat', 20:04:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:51 INFO - 'PWD': '/builds/slave/test', 20:04:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:51 INFO - 'SHELL': '/bin/bash', 20:04:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0lnVZU4Z95/Listeners', 20:04:51 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 20:04:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:51 INFO - 'USER': 'cltbld', 20:04:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:51 INFO - 'XPC_FLAGS': '0x0', 20:04:51 INFO - 'XPC_SERVICE_NAME': '0', 20:04:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:04:52 INFO - Cleaning up... 20:04:52 INFO - Return code: 0 20:04:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10789db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef3bcb93c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10767bd30>, '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 0x1075a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107670be8>, '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.ixEhpXmFmR/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.0lnVZU4Z95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 20:04:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:04:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:04:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ixEhpXmFmR/Render', 20:04:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:52 INFO - 'HOME': '/Users/cltbld', 20:04:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:52 INFO - 'LOGNAME': 'cltbld', 20:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:52 INFO - 'MOZ_NO_REMOTE': '1', 20:04:52 INFO - 'NO_EM_RESTART': '1', 20:04:52 INFO - 'PAGER': '/bin/cat', 20:04:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:52 INFO - 'PWD': '/builds/slave/test', 20:04:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:52 INFO - 'SHELL': '/bin/bash', 20:04:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0lnVZU4Z95/Listeners', 20:04:52 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 20:04:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:52 INFO - 'USER': 'cltbld', 20:04:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:52 INFO - 'XPC_FLAGS': '0x0', 20:04:52 INFO - 'XPC_SERVICE_NAME': '0', 20:04:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:52 INFO - Downloading/unpacking blobuploader==1.2.4 20:04:52 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 20:04:52 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 20:04:52 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 20:04:52 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 20:04:52 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 20:04:52 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 20:04:54 INFO - Downloading blobuploader-1.2.4.tar.gz 20:04:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:04:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:04:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:04: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 20:04: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 20:04: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 20:04: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 20:04: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 20:04: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 20:04:56 INFO - Downloading docopt-0.6.1.tar.gz 20:04:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:04:56 INFO - Installing collected packages: blobuploader, requests, docopt 20:04:56 INFO - Running setup.py install for blobuploader 20:04:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:04:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:04:56 INFO - Running setup.py install for requests 20:04:56 INFO - Running setup.py install for docopt 20:04:57 INFO - Successfully installed blobuploader requests docopt 20:04:57 INFO - Cleaning up... 20:04:57 INFO - Return code: 0 20:04:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:04:57 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')]} 20:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:57 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')]} 20:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:57 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 0x10789db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef3bcb93c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10767bd30>, '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 0x1075a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107670be8>, '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.ixEhpXmFmR/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.0lnVZU4Z95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 20:04:57 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 20:04:57 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 20:04:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ixEhpXmFmR/Render', 20:04:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:57 INFO - 'HOME': '/Users/cltbld', 20:04:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:57 INFO - 'LOGNAME': 'cltbld', 20:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:57 INFO - 'MOZ_NO_REMOTE': '1', 20:04:57 INFO - 'NO_EM_RESTART': '1', 20:04:57 INFO - 'PAGER': '/bin/cat', 20:04:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:57 INFO - 'PWD': '/builds/slave/test', 20:04:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:57 INFO - 'SHELL': '/bin/bash', 20:04:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0lnVZU4Z95/Listeners', 20:04:57 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 20:04:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:57 INFO - 'USER': 'cltbld', 20:04:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:57 INFO - 'XPC_FLAGS': '0x0', 20:04:57 INFO - 'XPC_SERVICE_NAME': '0', 20:04:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:04:57 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-DSwDX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:04:57 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-jCwjxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:04:57 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-1lMuC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:04:57 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-eTJUty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:04:57 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-UhHz9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:04:57 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-taLBXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:04:58 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-NyLeqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:04:58 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-bRnOFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:04:58 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-gBMFtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:04:58 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-zYnzcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:04:58 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-7RcSgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:04:58 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-5lo9fW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:04:58 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-xVbBQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:04:58 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-k3VqER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:04:58 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-YVmBhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:04:58 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-8a70ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:04:59 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-lxapvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:04:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:04:59 INFO - Running setup.py install for manifestparser 20:04:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:04:59 INFO - Running setup.py install for mozcrash 20:04:59 INFO - Running setup.py install for mozdebug 20:04:59 INFO - Running setup.py install for mozdevice 20:04:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:04:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:04:59 INFO - Running setup.py install for mozfile 20:04:59 INFO - Running setup.py install for mozhttpd 20:05:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:05:00 INFO - Running setup.py install for mozinfo 20:05:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:05:00 INFO - Running setup.py install for mozInstall 20:05:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:05:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:05:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:05:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:05:00 INFO - Running setup.py install for mozleak 20:05:00 INFO - Running setup.py install for mozlog 20:05:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:05:00 INFO - Running setup.py install for moznetwork 20:05:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:05:00 INFO - Running setup.py install for mozprocess 20:05:00 INFO - Running setup.py install for mozprofile 20:05:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:05:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:05:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:05:01 INFO - Running setup.py install for mozrunner 20:05:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:05:01 INFO - Running setup.py install for mozscreenshot 20:05:01 INFO - Running setup.py install for moztest 20:05:01 INFO - Running setup.py install for mozversion 20:05:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:05:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:05:01 INFO - Cleaning up... 20:05:01 INFO - Return code: 0 20:05:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:05:01 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')]} 20:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:01 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')]} 20:05:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:01 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 0x10789db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef3bcb93c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10767bd30>, '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 0x1075a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107670be8>, '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.ixEhpXmFmR/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.0lnVZU4Z95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 20:05:01 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 20:05:01 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 20:05:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ixEhpXmFmR/Render', 20:05:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:05:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:05:01 INFO - 'HOME': '/Users/cltbld', 20:05:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:05:01 INFO - 'LOGNAME': 'cltbld', 20:05:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:01 INFO - 'MOZ_NO_REMOTE': '1', 20:05:01 INFO - 'NO_EM_RESTART': '1', 20:05:01 INFO - 'PAGER': '/bin/cat', 20:05:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:05:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:01 INFO - 'PWD': '/builds/slave/test', 20:05:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:05:01 INFO - 'SHELL': '/bin/bash', 20:05:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0lnVZU4Z95/Listeners', 20:05:01 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 20:05:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:05:01 INFO - 'USER': 'cltbld', 20:05:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:05:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:05:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:01 INFO - 'XPC_FLAGS': '0x0', 20:05:01 INFO - 'XPC_SERVICE_NAME': '0', 20:05:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:05:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:05:02 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-RSz4KK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:05:02 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)) 20:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:05:02 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-zpYT3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:05:02 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)) 20:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:05:02 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-1ktdme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:05:02 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)) 20:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:05:02 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-8DIJxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:05:02 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)) 20:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:05:02 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-oqVHDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:05:02 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)) 20:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:05:02 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-CZUVXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:05:02 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)) 20:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:05:02 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-0vAwwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:05:02 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)) 20:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:05:02 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-plr5Q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:05:02 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)) 20:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:05:02 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-ezi4iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:05:02 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)) 20:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:05:02 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-vdNGUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:05:03 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)) 20:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:05:03 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-WgbpLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:05:03 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)) 20:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:05:03 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-WHQkIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 20:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:05:03 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-Q1BpsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:05:03 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)) 20:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:05:03 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-ou5XZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:05:03 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)) 20:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:05:03 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-F5LbEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:05:03 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)) 20:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:05:03 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-Lzyb1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:05:03 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)) 20:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:05:03 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-eQeZcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:05:03 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)) 20:05:03 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)) 20:05:03 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)) 20:05:03 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)) 20:05:03 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)) 20:05:03 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)) 20:05:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:05:03 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 20:05:03 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 20:05:03 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 20:05:03 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 20:05:03 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 20:05:03 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 20:05:06 INFO - Downloading blessings-1.6.tar.gz 20:05:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:05:06 INFO - Installing collected packages: blessings 20:05:06 INFO - Running setup.py install for blessings 20:05:07 INFO - Successfully installed blessings 20:05:07 INFO - Cleaning up... 20:05:07 INFO - Return code: 0 20:05:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:05:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:05:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:05:07 INFO - Reading from file tmpfile_stdout 20:05:07 INFO - Current package versions: 20:05:07 INFO - blessings == 1.6 20:05:07 INFO - blobuploader == 1.2.4 20:05:07 INFO - docopt == 0.6.1 20:05:07 INFO - functools32 == 3.2.3-2 20:05:07 INFO - jsonschema == 2.5.1 20:05:07 INFO - manifestparser == 1.1 20:05:07 INFO - mozInstall == 1.12 20:05:07 INFO - mozcrash == 1.0 20:05:07 INFO - mozdebug == 0.1 20:05:07 INFO - mozdevice == 0.49 20:05:07 INFO - mozfile == 1.2 20:05:07 INFO - mozhttpd == 0.7 20:05:07 INFO - mozinfo == 0.9 20:05:07 INFO - mozleak == 0.1 20:05:07 INFO - mozlog == 3.4 20:05:07 INFO - moznetwork == 0.27 20:05:07 INFO - mozprocess == 0.24 20:05:07 INFO - mozprofile == 0.28 20:05:07 INFO - mozrunner == 6.13 20:05:07 INFO - mozscreenshot == 0.1 20:05:07 INFO - mozsystemmonitor == 0.3 20:05:07 INFO - moztest == 0.8 20:05:07 INFO - mozversion == 1.4 20:05:07 INFO - psutil == 3.1.1 20:05:07 INFO - requests == 1.2.3 20:05:07 INFO - wsgiref == 0.1.2 20:05:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:05: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')]} 20:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05: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')]} 20:05:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:07 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 0x10789db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef3bcb93c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10767bd30>, '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 0x1075a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107670be8>, '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.ixEhpXmFmR/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.0lnVZU4Z95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 20:05:07 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 20:05:07 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 20:05:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ixEhpXmFmR/Render', 20:05:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:05:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:05:07 INFO - 'HOME': '/Users/cltbld', 20:05:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:05:07 INFO - 'LOGNAME': 'cltbld', 20:05:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:07 INFO - 'MOZ_NO_REMOTE': '1', 20:05:07 INFO - 'NO_EM_RESTART': '1', 20:05:07 INFO - 'PAGER': '/bin/cat', 20:05:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:05:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:07 INFO - 'PWD': '/builds/slave/test', 20:05:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:05:07 INFO - 'SHELL': '/bin/bash', 20:05:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0lnVZU4Z95/Listeners', 20:05:07 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 20:05:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:05:07 INFO - 'USER': 'cltbld', 20:05:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:05:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:05:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:07 INFO - 'XPC_FLAGS': '0x0', 20:05:07 INFO - 'XPC_SERVICE_NAME': '0', 20:05:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:05:08 INFO - Cleaning up... 20:05:08 INFO - Return code: 0 20:05:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10789db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef3bcb93c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10767bd30>, '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 0x1075a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107670be8>, '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.ixEhpXmFmR/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.0lnVZU4Z95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 20:05:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:05:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ixEhpXmFmR/Render', 20:05:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:05:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:05:08 INFO - 'HOME': '/Users/cltbld', 20:05:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:05:08 INFO - 'LOGNAME': 'cltbld', 20:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:08 INFO - 'MOZ_NO_REMOTE': '1', 20:05:08 INFO - 'NO_EM_RESTART': '1', 20:05:08 INFO - 'PAGER': '/bin/cat', 20:05:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:08 INFO - 'PWD': '/builds/slave/test', 20:05:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:05:08 INFO - 'SHELL': '/bin/bash', 20:05:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0lnVZU4Z95/Listeners', 20:05:08 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 20:05:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:05:08 INFO - 'USER': 'cltbld', 20:05:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:05:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:08 INFO - 'XPC_FLAGS': '0x0', 20:05:08 INFO - 'XPC_SERVICE_NAME': '0', 20:05:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:05:08 INFO - Cleaning up... 20:05:08 INFO - Return code: 0 20:05:08 INFO - Running post-action listener: _resource_record_post_action 20:05:08 INFO - Running post-action listener: _start_resource_monitoring 20:05:08 INFO - Starting resource monitoring. 20:05:08 INFO - [mozharness: 2017-01-25 04:05:08.476661Z] Finished create-virtualenv step (success) 20:05:08 INFO - [mozharness: 2017-01-25 04:05:08.477439Z] Running install step. 20:05:08 INFO - Running pre-action listener: _resource_record_pre_action 20:05:08 INFO - Running main action method: install 20:05:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:05:08 INFO - Reading from file tmpfile_stdout 20:05:08 INFO - Detecting whether we're running mozinstall >=1.0... 20:05:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:05:08 INFO - Reading from file tmpfile_stdout 20:05:08 INFO - Output received: 20:05:08 INFO - Usage: mozinstall [options] installer 20:05:08 INFO - Options: 20:05:08 INFO - -h, --help show this help message and exit 20:05:08 INFO - -d DEST, --destination=DEST 20:05:08 INFO - Directory to install application into. [default: 20:05:08 INFO - "/builds/slave/test"] 20:05:08 INFO - --app=APP Application being installed. [default: firefox] 20:05:08 INFO - mkdir: /builds/slave/test/build/application 20:05:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 20:05:30 INFO - Reading from file tmpfile_stdout 20:05:30 INFO - Output received: 20:05:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:05:30 INFO - Running post-action listener: _resource_record_post_action 20:05:30 INFO - [mozharness: 2017-01-25 04:05:30.710371Z] Finished install step (success) 20:05:30 INFO - [mozharness: 2017-01-25 04:05:30.710517Z] Running run-tests step. 20:05:30 INFO - Running pre-action listener: _resource_record_pre_action 20:05:30 INFO - Running main action method: run_tests 20:05:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:05:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:05:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:05:30 INFO - 2017-01-24 20:05:30.725 screenresolution[1621:7335] starting screenresolution argv=screenresolution get 20:05:30 INFO - 2017-01-24 20:05:30.728 screenresolution[1621:7335] Display 0: 1600x1200x32@60 20:05:30 INFO - 2017-01-24 20:05:30.734 screenresolution[1622:7337] starting screenresolution argv=screenresolution list 20:05:30 INFO - Available Modes on Display 0 20:05:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:05:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:05:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:05:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:05:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:05:30 INFO - Intel Iris: 20:05:30 INFO - Chipset Model: Intel Iris 20:05:30 INFO - Type: GPU 20:05:30 INFO - Bus: Built-In 20:05:30 INFO - VRAM (Dynamic, Max): 1536 MB 20:05:30 INFO - Vendor: Intel (0x8086) 20:05:30 INFO - Device ID: 0x0a2e 20:05:30 INFO - Revision ID: 0x0009 20:05:30 INFO - Displays: 20:05:30 INFO - Display: 20:05:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:05:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:05:30 INFO - Display Serial Number: 1600x1200 60 20:05:30 INFO - Main Display: Yes 20:05:30 INFO - Mirror: Off 20:05:30 INFO - Online: Yes 20:05:30 INFO - Rotation: Supported 20:05:30 INFO - Return code: 0 20:05:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:05:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:05:30 INFO - Python 2.7.3 20:05:30 INFO - Return code: 0 20:05:30 INFO - grabbing minidump binary from tooltool 20:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:30 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 0x10767bd30>, '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 0x1075a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107670be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:05:30 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 20:05:30 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 20:05:30 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 20:05:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:05:31 INFO - Return code: 0 20:05:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:05:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:05:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:05:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:05:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:05:31 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/TXOH-VD3TPenXJkpn0GB0g/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0002', '--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 20:05:31 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/TXOH-VD3TPenXJkpn0GB0g/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0002 --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 20:05:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ixEhpXmFmR/Render', 20:05:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:05:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:05:31 INFO - 'HOME': '/Users/cltbld', 20:05:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:05:31 INFO - 'LOGNAME': 'cltbld', 20:05:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:05:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:05:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:31 INFO - 'MOZ_NO_REMOTE': '1', 20:05:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:05:31 INFO - 'NO_EM_RESTART': '1', 20:05:31 INFO - 'PAGER': '/bin/cat', 20:05:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:05:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:31 INFO - 'PWD': '/builds/slave/test', 20:05:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:05:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:05:31 INFO - 'SHELL': '/bin/bash', 20:05:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0lnVZU4Z95/Listeners', 20:05:31 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 20:05:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:05:31 INFO - 'USER': 'cltbld', 20:05:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:05:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:05:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:31 INFO - 'XPC_FLAGS': '0x0', 20:05:31 INFO - 'XPC_SERVICE_NAME': '0', 20:05:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:05:31 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/TXOH-VD3TPenXJkpn0GB0g/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0002', '--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 20:05:31 INFO - mozversion application_buildid: 20170124185348 20:05:31 INFO - mozversion application_changeset: 6dccae211ae5fec6a1c1244b878ce0b93860154f 20:05:31 INFO - mozversion application_display_name: Nightly 20:05:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:05:31 INFO - mozversion application_name: Firefox 20:05:31 INFO - mozversion application_remotingname: firefox 20:05:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:05:31 INFO - mozversion application_vendor: Mozilla 20:05:31 INFO - mozversion application_version: 54.0a1 20:05:31 INFO - mozversion platform_buildid: 20170124185348 20:05:31 INFO - mozversion platform_changeset: 6dccae211ae5fec6a1c1244b878ce0b93860154f 20:05:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:05:31 INFO - mozversion platform_version: 54.0a1 20:05:31 INFO - using testdate: 1485317131 20:05:31 INFO - actual date: 1485317131 20:05:31 INFO - starting webserver on 'localhost:49241' 20:05:31 INFO - SUITE-START | Running 2 tests 20:05:31 INFO - TEST-START | dromaeo_css 20:05:31 INFO - operating with platform_type : mac_ 20:05:31 INFO - Initialising browser for dromaeo_css test... 20:05:31 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpFsud7R/profile http://localhost:49241/getInfo.html) 20:05:33 INFO - PROCESS | 1632 | __metrics Screen width/height:1600/1200 20:05:33 INFO - PROCESS | 1632 | colorDepth:24 20:05:33 INFO - PROCESS | 1632 | Browser inner width/height: 1024/689 20:05:33 INFO - PROCESS | 1632 | __metrics 20:05:33 INFO - PROCESS | 1632 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:05:33 INFO - PROCESS | 1632 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:05:34 INFO - TEST-INFO | 1632: exit 0 20:05:34 INFO - Browser initialized. 20:05:34 INFO - Running cycle 1/1 for dromaeo_css test... 20:05:34 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpFsud7R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:05:46 INFO - PROCESS | 1634 | RSS: Main: 247152640 20:05:46 INFO - PROCESS | 1634 | 20:08:51 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 20:08:52 INFO - PROCESS | 1634 | RSS: Main: 374902784 20:08:52 INFO - PROCESS | 1634 | 20:10:36 INFO - PROCESS | 1634 | ************************* 20:10:36 INFO - PROCESS | 1634 | A coding exception was thrown and uncaught in a Task. 20:10:36 INFO - PROCESS | 1634 | 20:10:36 ERROR - PROCESS | 1634 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:10:36 INFO - PROCESS | 1634 | Full stack: 20:10:36 INFO - PROCESS | 1634 | ************************* 20:11:55 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 20:11:56 INFO - PROCESS | 1634 | RSS: Main: 382812160 20:11:56 INFO - PROCESS | 1634 | 20:14:58 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 20:14:59 INFO - PROCESS | 1634 | RSS: Main: 357466112 20:14:59 INFO - PROCESS | 1634 | 20:18:01 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 20:18:02 INFO - PROCESS | 1634 | RSS: Main: 356339712 20:18:02 INFO - PROCESS | 1634 | 20:21:06 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 20:21:06 INFO - PROCESS | 1634 | RSS: Main: 348102656 20:21:06 INFO - PROCESS | 1634 | 20:24:10 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 20:24:10 INFO - PROCESS | 1634 | RSS: Main: 399015936 20:24:10 INFO - PROCESS | 1634 | 20:24:10 INFO - PROCESS | 1634 | __start_tp_report 20:24:10 INFO - PROCESS | 1634 | _x_x_mozilla_page_load 20:24:10 INFO - PROCESS | 1634 | _x_x_mozilla_page_load_details 20:24:10 INFO - PROCESS | 1634 | |i|pagename|runs| 20:24:10 INFO - PROCESS | 1634 | |0;dojo.html;3343.933121337573;3383.729301655866;3387.525746395505;3396.3716712408223;3447.603525594556;5623.297087864017;5691.800786972457;5827.155062515938;5834.154047663092;5836.9124463133085;4775.259834725614;4932.062908047468;5782.913256301159;5857.7364018619155;5889.911651325234;4996.725180115092;5174.741262936857;5187.118189907725;5234.214867769846;5273.235380869772;5187.19598462239;5328.280682107905;5346.599005074635;5353.866153346158;5366.248725178478;5319.335083114611;5333.306670132897;5333.839984800443;5347.946520534803;5348.545373643245;4364.869053928387;5127.359080114986;5178.093833579109;5187.092258854723;5297.12597421425;5185.922211166798;5209.479052094798;5240.502152295526;5264.789408423659;5291.444398338196;5780.364159942403;5788;5795.420457954213;5808.680522571257;5840.299164100293;5540.279763630702;6103;6138.020573254751;6295.937040629581;6312.968435157841;6167.321594624587;6172.444479996777;6223.346548612421;6226.377362263783;6245.6252624842655;5905.911411328833;5947.82156535309;5949.732262048218;5956.970215148896;5976.342602313742;6222.191115155001;6291.402316779899;6306.148669929501;6310.558260921784;6324.620522768649;5994.6403215807195;6032.276126864805;6051.304100028553;6137.8979746733885;6237.126802247689;5240.187770895517;6255.530835187288;6256.874862502725;6257.56197066201;6267.6866156691985;6099.0374119281705;6151.446369826737;6154.9384506154365;6158.04550294705;6168.691565421711;6150.938490615036;6240;6266.717997690115;6268.529860260499;6271.592346497463;4900.779464924087;5005.174146265826;5005.249212618136;5014.52362025607;5052;4414.492333381638;4416.712913660602;4418.226810308183;4433.512313645497;4438;5821.068629019422;5828.271466066742;5831.504322132581;5832.912506312408;5878.735456904449;6165.445109940127;6200.0699895016105;6213.440790328892;6223.346548612421;6246;5563.554915606742;5634.915476267859;5636.0982242841765;5665.773369065191;5828.854278642983;4708.4820669726305;5417.83746487606;5419.132938729785;5433.565314774809;5440.972795135999;5137.922931156036;6189.102580125947;6202.534809889276;6207.472364849038;6213.720382582705;6189.319174890668;6194.0708893666315;6206.875862482635;6213.161223234805;6221.346758590283;6242.625442473284;6289.622622642656;6305.8108256752375;6320.020396838498;6323.20959880015;6234.407731265523;6236.688165591611;6238.968805155945;6253.687315634291;6261.373862613702;6147.969260153671;6216.627002379872;6222.12890195364;6223.626582405071;6232.719527621177;6035.818925432244;6095.908561371672;6101.481374083252;6106.175666284995;6163.921313769983;6150.261968563801;6153.169322141633;6153.784617538365;6158.630482171084;6196.256449226122;5861.1501332307425;5920.79277225295;5920.851978700567;5927.229460170151;6050.45545900871;6090.878182436415;6102.962496375538;6108.827782940854;6122.825106970275;6181.443670069715;5853.239078919713;5910.231669882888;5922.407759224043;5930.140129681258;6044.788432404845 20:24:10 INFO - PROCESS | 1634 | |1;ext.html;440.5110327536434;477.3126697555518;479.6810121269355;501.2781594503916;510.50226029621103;31157.532637010434;36105;42068.36897446537;42972.78513607428;43194.352084718754;43107;43458.34812477815;44023.559764402344;44067.33898991509;44103.77948110255;7542.717737984528;9268.675596354129;9419.764505887339;9484.146426821584;9492.905070949306;8371.539565323905;11262.4368781561;11458.369789661565;11459.02598279143;11602.535898564047;9734.65928692496;11312.925272099137;11377.601783937564;11387.715307117305;11388.658340249805;8346.998360196754;9756;11438.313701177873;11443.542258309615;11446.08431325492;8475.728640703883;11003.119750420028;11256.212065155443;11277.887221127765;11437;40762.9809254771;41110.58889411097;41205;41205.79397103025;41238.587614123775;4061.8578349757618;4081.3877918312196;4106.486689163855;4134.834606615732;4260.616544511009;25438.109666161596;30121;31604.73581056755;31720.841395792875;31727.365452690818;3217.8069315841126;3267.3656553391907;3293.847153496281;3372.426687463137;3372.7133193678565;451247;452598;453066;453614.73192634154;456050.43949560745;60888.08667869985;62267.37732622706;62853.05720414197;62938.68530657318;63051;66551;68397;68527.65736171287;68795.31204687888;68942;15471.381144754083;15933;15969.281382337822;15994.96032757867;16014.599635009217;11069.612563560237;11982.700432489257;12157.02743780513;12159.574414895436;12175.0868684849;16527.669446611002;18515.537111572048;19012;19035.714464283046;19566.902165489366;6478.643674597848;7765.2140007798525;7807.141214466405;7830.647620857075;7916.564588947663;875.8511053120985;879.7536689726886;889.3729920406098;918.4672889724078;926.8285367207088;29020.564691529646;30320.241993950327;30546.847265763972;31164.220894477818;31313.530297045563;1017.5726194998118;1031.3347890610514;1058.5501162006117;1064.7338165458636;1065.8774240962234;14669.559913202622;14673.413063477556;14728;14819.703605927822;14826;574763;581414;585371;585439;586214;54526.72736636292;54659.63350916259;54777.726111369186;54821.62945926384;54957;1405.7048019915728;1427.343422025859;1455.243273497754;1464.545990742852;1466.1789397937189;27157.185284441497;28391.006314778882;28465.146045618665;28579.571306430837;30542.694573054872;51883;52254.47745522648;52715.472845271055;52748;56442.7177864108;515920;525391;526617;526962;528481;24949.376265593506;25292.11477598275;25318.873405632854;25350.74649253484;25431;31279.687203127676;43151.568484314754;44179.77910110429;44234.3364849534;45190.54809451995;35975;35981.64018359783;36020.27959440849;37069.62930370662;37242.06894827651;36226.8188659055;36556.26887462289;36604.81697591495;36698.725117423186;37304;34740.47889281713;35002.12494687653;35648.465273021444;35652.82173589116;35921.281574367844;27707.584386234626;31498;32086.358272833946;32235.032949011566;32391.676083238865;21146.259880904094;22938.770612293665;23130.884345578164;23457.94439250204;23911.52176956486 20:24:10 INFO - PROCESS | 1634 | |2;jquery.html;369.94450832375156;385.92860320840646;387.23521045934285;400.5433805461774;417.6909087275417;14780.965332426735;15093.924530377346;15426;19554.51113722154;20977.16091356348;20738.481537961557;21302.57394852102;21530.89234553829;21733.782662173373;22061.889690551525;5552.91670624941;5650.208970744099;5735.885282294352;5890.2931648202275;5903.114532820068;4134.710570260083;5717.371089180187;5825.009748342771;5833;5836.883262334751;4311.5472875348105;6067.575269731121;6322.146510221107;6331.461825744817;6422.389872962084;5665.2351932489;5990.550708696822;6386.425221730044;6413.518986076063;6467.2562655294305;5638.943610563882;5639.8590035249035;5641.435856414367;5654.349749778746;5655.7454914528535;25658.717064146716;26158.953641854303;26177.73822261772;26230.606540901903;26447.47105057907;2733.3986522964915;2748.6839013513504;2755.641766570333;2761.9309517262027;2766.0871912268904;13601.795973060413;15180.392784288615;15880.523584292374;16036.438724644699;16702.66594668112;1781.9287228510843;1803.3868484715128;1877.9624407511774;1890.1399863062275;1890.8014658460802;136990;141716.45111458882;141793;144667;144787;9928.453935033498;11657.941710291394;11817.586384476503;11878.287302761863;12002.339871306987;15623.14072726011;15683.764743528856;15705.607359816097;15708.764368534481;15725;6534.117894084333;7472.813179670552;8174.550399728072;8487.278581320534;8634.78413039679;6741.910007897567;7897.763067107996;8114.29599784052;8293.83412331762;8331.66673333072;4224.943764058985;4507.18870603288;4785.904281914342;4799.28010798383;4862.343583616237;1753.9123043847756;1947.9415617531497;1972.3294080012865;2027.5843452092286;2028.1583142995491;849.1593322610571;860.8106216632331;872.4154816272985;879.9089129479399;899.3884158771967;20611.969401529863;21469.67795483069;21472.892635536722;21576.92115394224;21671.52090647915;727.7925791149603;740.5186628691393;887.924526415262;917.554985831871;921.1019256225127;10534.631287904887;10723.83914241287;10946.890531094747;11012.834807477895;11035.779284414266;593405;673450;676417;678947.6052619705;693339;117962.41018794851;146962;147103.78579962743;149191;150909;1013.1692012549638;1016.3850870223556;1037.2479952034714;1039.5374058543875;1043.3844032021143;15501.837362197655;16230.350785968429;16295.348186072899;17722.379716709853;18681.6263674723;53637.731811340695;55751.884962299715;60595.697021514614;61387.38612613817;62646.68676656587;86045;86248;87731.56134219289;90267.54866225627;91232.63151052607;7898;8248.958755206186;8480.74557763268;8536.871946920677;8720.171583699539;9405.81188376215;13120.409581569043;13149.868501315246;13337.799933001206;13638.659033523845;10632.362058276529;11078.723031924266;11119;11412.71468213268;11587.652370428901;11239.775204496027;11340.753042659393;11399.031082358093;11851.992580630744;11871.940640296743;11196.552137914718;11419.37193454368;11651.650450486499;11656.825147622623;11774.587889423829;8292.83414331722;8423.368247381593;8449.197326253996;8453.746387608382;8524.753959134687;8256;9142.451452912846;11020.779584408427;11266.380349080879;11378.03286720605 20:24:10 INFO - PROCESS | 1634 | |3;mootools.html;1444.6966137111206;1448.8116544849167;1451.6951440197558;1464.377639503211;1466.6993266380389;7996.520208787477;8275.337972962163;8371.706990255343;8426.199511046441;8440.788980275482;7392.778216653495;7643.082830060401;7646.961765191167;8018.398620103501;8240.711575094872;2238.7425446073667;2317.721873375189;2318.0380142241033;2321.431249343913;2321.7562155973633;2178.7689955175274;2249.8312626552993;2318.6174281243575;2341.063574570177;2354.9058037678474;2041.7243672104298;2287.7597852225526;2301.7583153768865;2302.332323626155;2336.4626135988733;2277.1005452846116;2280.7719228077226;2317.2005658047947;2323.9767602323927;2325.046730840364;2261.796438320559;2332.4635333873302;2338.660894170353;2341.915695031423;2348.953020939589;8376.623051962677;8426;8430.915690843074;8444.873326900102;8474.872876906851;5027.597792176617;5180.922286165711;5189.351331083614;5204.661696989683;5207.140821764404;3275.9836200818845;3295.3903527847187;3409.880654177092;3432.742544309162;3479.2693534357813;1043.2644985285356;1081.8160912644869;1095.1403148528448;1235.8455193100863;1253.4359538207843;10488.947555262252;10604.992525710046;10608.893911060944;10628.14974802014;10634.096101831354;4427.933580996288;4601.539846015372;4666.066786642685;4674.111918735497;4685.297205419214;9395.248380129573;9480.952595237117;9491.572879220314;9497.620095196253;9510.429374237568;5266.710330931759;5277.973610131925;5280.155175171954;5283.128283833202;5283.996040752245;3998.6801055915457;4162.250794856955;4707.270373092176;4709.411323584552;4814.975925120352;3721.9441708374397;3811.7712937223855;3816.198598294334;3897.18159186574;3907.5506316773367;1110.3559935237543;1263.298869127643;1269.6000759760645;1275.355945247644;1281.218456741387;762.9809254768564;764.4228607401487;781.9960900195463;785.344237561631;793.4644115222202;5451.236826844245;5466.671999680032;5541.556675465953;5583.441655834384;5588.21764952907;577.96243244189;598.4255115089476;602.295314482057;938.7746940734174;1008.0423597582326;3540.504329393887;3665.486831843544;3773.396256598986;3788.5264341957254;3798.506194194737;9769.609215631295;9847.606095756233;10000.799984000425;10094.899051009543;10105.44420056904;10014.449205293779;10032.097111260022;10034.845992710932;10058.647947321808;10078.74803129913;7362.44781641379;7749.4575379724;7767.92232077672;7854.4894581851995;7881.645325960231;5505.889882202254;5560.276314342566;5617.662940223599;5685.545156387397;5700.600957933071;8731.25784308341;8988.415752976036;9246.95376523113;9251.491167985556;9353.719388418358;7668.309852113337;8913.019567847661;9253.398529095588;9323.533823308671;9421.434713917188;6641.833954151185;6659.833504162435;6876.140482439695;7134.250903655042;7240.203577606354;7932.008498937633;8042.798930026796;8094.635741391769;8101.351891848756;8110.594470276581;6964.895526567207;7122.501424900207;7162.391196748335;7171.569705817667;7253.746118885813;7030.9296907030275;7031.753888613874;7038.472114591324;7185;7256.310650488195;5426.240326354235;6035.094735789491;6045.304789949212;6139.570230083851;6148.9692551536955;4845.103655823543;4865.562099410929;4902.852914412573;4917.016596680606;4990.900181996412;4788.233882578771;4836.903261934671;4847.394075740533;4891.290762839297;4912.435069966999 20:24:10 INFO - PROCESS | 1634 | |4;prototype.html;320.50322000898603;354.5408695739018;364.4551395663483;371.97768133911984;374.65531710826036;4864.367632207817;5283.63014588979;5290.788573255345;5298.8668838306085;5348.946510534894;4901.877453063676;5049.192129259319;5151.587872970163;5172.974135129319;5208.401033881095;4098.877033688987;4126.595558664099;4130.938035929464;4149.668026557883;4166.000159961618;3824.7569539899646;4166.812493437787;4191.413202151702;4191.517975432818;4196.237580216317;3470.6182319944787;3602.2255215128744;3680.11677197472;3893.396523538842;4165.33354663254;3344.1138098403944;3430.6397828227928;3627.963720362789;3952.861649842256;3961.1681546875193;2675.745804148603;2808.9719102808913;3289.832109601081;3437.6218615952225;3448.8620455181763;4616.976915115437;4932.630052746023;5113.948860511385;5155.742212889378;5175;4358.493866027047;4528.569785870337;4550.271956486979;4558.2650409754215;4561.201789686792;4443.244648409778;4869.026194761062;5521.641093328921;5545.445455454463;5546.417626149237;3169.3661267746543;3655.0862284428895;3686.8156592170285;3745.6441638044616;3862.748921320105;4689.742064186468;5553.7778488860395;5703.686297253649;5759.481646651821;5793.333766616809;3616.5298511193378;3835.2904712627696;3849.825803130072;3875.70932180082;3879.3599056155417;3210.7110360067704;3856.3636999895266;3867.176960818562;3926.312895243321;3937.3503371943307;4273.658107351404;4516.209663308908;4574.519675434098;4586.518415566385;4598.493820867635;4612;4686.867879671822;5543.861403464945;5550.944490555043;5606.60753747242;1131.3155540897803;1170.3446070200714;1203.602811072344;1214.8238505416666;1274.643099932002;733.7468573342188;761.6382218446194;773.9380849532024;854.918782715641;861.5649097205871;4333.140127515824;4465.665075119379;4548.317752337176;4734.029523947583;4823.421189457217;4844.249141383021;5027.4218464877;5048.460219632973;5396.568274538027;5500.42245564218;4373.934390984138;4498.865034048984;4705.576498115186;5131;5194.506521880416;2593.844369337846;2763.875625596853;2811.102505808571;2850.5154123799;2864.942701145965;5099.725068732817;5565.443455654483;5604.038586494776;5606.887862242814;5651.106879195433;5136.075506408883;5212.325310655979;5234.214867769865;5250.527452529291;5537.425097329761;4812.903741925142;5042.823501177441;5187.818426355059;5355.839324820262;5510.366307874646;4567.903703111296;4767.618590512681;4956.925646115239;5392.333213414759;5465.562754979672;4815.832875206102;4935.679180853233;5327.733613319396;5332.746804500862;5357.544608708304;4676.532346765296;5009.298698182331;5418.674879507243;5599.272094627672;5634.605577609528;3291.078498020558;3408.2842603053637;3572.964270357263;3626.2928728897614;3633.7093032556804;4599.609033232213;5103.8468845934685;5138;5280.201493208606;5319.46805319465;4639.420072490939;4661.387424745849;5164.638475306692;5191.299174611379;5245.816396426107;4479.820807167677;4511.8646440606835;5133.332666753298;5179.559737422362;5187.740612969412;4453.844115455943;4765.976170119127;4771.308160316804;5112.795488180431;5288.629795914249;4356.651467882499;4574.987005717474;5076.289319495348;5502.532284755841;5532.28080349552;4745.5966242869745;5312.574994000548;5375.6774593524515;5376;5384.9381581315 20:24:10 INFO - PROCESS | 1634 | |5;yui.html;695.808652620529;696.3906581740978;697.3549466743261;772.4322622872188;789.9210078992099;15029.549113526598;15716.978396404225;15718.292676829542;15873.206339683027;15922.681546369065;14409.351579178936;14808.55574332769;14956;14974.176420296879;15014.774778378305;855.0423525651279;856.16096225699;869.0917990699734;874.5889431966965;880.2034159086005;687.8142901416614;708.0901042160824;712.7006657203987;872.2585802068255;877.3595275448926;885.190051103243;911.539672465404;913.1598928985317;922.40504874356;924.8890133184027;908.2098574240387;910.7905181808221;912.3020889019905;912.5619702542783;917.8302014127374;525.7134861500491;682.7371461987121;682.8600136971909;684.0184335478605;687.0552989639247;12434.937825310815;14532.854671453362;15030.549083527512;15071.944963852535;15441.691166176726;14404.957316981816;14429.783553246709;14441.78337324941;14498.782518262235;14615.488457904028;10574.947125264402;11280.492377843017;11755.882441175565;11825.408729563487;12097.274163550215;3752.2870654575545;3763.7741735495683;3802;3922.8626998054933;3925.9214815703813;77743.22256777473;90443;97428.02571974261;101114;101165;10863.130949524018;10968.506417211245;11175.217734758651;11310.547578096948;11376.544938202545;19450.8054919449;22817.88591057034;23025;23054.42363940915;23073.307800766004;7841.607919603997;7871.645775940096;7910.288074073361;7962.960185199037;8044.879326810103;3658.7987660678386;4075.857344992911;4313.654907607384;4382.406744611484;4456.131054444417;3554.5201397811484;3578.8926332210076;3666.156783939709;3667.156553992597;3669.8165091745304;662.9502787290972;668.9331066893271;679.3308591037824;690.6443181761397;693.8196069022091;675.8614484030762;681.2268075734078;711.2283172757616;730.9232530584319;735.3308489274734;9645.9035409645;10217.897821021843;10293.176545876311;10314.587416503256;10357.844632330522;669.2270427656065;691.7509696509253;699.8250437390652;700.4291502425507;704.6864145455223;4750.809967601326;5022.924656130161;5043.5965122790085;5047.671901326402;5051.368578927634;102978;103429;107642;107751;109072.4546377263;67901.66049169723;77157.6142119297;78017.60991195121;78205.60897195591;79181;59275.40724592871;63964.36035639584;81197.18802812014;82404;86705.26589468302;8678.566071696516;9643.807123857623;9816.55825487869;9821.36161149523;9825.459599722084;47180.52819471899;47236;53724.73137634443;54345.18482222691;56950.29149125533;65036.67481662751;66083.66958165179;66879.66560167167;69737.60524789375;72475.63762181366;13297.933510332387;13339.266340351374;13340.517456421418;13584.660383490493;13596.456141754616;14512.455800387355;14861.331240094005;14975;15413.075215487106;15629.921850390676;12770.68073298175;12844.229346239255;13477.595672129852;13525;13542.854310216704;13713.657158571115;13854.930725346308;14013.229272390117;14017.859821402064;14172;12943.741125177256;12971.221726696429;13534.729305414034;13861.584152475441;13864.653383665489;11142.888571114185;11285.548578056785;11434.375464499892;11497.367644779617;11775.411229438323;9457.574409151743;9948.230932889597;10173;10736.89263107359;10995.505202265756 20:24:10 INFO - PROCESS | 1634 | __end_tp_report 20:24:10 INFO - PROCESS | 1634 | __start_cc_report 20:24:10 INFO - PROCESS | 1634 | _x_x_mozilla_cycle_collect,1136 20:24:10 INFO - PROCESS | 1634 | __end_cc_report 20:24:10 INFO - PROCESS | 1634 | __startTimestamp1485318250304__endTimestamp 20:24:10 INFO - PROCESS | 1634 | 20:24:10 INFO - PROCESS | 1634 | ------- Summary: start ------- 20:24:10 INFO - PROCESS | 1634 | Number of tests: 6 20:24:10 INFO - PROCESS | 1634 | 20:24:10 INFO - PROCESS | 1634 | [#0] dojo.html Cycles:165 Average:5732.46 Median:5947.82 stddev:643.49 (10.8%) stddev-sans-first:617.58 20:24:10 INFO - PROCESS | 1634 | Values: 3343.9 3383.7 3387.5 3396.4 3447.6 5623.3 5691.8 5827.2 5834.2 5836.9 4775.3 4932.1 5782.9 5857.7 5889.9 4996.7 5174.7 5187.1 5234.2 5273.2 5187.2 5328.3 5346.6 5353.9 5366.2 5319.3 5333.3 5333.8 5347.9 5348.5 4364.9 5127.4 5178.1 5187.1 5297.1 5185.9 5209.5 5240.5 5264.8 5291.4 5780.4 5788.0 5795.4 5808.7 5840.3 5540.3 6103.0 6138.0 6295.9 6313.0 6167.3 6172.4 6223.3 6226.4 6245.6 5905.9 5947.8 5949.7 5957.0 5976.3 6222.2 6291.4 6306.1 6310.6 6324.6 5994.6 6032.3 6051.3 6137.9 6237.1 5240.2 6255.5 6256.9 6257.6 6267.7 6099.0 6151.4 6154.9 6158.0 6168.7 6150.9 6240.0 6266.7 6268.5 6271.6 4900.8 5005.2 5005.2 5014.5 5052.0 4414.5 4416.7 4418.2 4433.5 4438.0 5821.1 5828.3 5831.5 5832.9 5878.7 6165.4 6200.1 6213.4 6223.3 6246.0 5563.6 5634.9 5636.1 5665.8 5828.9 4708.5 5417.8 5419.1 5433.6 5441.0 5137.9 6189.1 6202.5 6207.5 6213.7 6189.3 6194.1 6206.9 6213.2 6221.3 6242.6 6289.6 6305.8 6320.0 6323.2 6234.4 6236.7 6239.0 6253.7 6261.4 6148.0 6216.6 6222.1 6223.6 6232.7 6035.8 6095.9 6101.5 6106.2 6163.9 6150.3 6153.2 6153.8 6158.6 6196.3 5861.2 5920.8 5920.9 5927.2 6050.5 6090.9 6103.0 6108.8 6122.8 6181.4 5853.2 5910.2 5922.4 5930.1 6044.8 20:24:10 INFO - PROCESS | 1634 | 20:24:10 INFO - PROCESS | 1634 | [#1] ext.html Cycles:180 Average:65942.43 Median:36165.91 stddev:139369.09 (385.4%) stddev-sans-first:139673.29 20:24:10 INFO - PROCESS | 1634 | Values: 440.5 477.3 479.7 501.3 510.5 31157.5 36105.0 42068.4 42972.8 43194.4 43107.0 43458.3 44023.6 44067.3 44103.8 7542.7 9268.7 9419.8 9484.1 9492.9 8371.5 11262.4 11458.4 11459.0 11602.5 9734.7 11312.9 11377.6 11387.7 11388.7 8347.0 9756.0 11438.3 11443.5 11446.1 8475.7 11003.1 11256.2 11277.9 11437.0 40763.0 41110.6 41205.0 41205.8 41238.6 4061.9 4081.4 4106.5 4134.8 4260.6 25438.1 30121.0 31604.7 31720.8 31727.4 3217.8 3267.4 3293.8 3372.4 3372.7 451247.0 452598.0 453066.0 453614.7 456050.4 60888.1 62267.4 62853.1 62938.7 63051.0 66551.0 68397.0 68527.7 68795.3 68942.0 15471.4 15933.0 15969.3 15995.0 16014.6 11069.6 11982.7 12157.0 12159.6 12175.1 16527.7 18515.5 19012.0 19035.7 19566.9 6478.6 7765.2 7807.1 7830.6 7916.6 875.9 879.8 889.4 918.5 926.8 29020.6 30320.2 30546.8 31164.2 31313.5 1017.6 1031.3 1058.6 1064.7 1065.9 14669.6 14673.4 14728.0 14819.7 14826.0 574763.0 581414.0 585371.0 585439.0 586214.0 54526.7 54659.6 54777.7 54821.6 54957.0 1405.7 1427.3 1455.2 1464.5 1466.2 27157.2 28391.0 28465.1 28579.6 30542.7 51883.0 52254.5 52715.5 52748.0 56442.7 515920.0 525391.0 526617.0 526962.0 528481.0 24949.4 25292.1 25318.9 25350.7 25431.0 31279.7 43151.6 44179.8 44234.3 45190.5 35975.0 35981.6 36020.3 37069.6 37242.1 36226.8 36556.3 36604.8 36698.7 37304.0 34740.5 35002.1 35648.5 35652.8 35921.3 27707.6 31498.0 32086.4 32235.0 32391.7 21146.3 22938.8 23130.9 23457.9 23911.5 20:24:10 INFO - PROCESS | 1634 | 20:24:10 INFO - PROCESS | 1634 | [#2] jquery.html Cycles:180 Average:38442.31 Median:14590.43 stddev:111329.16 (763.0%) stddev-sans-first:111604.77 20:24:10 INFO - PROCESS | 1634 | Values: 369.9 385.9 387.2 400.5 417.7 14781.0 15093.9 15426.0 19554.5 20977.2 20738.5 21302.6 21530.9 21733.8 22061.9 5552.9 5650.2 5735.9 5890.3 5903.1 4134.7 5717.4 5825.0 5833.0 5836.9 4311.5 6067.6 6322.1 6331.5 6422.4 5665.2 5990.6 6386.4 6413.5 6467.3 5638.9 5639.9 5641.4 5654.3 5655.7 25658.7 26159.0 26177.7 26230.6 26447.5 2733.4 2748.7 2755.6 2761.9 2766.1 13601.8 15180.4 15880.5 16036.4 16702.7 1781.9 1803.4 1878.0 1890.1 1890.8 136990.0 141716.5 141793.0 144667.0 144787.0 9928.5 11657.9 11817.6 11878.3 12002.3 15623.1 15683.8 15705.6 15708.8 15725.0 6534.1 7472.8 8174.6 8487.3 8634.8 6741.9 7897.8 8114.3 8293.8 8331.7 4224.9 4507.2 4785.9 4799.3 4862.3 1753.9 1947.9 1972.3 2027.6 2028.2 849.2 860.8 872.4 879.9 899.4 20612.0 21469.7 21472.9 21576.9 21671.5 727.8 740.5 887.9 917.6 921.1 10534.6 10723.8 10946.9 11012.8 11035.8 593405.0 673450.0 676417.0 678947.6 693339.0 117962.4 146962.0 147103.8 149191.0 150909.0 1013.2 1016.4 1037.2 1039.5 1043.4 15501.8 16230.4 16295.3 17722.4 18681.6 53637.7 55751.9 60595.7 61387.4 62646.7 86045.0 86248.0 87731.6 90267.5 91232.6 7898.0 8249.0 8480.7 8536.9 8720.2 9405.8 13120.4 13149.9 13337.8 13638.7 10632.4 11078.7 11119.0 11412.7 11587.7 11239.8 11340.8 11399.0 11852.0 11871.9 11196.6 11419.4 11651.7 11656.8 11774.6 8292.8 8423.4 8449.2 8453.7 8524.8 8256.0 9142.5 11020.8 11266.4 11378.0 20:24:10 INFO - PROCESS | 1634 | 20:24:10 INFO - PROCESS | 1634 | [#3] mootools.html Cycles:180 Average:5380.77 Median:5185.14 stddev:2948.34 (56.9%) stddev-sans-first:2941.77 20:24:10 INFO - PROCESS | 1634 | Values: 1444.7 1448.8 1451.7 1464.4 1466.7 7996.5 8275.3 8371.7 8426.2 8440.8 7392.8 7643.1 7647.0 8018.4 8240.7 2238.7 2317.7 2318.0 2321.4 2321.8 2178.8 2249.8 2318.6 2341.1 2354.9 2041.7 2287.8 2301.8 2302.3 2336.5 2277.1 2280.8 2317.2 2324.0 2325.0 2261.8 2332.5 2338.7 2341.9 2349.0 8376.6 8426.0 8430.9 8444.9 8474.9 5027.6 5180.9 5189.4 5204.7 5207.1 3276.0 3295.4 3409.9 3432.7 3479.3 1043.3 1081.8 1095.1 1235.8 1253.4 10488.9 10605.0 10608.9 10628.1 10634.1 4427.9 4601.5 4666.1 4674.1 4685.3 9395.2 9481.0 9491.6 9497.6 9510.4 5266.7 5278.0 5280.2 5283.1 5284.0 3998.7 4162.3 4707.3 4709.4 4815.0 3721.9 3811.8 3816.2 3897.2 3907.6 1110.4 1263.3 1269.6 1275.4 1281.2 763.0 764.4 782.0 785.3 793.5 5451.2 5466.7 5541.6 5583.4 5588.2 578.0 598.4 602.3 938.8 1008.0 3540.5 3665.5 3773.4 3788.5 3798.5 9769.6 9847.6 10000.8 10094.9 10105.4 10014.4 10032.1 10034.8 10058.6 10078.7 7362.4 7749.5 7767.9 7854.5 7881.6 5505.9 5560.3 5617.7 5685.5 5700.6 8731.3 8988.4 9247.0 9251.5 9353.7 7668.3 8913.0 9253.4 9323.5 9421.4 6641.8 6659.8 6876.1 7134.3 7240.2 7932.0 8042.8 8094.6 8101.4 8110.6 6964.9 7122.5 7162.4 7171.6 7253.7 7030.9 7031.8 7038.5 7185.0 7256.3 5426.2 6035.1 6045.3 6139.6 6149.0 4845.1 4865.6 4902.9 4917.0 4990.9 4788.2 4836.9 4847.4 4891.3 4912.4 20:24:10 INFO - PROCESS | 1634 | 20:24:10 INFO - PROCESS | 1634 | [#4] prototype.html Cycles:180 Average:4302.47 Median:4719.80 stddev:1300.43 (27.6%) stddev-sans-first:1269.27 20:24:10 INFO - PROCESS | 1634 | Values: 320.5 354.5 364.5 372.0 374.7 4864.4 5283.6 5290.8 5298.9 5348.9 4901.9 5049.2 5151.6 5173.0 5208.4 4098.9 4126.6 4130.9 4149.7 4166.0 3824.8 4166.8 4191.4 4191.5 4196.2 3470.6 3602.2 3680.1 3893.4 4165.3 3344.1 3430.6 3628.0 3952.9 3961.2 2675.7 2809.0 3289.8 3437.6 3448.9 4617.0 4932.6 5113.9 5155.7 5175.0 4358.5 4528.6 4550.3 4558.3 4561.2 4443.2 4869.0 5521.6 5545.4 5546.4 3169.4 3655.1 3686.8 3745.6 3862.7 4689.7 5553.8 5703.7 5759.5 5793.3 3616.5 3835.3 3849.8 3875.7 3879.4 3210.7 3856.4 3867.2 3926.3 3937.4 4273.7 4516.2 4574.5 4586.5 4598.5 4612.0 4686.9 5543.9 5550.9 5606.6 1131.3 1170.3 1203.6 1214.8 1274.6 733.7 761.6 773.9 854.9 861.6 4333.1 4465.7 4548.3 4734.0 4823.4 4844.2 5027.4 5048.5 5396.6 5500.4 4373.9 4498.9 4705.6 5131.0 5194.5 2593.8 2763.9 2811.1 2850.5 2864.9 5099.7 5565.4 5604.0 5606.9 5651.1 5136.1 5212.3 5234.2 5250.5 5537.4 4812.9 5042.8 5187.8 5355.8 5510.4 4567.9 4767.6 4956.9 5392.3 5465.6 4815.8 4935.7 5327.7 5332.7 5357.5 4676.5 5009.3 5418.7 5599.3 5634.6 3291.1 3408.3 3573.0 3626.3 3633.7 4599.6 5103.8 5138.0 5280.2 5319.5 4639.4 4661.4 5164.6 5191.3 5245.8 4479.8 4511.9 5133.3 5179.6 5187.7 4453.8 4766.0 4771.3 5112.8 5288.6 4356.7 4575.0 5076.3 5502.5 5532.3 4745.6 5312.6 5375.7 5376.0 5384.9 20:24:10 INFO - PROCESS | 1634 | 20:24:10 INFO - PROCESS | 1634 | [#5] yui.html Cycles:180 Average:19913.79 Median:4194.76 stddev:27897.27 (665.1%) stddev-sans-first:27938.21 20:24:10 INFO - PROCESS | 1634 | Values: 695.8 696.4 697.4 772.4 789.9 15029.5 15717.0 15718.3 15873.2 15922.7 14409.4 14808.6 14956.0 14974.2 15014.8 855.0 856.2 869.1 874.6 880.2 687.8 708.1 712.7 872.3 877.4 885.2 911.5 913.2 922.4 924.9 908.2 910.8 912.3 912.6 917.8 525.7 682.7 682.9 684.0 687.1 12434.9 14532.9 15030.5 15071.9 15441.7 14405.0 14429.8 14441.8 14498.8 14615.5 10574.9 11280.5 11755.9 11825.4 12097.3 3752.3 3763.8 3802.0 3922.9 3925.9 77743.2 90443.0 97428.0 101114.0 101165.0 10863.1 10968.5 11175.2 11310.5 11376.5 19450.8 22817.9 23025.0 23054.4 23073.3 7841.6 7871.6 7910.3 7963.0 8044.9 3658.8 4075.9 4313.7 4382.4 4456.1 3554.5 3578.9 3666.2 3667.2 3669.8 663.0 668.9 679.3 690.6 693.8 675.9 681.2 711.2 730.9 735.3 9645.9 10217.9 10293.2 10314.6 10357.8 669.2 691.8 699.8 700.4 704.7 4750.8 5022.9 5043.6 5047.7 5051.4 102978.0 103429.0 107642.0 107751.0 109072.5 67901.7 77157.6 78017.6 78205.6 79181.0 59275.4 63964.4 81197.2 82404.0 86705.3 8678.6 9643.8 9816.6 9821.4 9825.5 47180.5 47236.0 53724.7 54345.2 56950.3 65036.7 66083.7 66879.7 69737.6 72475.6 13297.9 13339.3 13340.5 13584.7 13596.5 14512.5 14861.3 14975.0 15413.1 15629.9 12770.7 12844.2 13477.6 13525.0 13542.9 13713.7 13854.9 14013.2 14017.9 14172.0 12943.7 12971.2 13534.7 13861.6 13864.7 11142.9 11285.5 11434.4 11497.4 11775.4 9457.6 9948.2 10173.0 10736.9 10995.5 20:24:10 INFO - PROCESS | 1634 | -------- Summary: end -------- 20:24:10 INFO - PROCESS | 1634 | 20:24:10 INFO - TEST-INFO | 1634: exit 0 20:24:10 INFO - TEST-OK | dromaeo_css | took 1119646ms 20:24:10 INFO - TEST-START | kraken 20:24:10 INFO - operating with platform_type : mac_ 20:24:10 INFO - Initialising browser for kraken test... 20:24:10 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpgbkyMX/profile http://localhost:49241/getInfo.html) 20:24:13 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 20:24:13 INFO - PROCESS | 1644 | colorDepth:24 20:24:13 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 20:24:13 INFO - PROCESS | 1644 | __metrics 20:24:13 INFO - PROCESS | 1644 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:24:13 INFO - PROCESS | 1644 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:24:14 INFO - TEST-INFO | 1644: exit 0 20:24:14 INFO - Browser initialized. 20:24:14 INFO - Running cycle 1/1 for kraken test... 20:24:14 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpgbkyMX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:24:26 INFO - PROCESS | 1645 | RSS: Main: 247091200 20:24:26 INFO - PROCESS | 1645 | 20:24:29 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 20:24:30 INFO - PROCESS | 1645 | RSS: Main: 304680960 20:24:30 INFO - PROCESS | 1645 | 20:24:32 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 20:24:33 INFO - PROCESS | 1645 | RSS: Main: 307150848 20:24:33 INFO - PROCESS | 1645 | 20:24:36 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 20:24:37 INFO - PROCESS | 1645 | RSS: Main: 393269248 20:24:37 INFO - PROCESS | 1645 | 20:24:39 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 20:24:39 INFO - PROCESS | 1645 | RSS: Main: 295796736 20:24:39 INFO - PROCESS | 1645 | 20:24:41 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:24:42 INFO - PROCESS | 1645 | RSS: Main: 299462656 20:24:42 INFO - PROCESS | 1645 | 20:24:45 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 20:24:45 INFO - PROCESS | 1645 | RSS: Main: 341872640 20:24:45 INFO - PROCESS | 1645 | 20:24:48 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 20:24:49 INFO - PROCESS | 1645 | RSS: Main: 343871488 20:24:49 INFO - PROCESS | 1645 | 20:24:52 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 20:24:52 INFO - PROCESS | 1645 | RSS: Main: 340545536 20:24:52 INFO - PROCESS | 1645 | 20:24:54 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:24:55 INFO - PROCESS | 1645 | RSS: Main: 316764160 20:24:55 INFO - PROCESS | 1645 | 20:24:57 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:24:57 INFO - PROCESS | 1645 | RSS: Main: 321757184 20:24:57 INFO - PROCESS | 1645 | 20:25:00 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:25:00 INFO - PROCESS | 1645 | RSS: Main: 323334144 20:25:00 INFO - PROCESS | 1645 | 20:25:03 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:25:04 INFO - PROCESS | 1645 | RSS: Main: 339959808 20:25:04 INFO - PROCESS | 1645 | 20:25:07 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:25:08 INFO - PROCESS | 1645 | RSS: Main: 334184448 20:25:08 INFO - PROCESS | 1645 | 20:25:10 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 20:25:10 INFO - PROCESS | 1645 | RSS: Main: 378875904 20:25:10 INFO - PROCESS | 1645 | 20:25:10 INFO - PROCESS | 1645 | __start_tp_report 20:25:10 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 20:25:10 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 20:25:10 INFO - PROCESS | 1645 | |i|pagename|runs| 20:25:10 INFO - PROCESS | 1645 | |0;ai-astar;112;115;114;115;115;115;128;153;169;114 20:25:10 INFO - PROCESS | 1645 | |1;audio-beat-detection;143;109;111;149;106;113;109;108;129;103 20:25:10 INFO - PROCESS | 1645 | |2;audio-dft;185;184;182;184;183;183;181;181;181;184 20:25:10 INFO - PROCESS | 1645 | |3;audio-fft;80;57;59;88;61;58;58;60;74;57 20:25:10 INFO - PROCESS | 1645 | |4;audio-oscillator;87;70;87;70;68;68;82;67;71;105 20:25:10 INFO - PROCESS | 1645 | |5;imaging-gaussian-blur;89;95;133;72;126;128;132;87;90;86 20:25:10 INFO - PROCESS | 1645 | |6;imaging-darkroom;94;95;95;94;95;94;94;95;93;95 20:25:10 INFO - PROCESS | 1645 | |7;imaging-desaturate;85;87;86;88;87;88;87;85;89;102 20:25:10 INFO - PROCESS | 1645 | |8;json-parse-financial;58;56;56;57;57;55;53;54;56;79 20:25:10 INFO - PROCESS | 1645 | |9;json-stringify-tinderbox;66;66;81;76;102;102;80;72;71;72 20:25:10 INFO - PROCESS | 1645 | |10;stanford-crypto-aes;96;100;79;87;86;105;85;87;87;92 20:25:10 INFO - PROCESS | 1645 | |11;stanford-crypto-ccm;141;146;152;154;140;140;145;124;190;168 20:25:10 INFO - PROCESS | 1645 | |12;stanford-crypto-pbkdf2;200;238;162;226;224;185;172;173;173;171 20:25:10 INFO - PROCESS | 1645 | |13;stanford-crypto-sha256-iterative;67;68;67;66;66;67;75;84;83;82 20:25:10 INFO - PROCESS | 1645 | __end_tp_report 20:25:10 INFO - PROCESS | 1645 | __start_cc_report 20:25:10 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,2010 20:25:10 INFO - PROCESS | 1645 | __end_cc_report 20:25:10 INFO - PROCESS | 1645 | __startTimestamp1485318310312__endTimestamp 20:25:10 INFO - PROCESS | 1645 | 20:25:10 INFO - PROCESS | 1645 | ------- Summary: start ------- 20:25:10 INFO - PROCESS | 1645 | Number of tests: 14 20:25:10 INFO - PROCESS | 1645 | 20:25:10 INFO - PROCESS | 1645 | [#0] ai-astar Cycles:10 Average:125.00 Median:115.00 stddev:19.83 (17.2%) stddev-sans-first:20.47 20:25:10 INFO - PROCESS | 1645 | Values: 112.0 115.0 114.0 115.0 115.0 115.0 128.0 153.0 169.0 114.0 20:25:10 INFO - PROCESS | 1645 | 20:25:10 INFO - PROCESS | 1645 | [#1] audio-beat-detection Cycles:10 Average:118.00 Median:112.00 stddev:16.37 (14.6%) stddev-sans-first:14.65 20:25:10 INFO - PROCESS | 1645 | Values: 143.0 109.0 111.0 149.0 106.0 113.0 109.0 108.0 129.0 103.0 20:25:10 INFO - PROCESS | 1645 | 20:25:10 INFO - PROCESS | 1645 | [#2] audio-dft Cycles:10 Average:182.80 Median:183.50 stddev:1.48 (0.8%) stddev-sans-first:1.33 20:25:10 INFO - PROCESS | 1645 | Values: 185.0 184.0 182.0 184.0 183.0 183.0 181.0 181.0 181.0 184.0 20:25:10 INFO - PROCESS | 1645 | 20:25:10 INFO - PROCESS | 1645 | [#3] audio-fft Cycles:10 Average:65.20 Median:60.50 stddev:11.24 (18.6%) stddev-sans-first:10.57 20:25:10 INFO - PROCESS | 1645 | Values: 80.0 57.0 59.0 88.0 61.0 58.0 58.0 60.0 74.0 57.0 20:25:10 INFO - PROCESS | 1645 | 20:25:10 INFO - PROCESS | 1645 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:70.50 stddev:12.48 (17.7%) stddev-sans-first:12.76 20:25:10 INFO - PROCESS | 1645 | Values: 87.0 70.0 87.0 70.0 68.0 68.0 82.0 67.0 71.0 105.0 20:25:10 INFO - PROCESS | 1645 | 20:25:10 INFO - PROCESS | 1645 | [#5] imaging-gaussian-blur Cycles:10 Average:103.80 Median:86.50 stddev:23.15 (26.8%) stddev-sans-first:23.93 20:25:10 INFO - PROCESS | 1645 | Values: 89.0 95.0 133.0 72.0 126.0 128.0 132.0 87.0 90.0 86.0 20:25:10 INFO - PROCESS | 1645 | 20:25:10 INFO - PROCESS | 1645 | [#6] imaging-darkroom Cycles:10 Average:94.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 20:25:10 INFO - PROCESS | 1645 | Values: 94.0 95.0 95.0 94.0 95.0 94.0 94.0 95.0 93.0 95.0 20:25:10 INFO - PROCESS | 1645 | 20:25:10 INFO - PROCESS | 1645 | [#7] imaging-desaturate Cycles:10 Average:88.40 Median:87.00 stddev:4.95 (5.7%) stddev-sans-first:5.09 20:25:10 INFO - PROCESS | 1645 | Values: 85.0 87.0 86.0 88.0 87.0 88.0 87.0 85.0 89.0 102.0 20:25:10 INFO - PROCESS | 1645 | 20:25:10 INFO - PROCESS | 1645 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:56.50 stddev:7.49 (13.3%) stddev-sans-first:7.94 20:25:10 INFO - PROCESS | 1645 | Values: 58.0 56.0 56.0 57.0 57.0 55.0 53.0 54.0 56.0 79.0 20:25:10 INFO - PROCESS | 1645 | 20:25:10 INFO - PROCESS | 1645 | [#9] json-stringify-tinderbox Cycles:10 Average:78.80 Median:72.00 stddev:13.21 (18.4%) stddev-sans-first:13.18 20:25:10 INFO - PROCESS | 1645 | Values: 66.0 66.0 81.0 76.0 102.0 102.0 80.0 72.0 71.0 72.0 20:25:10 INFO - PROCESS | 1645 | 20:25:10 INFO - PROCESS | 1645 | [#10] stanford-crypto-aes Cycles:10 Average:90.40 Median:87.00 stddev:7.83 (9.0%) stddev-sans-first:8.04 20:25:10 INFO - PROCESS | 1645 | Values: 96.0 100.0 79.0 87.0 86.0 105.0 85.0 87.0 87.0 92.0 20:25:10 INFO - PROCESS | 1645 | 20:25:10 INFO - PROCESS | 1645 | [#11] stanford-crypto-ccm Cycles:10 Average:150.00 Median:149.00 stddev:18.08 (12.1%) stddev-sans-first:18.88 20:25:10 INFO - PROCESS | 1645 | Values: 141.0 146.0 152.0 154.0 140.0 140.0 145.0 124.0 190.0 168.0 20:25:10 INFO - PROCESS | 1645 | 20:25:10 INFO - PROCESS | 1645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.40 Median:192.50 stddev:27.63 (14.4%) stddev-sans-first:29.17 20:25:10 INFO - PROCESS | 1645 | Values: 200.0 238.0 162.0 226.0 224.0 185.0 172.0 173.0 173.0 171.0 20:25:10 INFO - PROCESS | 1645 | 20:25:10 INFO - PROCESS | 1645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:71.50 stddev:7.71 (10.8%) stddev-sans-first:7.91 20:25:10 INFO - PROCESS | 1645 | Values: 67.0 68.0 67.0 66.0 66.0 67.0 75.0 84.0 83.0 82.0 20:25:10 INFO - PROCESS | 1645 | -------- Summary: end -------- 20:25:10 INFO - PROCESS | 1645 | 20:25:11 INFO - TEST-INFO | 1645: exit 0 20:25:11 INFO - TEST-OK | kraken | took 60434ms 20:25:11 INFO - SUITE-END | took 1180s 20:25:11 INFO - Completed test suite (00:19:40) 20:25:11 INFO - javascript benchmark 20:25:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3343.933121337573, 3383.729301655866, 3387.525746395505, 3396.3716712408223, 3447.603525594556, 5623.297087864017, 5691.800786972457, 5827.155062515938, 5834.154047663092, 5836.9124463133085, 4775.259834725614, 4932.062908047468, 5782.913256301159, 5857.7364018619155, 5889.911651325234, 4996.725180115092, 5174.741262936857, 5187.118189907725, 5234.214867769846, 5273.235380869772, 5187.19598462239, 5328.280682107905, 5346.599005074635, 5353.866153346158, 5366.248725178478, 5319.335083114611, 5333.306670132897, 5333.839984800443, 5347.946520534803, 5348.545373643245, 4364.869053928387, 5127.359080114986, 5178.093833579109, 5187.092258854723, 5297.12597421425, 5185.922211166798, 5209.479052094798, 5240.502152295526, 5264.789408423659, 5291.444398338196, 5780.364159942403, 5788.0, 5795.420457954213, 5808.680522571257, 5840.299164100293, 5540.279763630702, 6103.0, 6138.020573254751, 6295.937040629581, 6312.968435157841, 6167.321594624587, 6172.444479996777, 6223.346548612421, 6226.377362263783, 6245.6252624842655, 5905.911411328833, 5947.82156535309, 5949.732262048218, 5956.970215148896, 5976.342602313742, 6222.191115155001, 6291.402316779899, 6306.148669929501, 6310.558260921784, 6324.620522768649, 5994.6403215807195, 6032.276126864805, 6051.304100028553, 6137.8979746733885, 6237.126802247689, 5240.187770895517, 6255.530835187288, 6256.874862502725, 6257.56197066201, 6267.6866156691985, 6099.0374119281705, 6151.446369826737, 6154.9384506154365, 6158.04550294705, 6168.691565421711, 6150.938490615036, 6240.0, 6266.717997690115, 6268.529860260499, 6271.592346497463, 4900.779464924087, 5005.174146265826, 5005.249212618136, 5014.52362025607, 5052.0, 4414.492333381638, 4416.712913660602, 4418.226810308183, 4433.512313645497, 4438.0, 5821.068629019422, 5828.271466066742, 5831.504322132581, 5832.912506312408, 5878.735456904449, 6165.445109940127, 6200.0699895016105, 6213.440790328892, 6223.346548612421, 6246.0, 5563.554915606742, 5634.915476267859, 5636.0982242841765, 5665.773369065191, 5828.854278642983, 4708.4820669726305, 5417.83746487606, 5419.132938729785, 5433.565314774809, 5440.972795135999, 5137.922931156036, 6189.102580125947, 6202.534809889276, 6207.472364849038, 6213.720382582705, 6189.319174890668, 6194.0708893666315, 6206.875862482635, 6213.161223234805, 6221.346758590283, 6242.625442473284, 6289.622622642656, 6305.8108256752375, 6320.020396838498, 6323.20959880015, 6234.407731265523, 6236.688165591611, 6238.968805155945, 6253.687315634291, 6261.373862613702, 6147.969260153671, 6216.627002379872, 6222.12890195364, 6223.626582405071, 6232.719527621177, 6035.818925432244, 6095.908561371672, 6101.481374083252, 6106.175666284995, 6163.921313769983, 6150.261968563801, 6153.169322141633, 6153.784617538365, 6158.630482171084, 6196.256449226122, 5861.1501332307425, 5920.79277225295, 5920.851978700567, 5927.229460170151, 6050.45545900871, 6090.878182436415, 6102.962496375538, 6108.827782940854, 6122.825106970275, 6181.443670069715, 5853.239078919713, 5910.231669882888, 5922.407759224043, 5930.140129681258, 6044.788432404845], "value": 5692.567735202329, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [440.5110327536434, 477.3126697555518, 479.6810121269355, 501.2781594503916, 510.50226029621103, 31157.532637010434, 36105.0, 42068.36897446537, 42972.78513607428, 43194.352084718754, 43107.0, 43458.34812477815, 44023.559764402344, 44067.33898991509, 44103.77948110255, 7542.717737984528, 9268.675596354129, 9419.764505887339, 9484.146426821584, 9492.905070949306, 8371.539565323905, 11262.4368781561, 11458.369789661565, 11459.02598279143, 11602.535898564047, 9734.65928692496, 11312.925272099137, 11377.601783937564, 11387.715307117305, 11388.658340249805, 8346.998360196754, 9756.0, 11438.313701177873, 11443.542258309615, 11446.08431325492, 8475.728640703883, 11003.119750420028, 11256.212065155443, 11277.887221127765, 11437.0, 40762.9809254771, 41110.58889411097, 41205.0, 41205.79397103025, 41238.587614123775, 4061.8578349757618, 4081.3877918312196, 4106.486689163855, 4134.834606615732, 4260.616544511009, 25438.109666161596, 30121.0, 31604.73581056755, 31720.841395792875, 31727.365452690818, 3217.8069315841126, 3267.3656553391907, 3293.847153496281, 3372.426687463137, 3372.7133193678565, 451247.0, 452598.0, 453066.0, 453614.73192634154, 456050.43949560745, 60888.08667869985, 62267.37732622706, 62853.05720414197, 62938.68530657318, 63051.0, 66551.0, 68397.0, 68527.65736171287, 68795.31204687888, 68942.0, 15471.381144754083, 15933.0, 15969.281382337822, 15994.96032757867, 16014.599635009217, 11069.612563560237, 11982.700432489257, 12157.02743780513, 12159.574414895436, 12175.0868684849, 16527.669446611002, 18515.537111572048, 19012.0, 19035.714464283046, 19566.902165489366, 6478.643674597848, 7765.2140007798525, 7807.141214466405, 7830.647620857075, 7916.564588947663, 875.8511053120985, 879.7536689726886, 889.3729920406098, 918.4672889724078, 926.8285367207088, 29020.564691529646, 30320.241993950327, 30546.847265763972, 31164.220894477818, 31313.530297045563, 1017.5726194998118, 1031.3347890610514, 1058.5501162006117, 1064.7338165458636, 1065.8774240962234, 14669.559913202622, 14673.413063477556, 14728.0, 14819.703605927822, 14826.0, 574763.0, 581414.0, 585371.0, 585439.0, 586214.0, 54526.72736636292, 54659.63350916259, 54777.726111369186, 54821.62945926384, 54957.0, 1405.7048019915728, 1427.343422025859, 1455.243273497754, 1464.545990742852, 1466.1789397937189, 27157.185284441497, 28391.006314778882, 28465.146045618665, 28579.571306430837, 30542.694573054872, 51883.0, 52254.47745522648, 52715.472845271055, 52748.0, 56442.7177864108, 515920.0, 525391.0, 526617.0, 526962.0, 528481.0, 24949.376265593506, 25292.11477598275, 25318.873405632854, 25350.74649253484, 25431.0, 31279.687203127676, 43151.568484314754, 44179.77910110429, 44234.3364849534, 45190.54809451995, 35975.0, 35981.64018359783, 36020.27959440849, 37069.62930370662, 37242.06894827651, 36226.8188659055, 36556.26887462289, 36604.81697591495, 36698.725117423186, 37304.0, 34740.47889281713, 35002.12494687653, 35648.465273021444, 35652.82173589116, 35921.281574367844, 27707.584386234626, 31498.0, 32086.358272833946, 32235.032949011566, 32391.676083238865, 21146.259880904094, 22938.770612293665, 23130.884345578164, 23457.94439250204, 23911.52176956486], "value": 19801.406027951278, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.94450832375156, 385.92860320840646, 387.23521045934285, 400.5433805461774, 417.6909087275417, 14780.965332426735, 15093.924530377346, 15426.0, 19554.51113722154, 20977.16091356348, 20738.481537961557, 21302.57394852102, 21530.89234553829, 21733.782662173373, 22061.889690551525, 5552.91670624941, 5650.208970744099, 5735.885282294352, 5890.2931648202275, 5903.114532820068, 4134.710570260083, 5717.371089180187, 5825.009748342771, 5833.0, 5836.883262334751, 4311.5472875348105, 6067.575269731121, 6322.146510221107, 6331.461825744817, 6422.389872962084, 5665.2351932489, 5990.550708696822, 6386.425221730044, 6413.518986076063, 6467.2562655294305, 5638.943610563882, 5639.8590035249035, 5641.435856414367, 5654.349749778746, 5655.7454914528535, 25658.717064146716, 26158.953641854303, 26177.73822261772, 26230.606540901903, 26447.47105057907, 2733.3986522964915, 2748.6839013513504, 2755.641766570333, 2761.9309517262027, 2766.0871912268904, 13601.795973060413, 15180.392784288615, 15880.523584292374, 16036.438724644699, 16702.66594668112, 1781.9287228510843, 1803.3868484715128, 1877.9624407511774, 1890.1399863062275, 1890.8014658460802, 136990.0, 141716.45111458882, 141793.0, 144667.0, 144787.0, 9928.453935033498, 11657.941710291394, 11817.586384476503, 11878.287302761863, 12002.339871306987, 15623.14072726011, 15683.764743528856, 15705.607359816097, 15708.764368534481, 15725.0, 6534.117894084333, 7472.813179670552, 8174.550399728072, 8487.278581320534, 8634.78413039679, 6741.910007897567, 7897.763067107996, 8114.29599784052, 8293.83412331762, 8331.66673333072, 4224.943764058985, 4507.18870603288, 4785.904281914342, 4799.28010798383, 4862.343583616237, 1753.9123043847756, 1947.9415617531497, 1972.3294080012865, 2027.5843452092286, 2028.1583142995491, 849.1593322610571, 860.8106216632331, 872.4154816272985, 879.9089129479399, 899.3884158771967, 20611.969401529863, 21469.67795483069, 21472.892635536722, 21576.92115394224, 21671.52090647915, 727.7925791149603, 740.5186628691393, 887.924526415262, 917.554985831871, 921.1019256225127, 10534.631287904887, 10723.83914241287, 10946.890531094747, 11012.834807477895, 11035.779284414266, 593405.0, 673450.0, 676417.0, 678947.6052619705, 693339.0, 117962.41018794851, 146962.0, 147103.78579962743, 149191.0, 150909.0, 1013.1692012549638, 1016.3850870223556, 1037.2479952034714, 1039.5374058543875, 1043.3844032021143, 15501.837362197655, 16230.350785968429, 16295.348186072899, 17722.379716709853, 18681.6263674723, 53637.731811340695, 55751.884962299715, 60595.697021514614, 61387.38612613817, 62646.68676656587, 86045.0, 86248.0, 87731.56134219289, 90267.54866225627, 91232.63151052607, 7898.0, 8248.958755206186, 8480.74557763268, 8536.871946920677, 8720.171583699539, 9405.81188376215, 13120.409581569043, 13149.868501315246, 13337.799933001206, 13638.659033523845, 10632.362058276529, 11078.723031924266, 11119.0, 11412.71468213268, 11587.652370428901, 11239.775204496027, 11340.753042659393, 11399.031082358093, 11851.992580630744, 11871.940640296743, 11196.552137914718, 11419.37193454368, 11651.650450486499, 11656.825147622623, 11774.587889423829, 8292.83414331722, 8423.368247381593, 8449.197326253996, 8453.746387608382, 8524.753959134687, 8256.0, 9142.451452912846, 11020.779584408427, 11266.380349080879, 11378.03286720605], "value": 9828.710149548268, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1444.6966137111206, 1448.8116544849167, 1451.6951440197558, 1464.377639503211, 1466.6993266380389, 7996.520208787477, 8275.337972962163, 8371.706990255343, 8426.199511046441, 8440.788980275482, 7392.778216653495, 7643.082830060401, 7646.961765191167, 8018.398620103501, 8240.711575094872, 2238.7425446073667, 2317.721873375189, 2318.0380142241033, 2321.431249343913, 2321.7562155973633, 2178.7689955175274, 2249.8312626552993, 2318.6174281243575, 2341.063574570177, 2354.9058037678474, 2041.7243672104298, 2287.7597852225526, 2301.7583153768865, 2302.332323626155, 2336.4626135988733, 2277.1005452846116, 2280.7719228077226, 2317.2005658047947, 2323.9767602323927, 2325.046730840364, 2261.796438320559, 2332.4635333873302, 2338.660894170353, 2341.915695031423, 2348.953020939589, 8376.623051962677, 8426.0, 8430.915690843074, 8444.873326900102, 8474.872876906851, 5027.597792176617, 5180.922286165711, 5189.351331083614, 5204.661696989683, 5207.140821764404, 3275.9836200818845, 3295.3903527847187, 3409.880654177092, 3432.742544309162, 3479.2693534357813, 1043.2644985285356, 1081.8160912644869, 1095.1403148528448, 1235.8455193100863, 1253.4359538207843, 10488.947555262252, 10604.992525710046, 10608.893911060944, 10628.14974802014, 10634.096101831354, 4427.933580996288, 4601.539846015372, 4666.066786642685, 4674.111918735497, 4685.297205419214, 9395.248380129573, 9480.952595237117, 9491.572879220314, 9497.620095196253, 9510.429374237568, 5266.710330931759, 5277.973610131925, 5280.155175171954, 5283.128283833202, 5283.996040752245, 3998.6801055915457, 4162.250794856955, 4707.270373092176, 4709.411323584552, 4814.975925120352, 3721.9441708374397, 3811.7712937223855, 3816.198598294334, 3897.18159186574, 3907.5506316773367, 1110.3559935237543, 1263.298869127643, 1269.6000759760645, 1275.355945247644, 1281.218456741387, 762.9809254768564, 764.4228607401487, 781.9960900195463, 785.344237561631, 793.4644115222202, 5451.236826844245, 5466.671999680032, 5541.556675465953, 5583.441655834384, 5588.21764952907, 577.96243244189, 598.4255115089476, 602.295314482057, 938.7746940734174, 1008.0423597582326, 3540.504329393887, 3665.486831843544, 3773.396256598986, 3788.5264341957254, 3798.506194194737, 9769.609215631295, 9847.606095756233, 10000.799984000425, 10094.899051009543, 10105.44420056904, 10014.449205293779, 10032.097111260022, 10034.845992710932, 10058.647947321808, 10078.74803129913, 7362.44781641379, 7749.4575379724, 7767.92232077672, 7854.4894581851995, 7881.645325960231, 5505.889882202254, 5560.276314342566, 5617.662940223599, 5685.545156387397, 5700.600957933071, 8731.25784308341, 8988.415752976036, 9246.95376523113, 9251.491167985556, 9353.719388418358, 7668.309852113337, 8913.019567847661, 9253.398529095588, 9323.533823308671, 9421.434713917188, 6641.833954151185, 6659.833504162435, 6876.140482439695, 7134.250903655042, 7240.203577606354, 7932.008498937633, 8042.798930026796, 8094.635741391769, 8101.351891848756, 8110.594470276581, 6964.895526567207, 7122.501424900207, 7162.391196748335, 7171.569705817667, 7253.746118885813, 7030.9296907030275, 7031.753888613874, 7038.472114591324, 7185.0, 7256.310650488195, 5426.240326354235, 6035.094735789491, 6045.304789949212, 6139.570230083851, 6148.9692551536955, 4845.103655823543, 4865.562099410929, 4902.852914412573, 4917.016596680606, 4990.900181996412, 4788.233882578771, 4836.903261934671, 4847.394075740533, 4891.290762839297, 4912.435069966999], "value": 4338.689934972114, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.50322000898603, 354.5408695739018, 364.4551395663483, 371.97768133911984, 374.65531710826036, 4864.367632207817, 5283.63014588979, 5290.788573255345, 5298.8668838306085, 5348.946510534894, 4901.877453063676, 5049.192129259319, 5151.587872970163, 5172.974135129319, 5208.401033881095, 4098.877033688987, 4126.595558664099, 4130.938035929464, 4149.668026557883, 4166.000159961618, 3824.7569539899646, 4166.812493437787, 4191.413202151702, 4191.517975432818, 4196.237580216317, 3470.6182319944787, 3602.2255215128744, 3680.11677197472, 3893.396523538842, 4165.33354663254, 3344.1138098403944, 3430.6397828227928, 3627.963720362789, 3952.861649842256, 3961.1681546875193, 2675.745804148603, 2808.9719102808913, 3289.832109601081, 3437.6218615952225, 3448.8620455181763, 4616.976915115437, 4932.630052746023, 5113.948860511385, 5155.742212889378, 5175.0, 4358.493866027047, 4528.569785870337, 4550.271956486979, 4558.2650409754215, 4561.201789686792, 4443.244648409778, 4869.026194761062, 5521.641093328921, 5545.445455454463, 5546.417626149237, 3169.3661267746543, 3655.0862284428895, 3686.8156592170285, 3745.6441638044616, 3862.748921320105, 4689.742064186468, 5553.7778488860395, 5703.686297253649, 5759.481646651821, 5793.333766616809, 3616.5298511193378, 3835.2904712627696, 3849.825803130072, 3875.70932180082, 3879.3599056155417, 3210.7110360067704, 3856.3636999895266, 3867.176960818562, 3926.312895243321, 3937.3503371943307, 4273.658107351404, 4516.209663308908, 4574.519675434098, 4586.518415566385, 4598.493820867635, 4612.0, 4686.867879671822, 5543.861403464945, 5550.944490555043, 5606.60753747242, 1131.3155540897803, 1170.3446070200714, 1203.602811072344, 1214.8238505416666, 1274.643099932002, 733.7468573342188, 761.6382218446194, 773.9380849532024, 854.918782715641, 861.5649097205871, 4333.140127515824, 4465.665075119379, 4548.317752337176, 4734.029523947583, 4823.421189457217, 4844.249141383021, 5027.4218464877, 5048.460219632973, 5396.568274538027, 5500.42245564218, 4373.934390984138, 4498.865034048984, 4705.576498115186, 5131.0, 5194.506521880416, 2593.844369337846, 2763.875625596853, 2811.102505808571, 2850.5154123799, 2864.942701145965, 5099.725068732817, 5565.443455654483, 5604.038586494776, 5606.887862242814, 5651.106879195433, 5136.075506408883, 5212.325310655979, 5234.214867769865, 5250.527452529291, 5537.425097329761, 4812.903741925142, 5042.823501177441, 5187.818426355059, 5355.839324820262, 5510.366307874646, 4567.903703111296, 4767.618590512681, 4956.925646115239, 5392.333213414759, 5465.562754979672, 4815.832875206102, 4935.679180853233, 5327.733613319396, 5332.746804500862, 5357.544608708304, 4676.532346765296, 5009.298698182331, 5418.674879507243, 5599.272094627672, 5634.605577609528, 3291.078498020558, 3408.2842603053637, 3572.964270357263, 3626.2928728897614, 3633.7093032556804, 4599.609033232213, 5103.8468845934685, 5138.0, 5280.201493208606, 5319.46805319465, 4639.420072490939, 4661.387424745849, 5164.638475306692, 5191.299174611379, 5245.816396426107, 4479.820807167677, 4511.8646440606835, 5133.332666753298, 5179.559737422362, 5187.740612969412, 4453.844115455943, 4765.976170119127, 4771.308160316804, 5112.795488180431, 5288.629795914249, 4356.651467882499, 4574.987005717474, 5076.289319495348, 5502.532284755841, 5532.28080349552, 4745.5966242869745, 5312.574994000548, 5375.6774593524515, 5376.0, 5384.9381581315], "value": 3899.1244359526904, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.808652620529, 696.3906581740978, 697.3549466743261, 772.4322622872188, 789.9210078992099, 15029.549113526598, 15716.978396404225, 15718.292676829542, 15873.206339683027, 15922.681546369065, 14409.351579178936, 14808.55574332769, 14956.0, 14974.176420296879, 15014.774778378305, 855.0423525651279, 856.16096225699, 869.0917990699734, 874.5889431966965, 880.2034159086005, 687.8142901416614, 708.0901042160824, 712.7006657203987, 872.2585802068255, 877.3595275448926, 885.190051103243, 911.539672465404, 913.1598928985317, 922.40504874356, 924.8890133184027, 908.2098574240387, 910.7905181808221, 912.3020889019905, 912.5619702542783, 917.8302014127374, 525.7134861500491, 682.7371461987121, 682.8600136971909, 684.0184335478605, 687.0552989639247, 12434.937825310815, 14532.854671453362, 15030.549083527512, 15071.944963852535, 15441.691166176726, 14404.957316981816, 14429.783553246709, 14441.78337324941, 14498.782518262235, 14615.488457904028, 10574.947125264402, 11280.492377843017, 11755.882441175565, 11825.408729563487, 12097.274163550215, 3752.2870654575545, 3763.7741735495683, 3802.0, 3922.8626998054933, 3925.9214815703813, 77743.22256777473, 90443.0, 97428.02571974261, 101114.0, 101165.0, 10863.130949524018, 10968.506417211245, 11175.217734758651, 11310.547578096948, 11376.544938202545, 19450.8054919449, 22817.88591057034, 23025.0, 23054.42363940915, 23073.307800766004, 7841.607919603997, 7871.645775940096, 7910.288074073361, 7962.960185199037, 8044.879326810103, 3658.7987660678386, 4075.857344992911, 4313.654907607384, 4382.406744611484, 4456.131054444417, 3554.5201397811484, 3578.8926332210076, 3666.156783939709, 3667.156553992597, 3669.8165091745304, 662.9502787290972, 668.9331066893271, 679.3308591037824, 690.6443181761397, 693.8196069022091, 675.8614484030762, 681.2268075734078, 711.2283172757616, 730.9232530584319, 735.3308489274734, 9645.9035409645, 10217.897821021843, 10293.176545876311, 10314.587416503256, 10357.844632330522, 669.2270427656065, 691.7509696509253, 699.8250437390652, 700.4291502425507, 704.6864145455223, 4750.809967601326, 5022.924656130161, 5043.5965122790085, 5047.671901326402, 5051.368578927634, 102978.0, 103429.0, 107642.0, 107751.0, 109072.4546377263, 67901.66049169723, 77157.6142119297, 78017.60991195121, 78205.60897195591, 79181.0, 59275.40724592871, 63964.36035639584, 81197.18802812014, 82404.0, 86705.26589468302, 8678.566071696516, 9643.807123857623, 9816.55825487869, 9821.36161149523, 9825.459599722084, 47180.52819471899, 47236.0, 53724.73137634443, 54345.18482222691, 56950.29149125533, 65036.67481662751, 66083.66958165179, 66879.66560167167, 69737.60524789375, 72475.63762181366, 13297.933510332387, 13339.266340351374, 13340.517456421418, 13584.660383490493, 13596.456141754616, 14512.455800387355, 14861.331240094005, 14975.0, 15413.075215487106, 15629.921850390676, 12770.68073298175, 12844.229346239255, 13477.595672129852, 13525.0, 13542.854310216704, 13713.657158571115, 13854.930725346308, 14013.229272390117, 14017.859821402064, 14172.0, 12943.741125177256, 12971.221726696429, 13534.729305414034, 13861.584152475441, 13864.653383665489, 11142.888571114185, 11285.548578056785, 11434.375464499892, 11497.367644779617, 11775.411229438323, 9457.574409151743, 9948.230932889597, 10173.0, 10736.89263107359, 10995.505202265756], "value": 7504.508605215189, "unit": "score"}], "name": "dromaeo_css", "value": 7211.625938978003, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 114.0, 115.0, 115.0, 115.0, 128.0, 153.0, 169.0, 114.0], "value": 125.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 109.0, 111.0, 149.0, 106.0, 113.0, 109.0, 108.0, 129.0, 103.0], "value": 118.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 182.0, 184.0, 183.0, 183.0, 181.0, 181.0, 181.0, 184.0], "value": 182.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 59.0, 88.0, 61.0, 58.0, 58.0, 60.0, 74.0, 57.0], "value": 65.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 87.0, 70.0, 68.0, 68.0, 82.0, 67.0, 71.0, 105.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 95.0, 133.0, 72.0, 126.0, 128.0, 132.0, 87.0, 90.0, 86.0], "value": 103.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 93.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 86.0, 88.0, 87.0, 88.0, 87.0, 85.0, 89.0, 102.0], "value": 88.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 56.0, 57.0, 57.0, 55.0, 53.0, 54.0, 56.0, 79.0], "value": 58.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 81.0, 76.0, 102.0, 102.0, 80.0, 72.0, 71.0, 72.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 100.0, 79.0, 87.0, 86.0, 105.0, 85.0, 87.0, 87.0, 92.0], "value": 90.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 146.0, 152.0, 154.0, 140.0, 140.0, 145.0, 124.0, 190.0, 168.0], "value": 150.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 238.0, 162.0, 226.0, 224.0, 185.0, 172.0, 173.0, 173.0, 171.0], "value": 192.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 66.0, 66.0, 67.0, 75.0, 84.0, 83.0, 82.0], "value": 72.5, "unit": "score"}], "name": "kraken", "value": 1497.3, "alertThreshold": 2.0}]} 20:25:11 INFO - Return code: 0 20:25:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:25:11 ERROR - # TBPL SUCCESS # 20:25:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:25:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:25:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:25:11 INFO - 2017-01-24 20:25:11.604 screenresolution[1649:9870] starting screenresolution argv=screenresolution get 20:25:11 INFO - 2017-01-24 20:25:11.607 screenresolution[1649:9870] Display 0: 1600x1200x32@60 20:25:11 INFO - 2017-01-24 20:25:11.614 screenresolution[1650:9873] starting screenresolution argv=screenresolution list 20:25:11 INFO - Available Modes on Display 0 20:25:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:25:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:25:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:25:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:25:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:25:11 INFO - Intel Iris: 20:25:11 INFO - Chipset Model: Intel Iris 20:25:11 INFO - Type: GPU 20:25:11 INFO - Bus: Built-In 20:25:11 INFO - VRAM (Dynamic, Max): 1536 MB 20:25:11 INFO - Vendor: Intel (0x8086) 20:25:11 INFO - Device ID: 0x0a2e 20:25:11 INFO - Revision ID: 0x0009 20:25:11 INFO - Displays: 20:25:11 INFO - Display: 20:25:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:25:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:25:11 INFO - Display Serial Number: 1600x1200 60 20:25:11 INFO - Main Display: Yes 20:25:11 INFO - Mirror: Off 20:25:11 INFO - Online: Yes 20:25:11 INFO - Rotation: Supported 20:25:11 INFO - Return code: 0 20:25:11 INFO - Running post-action listener: _resource_record_post_action 20:25:11 INFO - [mozharness: 2017-01-25 04:25:11.860636Z] Finished run-tests step (success) 20:25:11 INFO - Running post-run listener: _resource_record_post_run 20:25:11 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 50333696; Write bytes: 560211968; Read time: 543; Write time: 2040 20:25:11 INFO - TinderboxPrint: CPU usage
53.9% 20:25:11 INFO - TinderboxPrint: I/O read bytes / time
50,333,696 / 543 20:25:11 INFO - TinderboxPrint: I/O write bytes / time
560,211,968 / 2,040 20:25:11 INFO - TinderboxPrint: CPU idle
2,215.2 (46.1%) 20:25:11 INFO - TinderboxPrint: CPU system
964.8 (20.1%) 20:25:11 INFO - TinderboxPrint: CPU user
1,629.7 (33.9%) 20:25:11 INFO - TinderboxPrint: Swap in / out
293,912,576 / 0 20:25:11 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 249395712; Write bytes: 243197440; Read time: 18056; Write time: 487 20:25:11 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 45750272; Write bytes: 305578496; Read time: 510; Write time: 1520 20:25:12 INFO - Running post-run listener: _upload_blobber_files 20:25:12 INFO - Blob upload gear active. 20:25:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:25:12 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 20:25:12 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'] 20:25:12 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 20:25:12 INFO - (blobuploader) - INFO - Open directory for files ... 20:25:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:25:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:25:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:25:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:25:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:25:13 INFO - (blobuploader) - INFO - Done attempting. 20:25:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:25:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:25:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:25:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:25:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:25:14 INFO - (blobuploader) - INFO - Done attempting. 20:25:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:25:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:25:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:25:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:25:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:25:15 INFO - (blobuploader) - INFO - Done attempting. 20:25:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:25:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:25:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:25:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:25:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:25:18 INFO - (blobuploader) - INFO - Done attempting. 20:25:18 INFO - (blobuploader) - INFO - Iteration through files over. 20:25:18 INFO - Return code: 0 20:25:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:25:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:25:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/203f51f6e0df8a2a8dcfea7903329bc3fbfa99d999db0dc57808a1de67d176c1a9efcc33b4328a895158ce89984b8ae72945e16ee172fb876f9b0b115d0dc42e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c02998fa8bf4d9ac4ed8cd254d028e6a531fea965ca6903de58b651065ee9ea7e7b8c2c5cab5bec84b5fe38b35dd502f31a09b0a6dc0a6dac13155b4e25d149e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8bdcb4e2c0598be9a71b6812cfb526d0e6ce147c8d953340ce8cc06ac289c301ec6e3926cfdebe1bf4cce8a61a5f00c780f0d9cde158c8e04789ee039069f517", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24db5946ed50bc5e18ee5934747d6f5e88b2947a183b43de24e1863bcd91d2e0ab46c62709f72907314e1e973487cde1e18a8926b6ee8194b9959d43b219edef"} 20:25:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:25:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:25:18 INFO - Contents: 20:25:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/203f51f6e0df8a2a8dcfea7903329bc3fbfa99d999db0dc57808a1de67d176c1a9efcc33b4328a895158ce89984b8ae72945e16ee172fb876f9b0b115d0dc42e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c02998fa8bf4d9ac4ed8cd254d028e6a531fea965ca6903de58b651065ee9ea7e7b8c2c5cab5bec84b5fe38b35dd502f31a09b0a6dc0a6dac13155b4e25d149e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8bdcb4e2c0598be9a71b6812cfb526d0e6ce147c8d953340ce8cc06ac289c301ec6e3926cfdebe1bf4cce8a61a5f00c780f0d9cde158c8e04789ee039069f517", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24db5946ed50bc5e18ee5934747d6f5e88b2947a183b43de24e1863bcd91d2e0ab46c62709f72907314e1e973487cde1e18a8926b6ee8194b9959d43b219edef"} 20:25:18 INFO - Running post-run listener: copy_logs_to_upload_dir 20:25:18 INFO - Copying logs to upload dir... 20:25:18 INFO - mkdir: /builds/slave/test/build/upload/logs 20:25:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.839633 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-24 20:25:18.507162) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 20:25:18.511111) ========= 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.ixEhpXmFmR/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.0lnVZU4Z95/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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/203f51f6e0df8a2a8dcfea7903329bc3fbfa99d999db0dc57808a1de67d176c1a9efcc33b4328a895158ce89984b8ae72945e16ee172fb876f9b0b115d0dc42e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c02998fa8bf4d9ac4ed8cd254d028e6a531fea965ca6903de58b651065ee9ea7e7b8c2c5cab5bec84b5fe38b35dd502f31a09b0a6dc0a6dac13155b4e25d149e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8bdcb4e2c0598be9a71b6812cfb526d0e6ce147c8d953340ce8cc06ac289c301ec6e3926cfdebe1bf4cce8a61a5f00c780f0d9cde158c8e04789ee039069f517", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24db5946ed50bc5e18ee5934747d6f5e88b2947a183b43de24e1863bcd91d2e0ab46c62709f72907314e1e973487cde1e18a8926b6ee8194b9959d43b219edef"} build_url:https://queue.taskcluster.net/v1/task/TXOH-VD3TPenXJkpn0GB0g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010586 build_url: 'https://queue.taskcluster.net/v1/task/TXOH-VD3TPenXJkpn0GB0g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/203f51f6e0df8a2a8dcfea7903329bc3fbfa99d999db0dc57808a1de67d176c1a9efcc33b4328a895158ce89984b8ae72945e16ee172fb876f9b0b115d0dc42e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c02998fa8bf4d9ac4ed8cd254d028e6a531fea965ca6903de58b651065ee9ea7e7b8c2c5cab5bec84b5fe38b35dd502f31a09b0a6dc0a6dac13155b4e25d149e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8bdcb4e2c0598be9a71b6812cfb526d0e6ce147c8d953340ce8cc06ac289c301ec6e3926cfdebe1bf4cce8a61a5f00c780f0d9cde158c8e04789ee039069f517", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24db5946ed50bc5e18ee5934747d6f5e88b2947a183b43de24e1863bcd91d2e0ab46c62709f72907314e1e973487cde1e18a8926b6ee8194b9959d43b219edef"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 20:25:18.544883) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 20:25:18.545202) ========= 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.ixEhpXmFmR/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.0lnVZU4Z95/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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.005029 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 20:25:18.593461) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 20:25:18.593780) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 20:25:18.594083) ========= ========= Total master_lag: 0.18 =========