builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0130 starttime: 1481816093.74 results: success (0) buildid: 20161215062900 builduid: b35aa4d99b6f4fd7b6452d4c69cfa783 revision: 6dbc6e9f62a705d5f523cc750811bd01c8275ec6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 07:34:53.739175) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 07:34:53.739535) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 07:34:53.739798) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 07:34:53.891708) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-12-15 07:34:53.891968) ========= 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.61W9oSw1M0/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.f6fCL9t30p/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 --2016-12-15 07:34:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.16M=0.001s 2016-12-15 07:34:54 (8.16 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.592997 ========= master_lag: 3.00 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-12-15 07:34:57.489120) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 07:34:57.489408) ========= 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.61W9oSw1M0/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.f6fCL9t30p/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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.020679 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 07:34:57.599069) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-15 07:34:57.599400) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6dbc6e9f62a705d5f523cc750811bd01c8275ec6 --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 6dbc6e9f62a705d5f523cc750811bd01c8275ec6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.61W9oSw1M0/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.f6fCL9t30p/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 2016-12-15 07:34:57,674 truncating revision to first 12 chars 2016-12-15 07:34:57,674 Setting DEBUG logging. 2016-12-15 07:34:57,674 attempt 1/10 2016-12-15 07:34:57,674 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6dbc6e9f62a7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-15 07:34:58,822 unpacking tar archive at: mozilla-central-6dbc6e9f62a7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.408689 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-15 07:34:59.035534) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 07:34:59.035870) ========= script_repo_revision: 6dbc6e9f62a705d5f523cc750811bd01c8275ec6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 07:34:59.036270) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 07:34:59.036534) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 07:34:59.057167) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-12-15 07:34:59.057457) ========= /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.61W9oSw1M0/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.f6fCL9t30p/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 07:34:59 INFO - MultiFileLogger online at 20161215 07:34:59 in /builds/slave/test 07:34:59 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 07:34:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:34:59 INFO - {'append_to_log': False, 07:34:59 INFO - 'base_work_dir': '/builds/slave/test', 07:34:59 INFO - 'blob_upload_branch': 'Firefox', 07:34:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:34:59 INFO - 'branch': 'Firefox', 07:34:59 INFO - 'buildbot_json_path': 'buildprops.json', 07:34:59 INFO - 'config_files': ('talos/mac_config.py',), 07:34:59 INFO - 'default_actions': ('clobber', 07:34:59 INFO - 'read-buildbot-config', 07:34:59 INFO - 'download-and-extract', 07:34:59 INFO - 'populate-webroot', 07:34:59 INFO - 'create-virtualenv', 07:34:59 INFO - 'install', 07:34:59 INFO - 'run-tests'), 07:34:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:34:59 INFO - 'download_minidump_stackwalk': True, 07:34:59 INFO - 'download_symbols': 'ondemand', 07:34:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:34:59 INFO - 'tooltool.py': '/tools/tooltool.py', 07:34:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:34:59 INFO - '/tools/misc-python/virtualenv.py')}, 07:34:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:34:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:34:59 INFO - 'installer_path': 'installer.exe', 07:34:59 INFO - 'log_level': 'info', 07:34:59 INFO - 'log_name': 'talos', 07:34:59 INFO - 'log_to_console': True, 07:34:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:34:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:34:59 INFO - 'opt_config_files': (), 07:34:59 INFO - 'pip_index': False, 07:34:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:34:59 INFO - 'cmd': ('bash', 07:34:59 INFO - '-c', 07:34:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:34:59 INFO - 'enabled': True, 07:34:59 INFO - 'halt_on_failure': False, 07:34:59 INFO - 'name': 'check_screen_resolution'},), 07:34:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:34:59 INFO - 'cmd': ('bash', 07:34:59 INFO - '-c', 07:34:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:34:59 INFO - 'enabled': True, 07:34:59 INFO - 'halt_on_failure': False, 07:34:59 INFO - 'name': 'check_screen_resolution'},), 07:34:59 INFO - 'run_cmd_checks_enabled': True, 07:34:59 INFO - 'sps_profile': False, 07:34:59 INFO - 'sps_profile_interval': 0, 07:34:59 INFO - 'suite': 'dromaeojs', 07:34:59 INFO - 'system_bits': '32', 07:34:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:34:59 INFO - 'title': 't-yosemite-r7-0130', 07:34:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:34:59 INFO - 'use_talos_json': True, 07:34:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:34:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:34:59 INFO - 'work_dir': 'build'} 07:34:59 INFO - [mozharness: 2016-12-15 15:34:59.260381Z] Running clobber step. 07:34:59 INFO - Running pre-action listener: _resource_record_pre_action 07:34:59 INFO - Running main action method: clobber 07:34:59 INFO - rmtree: /builds/slave/test/build 07:34:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:34:59 INFO - Running post-action listener: _resource_record_post_action 07:34:59 INFO - [mozharness: 2016-12-15 15:34:59.604371Z] Finished clobber step (success) 07:34:59 INFO - [mozharness: 2016-12-15 15:34:59.604548Z] Running read-buildbot-config step. 07:34:59 INFO - Running pre-action listener: _resource_record_pre_action 07:34:59 INFO - Running main action method: read_buildbot_config 07:34:59 INFO - Using buildbot properties: 07:34:59 INFO - { 07:34:59 INFO - "project": "", 07:34:59 INFO - "product": "firefox", 07:34:59 INFO - "script_repo_revision": "production", 07:34:59 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 07:34:59 INFO - "repository": "", 07:34:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 07:34:59 INFO - "buildid": "20161215062900", 07:34:59 INFO - "pgo_build": "False", 07:34:59 INFO - "basedir": "/builds/slave/test", 07:34:59 INFO - "buildnumber": 55, 07:34:59 INFO - "slavename": "t-yosemite-r7-0130", 07:34:59 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:34:59 INFO - "platform": "yosemite_r7", 07:34:59 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:34:59 INFO - "branch": "mozilla-central", 07:34:59 INFO - "repo_path": "mozilla-central", 07:34:59 INFO - "revision": "6dbc6e9f62a705d5f523cc750811bd01c8275ec6", 07:34:59 INFO - "stage_platform": "macosx64", 07:34:59 INFO - "builduid": "b35aa4d99b6f4fd7b6452d4c69cfa783", 07:34:59 INFO - "slavebuilddir": "test" 07:34:59 INFO - } 07:34:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/TpmcBWTXRB-LT13Sfcb_ZA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 07:34:59 INFO - Running post-action listener: _resource_record_post_action 07:34:59 INFO - [mozharness: 2016-12-15 15:34:59.608166Z] Finished read-buildbot-config step (success) 07:34:59 INFO - [mozharness: 2016-12-15 15:34:59.608279Z] Running download-and-extract step. 07:34:59 INFO - Running pre-action listener: _resource_record_pre_action 07:34:59 INFO - Running main action method: download_and_extract 07:34:59 INFO - mkdir: /builds/slave/test/build/tests 07:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:59 INFO - trying https://queue.taskcluster.net/v1/task/TpmcBWTXRB-LT13Sfcb_ZA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 07:34:59 INFO - Downloading https://queue.taskcluster.net/v1/task/TpmcBWTXRB-LT13Sfcb_ZA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:34:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TpmcBWTXRB-LT13Sfcb_ZA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 07:35:00 INFO - Downloaded 1199 bytes. 07:35:00 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:35:00 INFO - Using the following test package requirements: 07:35:00 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:35:00 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:35:00 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 07:35:00 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:35:00 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 07:35:00 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:35:00 INFO - u'jsshell-mac.zip'], 07:35:00 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:35:00 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 07:35:00 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:35:00 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:35:00 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 07:35:00 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:35:00 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 07:35:00 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:35:00 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 07:35:00 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:35:00 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 07:35:00 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:35:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TpmcBWTXRB-LT13Sfcb_ZA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:35:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TpmcBWTXRB-LT13Sfcb_ZA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:35:00 INFO - Fetch https://queue.taskcluster.net/v1/task/TpmcBWTXRB-LT13Sfcb_ZA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:35:01 INFO - Expected file size: 16277094 07:35:01 INFO - Obtained file size: 16277094 07:35:08 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:35:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TpmcBWTXRB-LT13Sfcb_ZA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:35:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TpmcBWTXRB-LT13Sfcb_ZA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:35:08 INFO - Fetch https://queue.taskcluster.net/v1/task/TpmcBWTXRB-LT13Sfcb_ZA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:35:09 INFO - Expected file size: 16277094 07:35:09 INFO - Obtained file size: 16277094 07:35:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TpmcBWTXRB-LT13Sfcb_ZA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 07:35:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TpmcBWTXRB-LT13Sfcb_ZA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:35:15 INFO - Fetch https://queue.taskcluster.net/v1/task/TpmcBWTXRB-LT13Sfcb_ZA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 07:35:16 INFO - Expected file size: 14409734 07:35:16 INFO - Obtained file size: 14409734 07:35:16 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')]} 07:35:16 INFO - trying https://queue.taskcluster.net/v1/task/TpmcBWTXRB-LT13Sfcb_ZA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:35:16 INFO - Downloading https://queue.taskcluster.net/v1/task/TpmcBWTXRB-LT13Sfcb_ZA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 07:35:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TpmcBWTXRB-LT13Sfcb_ZA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 07:35:19 INFO - Downloaded 69604153 bytes. 07:35:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TpmcBWTXRB-LT13Sfcb_ZA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:35:19 INFO - mkdir: /builds/slave/test/properties 07:35:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:35:19 INFO - Writing to file /builds/slave/test/properties/build_url 07:35:19 INFO - Contents: 07:35:19 INFO - build_url:https://queue.taskcluster.net/v1/task/TpmcBWTXRB-LT13Sfcb_ZA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:35:20 INFO - Running post-action listener: _resource_record_post_action 07:35:20 INFO - Running post-action listener: set_extra_try_arguments 07:35:20 INFO - [mozharness: 2016-12-15 15:35:20.199046Z] Finished download-and-extract step (success) 07:35:20 INFO - [mozharness: 2016-12-15 15:35:20.199170Z] Running populate-webroot step. 07:35:20 INFO - Running pre-action listener: _resource_record_pre_action 07:35:20 INFO - Running main action method: populate_webroot 07:35:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:35:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:35:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:35:20 INFO - '--tppagecycles', 07:35:20 INFO - '7'], 07:35:20 INFO - 'tests': ['tsvgm']}}, 07:35:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:35:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:35:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:35:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:35:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:35:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:35:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:35:20 INFO - 'talos_options': ['--disable-e10s'], 07:35:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:35:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:35:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:35:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:35:20 INFO - 'talos_options': ['--disable-e10s'], 07:35:20 INFO - 'tests': ['damp', 'tps']}, 07:35:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:35:20 INFO - 'tests': ['damp', 'tps']}, 07:35:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:35:20 INFO - 'tests': ['dromaeo_dom']}, 07:35:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:35:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:35:20 INFO - 'tests': ['basic_compositor_video']}, 07:35:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:35:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:35:20 INFO - 'tests': ['a11yr', 07:35:20 INFO - 'ts_paint', 07:35:20 INFO - 'tpaint', 07:35:20 INFO - 'sessionrestore', 07:35:20 INFO - 'sessionrestore_no_auto_restore', 07:35:20 INFO - 'tabpaint']}, 07:35:20 INFO - 'other-e10s': {'tests': ['a11yr', 07:35:20 INFO - 'ts_paint', 07:35:20 INFO - 'tpaint', 07:35:20 INFO - 'sessionrestore', 07:35:20 INFO - 'sessionrestore_no_auto_restore', 07:35:20 INFO - 'tabpaint']}, 07:35:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:35:20 INFO - 'ts_paint', 07:35:20 INFO - 'tpaint', 07:35:20 INFO - 'sessionrestore', 07:35:20 INFO - 'sessionrestore_no_auto_restore', 07:35:20 INFO - 'tabpaint']}, 07:35:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:35:20 INFO - 'ts_paint', 07:35:20 INFO - 'tpaint', 07:35:20 INFO - 'sessionrestore', 07:35:20 INFO - 'sessionrestore_no_auto_restore', 07:35:20 INFO - 'tabpaint']}, 07:35:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:35:20 INFO - 'tests': ['a11yr', 07:35:20 INFO - 'ts_paint', 07:35:20 INFO - 'tpaint', 07:35:20 INFO - 'sessionrestore', 07:35:20 INFO - 'sessionrestore_no_auto_restore', 07:35:20 INFO - 'tabpaint']}, 07:35:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:35:20 INFO - 'tests': ['a11yr', 07:35:20 INFO - 'ts_paint', 07:35:20 INFO - 'tpaint', 07:35:20 INFO - 'sessionrestore', 07:35:20 INFO - 'sessionrestore_no_auto_restore', 07:35:20 INFO - 'tabpaint']}, 07:35:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:35:20 INFO - 'tests': ['tsvgx', 07:35:20 INFO - 'tsvgr_opacity', 07:35:20 INFO - 'tart', 07:35:20 INFO - 'tscrollx', 07:35:20 INFO - 'cart', 07:35:20 INFO - 'tsvg_static']}, 07:35:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:35:20 INFO - 'tsvgr_opacity', 07:35:20 INFO - 'tart', 07:35:20 INFO - 'tscrollx', 07:35:20 INFO - 'cart', 07:35:20 INFO - 'tsvg_static']}, 07:35:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:35:20 INFO - 'talos_options': ['--disable-e10s'], 07:35:20 INFO - 'tests': ['tp5o']}, 07:35:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:35:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:35:20 INFO - 'talos_options': ['--disable-e10s', 07:35:20 INFO - '--xperf_path', 07:35:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:35:20 INFO - 'tests': ['tp5n']}, 07:35:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:35:20 INFO - 'talos_options': ['--xperf_path', 07:35:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:35:20 INFO - 'tests': ['tp5n']}}, 07:35:20 INFO - 'talos.zip': {'path': '', 07:35:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:35:20 INFO - Running post-action listener: _resource_record_post_action 07:35:20 INFO - [mozharness: 2016-12-15 15:35:20.217735Z] Finished populate-webroot step (success) 07:35:20 INFO - [mozharness: 2016-12-15 15:35:20.217841Z] Running create-virtualenv step. 07:35:20 INFO - Running pre-action listener: _resource_record_pre_action 07:35:20 INFO - Running main action method: create_virtualenv 07:35:20 INFO - Creating virtualenv /builds/slave/test/build/venv 07:35:20 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 07:35:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:35:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:35:20 INFO - Using real prefix '/tools/python27' 07:35:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:35:21 INFO - Installing distribute.............................................................................................................................................................................................done. 07:35:23 INFO - Installing pip.................done. 07:35:23 INFO - Return code: 0 07:35:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:35:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:35:24 INFO - Reading from file tmpfile_stdout 07:35:24 INFO - Output received: 07:35:24 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) 07:35:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:35:24 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')]} 07:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:24 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')]} 07:35:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:24 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 0x10286b3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaf0ca3d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102680d30>, '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 0x1024e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102678b20>, '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.61W9oSw1M0/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.f6fCL9t30p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 07:35:24 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 07:35:24 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 07:35:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61W9oSw1M0/Render', 07:35:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:24 INFO - 'HOME': '/Users/cltbld', 07:35:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:24 INFO - 'LOGNAME': 'cltbld', 07:35:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:24 INFO - 'MOZ_NO_REMOTE': '1', 07:35:24 INFO - 'NO_EM_RESTART': '1', 07:35:24 INFO - 'PAGER': '/bin/cat', 07:35:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:24 INFO - 'PWD': '/builds/slave/test', 07:35:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:24 INFO - 'SHELL': '/bin/bash', 07:35:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f6fCL9t30p/Listeners', 07:35:24 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 07:35:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:24 INFO - 'USER': 'cltbld', 07:35:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:24 INFO - 'XPC_FLAGS': '0x0', 07:35:24 INFO - 'XPC_SERVICE_NAME': '0', 07:35:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:24 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 07:35:24 INFO - Cleaning up... 07:35:24 INFO - Return code: 0 07:35:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:35:24 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')]} 07:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:24 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')]} 07:35:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:24 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 0x10286b3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaf0ca3d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102680d30>, '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 0x1024e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102678b20>, '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.61W9oSw1M0/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.f6fCL9t30p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 07:35:24 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 07:35:24 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 07:35:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61W9oSw1M0/Render', 07:35:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:24 INFO - 'HOME': '/Users/cltbld', 07:35:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:24 INFO - 'LOGNAME': 'cltbld', 07:35:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:24 INFO - 'MOZ_NO_REMOTE': '1', 07:35:24 INFO - 'NO_EM_RESTART': '1', 07:35:24 INFO - 'PAGER': '/bin/cat', 07:35:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:24 INFO - 'PWD': '/builds/slave/test', 07:35:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:24 INFO - 'SHELL': '/bin/bash', 07:35:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f6fCL9t30p/Listeners', 07:35:24 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 07:35:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:24 INFO - 'USER': 'cltbld', 07:35:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:24 INFO - 'XPC_FLAGS': '0x0', 07:35:24 INFO - 'XPC_SERVICE_NAME': '0', 07:35:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:24 INFO - Downloading/unpacking psutil>=3.1.1 07:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:35:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:35:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:35:28 INFO - Installing collected packages: psutil 07:35:28 INFO - Running setup.py install for psutil 07:35:28 INFO - building 'psutil._psutil_osx' extension 07:35:28 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 07:35:29 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 07:35:29 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 07:35:29 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 07:35:29 INFO - building 'psutil._psutil_posix' extension 07:35:29 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 07:35:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:35:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:35:29 INFO - ^ 07:35:29 INFO - 1 warning generated. 07:35:29 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 07:35:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:35:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:35:29 INFO - Successfully installed psutil 07:35:29 INFO - Cleaning up... 07:35:29 INFO - Return code: 0 07:35:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:35:29 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')]} 07:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:29 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')]} 07:35:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:29 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 0x10286b3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaf0ca3d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102680d30>, '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 0x1024e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102678b20>, '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.61W9oSw1M0/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.f6fCL9t30p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 07:35:29 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 07:35:29 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 07:35:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61W9oSw1M0/Render', 07:35:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:29 INFO - 'HOME': '/Users/cltbld', 07:35:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:29 INFO - 'LOGNAME': 'cltbld', 07:35:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:29 INFO - 'MOZ_NO_REMOTE': '1', 07:35:29 INFO - 'NO_EM_RESTART': '1', 07:35:29 INFO - 'PAGER': '/bin/cat', 07:35:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:29 INFO - 'PWD': '/builds/slave/test', 07:35:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:29 INFO - 'SHELL': '/bin/bash', 07:35:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f6fCL9t30p/Listeners', 07:35:29 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 07:35:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:29 INFO - 'USER': 'cltbld', 07:35:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:29 INFO - 'XPC_FLAGS': '0x0', 07:35:29 INFO - 'XPC_SERVICE_NAME': '0', 07:35:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:35:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:35:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:35:32 INFO - Installing collected packages: mozsystemmonitor 07:35:32 INFO - Running setup.py install for mozsystemmonitor 07:35:32 INFO - Successfully installed mozsystemmonitor 07:35:32 INFO - Cleaning up... 07:35:32 INFO - Return code: 0 07:35:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10286b3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaf0ca3d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102680d30>, '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 0x1024e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102678b20>, '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.61W9oSw1M0/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.f6fCL9t30p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 07:35:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:35:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:35:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61W9oSw1M0/Render', 07:35:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:32 INFO - 'HOME': '/Users/cltbld', 07:35:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:32 INFO - 'LOGNAME': 'cltbld', 07:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:32 INFO - 'MOZ_NO_REMOTE': '1', 07:35:32 INFO - 'NO_EM_RESTART': '1', 07:35:32 INFO - 'PAGER': '/bin/cat', 07:35:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:32 INFO - 'PWD': '/builds/slave/test', 07:35:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:32 INFO - 'SHELL': '/bin/bash', 07:35:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f6fCL9t30p/Listeners', 07:35:32 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 07:35:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:32 INFO - 'USER': 'cltbld', 07:35:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:32 INFO - 'XPC_FLAGS': '0x0', 07:35:32 INFO - 'XPC_SERVICE_NAME': '0', 07:35:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:33 INFO - Downloading/unpacking jsonschema==2.5.1 07:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:35:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:36 INFO - Downloading functools32-3.2.3-2.tar.gz 07:35:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:35:36 INFO - warning: no files found matching '*.txt' 07:35:36 INFO - no previously-included directories found matching 'build' 07:35:36 INFO - no previously-included directories found matching 'dist' 07:35:36 INFO - no previously-included directories found matching '.git*' 07:35:36 INFO - Installing collected packages: jsonschema, functools32 07:35:36 INFO - Running setup.py install for functools32 07:35:36 INFO - warning: no files found matching '*.txt' 07:35:36 INFO - no previously-included directories found matching 'build' 07:35:36 INFO - no previously-included directories found matching 'dist' 07:35:36 INFO - no previously-included directories found matching '.git*' 07:35:36 INFO - Successfully installed jsonschema functools32 07:35:36 INFO - Cleaning up... 07:35:36 INFO - Return code: 0 07:35:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:35:36 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')]} 07:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:36 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')]} 07:35:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:36 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 0x10286b3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaf0ca3d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102680d30>, '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 0x1024e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102678b20>, '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.61W9oSw1M0/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.f6fCL9t30p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 07:35:36 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 07:35:36 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 07:35:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61W9oSw1M0/Render', 07:35:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:36 INFO - 'HOME': '/Users/cltbld', 07:35:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:36 INFO - 'LOGNAME': 'cltbld', 07:35:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:36 INFO - 'MOZ_NO_REMOTE': '1', 07:35:36 INFO - 'NO_EM_RESTART': '1', 07:35:36 INFO - 'PAGER': '/bin/cat', 07:35:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:36 INFO - 'PWD': '/builds/slave/test', 07:35:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:36 INFO - 'SHELL': '/bin/bash', 07:35:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f6fCL9t30p/Listeners', 07:35:36 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 07:35:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:36 INFO - 'USER': 'cltbld', 07:35:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:36 INFO - 'XPC_FLAGS': '0x0', 07:35:36 INFO - 'XPC_SERVICE_NAME': '0', 07:35:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:35:36 INFO - Cleaning up... 07:35:36 INFO - Return code: 0 07:35:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:35:36 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')]} 07:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:36 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')]} 07:35:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:36 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 0x10286b3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaf0ca3d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102680d30>, '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 0x1024e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102678b20>, '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.61W9oSw1M0/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.f6fCL9t30p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 07:35:36 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 07:35:36 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 07:35:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61W9oSw1M0/Render', 07:35:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:36 INFO - 'HOME': '/Users/cltbld', 07:35:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:36 INFO - 'LOGNAME': 'cltbld', 07:35:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:36 INFO - 'MOZ_NO_REMOTE': '1', 07:35:36 INFO - 'NO_EM_RESTART': '1', 07:35:36 INFO - 'PAGER': '/bin/cat', 07:35:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:36 INFO - 'PWD': '/builds/slave/test', 07:35:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:36 INFO - 'SHELL': '/bin/bash', 07:35:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f6fCL9t30p/Listeners', 07:35:36 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 07:35:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:36 INFO - 'USER': 'cltbld', 07:35:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:36 INFO - 'XPC_FLAGS': '0x0', 07:35:36 INFO - 'XPC_SERVICE_NAME': '0', 07:35:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:36 INFO - Downloading/unpacking blobuploader==1.2.4 07:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:39 INFO - Downloading blobuploader-1.2.4.tar.gz 07:35:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:35:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:35:39 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 07:35:39 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 07:35:39 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 07:35:39 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 07:35:39 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 07:35:39 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 07:35:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:35:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:35:40 INFO - Downloading docopt-0.6.1.tar.gz 07:35:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:35:40 INFO - Installing collected packages: blobuploader, requests, docopt 07:35:40 INFO - Running setup.py install for blobuploader 07:35:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:35:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:35:41 INFO - Running setup.py install for requests 07:35:41 INFO - Running setup.py install for docopt 07:35:41 INFO - Successfully installed blobuploader requests docopt 07:35:41 INFO - Cleaning up... 07:35:41 INFO - Return code: 0 07:35:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35:41 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')]} 07:35:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:41 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')]} 07:35:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:41 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 0x10286b3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaf0ca3d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102680d30>, '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 0x1024e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102678b20>, '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.61W9oSw1M0/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.f6fCL9t30p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 07:35:41 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 07:35:41 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 07:35:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61W9oSw1M0/Render', 07:35:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:41 INFO - 'HOME': '/Users/cltbld', 07:35:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:41 INFO - 'LOGNAME': 'cltbld', 07:35:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:41 INFO - 'MOZ_NO_REMOTE': '1', 07:35:41 INFO - 'NO_EM_RESTART': '1', 07:35:41 INFO - 'PAGER': '/bin/cat', 07:35:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:41 INFO - 'PWD': '/builds/slave/test', 07:35:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:41 INFO - 'SHELL': '/bin/bash', 07:35:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f6fCL9t30p/Listeners', 07:35:41 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 07:35:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:41 INFO - 'USER': 'cltbld', 07:35:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:41 INFO - 'XPC_FLAGS': '0x0', 07:35:41 INFO - 'XPC_SERVICE_NAME': '0', 07:35:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:35:42 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-nT7SAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:35:42 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-4wEegY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:35:42 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-tPJBxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:35:42 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-9tONrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:35:42 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-mv7rBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:35:42 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-9qa8a5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:35:42 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-FfcY5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:35:42 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-CY0yMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:35:42 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-ETjFZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:35:42 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-GbtliZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:35:43 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-PP3P4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:35:43 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-wQ7VPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:35:43 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-7hINZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:35:43 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-BinFjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:43 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-CM5S8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:35:43 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-KM3uRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:35:43 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-3YPqUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:35:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:35:43 INFO - Running setup.py install for manifestparser 07:35:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:35:43 INFO - Running setup.py install for mozcrash 07:35:44 INFO - Running setup.py install for mozdebug 07:35:44 INFO - Running setup.py install for mozdevice 07:35:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:35:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:35:44 INFO - Running setup.py install for mozfile 07:35:44 INFO - Running setup.py install for mozhttpd 07:35:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:35:44 INFO - Running setup.py install for mozinfo 07:35:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:35:44 INFO - Running setup.py install for mozInstall 07:35:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:35:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:35:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:35:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:35:45 INFO - Running setup.py install for mozleak 07:35:45 INFO - Running setup.py install for mozlog 07:35:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:35:45 INFO - Running setup.py install for moznetwork 07:35:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:35:45 INFO - Running setup.py install for mozprocess 07:35:45 INFO - Running setup.py install for mozprofile 07:35:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:35:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:35:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:35:45 INFO - Running setup.py install for mozrunner 07:35:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:35:45 INFO - Running setup.py install for mozscreenshot 07:35:46 INFO - Running setup.py install for moztest 07:35:46 INFO - Running setup.py install for mozversion 07:35:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:35:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:35:46 INFO - Cleaning up... 07:35:46 INFO - Return code: 0 07:35:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:46 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 0x10286b3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaf0ca3d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102680d30>, '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 0x1024e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102678b20>, '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.61W9oSw1M0/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.f6fCL9t30p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 07:35:46 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 07:35:46 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 07:35:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61W9oSw1M0/Render', 07:35:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:46 INFO - 'HOME': '/Users/cltbld', 07:35:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:46 INFO - 'LOGNAME': 'cltbld', 07:35:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:46 INFO - 'MOZ_NO_REMOTE': '1', 07:35:46 INFO - 'NO_EM_RESTART': '1', 07:35:46 INFO - 'PAGER': '/bin/cat', 07:35:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:46 INFO - 'PWD': '/builds/slave/test', 07:35:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:46 INFO - 'SHELL': '/bin/bash', 07:35:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f6fCL9t30p/Listeners', 07:35:46 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 07:35:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:46 INFO - 'USER': 'cltbld', 07:35:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:46 INFO - 'XPC_FLAGS': '0x0', 07:35:46 INFO - 'XPC_SERVICE_NAME': '0', 07:35:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:35:46 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-Ns2hbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:35:46 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)) 07:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:35:46 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-brV2ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:35:46 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)) 07:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:35:46 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-XWWh0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:35:47 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)) 07:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:35:47 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-vQlUtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:35:47 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)) 07:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:35:47 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-b1Wyed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:35:47 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)) 07:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:35:47 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-FxzKaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:35:47 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)) 07:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:35:47 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-CBMMkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:35:47 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)) 07:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:35:47 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-U5JSfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:35:47 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)) 07:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:35:47 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-k_P3U1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:35:47 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)) 07:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:35:47 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-BpT2Sq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:35:47 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)) 07:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:35:47 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-Dj7Cqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:35:47 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)) 07:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:35:47 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-i4zQ7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:35:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 07:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:35:48 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-ptomoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:35:48 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)) 07:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:35:48 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-v8sJ0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:35:48 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)) 07:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:48 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-qGM3g4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:48 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)) 07:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:35:48 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-dKbfAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:35:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 07:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:35:48 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-a1t1F1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:35:48 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)) 07:35:48 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)) 07:35:48 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)) 07:35:48 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)) 07:35:48 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)) 07:35:48 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)) 07:35:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:35:51 INFO - Downloading blessings-1.6.tar.gz 07:35:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:35:51 INFO - Installing collected packages: blessings 07:35:51 INFO - Running setup.py install for blessings 07:35:51 INFO - Successfully installed blessings 07:35:51 INFO - Cleaning up... 07:35:51 INFO - Return code: 0 07:35:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:35:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:35:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:35:51 INFO - Reading from file tmpfile_stdout 07:35:51 INFO - Current package versions: 07:35:51 INFO - blessings == 1.6 07:35:51 INFO - blobuploader == 1.2.4 07:35:51 INFO - docopt == 0.6.1 07:35:51 INFO - functools32 == 3.2.3-2 07:35:51 INFO - jsonschema == 2.5.1 07:35:51 INFO - manifestparser == 1.1 07:35:51 INFO - mozInstall == 1.12 07:35:51 INFO - mozcrash == 1.0 07:35:51 INFO - mozdebug == 0.1 07:35:51 INFO - mozdevice == 0.49 07:35:51 INFO - mozfile == 1.2 07:35:51 INFO - mozhttpd == 0.7 07:35:51 INFO - mozinfo == 0.9 07:35:51 INFO - mozleak == 0.1 07:35:51 INFO - mozlog == 3.4 07:35:51 INFO - moznetwork == 0.27 07:35:51 INFO - mozprocess == 0.23 07:35:51 INFO - mozprofile == 0.28 07:35:51 INFO - mozrunner == 6.13 07:35:51 INFO - mozscreenshot == 0.1 07:35:51 INFO - mozsystemmonitor == 0.3 07:35:51 INFO - moztest == 0.7 07:35:51 INFO - mozversion == 1.4 07:35:51 INFO - psutil == 3.1.1 07:35:51 INFO - requests == 1.2.3 07:35:51 INFO - wsgiref == 0.1.2 07:35:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35: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')]} 07:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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')]} 07:35:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:51 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 0x10286b3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaf0ca3d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102680d30>, '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 0x1024e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102678b20>, '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.61W9oSw1M0/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.f6fCL9t30p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 07:35:51 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 07:35:51 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 07:35:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61W9oSw1M0/Render', 07:35:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:51 INFO - 'HOME': '/Users/cltbld', 07:35:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:51 INFO - 'LOGNAME': 'cltbld', 07:35:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:51 INFO - 'MOZ_NO_REMOTE': '1', 07:35:51 INFO - 'NO_EM_RESTART': '1', 07:35:51 INFO - 'PAGER': '/bin/cat', 07:35:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:51 INFO - 'PWD': '/builds/slave/test', 07:35:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:51 INFO - 'SHELL': '/bin/bash', 07:35:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f6fCL9t30p/Listeners', 07:35:51 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 07:35:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:51 INFO - 'USER': 'cltbld', 07:35:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:51 INFO - 'XPC_FLAGS': '0x0', 07:35:51 INFO - 'XPC_SERVICE_NAME': '0', 07:35:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:52 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)) 07:35:52 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)) 07:35:52 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)) 07:35:52 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)) 07:35:52 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)) 07:35:52 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)) 07:35:52 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)) 07:35:52 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)) 07:35:52 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)) 07:35:52 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)) 07:35:52 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)) 07:35:52 INFO - Cleaning up... 07:35:52 INFO - Return code: 0 07:35:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:35: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')]} 07:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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')]} 07:35:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10286b3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaf0ca3d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102680d30>, '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 0x1024e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102678b20>, '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.61W9oSw1M0/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.f6fCL9t30p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 07:35: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', 'jsonschema'] in /builds/slave/test/build 07:35: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 jsonschema 07:35:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61W9oSw1M0/Render', 07:35:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:52 INFO - 'HOME': '/Users/cltbld', 07:35:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:52 INFO - 'LOGNAME': 'cltbld', 07:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:52 INFO - 'MOZ_NO_REMOTE': '1', 07:35:52 INFO - 'NO_EM_RESTART': '1', 07:35:52 INFO - 'PAGER': '/bin/cat', 07:35:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:52 INFO - 'PWD': '/builds/slave/test', 07:35:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:52 INFO - 'SHELL': '/bin/bash', 07:35:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f6fCL9t30p/Listeners', 07:35:52 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 07:35:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:52 INFO - 'USER': 'cltbld', 07:35:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:52 INFO - 'XPC_FLAGS': '0x0', 07:35:52 INFO - 'XPC_SERVICE_NAME': '0', 07:35:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:35:52 INFO - Cleaning up... 07:35:52 INFO - Return code: 0 07:35:52 INFO - Running post-action listener: _resource_record_post_action 07:35:52 INFO - Running post-action listener: _start_resource_monitoring 07:35:52 INFO - Starting resource monitoring. 07:35:52 INFO - [mozharness: 2016-12-15 15:35:52.353427Z] Finished create-virtualenv step (success) 07:35:52 INFO - [mozharness: 2016-12-15 15:35:52.354214Z] Running install step. 07:35:52 INFO - Running pre-action listener: _resource_record_pre_action 07:35:52 INFO - Running main action method: install 07:35:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:35:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:35:52 INFO - Reading from file tmpfile_stdout 07:35:52 INFO - Detecting whether we're running mozinstall >=1.0... 07:35:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:35:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:35:52 INFO - Reading from file tmpfile_stdout 07:35:52 INFO - Output received: 07:35:52 INFO - Usage: mozinstall [options] installer 07:35:52 INFO - Options: 07:35:52 INFO - -h, --help show this help message and exit 07:35:52 INFO - -d DEST, --destination=DEST 07:35:52 INFO - Directory to install application into. [default: 07:35:52 INFO - "/builds/slave/test"] 07:35:52 INFO - --app=APP Application being installed. [default: firefox] 07:35:52 INFO - mkdir: /builds/slave/test/build/application 07:35:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:35:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:36:14 INFO - Reading from file tmpfile_stdout 07:36:14 INFO - Output received: 07:36:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:36:14 INFO - Running post-action listener: _resource_record_post_action 07:36:14 INFO - [mozharness: 2016-12-15 15:36:14.382864Z] Finished install step (success) 07:36:14 INFO - [mozharness: 2016-12-15 15:36:14.383055Z] Running run-tests step. 07:36:14 INFO - Running pre-action listener: _resource_record_pre_action 07:36:14 INFO - Running main action method: run_tests 07:36:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:36:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:36:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:36:14 INFO - 2016-12-15 07:36:14.397 screenresolution[2233:283618] starting screenresolution argv=screenresolution get 07:36:14 INFO - 2016-12-15 07:36:14.400 screenresolution[2233:283618] Display 0: 1600x1200x32@60 07:36:14 INFO - 2016-12-15 07:36:14.406 screenresolution[2234:283620] starting screenresolution argv=screenresolution list 07:36:14 INFO - Available Modes on Display 0 07:36:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:36:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:36:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:36:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:36:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:36:14 INFO - Intel Iris: 07:36:14 INFO - Chipset Model: Intel Iris 07:36:14 INFO - Type: GPU 07:36:14 INFO - Bus: Built-In 07:36:14 INFO - VRAM (Dynamic, Max): 1536 MB 07:36:14 INFO - Vendor: Intel (0x8086) 07:36:14 INFO - Device ID: 0x0a2e 07:36:14 INFO - Revision ID: 0x0009 07:36:14 INFO - Displays: 07:36:14 INFO - Display: 07:36:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:36:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:36:14 INFO - Display Serial Number: 1600x1200 60 07:36:14 INFO - Main Display: Yes 07:36:14 INFO - Mirror: Off 07:36:14 INFO - Online: Yes 07:36:14 INFO - Rotation: Supported 07:36:14 INFO - Return code: 0 07:36:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:36:14 INFO - Python 2.7.3 07:36:14 INFO - Return code: 0 07:36:14 INFO - grabbing minidump binary from tooltool 07:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:14 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 0x102680d30>, '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 0x1024e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102678b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:36:14 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 07:36:14 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 07:36:14 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 07:36:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:36:14 INFO - Return code: 0 07:36:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:36:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:36:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:36:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:36:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:36:14 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/TpmcBWTXRB-LT13Sfcb_ZA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0130', '--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 07:36:14 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/TpmcBWTXRB-LT13Sfcb_ZA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0130 --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 07:36:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61W9oSw1M0/Render', 07:36:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:14 INFO - 'HOME': '/Users/cltbld', 07:36:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:14 INFO - 'LOGNAME': 'cltbld', 07:36:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:36:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:14 INFO - 'MOZ_NO_REMOTE': '1', 07:36:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:36:14 INFO - 'NO_EM_RESTART': '1', 07:36:14 INFO - 'PAGER': '/bin/cat', 07:36:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:14 INFO - 'PWD': '/builds/slave/test', 07:36:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:36:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:14 INFO - 'SHELL': '/bin/bash', 07:36:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f6fCL9t30p/Listeners', 07:36:14 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 07:36:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:14 INFO - 'USER': 'cltbld', 07:36:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:14 INFO - 'XPC_FLAGS': '0x0', 07:36:14 INFO - 'XPC_SERVICE_NAME': '0', 07:36:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:14 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/TpmcBWTXRB-LT13Sfcb_ZA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0130', '--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 07:36:14 INFO - mozversion application_buildid: 20161215062900 07:36:14 INFO - mozversion application_changeset: 6dbc6e9f62a705d5f523cc750811bd01c8275ec6 07:36:14 INFO - mozversion application_display_name: Nightly 07:36:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:36:14 INFO - mozversion application_name: Firefox 07:36:14 INFO - mozversion application_remotingname: firefox 07:36:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:36:14 INFO - mozversion application_vendor: Mozilla 07:36:14 INFO - mozversion application_version: 53.0a1 07:36:14 INFO - mozversion platform_buildid: 20161215062900 07:36:14 INFO - mozversion platform_changeset: 6dbc6e9f62a705d5f523cc750811bd01c8275ec6 07:36:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:36:14 INFO - mozversion platform_version: 53.0a1 07:36:14 INFO - using testdate: 1481816174 07:36:14 INFO - actual date: 1481816174 07:36:14 INFO - starting webserver on 'localhost:49440' 07:36:14 INFO - SUITE-START | Running 2 tests 07:36:14 INFO - TEST-START | dromaeo_css 07:36:14 INFO - operating with platform_type : mac_ 07:36:14 INFO - Initialising browser for dromaeo_css test... 07:36:15 INFO - TEST-INFO | started process 2244 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmph_I26E/profile http://localhost:49440/getInfo.html) 07:36:17 INFO - PROCESS | 2244 | __metrics Screen width/height:1600/1200 07:36:17 INFO - PROCESS | 2244 | colorDepth:24 07:36:17 INFO - PROCESS | 2244 | Browser inner width/height: 1024/689 07:36:17 INFO - PROCESS | 2244 | __metrics 07:36:17 INFO - PROCESS | 2244 | 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" 07:36:17 INFO - PROCESS | 2244 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:36:18 INFO - TEST-INFO | 2244: exit 0 07:36:18 INFO - Browser initialized. 07:36:18 INFO - Running cycle 1/1 for dromaeo_css test... 07:36:18 INFO - TEST-INFO | started process 2247 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmph_I26E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:36:30 INFO - PROCESS | 2247 | RSS: Main: 236679168 07:36:30 INFO - PROCESS | 2247 | 07:37:21 INFO - PROCESS | 2247 | 1481816241679 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:39:34 INFO - PROCESS | 2247 | Cycle 1(1): loaded http://localhost:49440/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49440/tests/dromaeo/cssquery-ext.html) 07:39:35 INFO - PROCESS | 2247 | RSS: Main: 395644928 07:39:35 INFO - PROCESS | 2247 | 07:42:38 INFO - PROCESS | 2247 | Cycle 1(1): loaded http://localhost:49440/tests/dromaeo/cssquery-ext.html (next: http://localhost:49440/tests/dromaeo/cssquery-jquery.html) 07:42:39 INFO - PROCESS | 2247 | RSS: Main: 392978432 07:42:39 INFO - PROCESS | 2247 | 07:45:41 INFO - PROCESS | 2247 | Cycle 1(1): loaded http://localhost:49440/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49440/tests/dromaeo/cssquery-mootools.html) 07:45:42 INFO - PROCESS | 2247 | RSS: Main: 367661056 07:45:42 INFO - PROCESS | 2247 | 07:48:44 INFO - PROCESS | 2247 | Cycle 1(1): loaded http://localhost:49440/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49440/tests/dromaeo/cssquery-prototype.html) 07:48:45 INFO - PROCESS | 2247 | RSS: Main: 346558464 07:48:45 INFO - PROCESS | 2247 | 07:51:48 INFO - PROCESS | 2247 | Cycle 1(1): loaded http://localhost:49440/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49440/tests/dromaeo/cssquery-yui.html) 07:51:49 INFO - PROCESS | 2247 | RSS: Main: 344719360 07:51:49 INFO - PROCESS | 2247 | 07:54:52 INFO - PROCESS | 2247 | Cycle 1(1): loaded http://localhost:49440/tests/dromaeo/cssquery-yui.html (next: http://localhost:49440/tests/dromaeo/cssquery-dojo.html) 07:54:53 INFO - PROCESS | 2247 | RSS: Main: 461926400 07:54:53 INFO - PROCESS | 2247 | 07:54:53 INFO - PROCESS | 2247 | __start_tp_report 07:54:53 INFO - PROCESS | 2247 | _x_x_mozilla_page_load 07:54:53 INFO - PROCESS | 2247 | _x_x_mozilla_page_load_details 07:54:53 INFO - PROCESS | 2247 | |i|pagename|runs| 07:54:53 INFO - PROCESS | 2247 | |0;dojo.html;2688.408550118974;3281.589801274841;3293.8353082345893;3316.485944678576;3350.229447227138;5447.918281225775;5557.3886872444045;5596.384397716248;5596.496315331619;5633.521150702195;5552.91670624941;5554.91667624986;5644.04051311277;5647.43525647435;5648.350439699436;5022.045811295842;5068.695878247298;5076.44159142494;5132.486751324856;5139.023585518758;5089.7455127243675;5201.5838732901275;5205.349331333583;5213;5281.207818827187;5028.522290382444;5108.003939231851;5181.9740901295445;5183.637145399824;5222.32109825724;5126.128558145124;5128.743562821881;5136.460671629462;5136.871578210575;5140.228965655144;5035.018171456568;5085.160948443502;5086.847394578169;5094.2103973884105;5107.897842043139;4675.625949924032;5572.3870374258795;5576.721163941827;5579.497845193911;5583.5254003409755;6055;6064.272287325505;6069.57512974092;6075.119107729354;6075.878482430371;6118.296395914438;6119.143319935212;6123.323435039953;6135.048937646325;6145.631262124242;5568.832935011916;5644.153376993484;5649.632773869726;5649.661020338793;5653;6233.283172435137;6276.403741644536;6299.5275354348605;6313.05304204373;6323.114763933053;5773.24947756789;6015.54883383748;6029.547783916224;6049.637021778707;6080.665563393967;6043.7280322385595;6065.878682426327;6110.202397347066;6110.536573724199;6111.895622426936;6098.196343066944;6104.883608894094;6105.6401074306;6109.404666050415;6141;6091.208142941389;6113.358097399709;6117.418845209698;6123.693815309217;6130.325664176937;4747.477777444478;4807.158747219222;4816;4826.638002149853;4854.781534830941;4265.1469706058915;4341.674374421931;4361.563843615613;4390.912181756347;4409.11817636474;5519.089350257163;5665.716714164275;5680.6307590007345;5696.11710184922;5724.570657200727;6148.415900489446;6166.260048794084;6167.352427995085;6181.072839074175;6181.938180618226;5661.603687741818;5676.772929082873;5681.829545113653;5685.800996965087;5696.601237913306;5189.792408303626;5249.632525723239;5255.658382205144;5257.631965762436;5317.282166907496;5598.272224610774;6301.905471417932;6329.461995730415;6333.619982801047;6337.081123237197;5808.680522571299;6120.846978825387;6196.876062478816;6209.472194863487;6210.223722034746;6157.507399408126;6170.382961703794;6233.906491402542;6252.874942501034;6276.152719383008;5953.672548009901;6052.273727152769;6075.665838378754;6090.056041313604;6110.51115910735;4685.695429797052;5983;6134.754609815557;6147.231596050494;6149.292831324455;5700.401457847032;5812.593118481835;5908.940910591011;5914.142449344907;5917.85205369852;5850.0932355484965;5858.765649373977;5879.529637628894;5910.349861515144;5920.111983202554;5790.594658373873;5792.247007888947;5795.623284486495;5802.767889284381;5809.94190058111;5750.9648263313;5925.466707996128;5930.881382372415;5931.08068249422;5937.851553711192;5641.407652196624;5710.828675139753;5728.828135155952;5756.913646295393;5818.0981947798155 07:54:53 INFO - PROCESS | 2247 | |1;ext.html;422.9894252643684;472.20197865607145;472.6691316078746;474.9643776716747;493.3684883349313;29946.850265748668;38158.61841381586;39049.80475097628;39157.021074473116;39250.607493925054;41142.177156456855;41518.58481415185;41538;41549;41553.7922310388;9345.205657519102;9569.665061722806;9576.281778866578;9578.281628877827;9582.760430989212;8577.95711021444;8785.824283514326;11191.496382662759;11418.257813242113;11444.771104577903;11291.435428228597;11310.547578096908;11395.715107122347;11421.657350279505;11447.713807154847;8535.103814099555;11243.325400475998;11329.320240785579;11337.37644429556;11371.601993930255;8533.786655333666;11070.169737269736;11322.37726925027;11366.602168924048;11503.884961150365;38919.61080389217;39327.410088848694;39411.40882886759;39434.408483872765;39483.60516394828;3301.4882693182594;3437.570303712036;3537.9469307960403;3871.1676989447406;4074.674026077936;29858;30351;30403;30580.84709576438;31195.84402077998;3140;3140.120766185472;3167.7149056584785;3266.657001014883;3292.7695061345717;495102;495827;495859;496003;496456.97830793104;58378.7081064592;58614.70692646595;58844.11733823996;58846.82306353849;58854.41145588575;60059;61375.38624613786;61478;61684.766304673656;61790.1462956112;15288;15549.455769048029;15586.766198507032;15594.220288985505;15632.296546655427;11004.174686898514;11229.157813164045;12099.153059285765;12168.634940951786;12173.330466824409;14390.06464579799;15892.841071589368;15909;16172.514824555283;16396.016239025696;6457.5479716419395;6651.505685367987;6925.134358205224;7122.005838365266;7150.997720638125;842.2630198576246;862.7498025572639;902.2376092202079;1020.260311274335;1053.1359493696116;27892.581611275848;29534.409311814074;29657.775716686312;29865.104046878627;30003.849980749957;1020.3061917895753;1031.9690409287734;1057.6879820452984;1065.9520321585546;1068.086785798147;14925.179115148554;14954.551363459113;14989.40042398292;15365.615859603377;15377.538673839803;607266;612531;616752;617705.3179947898;618235;56878;57239.855202895706;57271.42728572661;57352.12506936874;57483;1355.8847497962784;1402.2287741742;1406.5147524104168;1415.5753274017754;1415.853158941261;21909.78090219141;28664.570031449963;28863.55682215923;29567.704322957357;29658.258543536584;48555.757221213666;48843.5115648839;48939.5106048935;48957.26564101613;49001.2649810246;553315;556660;561972;563927;564283;21714.348569542937;23702.88148559246;25278;25669.97320107175;25716.871415642803;35225.82387088048;35590;39476;41572.79213603913;42146.04977651535;34797.82601086979;35395.64604353924;36077;36613.81693091518;37461.87614371573;34175.658243417245;34237.82881085579;34371.828140859136;35931.640683593876;35937.46093808647;33197.83401082979;33872.49191262182;34391.140221494665;34674.47988280228;34712.479312810836;27907.860460697568;28699.856500718197;30558.541621875243;31334.68665313409;31369.8431507841;23250.3024909253;23457.06171753179;23675;23815.880920595286;23910 07:54:53 INFO - PROCESS | 2247 | |2;jquery.html;306.714755277592;321.8487310963846;374.79011753418087;379.59383459698125;404.7308539821019;19100.80899191008;19568.51078723031;19886.90056549715;20111.899440502813;20276.98615069248;20253.696194557095;20424.183032678677;20996.89501552494;21067.683984740204;21243.68134477984;5169.147090730025;5358.196270559428;5704.743286552105;6015.518758499309;6033.125196846455;5773.076307790754;5847.766089356421;5849.122631605272;5918.733656985446;5994.370591087938;5668.971655141719;5772;5819.243498345209;5867.295924489046;5868.090445980858;5839.79560715375;5872.17789509469;5880.735366908478;5893.410658934115;5895.233619629464;4881.341018962466;5099.980003999215;5143.459936706667;5159.690418574897;5174.301469301634;25603.743962560322;25605.10382136635;25611.231663050137;25689.35776605581;25924;2204.2395373596246;2231.163313757341;2273;2434.500927309897;2948.3218859662397;10086.899131008742;10462.110720588758;12523.373831308489;14137.929310353486;14974.47589334368;1791.7939436964787;1833.1567478959694;1904.3430016644236;1949.2397964793743;1957.4421289932302;96646.51676741571;116514.41742791317;123542;123804;126136.99999999908;9411.576479058458;11126.721831954104;11169.497372618252;11351.716207094889;11451.141164412702;14100.576982690536;14546.781798273034;14574.854251457562;14586.562403127924;14587.708245835023;8048.718294859769;8364.414490985695;8389.189621476751;8460.153984601491;8503.957480212683;8221.301189398968;8230.8353832923;8232.958835205905;8390.580470976427;8429.28351090152;4470.441194850644;4480.955190448119;4493.6854420190275;4497.662675299365;4568.931466028012;1611.5165450364843;1817.8273064058894;1840.5122642499748;1881.689521228982;1904.1526520698433;813.9593020348959;816.9060558035783;865.8441480533564;894.6019021535484;966.2656381150235;17566;19703.704444433344;21439.67840482394;21533.353999380044;21689.240876569558;826.2398593294183;881.0792721605937;890.7461373508519;980.6959842448864;986.5116767200282;9865.161461275871;11211.439428028565;11318.32090074598;11424.942875285571;11877.346745929057;583057;583843;593843;595860;596872;86002;114616;117415;123789;134944;983.1201075037801;1016.537475448669;1021.5249908792299;1034.9896501034893;1040.552562398176;19190.712139317642;19977.500562486053;19981.500462488555;19984;20018.399448016582;52898.47101528935;52967.735161323944;53060;53942.020726165785;54059.45940540702;71239;74781;76108;77834.6108269455;78023;7956.602169891598;7981.561014144278;8063;8240.1347858474;8296.87554686668;11677.824832627348;12817.679558010752;12910.67723306925;13191;13235.139715918434;11247.7750444989;11277.830832537682;11594.594189203337;11631.47658355359;11635.709107272385;10861.945690271497;11090.390028548507;11230.494627741935;11326.32042077478;11386.772264554827;8913.598888049924;9711.320207585684;11109.055730263019;11700.648980530597;11847.052235820942;7949.562774047483;8118.391120666091;8121.512709237465;8403.243708066058;8466.830663386821;10777.676669699922;11371.601993930173;11456.31262124242;11579.768404632028;11661.35862527569 07:54:53 INFO - PROCESS | 2247 | |3;mootools.html;1488.0848278308838;1527.2363818090957;1730.7317365808296;1784.9464516064522;1895.1282410091349;7272.600006999613;8027.91972080279;8430.662773489054;8433.945756780402;8450.197231263035;7448.888266676005;7655;7716.575588342639;7976.042874855011;8207.343412526998;2280.1905323610085;2332.195392589554;2344.7186337639505;2344.988275058622;2350.8236882233814;2294.9541009179807;2340.8010319122895;2342.3090188394463;2355.1521452277166;2368.14746691191;2301.873396963166;2308.2152068296778;2327.511222643247;2332.953340933189;2348.8708121053337;2296.8851557422063;2297.3797074789795;2323.7327707313707;2332.4052366646397;2333.824963127772;2329.301209637119;2330.7552706965694;2363.1847012780563;2369.289213236022;2396.8681722505257;8285.668573257062;8385.664573417056;8391.748247552583;8396.328293736486;8396.874046889301;4994.475580064113;5111.309973153651;5194.324737784102;5200.219967004941;5200.63595548308;3216.517522371663;3339.34882697874;3534.169470174507;3541.7946758183884;3542.2738338640515;1042.5360714482058;1056.0126281926423;1069.3209811769505;1069.6363236499549;1087.374759513283;10626;10628.309159904582;10775.407352595605;10798.028177464066;10802.405867677275;4394.406755088022;4523.557279069331;4615.93076103852;4617.792199351037;4693.0613877224005;9102.362834601647;9331;9338.719838404859;9341.953290233641;9358.906410935804;5159.226116082617;5172.922406163911;5183.2743415921805;5183.688978661217;5196.766145523385;4192.622663960258;4462.732236065846;4653.7207767534055;4703.929441058387;4781.832635857798;3704.2221133561716;3734.3651579231596;3808.3716186828865;3831.310364134427;3835.827387767557;1240.1319076646384;1249.262934868432;1250.9749805003848;1263.4251415605877;1269.3780047776522;783.7413653494447;863.2820686833156;910.526526206369;911.6171208092617;912.5163663258484;5363.785448582091;5525;5684.971575142098;5748.48263656273;5971.701414929323;888.5512816027865;935.5509355509394;944.244604316544;978.0610613810821;991.2119864707574;3406.863725450954;3465.86136554535;3486.89539313821;3498.7550871438757;3514.9297014059575;9650.565724542412;10142.087212150942;10143.695689129338;10171;10173.338732982333;9886.505674716236;9923.702288931343;10020.69937901864;10040.799184016425;10142.54358553852;7693.384529237647;7708.5760283183845;7754.651040703182;7778.533288002738;7864.449488535747;4800.423949125988;5433.619646624698;5440.020796256554;5531.751071201725;5557.610967232255;9101;9205.355625106446;9224.985251622182;9359.532023398666;9408.247340212629;8671.913280867111;8714.346424018097;9390.342676012613;9408.106229908148;9567;6210.906836397367;6291.96854015727;6442.130312407765;6629.734810607714;6811.421029212573;7804.84390312202;7876.488028278143;7913.643886025027;7986.281234688906;8011.919880801351;6971.163460384786;7114.430845532242;7172.928270717226;7218.494705370574;7249.05762250904;6818.147731533559;6979.651017449006;6990.4580247962185;7042.014118023379;7118.181409138016;6499.480041596756;6548.607083575001;6637;6642;6646.136002319668;4782.545658162469;4835.2505361669;4870.95129048705;4896.461389247109;4993.400791904995;4481.103779244229;4638.095571363552;4787.257975013878;4808.831690890942;4982.302477653204 07:54:53 INFO - PROCESS | 2247 | |4;prototype.html;331.8738879225894;350.2784264415305;357.3942168025197;357.9516765236692;362.41470025908166;4535.818567257314;4890.0268008204985;5060.620453465991;5180.585553155748;5272.23552584875;5014.473480284572;5102.591792656588;5128.358955130609;5140.460251673577;5198.558122559578;3671.210689701714;3764.3788774852114;3809.866654667087;3812.1803812180374;4079.5920407959115;3822.5412950445984;3957.8812635620834;4068.5524592294823;4096.951524237881;4101.241270364992;3896.941545876814;3986.3223252047223;4009.7393669411395;4074.22589707956;4112.300908845488;4000.9399859002137;4069.4506241657296;4073.8166782494563;4081.081891511015;4100.938485922714;3350.5927510445426;3623.547056617923;3637.2179981303884;3639.890803275906;3648.781073135594;4779.784909679072;4848.17581011229;5082.440931497532;5096.872578185538;5128.358955130609;3898.3177943859996;4492.3710680504755;4507.211238033331;4539.568740969603;4549.840755573539;5149.716765577892;5314.787408503656;5534.252875861787;5535.972320138373;5550.057479882049;3071.8003329783714;3281.3765384576855;3779.1119087014804;3797.2215695782297;3805.4101614249557;5348.625596208267;5405.648632838853;5728.562862282639;5756.352078044147;5796.62321949072;3286.802791832498;3566.4472006838982;3754.0614846288427;3845.2309538092495;3847.5960024197616;3514.841832117561;3574.8212589370946;3638.308721342936;3848.634379733921;3875.2830726315724;4318.775830447322;4461.397711308997;4496.235639941217;4535.795889184995;4544.363789069533;4559.452865656076;4975.447465568964;5558.722063896789;5578.30271216098;5606.505105228216;1091.47063674118;1110.3726394587034;1226.9631911042684;1247.6319485751544;1257.7988021439503;748.3377211168155;795.3796039089519;841.1546395872109;854.7435769269318;862.9611667474978;4506.102221578377;4933.580645645088;4953.653244272867;4978.77595508203;5028.673136246132;4350.608445239944;4783.856484305476;5366.597505187126;5367.543758780547;5401.3248343957;4423.717122034638;4564;4577.725336479755;4797.688150270221;4819.565879550839;2499.9750002500105;2823.6188114604674;2825.5620378841313;2827.674817396026;2851.6758841544074;5244.921326180111;5575.299533642197;5590.133529302883;5604.271444712243;5609.754879187973;4887.682300650446;4983.800647974041;5162.141629013552;5350;5376.166858957996;4863.513648635108;4962.528559786814;5499.89256070319;5594.888102238014;5606.971965140148;4595.805090676515;5096.847094587169;5157.303763991813;5282.939653535202;5387.622866399314;4615.369239533568;4702.694324868872;4858.3441235432765;5278.261043453843;5323.9803948019;5081.644284900021;5187.325647665779;5647.407022262768;5655.434456554476;5686.886262274814;3271.7219036382176;3345.1971526833872;3546.592141903714;3576.0344706928463;3610.8555657774446;4959.925601116059;5001.4998500149695;5218.504242096995;5275.287836142225;5398.352197736297;4915.557599816034;5000.549950504472;5203.505666961632;5208.401033881152;5254.605904557097;4374.650027997816;4507.63938884895;4619.607333376701;5177.870553236199;5187.170052791535;4540.954590454053;5090.287359769562;5115.107410258228;5116.82313067989;5222.686638801684;5190.948090519047;5237.711925844115;5242.165242165212;5246.685198888079;5259.319934470686;3989.900252493711;5103.642745007814;5105.719185444687;5134.9743251285;5172.172452407597 07:54:53 INFO - PROCESS | 2247 | |5;yui.html;658.6509150150422;729.945254105942;735.6726256815716;742.1576510660402;756.0436048398775;14507.419703211872;15364.539063828075;15484.845151548481;15489.302981365838;15517.922410387946;13818.93090534546;14052.929735351334;14070.803981661546;14205;14206.78689819651;866.3502373220085;875.9036505984336;890.4034297020979;894.7181637784109;895.3553441522093;691.2845205212581;877.3156937588691;882.9977974998359;883.9337049721264;886.4193952960821;754.8263899303164;764.7285213749122;901.1844280925773;942.5428667096453;946.5835032585641;936;936.6628013914985;937.6624415210518;939.5490164720973;941.2375975459831;536.5090941788259;692.6640579319027;694.4201591670961;694.9027136200936;696.7352406085655;12403.317817520032;12422.503099875994;12596.496140154382;12602.36988150598;13356.732865342736;13799;14021.088629239066;14147.85852141486;14171.220582867938;14606.634834129125;10700.71591409028;10744.570217191304;10972.067374273196;11910.880891191151;12134.939325303405;3353.815540145291;3395.473701576235;3791.5071040764524;3855.4409610606585;3866.8839934802;103344;109877.45061274643;110526.13158539412;110603;110969;10221.808978763805;10841.295315804447;10941.398223097647;10943.726406839893;11362.886371136348;22298.331050068526;22523;22695.659565106536;22714.318570442912;22744.20395286157;7189.6405179740805;7458.105027396638;7763.417743669247;7800.492967957178;8003.439759216799;4218.957810421918;4306.655467562588;4317;4356.738595684269;4434.55654434554;3437.1750779813165;3457.291255292659;3464.4630082337276;3496.650334966534;3500;602.0908428273339;607.1196764691127;612.9540284478593;619.8698273362644;632.7405763636887;481.7856054055982;576.1501784867371;599.1641659884436;617.102116420607;634.7810005548079;7888.64501097452;8398.412111152284;8455.534945577929;8565.229129378386;9006.189442950166;514.341642697348;578.4475825586554;628.0296941225726;632.1087266953573;635.3487675133026;3889.98860296325;3981.2833689936087;4150.040696404793;4281;4469.463664360298;84080.47758567253;99903;102887.4855625717;103282;104518.95481045244;84996.15003849882;86104;86601.5669921659;87122;88407;76699;77335;77454.61272693714;78237.21762782299;78569.82145267825;8439.95780021096;8511.361647876558;8524.488530688179;8627.266682332072;8761.956190219009;40774.77675669735;51258.23112653239;52005.479945200066;52803.471965281395;53581;71545.64227178831;73941.15147121366;74015.6299218522;76437;78156;10529.677084580739;10881.183911206534;10945.83581246298;10972.451377431256;11552.22746540841;11846.526138954345;11914.940425297818;11962.401879905796;12175.208611440228;12431.75136497247;11228.270162439416;11679.182457227913;11840.052795776144;11896.405179740805;12144.453499592362;11371.829422558834;11473.311601303949;11618.186726929034;12373.381330933238;13176.143550669176;13234.735305293647;13275.269860157785;13544.661383465493;13724.65688357799;13735.107218030797;8249.628766705393;10543.57825686964;10923.344599324066;11010.449477525932;11103.5558577656;11217.943910280723;11221.831672525082;11410.82883756761;11636;11685.298882067103 07:54:53 INFO - PROCESS | 2247 | __end_tp_report 07:54:53 INFO - PROCESS | 2247 | __start_cc_report 07:54:53 INFO - PROCESS | 2247 | _x_x_mozilla_cycle_collect,1503 07:54:53 INFO - PROCESS | 2247 | __end_cc_report 07:54:53 INFO - PROCESS | 2247 | __startTimestamp1481817293121__endTimestamp 07:54:53 INFO - PROCESS | 2247 | 07:54:53 INFO - PROCESS | 2247 | ------- Summary: start ------- 07:54:53 INFO - PROCESS | 2247 | Number of tests: 6 07:54:53 INFO - PROCESS | 2247 | 07:54:53 INFO - PROCESS | 2247 | [#0] dojo.html Cycles:165 Average:5615.07 Median:5756.91 stddev:646.62 (11.2%) stddev-sans-first:606.48 07:54:53 INFO - PROCESS | 2247 | Values: 2688.4 3281.6 3293.8 3316.5 3350.2 5447.9 5557.4 5596.4 5596.5 5633.5 5552.9 5554.9 5644.0 5647.4 5648.4 5022.0 5068.7 5076.4 5132.5 5139.0 5089.7 5201.6 5205.3 5213.0 5281.2 5028.5 5108.0 5182.0 5183.6 5222.3 5126.1 5128.7 5136.5 5136.9 5140.2 5035.0 5085.2 5086.8 5094.2 5107.9 4675.6 5572.4 5576.7 5579.5 5583.5 6055.0 6064.3 6069.6 6075.1 6075.9 6118.3 6119.1 6123.3 6135.0 6145.6 5568.8 5644.2 5649.6 5649.7 5653.0 6233.3 6276.4 6299.5 6313.1 6323.1 5773.2 6015.5 6029.5 6049.6 6080.7 6043.7 6065.9 6110.2 6110.5 6111.9 6098.2 6104.9 6105.6 6109.4 6141.0 6091.2 6113.4 6117.4 6123.7 6130.3 4747.5 4807.2 4816.0 4826.6 4854.8 4265.1 4341.7 4361.6 4390.9 4409.1 5519.1 5665.7 5680.6 5696.1 5724.6 6148.4 6166.3 6167.4 6181.1 6181.9 5661.6 5676.8 5681.8 5685.8 5696.6 5189.8 5249.6 5255.7 5257.6 5317.3 5598.3 6301.9 6329.5 6333.6 6337.1 5808.7 6120.8 6196.9 6209.5 6210.2 6157.5 6170.4 6233.9 6252.9 6276.2 5953.7 6052.3 6075.7 6090.1 6110.5 4685.7 5983.0 6134.8 6147.2 6149.3 5700.4 5812.6 5908.9 5914.1 5917.9 5850.1 5858.8 5879.5 5910.3 5920.1 5790.6 5792.2 5795.6 5802.8 5809.9 5751.0 5925.5 5930.9 5931.1 5937.9 5641.4 5710.8 5728.8 5756.9 5818.1 07:54:53 INFO - PROCESS | 2247 | 07:54:53 INFO - PROCESS | 2247 | [#1] ext.html Cycles:180 Average:68120.85 Median:34381.48 stddev:149387.66 (434.5%) stddev-sans-first:149720.26 07:54:53 INFO - PROCESS | 2247 | Values: 423.0 472.2 472.7 475.0 493.4 29946.9 38158.6 39049.8 39157.0 39250.6 41142.2 41518.6 41538.0 41549.0 41553.8 9345.2 9569.7 9576.3 9578.3 9582.8 8578.0 8785.8 11191.5 11418.3 11444.8 11291.4 11310.5 11395.7 11421.7 11447.7 8535.1 11243.3 11329.3 11337.4 11371.6 8533.8 11070.2 11322.4 11366.6 11503.9 38919.6 39327.4 39411.4 39434.4 39483.6 3301.5 3437.6 3537.9 3871.2 4074.7 29858.0 30351.0 30403.0 30580.8 31195.8 3140.0 3140.1 3167.7 3266.7 3292.8 495102.0 495827.0 495859.0 496003.0 496457.0 58378.7 58614.7 58844.1 58846.8 58854.4 60059.0 61375.4 61478.0 61684.8 61790.1 15288.0 15549.5 15586.8 15594.2 15632.3 11004.2 11229.2 12099.2 12168.6 12173.3 14390.1 15892.8 15909.0 16172.5 16396.0 6457.5 6651.5 6925.1 7122.0 7151.0 842.3 862.7 902.2 1020.3 1053.1 27892.6 29534.4 29657.8 29865.1 30003.8 1020.3 1032.0 1057.7 1066.0 1068.1 14925.2 14954.6 14989.4 15365.6 15377.5 607266.0 612531.0 616752.0 617705.3 618235.0 56878.0 57239.9 57271.4 57352.1 57483.0 1355.9 1402.2 1406.5 1415.6 1415.9 21909.8 28664.6 28863.6 29567.7 29658.3 48555.8 48843.5 48939.5 48957.3 49001.3 553315.0 556660.0 561972.0 563927.0 564283.0 21714.3 23702.9 25278.0 25670.0 25716.9 35225.8 35590.0 39476.0 41572.8 42146.0 34797.8 35395.6 36077.0 36613.8 37461.9 34175.7 34237.8 34371.8 35931.6 35937.5 33197.8 33872.5 34391.1 34674.5 34712.5 27907.9 28699.9 30558.5 31334.7 31369.8 23250.3 23457.1 23675.0 23815.9 23910.0 07:54:53 INFO - PROCESS | 2247 | 07:54:53 INFO - PROCESS | 2247 | [#2] jquery.html Cycles:180 Average:34453.06 Median:25806.68 stddev:98350.94 (381.1%) stddev-sans-first:98593.42 07:54:53 INFO - PROCESS | 2247 | Values: 306.7 321.8 374.8 379.6 404.7 19100.8 19568.5 19886.9 20111.9 20277.0 20253.7 20424.2 20996.9 21067.7 21243.7 5169.1 5358.2 5704.7 6015.5 6033.1 5773.1 5847.8 5849.1 5918.7 5994.4 5669.0 5772.0 5819.2 5867.3 5868.1 5839.8 5872.2 5880.7 5893.4 5895.2 4881.3 5100.0 5143.5 5159.7 5174.3 25603.7 25605.1 25611.2 25689.4 25924.0 2204.2 2231.2 2273.0 2434.5 2948.3 10086.9 10462.1 12523.4 14137.9 14974.5 1791.8 1833.2 1904.3 1949.2 1957.4 96646.5 116514.4 123542.0 123804.0 126137.0 9411.6 11126.7 11169.5 11351.7 11451.1 14100.6 14546.8 14574.9 14586.6 14587.7 8048.7 8364.4 8389.2 8460.2 8504.0 8221.3 8230.8 8233.0 8390.6 8429.3 4470.4 4481.0 4493.7 4497.7 4568.9 1611.5 1817.8 1840.5 1881.7 1904.2 814.0 816.9 865.8 894.6 966.3 17566.0 19703.7 21439.7 21533.4 21689.2 826.2 881.1 890.7 980.7 986.5 9865.2 11211.4 11318.3 11424.9 11877.3 583057.0 583843.0 593843.0 595860.0 596872.0 86002.0 114616.0 117415.0 123789.0 134944.0 983.1 1016.5 1021.5 1035.0 1040.6 19190.7 19977.5 19981.5 19984.0 20018.4 52898.5 52967.7 53060.0 53942.0 54059.5 71239.0 74781.0 76108.0 77834.6 78023.0 7956.6 7981.6 8063.0 8240.1 8296.9 11677.8 12817.7 12910.7 13191.0 13235.1 11247.8 11277.8 11594.6 11631.5 11635.7 10861.9 11090.4 11230.5 11326.3 11386.8 8913.6 9711.3 11109.1 11700.6 11847.1 7949.6 8118.4 8121.5 8403.2 8466.8 10777.7 11371.6 11456.3 11579.8 11661.4 07:54:53 INFO - PROCESS | 2247 | 07:54:53 INFO - PROCESS | 2247 | [#3] mootools.html Cycles:180 Average:5387.07 Median:5166.07 stddev:2932.36 (56.8%) stddev-sans-first:2925.95 07:54:53 INFO - PROCESS | 2247 | Values: 1488.1 1527.2 1730.7 1784.9 1895.1 7272.6 8027.9 8430.7 8433.9 8450.2 7448.9 7655.0 7716.6 7976.0 8207.3 2280.2 2332.2 2344.7 2345.0 2350.8 2295.0 2340.8 2342.3 2355.2 2368.1 2301.9 2308.2 2327.5 2333.0 2348.9 2296.9 2297.4 2323.7 2332.4 2333.8 2329.3 2330.8 2363.2 2369.3 2396.9 8285.7 8385.7 8391.7 8396.3 8396.9 4994.5 5111.3 5194.3 5200.2 5200.6 3216.5 3339.3 3534.2 3541.8 3542.3 1042.5 1056.0 1069.3 1069.6 1087.4 10626.0 10628.3 10775.4 10798.0 10802.4 4394.4 4523.6 4615.9 4617.8 4693.1 9102.4 9331.0 9338.7 9342.0 9358.9 5159.2 5172.9 5183.3 5183.7 5196.8 4192.6 4462.7 4653.7 4703.9 4781.8 3704.2 3734.4 3808.4 3831.3 3835.8 1240.1 1249.3 1251.0 1263.4 1269.4 783.7 863.3 910.5 911.6 912.5 5363.8 5525.0 5685.0 5748.5 5971.7 888.6 935.6 944.2 978.1 991.2 3406.9 3465.9 3486.9 3498.8 3514.9 9650.6 10142.1 10143.7 10171.0 10173.3 9886.5 9923.7 10020.7 10040.8 10142.5 7693.4 7708.6 7754.7 7778.5 7864.4 4800.4 5433.6 5440.0 5531.8 5557.6 9101.0 9205.4 9225.0 9359.5 9408.2 8671.9 8714.3 9390.3 9408.1 9567.0 6210.9 6292.0 6442.1 6629.7 6811.4 7804.8 7876.5 7913.6 7986.3 8011.9 6971.2 7114.4 7172.9 7218.5 7249.1 6818.1 6979.7 6990.5 7042.0 7118.2 6499.5 6548.6 6637.0 6642.0 6646.1 4782.5 4835.3 4871.0 4896.5 4993.4 4481.1 4638.1 4787.3 4808.8 4982.3 07:54:53 INFO - PROCESS | 2247 | 07:54:53 INFO - PROCESS | 2247 | [#4] prototype.html Cycles:180 Average:4319.73 Median:4860.93 stddev:1294.77 (26.6%) stddev-sans-first:1263.33 07:54:53 INFO - PROCESS | 2247 | Values: 331.9 350.3 357.4 358.0 362.4 4535.8 4890.0 5060.6 5180.6 5272.2 5014.5 5102.6 5128.4 5140.5 5198.6 3671.2 3764.4 3809.9 3812.2 4079.6 3822.5 3957.9 4068.6 4097.0 4101.2 3896.9 3986.3 4009.7 4074.2 4112.3 4000.9 4069.5 4073.8 4081.1 4100.9 3350.6 3623.5 3637.2 3639.9 3648.8 4779.8 4848.2 5082.4 5096.9 5128.4 3898.3 4492.4 4507.2 4539.6 4549.8 5149.7 5314.8 5534.3 5536.0 5550.1 3071.8 3281.4 3779.1 3797.2 3805.4 5348.6 5405.6 5728.6 5756.4 5796.6 3286.8 3566.4 3754.1 3845.2 3847.6 3514.8 3574.8 3638.3 3848.6 3875.3 4318.8 4461.4 4496.2 4535.8 4544.4 4559.5 4975.4 5558.7 5578.3 5606.5 1091.5 1110.4 1227.0 1247.6 1257.8 748.3 795.4 841.2 854.7 863.0 4506.1 4933.6 4953.7 4978.8 5028.7 4350.6 4783.9 5366.6 5367.5 5401.3 4423.7 4564.0 4577.7 4797.7 4819.6 2500.0 2823.6 2825.6 2827.7 2851.7 5244.9 5575.3 5590.1 5604.3 5609.8 4887.7 4983.8 5162.1 5350.0 5376.2 4863.5 4962.5 5499.9 5594.9 5607.0 4595.8 5096.8 5157.3 5282.9 5387.6 4615.4 4702.7 4858.3 5278.3 5324.0 5081.6 5187.3 5647.4 5655.4 5686.9 3271.7 3345.2 3546.6 3576.0 3610.9 4959.9 5001.5 5218.5 5275.3 5398.4 4915.6 5000.5 5203.5 5208.4 5254.6 4374.7 4507.6 4619.6 5177.9 5187.2 4541.0 5090.3 5115.1 5116.8 5222.7 5190.9 5237.7 5242.2 5246.7 5259.3 3989.9 5103.6 5105.7 5135.0 5172.2 07:54:53 INFO - PROCESS | 2247 | 07:54:53 INFO - PROCESS | 2247 | [#5] yui.html Cycles:180 Average:20200.76 Median:4184.50 stddev:29673.52 (709.1%) stddev-sans-first:29720.48 07:54:53 INFO - PROCESS | 2247 | Values: 658.7 729.9 735.7 742.2 756.0 14507.4 15364.5 15484.8 15489.3 15517.9 13818.9 14052.9 14070.8 14205.0 14206.8 866.4 875.9 890.4 894.7 895.4 691.3 877.3 883.0 883.9 886.4 754.8 764.7 901.2 942.5 946.6 936.0 936.7 937.7 939.5 941.2 536.5 692.7 694.4 694.9 696.7 12403.3 12422.5 12596.5 12602.4 13356.7 13799.0 14021.1 14147.9 14171.2 14606.6 10700.7 10744.6 10972.1 11910.9 12134.9 3353.8 3395.5 3791.5 3855.4 3866.9 103344.0 109877.5 110526.1 110603.0 110969.0 10221.8 10841.3 10941.4 10943.7 11362.9 22298.3 22523.0 22695.7 22714.3 22744.2 7189.6 7458.1 7763.4 7800.5 8003.4 4219.0 4306.7 4317.0 4356.7 4434.6 3437.2 3457.3 3464.5 3496.7 3500.0 602.1 607.1 613.0 619.9 632.7 481.8 576.2 599.2 617.1 634.8 7888.6 8398.4 8455.5 8565.2 9006.2 514.3 578.4 628.0 632.1 635.3 3890.0 3981.3 4150.0 4281.0 4469.5 84080.5 99903.0 102887.5 103282.0 104519.0 84996.2 86104.0 86601.6 87122.0 88407.0 76699.0 77335.0 77454.6 78237.2 78569.8 8440.0 8511.4 8524.5 8627.3 8762.0 40774.8 51258.2 52005.5 52803.5 53581.0 71545.6 73941.2 74015.6 76437.0 78156.0 10529.7 10881.2 10945.8 10972.5 11552.2 11846.5 11914.9 11962.4 12175.2 12431.8 11228.3 11679.2 11840.1 11896.4 12144.5 11371.8 11473.3 11618.2 12373.4 13176.1 13234.7 13275.3 13544.7 13724.7 13735.1 8249.6 10543.6 10923.3 11010.4 11103.6 11217.9 11221.8 11410.8 11636.0 11685.3 07:54:53 INFO - PROCESS | 2247 | -------- Summary: end -------- 07:54:53 INFO - PROCESS | 2247 | 07:54:53 INFO - TEST-INFO | 2247: exit 0 07:54:53 INFO - TEST-OK | dromaeo_css | took 1118797ms 07:54:53 INFO - TEST-START | kraken 07:54:53 INFO - operating with platform_type : mac_ 07:54:53 INFO - Initialising browser for kraken test... 07:54:53 INFO - TEST-INFO | started process 2249 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmpSgcAv8/profile http://localhost:49440/getInfo.html) 07:54:56 INFO - PROCESS | 2249 | __metrics Screen width/height:1600/1200 07:54:56 INFO - PROCESS | 2249 | colorDepth:24 07:54:56 INFO - PROCESS | 2249 | Browser inner width/height: 1024/689 07:54:56 INFO - PROCESS | 2249 | __metrics 07:54:56 INFO - PROCESS | 2249 | 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" 07:54:56 INFO - PROCESS | 2249 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:54:56 INFO - TEST-INFO | 2249: exit 0 07:54:56 INFO - Browser initialized. 07:54:56 INFO - Running cycle 1/1 for kraken test... 07:54:56 INFO - TEST-INFO | started process 2250 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmpSgcAv8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:55:08 INFO - PROCESS | 2250 | RSS: Main: 236875776 07:55:08 INFO - PROCESS | 2250 | 07:55:11 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49440/tests/kraken/driver.html?testName=audio-beat-detection) 07:55:12 INFO - PROCESS | 2250 | RSS: Main: 291094528 07:55:12 INFO - PROCESS | 2250 | 07:55:15 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49440/tests/kraken/driver.html?testName=audio-dft) 07:55:15 INFO - PROCESS | 2250 | RSS: Main: 293011456 07:55:15 INFO - PROCESS | 2250 | 07:55:19 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49440/tests/kraken/driver.html?testName=audio-fft) 07:55:19 INFO - PROCESS | 2250 | RSS: Main: 383504384 07:55:19 INFO - PROCESS | 2250 | 07:55:21 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49440/tests/kraken/driver.html?testName=audio-oscillator) 07:55:22 INFO - PROCESS | 2250 | RSS: Main: 283418624 07:55:22 INFO - PROCESS | 2250 | 07:55:24 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49440/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:55:25 INFO - PROCESS | 2250 | RSS: Main: 287002624 07:55:25 INFO - PROCESS | 2250 | 07:55:28 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49440/tests/kraken/driver.html?testName=imaging-darkroom) 07:55:28 INFO - PROCESS | 2250 | RSS: Main: 329805824 07:55:28 INFO - PROCESS | 2250 | 07:55:31 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49440/tests/kraken/driver.html?testName=imaging-desaturate) 07:55:32 INFO - PROCESS | 2250 | RSS: Main: 330559488 07:55:32 INFO - PROCESS | 2250 | 07:55:35 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49440/tests/kraken/driver.html?testName=json-parse-financial) 07:55:35 INFO - PROCESS | 2250 | RSS: Main: 327720960 07:55:35 INFO - PROCESS | 2250 | 07:55:37 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49440/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:55:38 INFO - PROCESS | 2250 | RSS: Main: 306335744 07:55:38 INFO - PROCESS | 2250 | 07:55:40 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:55:40 INFO - PROCESS | 2250 | RSS: Main: 309075968 07:55:40 INFO - PROCESS | 2250 | 07:55:42 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:55:43 INFO - PROCESS | 2250 | RSS: Main: 314179584 07:55:43 INFO - PROCESS | 2250 | 07:55:46 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:55:47 INFO - PROCESS | 2250 | RSS: Main: 328028160 07:55:47 INFO - PROCESS | 2250 | 07:55:50 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:55:51 INFO - PROCESS | 2250 | RSS: Main: 322342912 07:55:51 INFO - PROCESS | 2250 | 07:55:52 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49440/tests/kraken/driver.html?testName=ai-astar) 07:55:53 INFO - PROCESS | 2250 | RSS: Main: 366673920 07:55:53 INFO - PROCESS | 2250 | 07:55:53 INFO - PROCESS | 2250 | __start_tp_report 07:55:53 INFO - PROCESS | 2250 | _x_x_mozilla_page_load 07:55:53 INFO - PROCESS | 2250 | _x_x_mozilla_page_load_details 07:55:53 INFO - PROCESS | 2250 | |i|pagename|runs| 07:55:53 INFO - PROCESS | 2250 | |0;ai-astar;113;114;114;113;120;167;164;114;112;114 07:55:53 INFO - PROCESS | 2250 | |1;audio-beat-detection;144;114;115;149;114;115;117;114;134;113 07:55:53 INFO - PROCESS | 2250 | |2;audio-dft;189;190;186;189;187;182;185;182;186;185 07:55:53 INFO - PROCESS | 2250 | |3;audio-fft;82;61;61;87;60;62;58;58;73;57 07:55:53 INFO - PROCESS | 2250 | |4;audio-oscillator;91;70;87;70;67;69;84;69;68;108 07:55:53 INFO - PROCESS | 2250 | |5;imaging-gaussian-blur;108;111;109;111;109;111;108;112;109;111 07:55:53 INFO - PROCESS | 2250 | |6;imaging-darkroom;93;93;95;95;94;94;93;94;93;94 07:55:53 INFO - PROCESS | 2250 | |7;imaging-desaturate;85;85;85;85;84;88;86;86;86;85 07:55:53 INFO - PROCESS | 2250 | |8;json-parse-financial;55;57;55;55;55;56;56;55;53;62 07:55:53 INFO - PROCESS | 2250 | |9;json-stringify-tinderbox;63;71;69;76;73;70;69;71;68;69 07:55:53 INFO - PROCESS | 2250 | |10;stanford-crypto-aes;94;90;93;88;87;90;92;86;90;96 07:55:53 INFO - PROCESS | 2250 | |11;stanford-crypto-ccm;148;145;151;161;152;146;161;160;213;188 07:55:53 INFO - PROCESS | 2250 | |12;stanford-crypto-pbkdf2;170;174;177;176;177;176;178;174;177;177 07:55:53 INFO - PROCESS | 2250 | |13;stanford-crypto-sha256-iterative;69;69;69;69;69;69;68;67;67;68 07:55:53 INFO - PROCESS | 2250 | __end_tp_report 07:55:53 INFO - PROCESS | 2250 | __start_cc_report 07:55:53 INFO - PROCESS | 2250 | _x_x_mozilla_cycle_collect,2086 07:55:53 INFO - PROCESS | 2250 | __end_cc_report 07:55:53 INFO - PROCESS | 2250 | __startTimestamp1481817353099__endTimestamp 07:55:53 INFO - PROCESS | 2250 | 07:55:53 INFO - PROCESS | 2250 | ------- Summary: start ------- 07:55:53 INFO - PROCESS | 2250 | Number of tests: 14 07:55:53 INFO - PROCESS | 2250 | 07:55:53 INFO - PROCESS | 2250 | [#0] ai-astar Cycles:10 Average:124.50 Median:114.00 stddev:21.73 (19.1%) stddev-sans-first:22.64 07:55:53 INFO - PROCESS | 2250 | Values: 113.0 114.0 114.0 113.0 120.0 167.0 164.0 114.0 112.0 114.0 07:55:53 INFO - PROCESS | 2250 | 07:55:53 INFO - PROCESS | 2250 | [#1] audio-beat-detection Cycles:10 Average:122.90 Median:116.00 stddev:13.92 (12.0%) stddev-sans-first:12.50 07:55:53 INFO - PROCESS | 2250 | Values: 144.0 114.0 115.0 149.0 114.0 115.0 117.0 114.0 134.0 113.0 07:55:53 INFO - PROCESS | 2250 | 07:55:53 INFO - PROCESS | 2250 | [#2] audio-dft Cycles:10 Average:186.10 Median:186.50 stddev:2.77 (1.5%) stddev-sans-first:2.73 07:55:53 INFO - PROCESS | 2250 | Values: 189.0 190.0 186.0 189.0 187.0 182.0 185.0 182.0 186.0 185.0 07:55:53 INFO - PROCESS | 2250 | 07:55:53 INFO - PROCESS | 2250 | [#3] audio-fft Cycles:10 Average:65.90 Median:61.50 stddev:10.84 (17.6%) stddev-sans-first:9.80 07:55:53 INFO - PROCESS | 2250 | Values: 82.0 61.0 61.0 87.0 60.0 62.0 58.0 58.0 73.0 57.0 07:55:53 INFO - PROCESS | 2250 | 07:55:53 INFO - PROCESS | 2250 | [#4] audio-oscillator Cycles:10 Average:78.30 Median:70.00 stddev:13.73 (19.6%) stddev-sans-first:13.77 07:55:53 INFO - PROCESS | 2250 | Values: 91.0 70.0 87.0 70.0 67.0 69.0 84.0 69.0 68.0 108.0 07:55:53 INFO - PROCESS | 2250 | 07:55:53 INFO - PROCESS | 2250 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:111.00 stddev:1.45 (1.3%) stddev-sans-first:1.36 07:55:53 INFO - PROCESS | 2250 | Values: 108.0 111.0 109.0 111.0 109.0 111.0 108.0 112.0 109.0 111.0 07:55:53 INFO - PROCESS | 2250 | 07:55:53 INFO - PROCESS | 2250 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 07:55:53 INFO - PROCESS | 2250 | Values: 93.0 93.0 95.0 95.0 94.0 94.0 93.0 94.0 93.0 94.0 07:55:53 INFO - PROCESS | 2250 | 07:55:53 INFO - PROCESS | 2250 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:85.50 stddev:1.08 (1.3%) stddev-sans-first:1.13 07:55:53 INFO - PROCESS | 2250 | Values: 85.0 85.0 85.0 85.0 84.0 88.0 86.0 86.0 86.0 85.0 07:55:53 INFO - PROCESS | 2250 | 07:55:53 INFO - PROCESS | 2250 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:55.50 stddev:2.38 (4.3%) stddev-sans-first:2.50 07:55:53 INFO - PROCESS | 2250 | Values: 55.0 57.0 55.0 55.0 55.0 56.0 56.0 55.0 53.0 62.0 07:55:53 INFO - PROCESS | 2250 | 07:55:53 INFO - PROCESS | 2250 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.50 stddev:3.38 (4.8%) stddev-sans-first:2.50 07:55:53 INFO - PROCESS | 2250 | Values: 63.0 71.0 69.0 76.0 73.0 70.0 69.0 71.0 68.0 69.0 07:55:53 INFO - PROCESS | 2250 | 07:55:53 INFO - PROCESS | 2250 | [#10] stanford-crypto-aes Cycles:10 Average:90.60 Median:91.00 stddev:3.17 (3.5%) stddev-sans-first:3.11 07:55:53 INFO - PROCESS | 2250 | Values: 94.0 90.0 93.0 88.0 87.0 90.0 92.0 86.0 90.0 96.0 07:55:53 INFO - PROCESS | 2250 | 07:55:53 INFO - PROCESS | 2250 | [#11] stanford-crypto-ccm Cycles:10 Average:162.50 Median:160.50 stddev:21.71 (13.5%) stddev-sans-first:22.39 07:55:53 INFO - PROCESS | 2250 | Values: 148.0 145.0 151.0 161.0 152.0 146.0 161.0 160.0 213.0 188.0 07:55:53 INFO - PROCESS | 2250 | 07:55:53 INFO - PROCESS | 2250 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.60 Median:177.00 stddev:2.37 (1.3%) stddev-sans-first:1.39 07:55:53 INFO - PROCESS | 2250 | Values: 170.0 174.0 177.0 176.0 177.0 176.0 178.0 174.0 177.0 177.0 07:55:53 INFO - PROCESS | 2250 | 07:55:53 INFO - PROCESS | 2250 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:69.00 stddev:0.84 (1.2%) stddev-sans-first:0.87 07:55:53 INFO - PROCESS | 2250 | Values: 69.0 69.0 69.0 69.0 69.0 69.0 68.0 67.0 67.0 68.0 07:55:53 INFO - PROCESS | 2250 | -------- Summary: end -------- 07:55:53 INFO - PROCESS | 2250 | 07:55:53 INFO - TEST-INFO | 2250: exit 0 07:55:54 INFO - TEST-OK | kraken | took 60250ms 07:55:54 INFO - SUITE-END | took 1179s 07:55:54 INFO - Completed test suite (00:19:39) 07:55:54 INFO - javascript benchmark 07:55:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2688.408550118974, 3281.589801274841, 3293.8353082345893, 3316.485944678576, 3350.229447227138, 5447.918281225775, 5557.3886872444045, 5596.384397716248, 5596.496315331619, 5633.521150702195, 5552.91670624941, 5554.91667624986, 5644.04051311277, 5647.43525647435, 5648.350439699436, 5022.045811295842, 5068.695878247298, 5076.44159142494, 5132.486751324856, 5139.023585518758, 5089.7455127243675, 5201.5838732901275, 5205.349331333583, 5213.0, 5281.207818827187, 5028.522290382444, 5108.003939231851, 5181.9740901295445, 5183.637145399824, 5222.32109825724, 5126.128558145124, 5128.743562821881, 5136.460671629462, 5136.871578210575, 5140.228965655144, 5035.018171456568, 5085.160948443502, 5086.847394578169, 5094.2103973884105, 5107.897842043139, 4675.625949924032, 5572.3870374258795, 5576.721163941827, 5579.497845193911, 5583.5254003409755, 6055.0, 6064.272287325505, 6069.57512974092, 6075.119107729354, 6075.878482430371, 6118.296395914438, 6119.143319935212, 6123.323435039953, 6135.048937646325, 6145.631262124242, 5568.832935011916, 5644.153376993484, 5649.632773869726, 5649.661020338793, 5653.0, 6233.283172435137, 6276.403741644536, 6299.5275354348605, 6313.05304204373, 6323.114763933053, 5773.24947756789, 6015.54883383748, 6029.547783916224, 6049.637021778707, 6080.665563393967, 6043.7280322385595, 6065.878682426327, 6110.202397347066, 6110.536573724199, 6111.895622426936, 6098.196343066944, 6104.883608894094, 6105.6401074306, 6109.404666050415, 6141.0, 6091.208142941389, 6113.358097399709, 6117.418845209698, 6123.693815309217, 6130.325664176937, 4747.477777444478, 4807.158747219222, 4816.0, 4826.638002149853, 4854.781534830941, 4265.1469706058915, 4341.674374421931, 4361.563843615613, 4390.912181756347, 4409.11817636474, 5519.089350257163, 5665.716714164275, 5680.6307590007345, 5696.11710184922, 5724.570657200727, 6148.415900489446, 6166.260048794084, 6167.352427995085, 6181.072839074175, 6181.938180618226, 5661.603687741818, 5676.772929082873, 5681.829545113653, 5685.800996965087, 5696.601237913306, 5189.792408303626, 5249.632525723239, 5255.658382205144, 5257.631965762436, 5317.282166907496, 5598.272224610774, 6301.905471417932, 6329.461995730415, 6333.619982801047, 6337.081123237197, 5808.680522571299, 6120.846978825387, 6196.876062478816, 6209.472194863487, 6210.223722034746, 6157.507399408126, 6170.382961703794, 6233.906491402542, 6252.874942501034, 6276.152719383008, 5953.672548009901, 6052.273727152769, 6075.665838378754, 6090.056041313604, 6110.51115910735, 4685.695429797052, 5983.0, 6134.754609815557, 6147.231596050494, 6149.292831324455, 5700.401457847032, 5812.593118481835, 5908.940910591011, 5914.142449344907, 5917.85205369852, 5850.0932355484965, 5858.765649373977, 5879.529637628894, 5910.349861515144, 5920.111983202554, 5790.594658373873, 5792.247007888947, 5795.623284486495, 5802.767889284381, 5809.94190058111, 5750.9648263313, 5925.466707996128, 5930.881382372415, 5931.08068249422, 5937.851553711192, 5641.407652196624, 5710.828675139753, 5728.828135155952, 5756.913646295393, 5818.0981947798155], "value": 5572.565296687583, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.9894252643684, 472.20197865607145, 472.6691316078746, 474.9643776716747, 493.3684883349313, 29946.850265748668, 38158.61841381586, 39049.80475097628, 39157.021074473116, 39250.607493925054, 41142.177156456855, 41518.58481415185, 41538.0, 41549.0, 41553.7922310388, 9345.205657519102, 9569.665061722806, 9576.281778866578, 9578.281628877827, 9582.760430989212, 8577.95711021444, 8785.824283514326, 11191.496382662759, 11418.257813242113, 11444.771104577903, 11291.435428228597, 11310.547578096908, 11395.715107122347, 11421.657350279505, 11447.713807154847, 8535.103814099555, 11243.325400475998, 11329.320240785579, 11337.37644429556, 11371.601993930255, 8533.786655333666, 11070.169737269736, 11322.37726925027, 11366.602168924048, 11503.884961150365, 38919.61080389217, 39327.410088848694, 39411.40882886759, 39434.408483872765, 39483.60516394828, 3301.4882693182594, 3437.570303712036, 3537.9469307960403, 3871.1676989447406, 4074.674026077936, 29858.0, 30351.0, 30403.0, 30580.84709576438, 31195.84402077998, 3140.0, 3140.120766185472, 3167.7149056584785, 3266.657001014883, 3292.7695061345717, 495102.0, 495827.0, 495859.0, 496003.0, 496456.97830793104, 58378.7081064592, 58614.70692646595, 58844.11733823996, 58846.82306353849, 58854.41145588575, 60059.0, 61375.38624613786, 61478.0, 61684.766304673656, 61790.1462956112, 15288.0, 15549.455769048029, 15586.766198507032, 15594.220288985505, 15632.296546655427, 11004.174686898514, 11229.157813164045, 12099.153059285765, 12168.634940951786, 12173.330466824409, 14390.06464579799, 15892.841071589368, 15909.0, 16172.514824555283, 16396.016239025696, 6457.5479716419395, 6651.505685367987, 6925.134358205224, 7122.005838365266, 7150.997720638125, 842.2630198576246, 862.7498025572639, 902.2376092202079, 1020.260311274335, 1053.1359493696116, 27892.581611275848, 29534.409311814074, 29657.775716686312, 29865.104046878627, 30003.849980749957, 1020.3061917895753, 1031.9690409287734, 1057.6879820452984, 1065.9520321585546, 1068.086785798147, 14925.179115148554, 14954.551363459113, 14989.40042398292, 15365.615859603377, 15377.538673839803, 607266.0, 612531.0, 616752.0, 617705.3179947898, 618235.0, 56878.0, 57239.855202895706, 57271.42728572661, 57352.12506936874, 57483.0, 1355.8847497962784, 1402.2287741742, 1406.5147524104168, 1415.5753274017754, 1415.853158941261, 21909.78090219141, 28664.570031449963, 28863.55682215923, 29567.704322957357, 29658.258543536584, 48555.757221213666, 48843.5115648839, 48939.5106048935, 48957.26564101613, 49001.2649810246, 553315.0, 556660.0, 561972.0, 563927.0, 564283.0, 21714.348569542937, 23702.88148559246, 25278.0, 25669.97320107175, 25716.871415642803, 35225.82387088048, 35590.0, 39476.0, 41572.79213603913, 42146.04977651535, 34797.82601086979, 35395.64604353924, 36077.0, 36613.81693091518, 37461.87614371573, 34175.658243417245, 34237.82881085579, 34371.828140859136, 35931.640683593876, 35937.46093808647, 33197.83401082979, 33872.49191262182, 34391.140221494665, 34674.47988280228, 34712.479312810836, 27907.860460697568, 28699.856500718197, 30558.541621875243, 31334.68665313409, 31369.8431507841, 23250.3024909253, 23457.06171753179, 23675.0, 23815.880920595286, 23910.0], "value": 19366.416105780667, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.714755277592, 321.8487310963846, 374.79011753418087, 379.59383459698125, 404.7308539821019, 19100.80899191008, 19568.51078723031, 19886.90056549715, 20111.899440502813, 20276.98615069248, 20253.696194557095, 20424.183032678677, 20996.89501552494, 21067.683984740204, 21243.68134477984, 5169.147090730025, 5358.196270559428, 5704.743286552105, 6015.518758499309, 6033.125196846455, 5773.076307790754, 5847.766089356421, 5849.122631605272, 5918.733656985446, 5994.370591087938, 5668.971655141719, 5772.0, 5819.243498345209, 5867.295924489046, 5868.090445980858, 5839.79560715375, 5872.17789509469, 5880.735366908478, 5893.410658934115, 5895.233619629464, 4881.341018962466, 5099.980003999215, 5143.459936706667, 5159.690418574897, 5174.301469301634, 25603.743962560322, 25605.10382136635, 25611.231663050137, 25689.35776605581, 25924.0, 2204.2395373596246, 2231.163313757341, 2273.0, 2434.500927309897, 2948.3218859662397, 10086.899131008742, 10462.110720588758, 12523.373831308489, 14137.929310353486, 14974.47589334368, 1791.7939436964787, 1833.1567478959694, 1904.3430016644236, 1949.2397964793743, 1957.4421289932302, 96646.51676741571, 116514.41742791317, 123542.0, 123804.0, 126136.99999999908, 9411.576479058458, 11126.721831954104, 11169.497372618252, 11351.716207094889, 11451.141164412702, 14100.576982690536, 14546.781798273034, 14574.854251457562, 14586.562403127924, 14587.708245835023, 8048.718294859769, 8364.414490985695, 8389.189621476751, 8460.153984601491, 8503.957480212683, 8221.301189398968, 8230.8353832923, 8232.958835205905, 8390.580470976427, 8429.28351090152, 4470.441194850644, 4480.955190448119, 4493.6854420190275, 4497.662675299365, 4568.931466028012, 1611.5165450364843, 1817.8273064058894, 1840.5122642499748, 1881.689521228982, 1904.1526520698433, 813.9593020348959, 816.9060558035783, 865.8441480533564, 894.6019021535484, 966.2656381150235, 17566.0, 19703.704444433344, 21439.67840482394, 21533.353999380044, 21689.240876569558, 826.2398593294183, 881.0792721605937, 890.7461373508519, 980.6959842448864, 986.5116767200282, 9865.161461275871, 11211.439428028565, 11318.32090074598, 11424.942875285571, 11877.346745929057, 583057.0, 583843.0, 593843.0, 595860.0, 596872.0, 86002.0, 114616.0, 117415.0, 123789.0, 134944.0, 983.1201075037801, 1016.537475448669, 1021.5249908792299, 1034.9896501034893, 1040.552562398176, 19190.712139317642, 19977.500562486053, 19981.500462488555, 19984.0, 20018.399448016582, 52898.47101528935, 52967.735161323944, 53060.0, 53942.020726165785, 54059.45940540702, 71239.0, 74781.0, 76108.0, 77834.6108269455, 78023.0, 7956.602169891598, 7981.561014144278, 8063.0, 8240.1347858474, 8296.87554686668, 11677.824832627348, 12817.679558010752, 12910.67723306925, 13191.0, 13235.139715918434, 11247.7750444989, 11277.830832537682, 11594.594189203337, 11631.47658355359, 11635.709107272385, 10861.945690271497, 11090.390028548507, 11230.494627741935, 11326.32042077478, 11386.772264554827, 8913.598888049924, 9711.320207585684, 11109.055730263019, 11700.648980530597, 11847.052235820942, 7949.562774047483, 8118.391120666091, 8121.512709237465, 8403.243708066058, 8466.830663386821, 10777.676669699922, 11371.601993930173, 11456.31262124242, 11579.768404632028, 11661.35862527569], "value": 9524.450924479483, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1488.0848278308838, 1527.2363818090957, 1730.7317365808296, 1784.9464516064522, 1895.1282410091349, 7272.600006999613, 8027.91972080279, 8430.662773489054, 8433.945756780402, 8450.197231263035, 7448.888266676005, 7655.0, 7716.575588342639, 7976.042874855011, 8207.343412526998, 2280.1905323610085, 2332.195392589554, 2344.7186337639505, 2344.988275058622, 2350.8236882233814, 2294.9541009179807, 2340.8010319122895, 2342.3090188394463, 2355.1521452277166, 2368.14746691191, 2301.873396963166, 2308.2152068296778, 2327.511222643247, 2332.953340933189, 2348.8708121053337, 2296.8851557422063, 2297.3797074789795, 2323.7327707313707, 2332.4052366646397, 2333.824963127772, 2329.301209637119, 2330.7552706965694, 2363.1847012780563, 2369.289213236022, 2396.8681722505257, 8285.668573257062, 8385.664573417056, 8391.748247552583, 8396.328293736486, 8396.874046889301, 4994.475580064113, 5111.309973153651, 5194.324737784102, 5200.219967004941, 5200.63595548308, 3216.517522371663, 3339.34882697874, 3534.169470174507, 3541.7946758183884, 3542.2738338640515, 1042.5360714482058, 1056.0126281926423, 1069.3209811769505, 1069.6363236499549, 1087.374759513283, 10626.0, 10628.309159904582, 10775.407352595605, 10798.028177464066, 10802.405867677275, 4394.406755088022, 4523.557279069331, 4615.93076103852, 4617.792199351037, 4693.0613877224005, 9102.362834601647, 9331.0, 9338.719838404859, 9341.953290233641, 9358.906410935804, 5159.226116082617, 5172.922406163911, 5183.2743415921805, 5183.688978661217, 5196.766145523385, 4192.622663960258, 4462.732236065846, 4653.7207767534055, 4703.929441058387, 4781.832635857798, 3704.2221133561716, 3734.3651579231596, 3808.3716186828865, 3831.310364134427, 3835.827387767557, 1240.1319076646384, 1249.262934868432, 1250.9749805003848, 1263.4251415605877, 1269.3780047776522, 783.7413653494447, 863.2820686833156, 910.526526206369, 911.6171208092617, 912.5163663258484, 5363.785448582091, 5525.0, 5684.971575142098, 5748.48263656273, 5971.701414929323, 888.5512816027865, 935.5509355509394, 944.244604316544, 978.0610613810821, 991.2119864707574, 3406.863725450954, 3465.86136554535, 3486.89539313821, 3498.7550871438757, 3514.9297014059575, 9650.565724542412, 10142.087212150942, 10143.695689129338, 10171.0, 10173.338732982333, 9886.505674716236, 9923.702288931343, 10020.69937901864, 10040.799184016425, 10142.54358553852, 7693.384529237647, 7708.5760283183845, 7754.651040703182, 7778.533288002738, 7864.449488535747, 4800.423949125988, 5433.619646624698, 5440.020796256554, 5531.751071201725, 5557.610967232255, 9101.0, 9205.355625106446, 9224.985251622182, 9359.532023398666, 9408.247340212629, 8671.913280867111, 8714.346424018097, 9390.342676012613, 9408.106229908148, 9567.0, 6210.906836397367, 6291.96854015727, 6442.130312407765, 6629.734810607714, 6811.421029212573, 7804.84390312202, 7876.488028278143, 7913.643886025027, 7986.281234688906, 8011.919880801351, 6971.163460384786, 7114.430845532242, 7172.928270717226, 7218.494705370574, 7249.05762250904, 6818.147731533559, 6979.651017449006, 6990.4580247962185, 7042.014118023379, 7118.181409138016, 6499.480041596756, 6548.607083575001, 6637.0, 6642.0, 6646.136002319668, 4782.545658162469, 4835.2505361669, 4870.95129048705, 4896.461389247109, 4993.400791904995, 4481.103779244229, 4638.095571363552, 4787.257975013878, 4808.831690890942, 4982.302477653204], "value": 4389.918099635386, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.8738879225894, 350.2784264415305, 357.3942168025197, 357.9516765236692, 362.41470025908166, 4535.818567257314, 4890.0268008204985, 5060.620453465991, 5180.585553155748, 5272.23552584875, 5014.473480284572, 5102.591792656588, 5128.358955130609, 5140.460251673577, 5198.558122559578, 3671.210689701714, 3764.3788774852114, 3809.866654667087, 3812.1803812180374, 4079.5920407959115, 3822.5412950445984, 3957.8812635620834, 4068.5524592294823, 4096.951524237881, 4101.241270364992, 3896.941545876814, 3986.3223252047223, 4009.7393669411395, 4074.22589707956, 4112.300908845488, 4000.9399859002137, 4069.4506241657296, 4073.8166782494563, 4081.081891511015, 4100.938485922714, 3350.5927510445426, 3623.547056617923, 3637.2179981303884, 3639.890803275906, 3648.781073135594, 4779.784909679072, 4848.17581011229, 5082.440931497532, 5096.872578185538, 5128.358955130609, 3898.3177943859996, 4492.3710680504755, 4507.211238033331, 4539.568740969603, 4549.840755573539, 5149.716765577892, 5314.787408503656, 5534.252875861787, 5535.972320138373, 5550.057479882049, 3071.8003329783714, 3281.3765384576855, 3779.1119087014804, 3797.2215695782297, 3805.4101614249557, 5348.625596208267, 5405.648632838853, 5728.562862282639, 5756.352078044147, 5796.62321949072, 3286.802791832498, 3566.4472006838982, 3754.0614846288427, 3845.2309538092495, 3847.5960024197616, 3514.841832117561, 3574.8212589370946, 3638.308721342936, 3848.634379733921, 3875.2830726315724, 4318.775830447322, 4461.397711308997, 4496.235639941217, 4535.795889184995, 4544.363789069533, 4559.452865656076, 4975.447465568964, 5558.722063896789, 5578.30271216098, 5606.505105228216, 1091.47063674118, 1110.3726394587034, 1226.9631911042684, 1247.6319485751544, 1257.7988021439503, 748.3377211168155, 795.3796039089519, 841.1546395872109, 854.7435769269318, 862.9611667474978, 4506.102221578377, 4933.580645645088, 4953.653244272867, 4978.77595508203, 5028.673136246132, 4350.608445239944, 4783.856484305476, 5366.597505187126, 5367.543758780547, 5401.3248343957, 4423.717122034638, 4564.0, 4577.725336479755, 4797.688150270221, 4819.565879550839, 2499.9750002500105, 2823.6188114604674, 2825.5620378841313, 2827.674817396026, 2851.6758841544074, 5244.921326180111, 5575.299533642197, 5590.133529302883, 5604.271444712243, 5609.754879187973, 4887.682300650446, 4983.800647974041, 5162.141629013552, 5350.0, 5376.166858957996, 4863.513648635108, 4962.528559786814, 5499.89256070319, 5594.888102238014, 5606.971965140148, 4595.805090676515, 5096.847094587169, 5157.303763991813, 5282.939653535202, 5387.622866399314, 4615.369239533568, 4702.694324868872, 4858.3441235432765, 5278.261043453843, 5323.9803948019, 5081.644284900021, 5187.325647665779, 5647.407022262768, 5655.434456554476, 5686.886262274814, 3271.7219036382176, 3345.1971526833872, 3546.592141903714, 3576.0344706928463, 3610.8555657774446, 4959.925601116059, 5001.4998500149695, 5218.504242096995, 5275.287836142225, 5398.352197736297, 4915.557599816034, 5000.549950504472, 5203.505666961632, 5208.401033881152, 5254.605904557097, 4374.650027997816, 4507.63938884895, 4619.607333376701, 5177.870553236199, 5187.170052791535, 4540.954590454053, 5090.287359769562, 5115.107410258228, 5116.82313067989, 5222.686638801684, 5190.948090519047, 5237.711925844115, 5242.165242165212, 5246.685198888079, 5259.319934470686, 3989.900252493711, 5103.642745007814, 5105.719185444687, 5134.9743251285, 5172.172452407597], "value": 3915.6837190905812, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.6509150150422, 729.945254105942, 735.6726256815716, 742.1576510660402, 756.0436048398775, 14507.419703211872, 15364.539063828075, 15484.845151548481, 15489.302981365838, 15517.922410387946, 13818.93090534546, 14052.929735351334, 14070.803981661546, 14205.0, 14206.78689819651, 866.3502373220085, 875.9036505984336, 890.4034297020979, 894.7181637784109, 895.3553441522093, 691.2845205212581, 877.3156937588691, 882.9977974998359, 883.9337049721264, 886.4193952960821, 754.8263899303164, 764.7285213749122, 901.1844280925773, 942.5428667096453, 946.5835032585641, 936.0, 936.6628013914985, 937.6624415210518, 939.5490164720973, 941.2375975459831, 536.5090941788259, 692.6640579319027, 694.4201591670961, 694.9027136200936, 696.7352406085655, 12403.317817520032, 12422.503099875994, 12596.496140154382, 12602.36988150598, 13356.732865342736, 13799.0, 14021.088629239066, 14147.85852141486, 14171.220582867938, 14606.634834129125, 10700.71591409028, 10744.570217191304, 10972.067374273196, 11910.880891191151, 12134.939325303405, 3353.815540145291, 3395.473701576235, 3791.5071040764524, 3855.4409610606585, 3866.8839934802, 103344.0, 109877.45061274643, 110526.13158539412, 110603.0, 110969.0, 10221.808978763805, 10841.295315804447, 10941.398223097647, 10943.726406839893, 11362.886371136348, 22298.331050068526, 22523.0, 22695.659565106536, 22714.318570442912, 22744.20395286157, 7189.6405179740805, 7458.105027396638, 7763.417743669247, 7800.492967957178, 8003.439759216799, 4218.957810421918, 4306.655467562588, 4317.0, 4356.738595684269, 4434.55654434554, 3437.1750779813165, 3457.291255292659, 3464.4630082337276, 3496.650334966534, 3500.0, 602.0908428273339, 607.1196764691127, 612.9540284478593, 619.8698273362644, 632.7405763636887, 481.7856054055982, 576.1501784867371, 599.1641659884436, 617.102116420607, 634.7810005548079, 7888.64501097452, 8398.412111152284, 8455.534945577929, 8565.229129378386, 9006.189442950166, 514.341642697348, 578.4475825586554, 628.0296941225726, 632.1087266953573, 635.3487675133026, 3889.98860296325, 3981.2833689936087, 4150.040696404793, 4281.0, 4469.463664360298, 84080.47758567253, 99903.0, 102887.4855625717, 103282.0, 104518.95481045244, 84996.15003849882, 86104.0, 86601.5669921659, 87122.0, 88407.0, 76699.0, 77335.0, 77454.61272693714, 78237.21762782299, 78569.82145267825, 8439.95780021096, 8511.361647876558, 8524.488530688179, 8627.266682332072, 8761.956190219009, 40774.77675669735, 51258.23112653239, 52005.479945200066, 52803.471965281395, 53581.0, 71545.64227178831, 73941.15147121366, 74015.6299218522, 76437.0, 78156.0, 10529.677084580739, 10881.183911206534, 10945.83581246298, 10972.451377431256, 11552.22746540841, 11846.526138954345, 11914.940425297818, 11962.401879905796, 12175.208611440228, 12431.75136497247, 11228.270162439416, 11679.182457227913, 11840.052795776144, 11896.405179740805, 12144.453499592362, 11371.829422558834, 11473.311601303949, 11618.186726929034, 12373.381330933238, 13176.143550669176, 13234.735305293647, 13275.269860157785, 13544.661383465493, 13724.65688357799, 13735.107218030797, 8249.628766705393, 10543.57825686964, 10923.344599324066, 11010.449477525932, 11103.5558577656, 11217.943910280723, 11221.831672525082, 11410.82883756761, 11636.0, 11685.298882067103], "value": 7188.034697148499, "unit": "score"}], "name": "dromaeo_css", "value": 7089.9723178993845, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 113.0, 120.0, 167.0, 164.0, 114.0, 112.0, 114.0], "value": 124.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 114.0, 115.0, 149.0, 114.0, 115.0, 117.0, 114.0, 134.0, 113.0], "value": 122.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 190.0, 186.0, 189.0, 187.0, 182.0, 185.0, 182.0, 186.0, 185.0], "value": 186.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 61.0, 61.0, 87.0, 60.0, 62.0, 58.0, 58.0, 73.0, 57.0], "value": 65.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 87.0, 70.0, 67.0, 69.0, 84.0, 69.0, 68.0, 108.0], "value": 78.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 109.0, 111.0, 109.0, 111.0, 108.0, 112.0, 109.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 95.0, 95.0, 94.0, 94.0, 93.0, 94.0, 93.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 84.0, 88.0, 86.0, 86.0, 86.0, 85.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 55.0, 55.0, 55.0, 56.0, 56.0, 55.0, 53.0, 62.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 71.0, 69.0, 76.0, 73.0, 70.0, 69.0, 71.0, 68.0, 69.0], "value": 69.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 90.0, 93.0, 88.0, 87.0, 90.0, 92.0, 86.0, 90.0, 96.0], "value": 90.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 145.0, 151.0, 161.0, 152.0, 146.0, 161.0, 160.0, 213.0, 188.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 174.0, 177.0, 176.0, 177.0, 176.0, 178.0, 174.0, 177.0, 177.0], "value": 175.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 68.0, 67.0, 67.0, 68.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1489.7999999999997, "alertThreshold": 2.0}]} 07:55:54 INFO - Return code: 0 07:55:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:55:54 INFO - # TBPL SUCCESS # 07:55:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:55:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:55:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:55:54 INFO - 2016-12-15 07:55:54.421 screenresolution[2254:285970] starting screenresolution argv=screenresolution get 07:55:54 INFO - 2016-12-15 07:55:54.424 screenresolution[2254:285970] Display 0: 1600x1200x32@60 07:55:54 INFO - 2016-12-15 07:55:54.431 screenresolution[2255:285973] starting screenresolution argv=screenresolution list 07:55:54 INFO - Available Modes on Display 0 07:55:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:55:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:55:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:55:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:55:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:55:54 INFO - Intel Iris: 07:55:54 INFO - Chipset Model: Intel Iris 07:55:54 INFO - Type: GPU 07:55:54 INFO - Bus: Built-In 07:55:54 INFO - VRAM (Dynamic, Max): 1536 MB 07:55:54 INFO - Vendor: Intel (0x8086) 07:55:54 INFO - Device ID: 0x0a2e 07:55:54 INFO - Revision ID: 0x0009 07:55:54 INFO - Displays: 07:55:54 INFO - Display: 07:55:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:55:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:55:54 INFO - Display Serial Number: 1600x1200 60 07:55:54 INFO - Main Display: Yes 07:55:54 INFO - Mirror: Off 07:55:54 INFO - Online: Yes 07:55:54 INFO - Rotation: Supported 07:55:54 INFO - Return code: 0 07:55:54 INFO - Running post-action listener: _resource_record_post_action 07:55:54 INFO - [mozharness: 2016-12-15 15:55:54.666837Z] Finished run-tests step (success) 07:55:54 INFO - Running post-run listener: _resource_record_post_run 07:55:54 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 7283200; Write bytes: 548348928; Read time: 61; Write time: 1886 07:55:54 INFO - TinderboxPrint: CPU usage
54.0% 07:55:54 INFO - TinderboxPrint: I/O read bytes / time
7,283,200 / 61 07:55:54 INFO - TinderboxPrint: I/O write bytes / time
548,348,928 / 1,886 07:55:54 INFO - TinderboxPrint: CPU idle
2,210.2 (46.0%) 07:55:54 INFO - TinderboxPrint: CPU system
963.4 (20.0%) 07:55:54 INFO - TinderboxPrint: CPU user
1,632.1 (34.0%) 07:55:54 INFO - TinderboxPrint: Swap in / out
264,450,048 / 0 07:55:54 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 250132992; Write bytes: 250163200; Read time: 18102; Write time: 458 07:55:54 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 6947328; Write bytes: 296657920; Read time: 57; Write time: 1417 07:55:55 INFO - Running post-run listener: _upload_blobber_files 07:55:55 INFO - Blob upload gear active. 07:55:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:55:55 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 07:55:55 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'] 07:55:55 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 07:55:55 INFO - (blobuploader) - INFO - Open directory for files ... 07:55:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:55:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:55:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:55:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:55:56 INFO - (blobuploader) - INFO - Done attempting. 07:55:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:55:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:55:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:55:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:55:57 INFO - (blobuploader) - INFO - Done attempting. 07:55:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:55:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:55:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:55:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:55:59 INFO - (blobuploader) - INFO - Done attempting. 07:55:59 INFO - (blobuploader) - INFO - Iteration through files over. 07:55:59 INFO - Return code: 0 07:55:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:55:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:55:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/feed481ddafe4ccf340a70cb351312bbdefe0a1bda2d54d6e295fc06a961febe878b681c1f7e230b07bb3c4ba8d9ba8f0b75d7a037628b0ebeca4d1bccaeb9ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6fb550b3d148e4b9b43622f6d77415a29738d01d749520a635e8f15280f4d5267fc7f3481597474f10ebb67b328d5c08268ec078c49fc7db9ed3428ce46a3944", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28963be1297d9403cec79d02c8cc314d74d8c03dc59e99193a9701ea0caefaa81687de44b4ec053782971c73941765abadf246cc3681b97f6b81c3424c3e5e30"} 07:55:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:55:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:55:59 INFO - Contents: 07:55:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/feed481ddafe4ccf340a70cb351312bbdefe0a1bda2d54d6e295fc06a961febe878b681c1f7e230b07bb3c4ba8d9ba8f0b75d7a037628b0ebeca4d1bccaeb9ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6fb550b3d148e4b9b43622f6d77415a29738d01d749520a635e8f15280f4d5267fc7f3481597474f10ebb67b328d5c08268ec078c49fc7db9ed3428ce46a3944", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28963be1297d9403cec79d02c8cc314d74d8c03dc59e99193a9701ea0caefaa81687de44b4ec053782971c73941765abadf246cc3681b97f6b81c3424c3e5e30"} 07:55:59 INFO - Running post-run listener: copy_logs_to_upload_dir 07:55:59 INFO - Copying logs to upload dir... 07:55:59 INFO - mkdir: /builds/slave/test/build/upload/logs 07:55:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.456499 ========= master_lag: 0.64 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-12-15 07:56:00.149490) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 07:56:00.152538) ========= 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.61W9oSw1M0/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.f6fCL9t30p/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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/feed481ddafe4ccf340a70cb351312bbdefe0a1bda2d54d6e295fc06a961febe878b681c1f7e230b07bb3c4ba8d9ba8f0b75d7a037628b0ebeca4d1bccaeb9ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6fb550b3d148e4b9b43622f6d77415a29738d01d749520a635e8f15280f4d5267fc7f3481597474f10ebb67b328d5c08268ec078c49fc7db9ed3428ce46a3944", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28963be1297d9403cec79d02c8cc314d74d8c03dc59e99193a9701ea0caefaa81687de44b4ec053782971c73941765abadf246cc3681b97f6b81c3424c3e5e30"} build_url:https://queue.taskcluster.net/v1/task/TpmcBWTXRB-LT13Sfcb_ZA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011300 build_url: 'https://queue.taskcluster.net/v1/task/TpmcBWTXRB-LT13Sfcb_ZA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/feed481ddafe4ccf340a70cb351312bbdefe0a1bda2d54d6e295fc06a961febe878b681c1f7e230b07bb3c4ba8d9ba8f0b75d7a037628b0ebeca4d1bccaeb9ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6fb550b3d148e4b9b43622f6d77415a29738d01d749520a635e8f15280f4d5267fc7f3481597474f10ebb67b328d5c08268ec078c49fc7db9ed3428ce46a3944", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28963be1297d9403cec79d02c8cc314d74d8c03dc59e99193a9701ea0caefaa81687de44b4ec053782971c73941765abadf246cc3681b97f6b81c3424c3e5e30"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 07:56:00.191356) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-12-15 07:56:00.191642) ========= 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.61W9oSw1M0/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.f6fCL9t30p/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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.005244 ========= master_lag: 3.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-12-15 07:56:03.268090) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 07:56:03.268410) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 07:56:03.630435) ========= ========= Total master_lag: 6.85 =========