builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0304 starttime: 1481921480.0 results: success (0) buildid: 20161216103349 builduid: a371b3e3cbe04a95a11132e578c7a546 revision: a6b011d7c489a9db2aa1d8118d6fced23c62a7bf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-16 12:51:20.004412) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-16 12:51:20.004877) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-16 12:51:20.005169) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-16 12:51:20.029856) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 12:51:20.030245) ========= 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.5W3zUCroH1/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.Irr11I3BM0/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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-16 12:51:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 31.6M=0s 2016-12-16 12:51:20 (31.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087198 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 12:51:20.140732) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 12:51:20.141056) ========= 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.5W3zUCroH1/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.Irr11I3BM0/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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.020154 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 12:51:20.189922) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-16 12:51:20.190285) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a6b011d7c489a9db2aa1d8118d6fced23c62a7bf --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a6b011d7c489a9db2aa1d8118d6fced23c62a7bf --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5W3zUCroH1/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.Irr11I3BM0/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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-16 12:51:20,267 truncating revision to first 12 chars 2016-12-16 12:51:20,267 Setting DEBUG logging. 2016-12-16 12:51:20,267 attempt 1/10 2016-12-16 12:51:20,267 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a6b011d7c489?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-16 12:51:22,049 unpacking tar archive at: mozilla-beta-a6b011d7c489/testing/mozharness/ program finished with exit code 0 elapsedTime=2.073389 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-16 12:51:22.286972) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-16 12:51:22.287306) ========= script_repo_revision: a6b011d7c489a9db2aa1d8118d6fced23c62a7bf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-16 12:51:22.287686) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-16 12:51:22.287952) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-16 12:51:22.307663) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-12-16 12:51:22.308058) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5W3zUCroH1/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.Irr11I3BM0/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 12:51:22 INFO - MultiFileLogger online at 20161216 12:51:22 in /builds/slave/test 12:51:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:51:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:51:22 INFO - {'append_to_log': False, 12:51:22 INFO - 'base_work_dir': '/builds/slave/test', 12:51:22 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:51:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:51:22 INFO - 'branch': 'Mozilla-Beta', 12:51:22 INFO - 'buildbot_json_path': 'buildprops.json', 12:51:22 INFO - 'config_files': ('talos/mac_config.py',), 12:51:22 INFO - 'default_actions': ('clobber', 12:51:22 INFO - 'read-buildbot-config', 12:51:22 INFO - 'download-and-extract', 12:51:22 INFO - 'populate-webroot', 12:51:22 INFO - 'create-virtualenv', 12:51:22 INFO - 'install', 12:51:22 INFO - 'run-tests'), 12:51:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:51:22 INFO - 'download_minidump_stackwalk': True, 12:51:22 INFO - 'download_symbols': 'ondemand', 12:51:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:51:22 INFO - 'tooltool.py': '/tools/tooltool.py', 12:51:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:51:22 INFO - '/tools/misc-python/virtualenv.py')}, 12:51:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:51:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:51:22 INFO - 'installer_path': 'installer.exe', 12:51:22 INFO - 'log_level': 'info', 12:51:22 INFO - 'log_name': 'talos', 12:51:22 INFO - 'log_to_console': True, 12:51:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:51:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:51:22 INFO - 'opt_config_files': (), 12:51:22 INFO - 'pip_index': False, 12:51:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:51:22 INFO - 'cmd': ('bash', 12:51:22 INFO - '-c', 12:51:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:51:22 INFO - 'enabled': True, 12:51:22 INFO - 'halt_on_failure': False, 12:51:22 INFO - 'name': 'check_screen_resolution'},), 12:51:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:51:22 INFO - 'cmd': ('bash', 12:51:22 INFO - '-c', 12:51:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:51:22 INFO - 'enabled': True, 12:51:22 INFO - 'halt_on_failure': False, 12:51:22 INFO - 'name': 'check_screen_resolution'},), 12:51:22 INFO - 'run_cmd_checks_enabled': True, 12:51:22 INFO - 'sps_profile': False, 12:51:22 INFO - 'sps_profile_interval': 0, 12:51:22 INFO - 'suite': 'dromaeojs', 12:51:22 INFO - 'system_bits': '32', 12:51:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:51:22 INFO - 'title': 't-yosemite-r7-0304', 12:51:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:51:22 INFO - 'use_talos_json': True, 12:51:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:51:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:51:22 INFO - 'work_dir': 'build'} 12:51:22 INFO - [mozharness: 2016-12-16 20:51:22.499466Z] Running clobber step. 12:51:22 INFO - Running pre-action listener: _resource_record_pre_action 12:51:22 INFO - Running main action method: clobber 12:51:22 INFO - rmtree: /builds/slave/test/build 12:51:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:51:24 INFO - Running post-action listener: _resource_record_post_action 12:51:24 INFO - [mozharness: 2016-12-16 20:51:24.133421Z] Finished clobber step (success) 12:51:24 INFO - [mozharness: 2016-12-16 20:51:24.133575Z] Running read-buildbot-config step. 12:51:24 INFO - Running pre-action listener: _resource_record_pre_action 12:51:24 INFO - Running main action method: read_buildbot_config 12:51:24 INFO - Using buildbot properties: 12:51:24 INFO - { 12:51:24 INFO - "project": "", 12:51:24 INFO - "product": "firefox", 12:51:24 INFO - "script_repo_revision": "production", 12:51:24 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 12:51:24 INFO - "repository": "", 12:51:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 12:51:24 INFO - "buildid": "20161216103349", 12:51:24 INFO - "pgo_build": "False", 12:51:24 INFO - "basedir": "/builds/slave/test", 12:51:24 INFO - "buildnumber": 85, 12:51:24 INFO - "slavename": "t-yosemite-r7-0304", 12:51:24 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 12:51:24 INFO - "platform": "yosemite_r7", 12:51:24 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 12:51:24 INFO - "branch": "mozilla-beta", 12:51:24 INFO - "repo_path": "releases/mozilla-beta", 12:51:24 INFO - "revision": "a6b011d7c489a9db2aa1d8118d6fced23c62a7bf", 12:51:24 INFO - "stage_platform": "macosx64", 12:51:24 INFO - "builduid": "a371b3e3cbe04a95a11132e578c7a546", 12:51:24 INFO - "slavebuilddir": "test" 12:51:24 INFO - } 12:51:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/H9zWEq1-QwGDRbWOahZt9g/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 12:51:24 INFO - Running post-action listener: _resource_record_post_action 12:51:24 INFO - [mozharness: 2016-12-16 20:51:24.136689Z] Finished read-buildbot-config step (success) 12:51:24 INFO - [mozharness: 2016-12-16 20:51:24.136799Z] Running download-and-extract step. 12:51:24 INFO - Running pre-action listener: _resource_record_pre_action 12:51:24 INFO - Running main action method: download_and_extract 12:51:24 INFO - mkdir: /builds/slave/test/build/tests 12:51: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')]} 12:51:24 INFO - trying https://queue.taskcluster.net/v1/task/H9zWEq1-QwGDRbWOahZt9g/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 12:51:24 INFO - Downloading https://queue.taskcluster.net/v1/task/H9zWEq1-QwGDRbWOahZt9g/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 12:51:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H9zWEq1-QwGDRbWOahZt9g/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 12:51:25 INFO - Downloaded 1165 bytes. 12:51:25 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 12:51:25 INFO - Using the following test package requirements: 12:51:25 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 12:51:25 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:51:25 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 12:51:25 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:51:25 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 12:51:25 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 12:51:25 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:51:25 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 12:51:25 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 12:51:25 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:51:25 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 12:51:25 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:51:25 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 12:51:25 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:51:25 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 12:51:25 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:51:25 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 12:51:25 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 12:51:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H9zWEq1-QwGDRbWOahZt9g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 12:51:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H9zWEq1-QwGDRbWOahZt9g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 12:51:25 INFO - Fetch https://queue.taskcluster.net/v1/task/H9zWEq1-QwGDRbWOahZt9g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 12:51:26 INFO - Expected file size: 16232589 12:51:33 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 12:51:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H9zWEq1-QwGDRbWOahZt9g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 12:51:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H9zWEq1-QwGDRbWOahZt9g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 12:51:33 INFO - Fetch https://queue.taskcluster.net/v1/task/H9zWEq1-QwGDRbWOahZt9g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 12:51:33 INFO - Expected file size: 16232589 12:51:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H9zWEq1-QwGDRbWOahZt9g/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 12:51:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H9zWEq1-QwGDRbWOahZt9g/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 12:51:40 INFO - Fetch https://queue.taskcluster.net/v1/task/H9zWEq1-QwGDRbWOahZt9g/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 12:51:40 INFO - Expected file size: 14414089 12:51: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')]} 12:51:41 INFO - trying https://queue.taskcluster.net/v1/task/H9zWEq1-QwGDRbWOahZt9g/artifacts/public/build/firefox-51.0.en-US.mac.dmg 12:51:41 INFO - Downloading https://queue.taskcluster.net/v1/task/H9zWEq1-QwGDRbWOahZt9g/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 12:51:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H9zWEq1-QwGDRbWOahZt9g/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 12:51:44 INFO - Downloaded 86031249 bytes. 12:51:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H9zWEq1-QwGDRbWOahZt9g/artifacts/public/build/firefox-51.0.en-US.mac.dmg 12:51:44 INFO - mkdir: /builds/slave/test/properties 12:51:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:51:44 INFO - Writing to file /builds/slave/test/properties/build_url 12:51:44 INFO - Contents: 12:51:44 INFO - build_url:https://queue.taskcluster.net/v1/task/H9zWEq1-QwGDRbWOahZt9g/artifacts/public/build/firefox-51.0.en-US.mac.dmg 12:51:45 INFO - Running post-action listener: _resource_record_post_action 12:51:45 INFO - Running post-action listener: set_extra_try_arguments 12:51:45 INFO - [mozharness: 2016-12-16 20:51:45.465347Z] Finished download-and-extract step (success) 12:51:45 INFO - [mozharness: 2016-12-16 20:51:45.465493Z] Running populate-webroot step. 12:51:45 INFO - Running pre-action listener: _resource_record_pre_action 12:51:45 INFO - Running main action method: populate_webroot 12:51:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:51:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:51:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:51:45 INFO - '--tppagecycles', 12:51:45 INFO - '7'], 12:51:45 INFO - 'tests': ['tsvgm']}}, 12:51:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:51:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:51:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:51:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:51:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:51:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:51:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:45 INFO - 'talos_options': ['--disable-e10s'], 12:51:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:51:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:51:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:45 INFO - 'talos_options': ['--disable-e10s'], 12:51:45 INFO - 'tests': ['damp', 'tps']}, 12:51:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:45 INFO - 'tests': ['damp', 'tps']}, 12:51:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:51:45 INFO - 'tests': ['dromaeo_dom']}, 12:51:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:51:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:51:45 INFO - 'tests': ['basic_compositor_video']}, 12:51:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:51:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:51:45 INFO - 'tests': ['a11yr', 12:51:45 INFO - 'ts_paint', 12:51:45 INFO - 'tpaint', 12:51:45 INFO - 'sessionrestore', 12:51:45 INFO - 'sessionrestore_no_auto_restore', 12:51:45 INFO - 'tabpaint']}, 12:51:45 INFO - 'other-e10s': {'tests': ['a11yr', 12:51:45 INFO - 'ts_paint', 12:51:45 INFO - 'tpaint', 12:51:45 INFO - 'sessionrestore', 12:51:45 INFO - 'sessionrestore_no_auto_restore', 12:51:45 INFO - 'tabpaint']}, 12:51:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:51:45 INFO - 'ts_paint', 12:51:45 INFO - 'tpaint', 12:51:45 INFO - 'sessionrestore', 12:51:45 INFO - 'sessionrestore_no_auto_restore', 12:51:45 INFO - 'tabpaint']}, 12:51:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:51:45 INFO - 'ts_paint', 12:51:45 INFO - 'tpaint', 12:51:45 INFO - 'sessionrestore', 12:51:45 INFO - 'sessionrestore_no_auto_restore', 12:51:45 INFO - 'tabpaint']}, 12:51:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:51:45 INFO - 'tests': ['a11yr', 12:51:45 INFO - 'ts_paint', 12:51:45 INFO - 'tpaint', 12:51:45 INFO - 'sessionrestore', 12:51:45 INFO - 'sessionrestore_no_auto_restore', 12:51:45 INFO - 'tabpaint']}, 12:51:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:51:45 INFO - 'tests': ['a11yr', 12:51:45 INFO - 'ts_paint', 12:51:45 INFO - 'tpaint', 12:51:45 INFO - 'sessionrestore', 12:51:45 INFO - 'sessionrestore_no_auto_restore', 12:51:45 INFO - 'tabpaint']}, 12:51:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:51:45 INFO - 'tests': ['tsvgx', 12:51:45 INFO - 'tsvgr_opacity', 12:51:45 INFO - 'tart', 12:51:45 INFO - 'tscrollx', 12:51:45 INFO - 'cart']}, 12:51:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:51:45 INFO - 'tsvgr_opacity', 12:51:45 INFO - 'tart', 12:51:45 INFO - 'tscrollx', 12:51:45 INFO - 'cart']}, 12:51:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:45 INFO - 'talos_options': ['--disable-e10s'], 12:51:45 INFO - 'tests': ['tp5o']}, 12:51:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:45 INFO - 'tests': ['tp5o']}, 12:51:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:45 INFO - 'talos_options': ['--disable-e10s', 12:51:45 INFO - '--xperf_path', 12:51:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:51:45 INFO - 'tests': ['tp5n']}, 12:51:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:45 INFO - 'talos_options': ['--xperf_path', 12:51:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:51:45 INFO - 'tests': ['tp5n']}}, 12:51:45 INFO - 'talos.zip': {'path': '', 12:51:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:51:45 INFO - Running post-action listener: _resource_record_post_action 12:51:45 INFO - [mozharness: 2016-12-16 20:51:45.484068Z] Finished populate-webroot step (success) 12:51:45 INFO - [mozharness: 2016-12-16 20:51:45.484177Z] Running create-virtualenv step. 12:51:45 INFO - Running pre-action listener: _resource_record_pre_action 12:51:45 INFO - Running main action method: create_virtualenv 12:51:45 INFO - Creating virtualenv /builds/slave/test/build/venv 12:51:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:51:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:51:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:51:45 INFO - Using real prefix '/tools/python27' 12:51:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:51:46 INFO - Installing distribute.............................................................................................................................................................................................done. 12:51:49 INFO - Installing pip.................done. 12:51:49 INFO - Return code: 0 12:51:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a572490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4e8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febc8d66360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a386d30>, '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 0x10a1ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a37eb20>, '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.5W3zUCroH1/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.Irr11I3BM0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:51:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:51:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5W3zUCroH1/Render', 12:51:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:49 INFO - 'HOME': '/Users/cltbld', 12:51:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:49 INFO - 'LOGNAME': 'cltbld', 12:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:49 INFO - 'MOZ_NO_REMOTE': '1', 12:51:49 INFO - 'NO_EM_RESTART': '1', 12:51:49 INFO - 'PAGER': '/bin/cat', 12:51:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:49 INFO - 'PWD': '/builds/slave/test', 12:51:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:49 INFO - 'SHELL': '/bin/bash', 12:51:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Irr11I3BM0/Listeners', 12:51:49 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 12:51:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:49 INFO - 'USER': 'cltbld', 12:51:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:49 INFO - 'XPC_FLAGS': '0x0', 12:51:49 INFO - 'XPC_SERVICE_NAME': '0', 12:51:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:51:49 INFO - Cleaning up... 12:51:49 INFO - Return code: 0 12:51:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a572490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4e8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febc8d66360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a386d30>, '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 0x10a1ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a37eb20>, '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.5W3zUCroH1/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.Irr11I3BM0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:51:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:51:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5W3zUCroH1/Render', 12:51:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:49 INFO - 'HOME': '/Users/cltbld', 12:51:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:49 INFO - 'LOGNAME': 'cltbld', 12:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:49 INFO - 'MOZ_NO_REMOTE': '1', 12:51:49 INFO - 'NO_EM_RESTART': '1', 12:51:49 INFO - 'PAGER': '/bin/cat', 12:51:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:49 INFO - 'PWD': '/builds/slave/test', 12:51:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:49 INFO - 'SHELL': '/bin/bash', 12:51:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Irr11I3BM0/Listeners', 12:51:49 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 12:51:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:49 INFO - 'USER': 'cltbld', 12:51:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:49 INFO - 'XPC_FLAGS': '0x0', 12:51:49 INFO - 'XPC_SERVICE_NAME': '0', 12:51:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:49 INFO - Downloading/unpacking psutil>=3.1.1 12:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:51:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:51:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:51:52 INFO - Installing collected packages: psutil 12:51:52 INFO - Running setup.py install for psutil 12:51:52 INFO - building 'psutil._psutil_osx' extension 12:51:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 12:51:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 12:51:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 12:51:53 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 12:51:53 INFO - building 'psutil._psutil_posix' extension 12:51:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 12:51:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:51:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:51:53 INFO - ^ 12:51:53 INFO - 1 warning generated. 12:51:53 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 12:51:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:51:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:51:53 INFO - Successfully installed psutil 12:51:53 INFO - Cleaning up... 12:51:53 INFO - Return code: 0 12:51:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:53 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 0x10a572490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4e8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febc8d66360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a386d30>, '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 0x10a1ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a37eb20>, '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.5W3zUCroH1/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.Irr11I3BM0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:51:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:51:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:51:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5W3zUCroH1/Render', 12:51:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:53 INFO - 'HOME': '/Users/cltbld', 12:51:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:53 INFO - 'LOGNAME': 'cltbld', 12:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:53 INFO - 'MOZ_NO_REMOTE': '1', 12:51:53 INFO - 'NO_EM_RESTART': '1', 12:51:53 INFO - 'PAGER': '/bin/cat', 12:51:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:53 INFO - 'PWD': '/builds/slave/test', 12:51:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:53 INFO - 'SHELL': '/bin/bash', 12:51:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Irr11I3BM0/Listeners', 12:51:53 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 12:51:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:53 INFO - 'USER': 'cltbld', 12:51:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:53 INFO - 'XPC_FLAGS': '0x0', 12:51:53 INFO - 'XPC_SERVICE_NAME': '0', 12:51:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:51:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:51:56 INFO - Installing collected packages: mozsystemmonitor 12:51:56 INFO - Running setup.py install for mozsystemmonitor 12:51:56 INFO - Successfully installed mozsystemmonitor 12:51:56 INFO - Cleaning up... 12:51:56 INFO - Return code: 0 12:51:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:51:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:56 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 0x10a572490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4e8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febc8d66360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a386d30>, '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 0x10a1ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a37eb20>, '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.5W3zUCroH1/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.Irr11I3BM0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:51:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:51:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:51:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5W3zUCroH1/Render', 12:51:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:56 INFO - 'HOME': '/Users/cltbld', 12:51:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:56 INFO - 'LOGNAME': 'cltbld', 12:51:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:56 INFO - 'MOZ_NO_REMOTE': '1', 12:51:56 INFO - 'NO_EM_RESTART': '1', 12:51:56 INFO - 'PAGER': '/bin/cat', 12:51:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:56 INFO - 'PWD': '/builds/slave/test', 12:51:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:56 INFO - 'SHELL': '/bin/bash', 12:51:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Irr11I3BM0/Listeners', 12:51:56 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 12:51:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:56 INFO - 'USER': 'cltbld', 12:51:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:56 INFO - 'XPC_FLAGS': '0x0', 12:51:56 INFO - 'XPC_SERVICE_NAME': '0', 12:51:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:57 INFO - Downloading/unpacking jsonschema==2.5.1 12:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:51:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:00 INFO - Downloading functools32-3.2.3-2.tar.gz 12:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:52:00 INFO - warning: no files found matching '*.txt' 12:52:00 INFO - no previously-included directories found matching 'build' 12:52:00 INFO - no previously-included directories found matching 'dist' 12:52:00 INFO - no previously-included directories found matching '.git*' 12:52:00 INFO - Installing collected packages: jsonschema, functools32 12:52:00 INFO - Running setup.py install for functools32 12:52:00 INFO - warning: no files found matching '*.txt' 12:52:00 INFO - no previously-included directories found matching 'build' 12:52:00 INFO - no previously-included directories found matching 'dist' 12:52:00 INFO - no previously-included directories found matching '.git*' 12:52:00 INFO - Successfully installed jsonschema functools32 12:52:00 INFO - Cleaning up... 12:52:00 INFO - Return code: 0 12:52:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:00 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 0x10a572490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4e8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febc8d66360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a386d30>, '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 0x10a1ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a37eb20>, '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.5W3zUCroH1/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.Irr11I3BM0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:52:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:52:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:52:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5W3zUCroH1/Render', 12:52:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:52:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:52:00 INFO - 'HOME': '/Users/cltbld', 12:52:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:52:00 INFO - 'LOGNAME': 'cltbld', 12:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:00 INFO - 'MOZ_NO_REMOTE': '1', 12:52:00 INFO - 'NO_EM_RESTART': '1', 12:52:00 INFO - 'PAGER': '/bin/cat', 12:52:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:00 INFO - 'PWD': '/builds/slave/test', 12:52:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:52:00 INFO - 'SHELL': '/bin/bash', 12:52:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Irr11I3BM0/Listeners', 12:52:00 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 12:52:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:52:00 INFO - 'USER': 'cltbld', 12:52:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:52:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:00 INFO - 'XPC_FLAGS': '0x0', 12:52:00 INFO - 'XPC_SERVICE_NAME': '0', 12:52:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:52:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:52:00 INFO - Cleaning up... 12:52:00 INFO - Return code: 0 12:52:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:00 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 0x10a572490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4e8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febc8d66360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a386d30>, '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 0x10a1ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a37eb20>, '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.5W3zUCroH1/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.Irr11I3BM0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:52:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:52:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:52:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5W3zUCroH1/Render', 12:52:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:52:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:52:00 INFO - 'HOME': '/Users/cltbld', 12:52:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:52:00 INFO - 'LOGNAME': 'cltbld', 12:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:00 INFO - 'MOZ_NO_REMOTE': '1', 12:52:00 INFO - 'NO_EM_RESTART': '1', 12:52:00 INFO - 'PAGER': '/bin/cat', 12:52:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:00 INFO - 'PWD': '/builds/slave/test', 12:52:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:52:00 INFO - 'SHELL': '/bin/bash', 12:52:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Irr11I3BM0/Listeners', 12:52:00 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 12:52:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:52:00 INFO - 'USER': 'cltbld', 12:52:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:52:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:00 INFO - 'XPC_FLAGS': '0x0', 12:52:00 INFO - 'XPC_SERVICE_NAME': '0', 12:52:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:52:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:01 INFO - Downloading/unpacking blobuploader==1.2.4 12:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:03 INFO - Downloading blobuploader-1.2.4.tar.gz 12:52:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:52:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:52:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:04 INFO - Downloading docopt-0.6.1.tar.gz 12:52:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:52:04 INFO - Installing collected packages: blobuploader, requests, docopt 12:52:04 INFO - Running setup.py install for blobuploader 12:52:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:52:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:52:05 INFO - Running setup.py install for requests 12:52:05 INFO - Running setup.py install for docopt 12:52:05 INFO - Successfully installed blobuploader requests docopt 12:52:05 INFO - Cleaning up... 12:52:05 INFO - Return code: 0 12:52:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:05 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 0x10a572490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4e8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febc8d66360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a386d30>, '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 0x10a1ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a37eb20>, '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.5W3zUCroH1/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.Irr11I3BM0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:52:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:52:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:52:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5W3zUCroH1/Render', 12:52:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:52:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:52:05 INFO - 'HOME': '/Users/cltbld', 12:52:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:52:05 INFO - 'LOGNAME': 'cltbld', 12:52:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:05 INFO - 'MOZ_NO_REMOTE': '1', 12:52:05 INFO - 'NO_EM_RESTART': '1', 12:52:05 INFO - 'PAGER': '/bin/cat', 12:52:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:52:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:05 INFO - 'PWD': '/builds/slave/test', 12:52:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:52:05 INFO - 'SHELL': '/bin/bash', 12:52:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Irr11I3BM0/Listeners', 12:52:05 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 12:52:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:52:05 INFO - 'USER': 'cltbld', 12:52:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:52:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:52:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:05 INFO - 'XPC_FLAGS': '0x0', 12:52:05 INFO - 'XPC_SERVICE_NAME': '0', 12:52:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:52:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:52:06 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-Qr6Won-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:52:06 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-R2hEj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:52:06 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-JHh4DO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:52:06 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-a1Zqny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:52:06 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-ifapa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:52:06 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-EwFRpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:52:06 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-rjkoAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:52:06 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-J61KGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:52:06 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-Ou2A2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:52:06 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-CCf1cQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:52:07 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-MZRkEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:52:07 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-CtfuHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:52:07 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-4p16WD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:52:07 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-qHOO9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:52:07 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-E0TqhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:52:07 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-eOR8QU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:52:07 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-rYb8al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:52:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:52:07 INFO - Running setup.py install for manifestparser 12:52:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:52:07 INFO - Running setup.py install for mozcrash 12:52:08 INFO - Running setup.py install for mozdebug 12:52:08 INFO - Running setup.py install for mozdevice 12:52:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:52:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:52:08 INFO - Running setup.py install for mozfile 12:52:08 INFO - Running setup.py install for mozhttpd 12:52:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:52:08 INFO - Running setup.py install for mozinfo 12:52:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:52:08 INFO - Running setup.py install for mozInstall 12:52:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:52:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:52:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:52:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:52:08 INFO - Running setup.py install for mozleak 12:52:09 INFO - Running setup.py install for mozlog 12:52:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:52:09 INFO - Running setup.py install for moznetwork 12:52:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:52:09 INFO - Running setup.py install for mozprocess 12:52:09 INFO - Running setup.py install for mozprofile 12:52:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:52:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:52:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:52:09 INFO - Running setup.py install for mozrunner 12:52:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:52:09 INFO - Running setup.py install for mozscreenshot 12:52:10 INFO - Running setup.py install for moztest 12:52:10 INFO - Running setup.py install for mozversion 12:52:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:52:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:52:10 INFO - Cleaning up... 12:52:10 INFO - Return code: 0 12:52:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:10 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 0x10a572490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4e8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febc8d66360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a386d30>, '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 0x10a1ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a37eb20>, '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.5W3zUCroH1/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.Irr11I3BM0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:52:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:52:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:52:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5W3zUCroH1/Render', 12:52:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:52:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:52:10 INFO - 'HOME': '/Users/cltbld', 12:52:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:52:10 INFO - 'LOGNAME': 'cltbld', 12:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:10 INFO - 'MOZ_NO_REMOTE': '1', 12:52:10 INFO - 'NO_EM_RESTART': '1', 12:52:10 INFO - 'PAGER': '/bin/cat', 12:52:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:10 INFO - 'PWD': '/builds/slave/test', 12:52:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:52:10 INFO - 'SHELL': '/bin/bash', 12:52:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Irr11I3BM0/Listeners', 12:52:10 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 12:52:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:52:10 INFO - 'USER': 'cltbld', 12:52:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:52:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:10 INFO - 'XPC_FLAGS': '0x0', 12:52:10 INFO - 'XPC_SERVICE_NAME': '0', 12:52:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:52:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:52:10 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-UgfTtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:52:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:52:10 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-auVwBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:52:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:52:10 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-xEkN2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:52:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:52:11 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-4oVVz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:52:11 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-klaU5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:52:11 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-wMuSh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:52:11 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-ctokYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:52:11 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-riKDZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:52:11 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-nHLK1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:52:11 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-GJdPGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:52:11 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-LDalM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:52:11 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-P9hADQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:52:11 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)) 12:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:52:11 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-GXHzfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:52:12 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-SXg9ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:52:12 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-qYWaju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:52:12 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-dA70U9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:52:12 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)) 12:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:52:12 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-3g38py-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:52:12 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:52:12 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:52:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:15 INFO - Downloading blessings-1.6.tar.gz 12:52:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:52:15 INFO - Installing collected packages: blessings 12:52:15 INFO - Running setup.py install for blessings 12:52:15 INFO - Successfully installed blessings 12:52:15 INFO - Cleaning up... 12:52:15 INFO - Return code: 0 12:52:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:52:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:52:15 INFO - Reading from file tmpfile_stdout 12:52:15 INFO - Current package versions: 12:52:15 INFO - blessings == 1.6 12:52:15 INFO - blobuploader == 1.2.4 12:52:15 INFO - docopt == 0.6.1 12:52:15 INFO - functools32 == 3.2.3-2 12:52:15 INFO - jsonschema == 2.5.1 12:52:15 INFO - manifestparser == 1.1 12:52:15 INFO - mozInstall == 1.12 12:52:15 INFO - mozcrash == 0.17 12:52:15 INFO - mozdebug == 0.1 12:52:15 INFO - mozdevice == 0.48 12:52:15 INFO - mozfile == 1.2 12:52:15 INFO - mozhttpd == 0.7 12:52:15 INFO - mozinfo == 0.9 12:52:15 INFO - mozleak == 0.1 12:52:15 INFO - mozlog == 3.4 12:52:15 INFO - moznetwork == 0.27 12:52:15 INFO - mozprocess == 0.23 12:52:15 INFO - mozprofile == 0.28 12:52:15 INFO - mozrunner == 6.12 12:52:15 INFO - mozscreenshot == 0.1 12:52:15 INFO - mozsystemmonitor == 0.3 12:52:15 INFO - moztest == 0.7 12:52:15 INFO - mozversion == 1.4 12:52:15 INFO - psutil == 3.1.1 12:52:15 INFO - requests == 1.2.3 12:52:15 INFO - wsgiref == 0.1.2 12:52:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:15 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 0x10a572490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4e8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febc8d66360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a386d30>, '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 0x10a1ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a37eb20>, '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.5W3zUCroH1/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.Irr11I3BM0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:52:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:52:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5W3zUCroH1/Render', 12:52:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:52:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:52:15 INFO - 'HOME': '/Users/cltbld', 12:52:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:52:15 INFO - 'LOGNAME': 'cltbld', 12:52:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:15 INFO - 'MOZ_NO_REMOTE': '1', 12:52:15 INFO - 'NO_EM_RESTART': '1', 12:52:15 INFO - 'PAGER': '/bin/cat', 12:52:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:52:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:15 INFO - 'PWD': '/builds/slave/test', 12:52:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:52:15 INFO - 'SHELL': '/bin/bash', 12:52:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Irr11I3BM0/Listeners', 12:52:15 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 12:52:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:52:15 INFO - 'USER': 'cltbld', 12:52:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:52:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:52:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:15 INFO - 'XPC_FLAGS': '0x0', 12:52:15 INFO - 'XPC_SERVICE_NAME': '0', 12:52:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:52:15 INFO - Cleaning up... 12:52:15 INFO - Return code: 0 12:52:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52: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')]} 12:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:16 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 0x10a572490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4e8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febc8d66360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a386d30>, '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 0x10a1ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a37eb20>, '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.5W3zUCroH1/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.Irr11I3BM0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:52:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:52:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5W3zUCroH1/Render', 12:52:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:52:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:52:16 INFO - 'HOME': '/Users/cltbld', 12:52:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:52:16 INFO - 'LOGNAME': 'cltbld', 12:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:16 INFO - 'MOZ_NO_REMOTE': '1', 12:52:16 INFO - 'NO_EM_RESTART': '1', 12:52:16 INFO - 'PAGER': '/bin/cat', 12:52:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:16 INFO - 'PWD': '/builds/slave/test', 12:52:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:52:16 INFO - 'SHELL': '/bin/bash', 12:52:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Irr11I3BM0/Listeners', 12:52:16 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 12:52:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:52:16 INFO - 'USER': 'cltbld', 12:52:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:52:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:16 INFO - 'XPC_FLAGS': '0x0', 12:52:16 INFO - 'XPC_SERVICE_NAME': '0', 12:52:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:52:16 INFO - Cleaning up... 12:52:16 INFO - Return code: 0 12:52:16 INFO - Running post-action listener: _resource_record_post_action 12:52:16 INFO - Running post-action listener: _start_resource_monitoring 12:52:16 INFO - Starting resource monitoring. 12:52:16 INFO - [mozharness: 2016-12-16 20:52:16.557212Z] Finished create-virtualenv step (success) 12:52:16 INFO - [mozharness: 2016-12-16 20:52:16.558174Z] Running install step. 12:52:16 INFO - Running pre-action listener: _resource_record_pre_action 12:52:16 INFO - Running main action method: install 12:52:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:52:16 INFO - Reading from file tmpfile_stdout 12:52:16 INFO - Detecting whether we're running mozinstall >=1.0... 12:52:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:52:16 INFO - Reading from file tmpfile_stdout 12:52:16 INFO - Output received: 12:52:16 INFO - Usage: mozinstall [options] installer 12:52:16 INFO - Options: 12:52:16 INFO - -h, --help show this help message and exit 12:52:16 INFO - -d DEST, --destination=DEST 12:52:16 INFO - Directory to install application into. [default: 12:52:16 INFO - "/builds/slave/test"] 12:52:16 INFO - --app=APP Application being installed. [default: firefox] 12:52:16 INFO - mkdir: /builds/slave/test/build/application 12:52:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 12:52:38 INFO - Reading from file tmpfile_stdout 12:52:38 INFO - Output received: 12:52:38 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 12:52:38 INFO - Running post-action listener: _resource_record_post_action 12:52:38 INFO - [mozharness: 2016-12-16 20:52:38.609950Z] Finished install step (success) 12:52:38 INFO - [mozharness: 2016-12-16 20:52:38.610132Z] Running run-tests step. 12:52:38 INFO - Running pre-action listener: _resource_record_pre_action 12:52:38 INFO - Running main action method: run_tests 12:52:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:52:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:52:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:52:38 INFO - 2016-12-16 12:52:38.625 screenresolution[1900:15373] starting screenresolution argv=screenresolution get 12:52:38 INFO - 2016-12-16 12:52:38.627 screenresolution[1900:15373] Display 0: 1600x1200x32@60 12:52:38 INFO - 2016-12-16 12:52:38.633 screenresolution[1901:15375] starting screenresolution argv=screenresolution list 12:52:38 INFO - Available Modes on Display 0 12:52:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:52:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:52:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:52:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:52:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:52:38 INFO - Intel Iris: 12:52:38 INFO - Chipset Model: Intel Iris 12:52:38 INFO - Type: GPU 12:52:38 INFO - Bus: Built-In 12:52:38 INFO - VRAM (Dynamic, Max): 1536 MB 12:52:38 INFO - Vendor: Intel (0x8086) 12:52:38 INFO - Device ID: 0x0a2e 12:52:38 INFO - Revision ID: 0x0009 12:52:38 INFO - Displays: 12:52:38 INFO - Display: 12:52:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:52:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:52:38 INFO - Display Serial Number: 1600x1200 60 12:52:38 INFO - Main Display: Yes 12:52:38 INFO - Mirror: Off 12:52:38 INFO - Online: Yes 12:52:38 INFO - Rotation: Supported 12:52:38 INFO - Return code: 0 12:52:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:52:38 INFO - Python 2.7.3 12:52:38 INFO - Return code: 0 12:52:38 INFO - grabbing minidump binary from tooltool 12:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:38 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 0x10a386d30>, '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 0x10a1ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a37eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:52:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:52:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 12:52:38 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:52:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:52:38 INFO - Return code: 0 12:52:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:52:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:52:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:52:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:52:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:52:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H9zWEq1-QwGDRbWOahZt9g/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0304', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H9zWEq1-QwGDRbWOahZt9g/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0304 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:52:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5W3zUCroH1/Render', 12:52:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:52:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:52:38 INFO - 'HOME': '/Users/cltbld', 12:52:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:52:38 INFO - 'LOGNAME': 'cltbld', 12:52:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:52:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:52:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:38 INFO - 'MOZ_NO_REMOTE': '1', 12:52:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:52:38 INFO - 'NO_EM_RESTART': '1', 12:52:38 INFO - 'PAGER': '/bin/cat', 12:52:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:52:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:38 INFO - 'PWD': '/builds/slave/test', 12:52:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:52:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:52:38 INFO - 'SHELL': '/bin/bash', 12:52:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Irr11I3BM0/Listeners', 12:52:38 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 12:52:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:52:38 INFO - 'USER': 'cltbld', 12:52:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:52:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:52:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:38 INFO - 'XPC_FLAGS': '0x0', 12:52:38 INFO - 'XPC_SERVICE_NAME': '0', 12:52:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:52:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H9zWEq1-QwGDRbWOahZt9g/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0304', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:52:39 INFO - mozversion application_buildid: 20161216103349 12:52:39 INFO - mozversion application_changeset: a6b011d7c489a9db2aa1d8118d6fced23c62a7bf 12:52:39 INFO - mozversion application_display_name: Firefox 12:52:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:52:39 INFO - mozversion application_name: Firefox 12:52:39 INFO - mozversion application_remotingname: firefox 12:52:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:52:39 INFO - mozversion application_vendor: Mozilla 12:52:39 INFO - mozversion application_version: 51.0 12:52:39 INFO - mozversion platform_buildid: 20161216103349 12:52:39 INFO - mozversion platform_changeset: a6b011d7c489a9db2aa1d8118d6fced23c62a7bf 12:52:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:52:39 INFO - mozversion platform_version: 51.0 12:52:39 INFO - using testdate: 1481921559 12:52:39 INFO - actual date: 1481921559 12:52:39 INFO - starting webserver on 'localhost:52427' 12:52:39 INFO - SUITE-START | Running 2 tests 12:52:39 INFO - TEST-START | dromaeo_css 12:52:39 INFO - operating with platform_type : mac_ 12:52:39 INFO - Initialising browser for dromaeo_css test... 12:52:39 INFO - TEST-INFO | started process 1911 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/tmp60a9pV/profile http://localhost:52427/getInfo.html) 12:52:41 INFO - PROCESS | 1911 | __metrics Screen width/height:1600/1200 12:52:41 INFO - PROCESS | 1911 | colorDepth:24 12:52:41 INFO - PROCESS | 1911 | Browser inner width/height: 1024/689 12:52:41 INFO - PROCESS | 1911 | __metrics 12:52:41 INFO - PROCESS | 1911 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:52:41 INFO - PROCESS | 1911 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:52:42 INFO - TEST-INFO | 1911: exit 0 12:52:42 INFO - Browser initialized. 12:52:42 INFO - Running cycle 1/1 for dromaeo_css test... 12:52:42 INFO - TEST-INFO | started process 1914 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/tmp60a9pV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:52:53 INFO - PROCESS | 1914 | RSS: Main: 168513536 12:52:53 INFO - PROCESS | 1914 | 12:53:45 INFO - PROCESS | 1914 | 1481921625038 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] 12:55:55 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:52427/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52427/tests/dromaeo/cssquery-ext.html) 12:55:57 INFO - PROCESS | 1914 | RSS: Main: 318308352 12:55:57 INFO - PROCESS | 1914 | 12:59:00 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:52427/tests/dromaeo/cssquery-ext.html (next: http://localhost:52427/tests/dromaeo/cssquery-jquery.html) 12:59:00 INFO - PROCESS | 1914 | RSS: Main: 300961792 12:59:00 INFO - PROCESS | 1914 | 13:02:02 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:52427/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52427/tests/dromaeo/cssquery-mootools.html) 13:02:03 INFO - PROCESS | 1914 | RSS: Main: 273764352 13:02:03 INFO - PROCESS | 1914 | 13:05:05 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:52427/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52427/tests/dromaeo/cssquery-prototype.html) 13:05:06 INFO - PROCESS | 1914 | RSS: Main: 270897152 13:05:06 INFO - PROCESS | 1914 | 13:08:09 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:52427/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52427/tests/dromaeo/cssquery-yui.html) 13:08:10 INFO - PROCESS | 1914 | RSS: Main: 269123584 13:08:10 INFO - PROCESS | 1914 | 13:11:13 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:52427/tests/dromaeo/cssquery-yui.html (next: http://localhost:52427/tests/dromaeo/cssquery-dojo.html) 13:11:13 INFO - PROCESS | 1914 | RSS: Main: 422846464 13:11:13 INFO - PROCESS | 1914 | 13:11:13 INFO - PROCESS | 1914 | __start_tp_report 13:11:13 INFO - PROCESS | 1914 | _x_x_mozilla_page_load 13:11:13 INFO - PROCESS | 1914 | _x_x_mozilla_page_load_details 13:11:13 INFO - PROCESS | 1914 | |i|pagename|runs| 13:11:13 INFO - PROCESS | 1914 | |0;dojo.html;3461.0482117417705;3461.896143115706;3487.895363139105;3509.2279698466327;3559.822008899556;5762.3949485304065;5905.114232865072;5913;5930.673812940292;5945.881082378355;5765.682887441189;5829.941700583004;5837;5932.11018347247;5940.613860099091;5308.0710875596715;5329.067413202693;5339.786408543673;5394.136938089907;5480.534154596864;5285.339332583427;5297.12597421425;5314.335708036496;5380.784768609251;5444.6188766786345;4455.2871540553515;4661.813527458915;5394.406615272317;5427.782888684448;5436.619436639437;5404.972975135139;5409.7295135243085;5420.512153906128;5424.457554244584;5425.02349577076;5228.581713462914;5283;5352.946470535284;5373.596980226499;5427.9185812212845;5742.454466825645;5745;5823.970880145572;5831.475167234969;5848.327442344143;6242.906356404657;6255.812325630239;6288.025356069817;6299.559030867841;6300.716467758962;6246.87506249877;6301.464375528039;6307.432331090224;6310.526710496685;6334.778282760081;5148.407933087743;5805.564582656233;5892.204552385373;5941.613795103304;6048.243969503856;6345.302016778151;6432.099506069154;6446;6468.6442245676935;6474.902876456857;6302.71637776292;6304.905426418607;6318.273398559132;6324.620522768649;6326.177596912372;6251.9687401562705;6301.653409062454;6304;6325.462335701517;6331.2085989251345;6204.937950620526;6272.560920735505;6283.5287353448675;6313;6361.2048493938255;6234.719437625317;6266.49868010558;6321.399467050623;6338.714757835908;6362.554621176566;5134.2298655201275;5143.691378517226;5149.253358263031;5157.226416037624;5163.741812909339;4149.8962525937095;4509.6843220974215;4537.909241815145;4551.908961820745;4591.288350305708;5949.970250148722;6033.637981721111;6046.848828779316;6078.270607527125;6082.604630699079;6231.1276421300145;6255.6872156392;6269.561130720897;6278.560500764994;6310.368963103745;5695.601307908407;5724.912266669319;5910.113482977587;6070.086985980606;6074.848128796815;5424.972875135678;5515.448455154453;5541.473560011793;5563.916541251884;5640.633358831663;5109.565686916654;6497.675116244263;6500.707468163944;6508.414242718272;6534.379233972765;6238.656873871981;6252.062190671254;6265.4361107500545;6282.1519094921605;6288.622682639057;6217.036359364306;6294.905576416449;6352.428281454507;6377.553571250153;6379.840503987438;6317.305096439296;6319.3364696706185;6332.556721029484;6335.65153916539;6346.3019067903415;6252.406021427957;6271.153394291712;6272.5922815016875;6286.654234017173;6305.117283580211;6137.039921714347;6140.228185505611;6194;6203.937960620517;6248.718807653758;6227.314995350417;6279.623222606659;6297.4017468340435;6303.810885673437;6314.747410103728;6169.321374648875;6189.752409903554;6191.318954914866;6213.254409470893;6218.595791273553;6075.2405949256345;6146.139540464428;6158.261008678987;6170.50635949132;6288.151099601495;5146.485351464824;6133.51829027926;6154.599951003171;6190;6191.25704915413 13:11:13 INFO - PROCESS | 1914 | |1;ext.html;461.2274440312478;484.907867505174;492.02578893790314;527.3987654074356;533.8718707510196;32532.349353012956;33420.997370078905;34941.301173976535;34965;35171.4724279136;43887.3416898746;45466;45536.77231613846;47953;48031.75984120083;10144.492775361221;10307.536160872742;10319.896801032006;10325.535350909227;10334.844977325347;9379.296552758537;10065.396076235413;10124.797504049915;10158.339707918962;10173.94913025434;9573.42559446432;12425.19236249641;12682.80975785364;12695.68260793483;12812.743745125092;12649.68375790608;12721.491140354376;12732.809007864937;12749.74500509994;12751.171173873761;12516.186447880858;12538.122331436804;12592.559260425842;12599.181053231603;12604.55884044054;43309.78345108286;43663.78168109171;43754.34368484475;43772.56227437749;43786.24855005796;3344.347852168828;3438.6905178534053;3468.3930312195266;3501.9474707879403;4332.263515202391;31224.531632025537;31253.843730781427;31290.843545782354;31671;32065.519017214527;3372.089535825338;3373.628900820908;3414.641462646411;3442.5008373785663;3505.5267538882435;530571;533373.3331333357;534690;536235;536293;35537.82231088828;35930.8203458981;36329.45505817362;66713.6664316685;67258.9911151333;37987;38172;38218.426723599165;38232.23535529274;38274.425883611766;15868.285927133307;16031.358745650277;16056.67886642284;16059.839401605834;16064.678706425806;13293.66765830862;13384.464621415034;13398;13406.195628262336;13414.195148290939;7725.536467811837;7886.132525422199;7896.131425543185;8398.706045288385;8444.155584441507;3191.361727654432;3249.675032496779;3331.133905184621;3432.6052503962364;3437.4671925851535;733.9155997060407;1000.1598657128047;1036.3522798251092;1080.330195278932;1106.9557217711201;31388.372232555223;31831;31838.681613184035;32236;32552.674473254963;1078.8435676826816;1111.0611533254387;1148.8851114888444;1165.7501023025643;1177.2936238256978;16308.592285192964;16659.916700416663;16715.832841671672;16758.832411675972;16967.236474358437;725560;730157;731072;731928;732269;55184.17223741647;63539.6823015882;64317.67841160858;64411.355886440535;64600.38499037562;1317.4203350525738;1401.3833913078213;1402.207752619787;1439.7264519741216;1451.3033743802823;31551.84224078865;33336.33327333488;33398;33532.66467335393;34215.144621384665;53947.46052539424;54628;54690.453095470126;54824.72587637196;54863;591889;596077;665042;790763;809477;27623.447531048863;28881.711182888743;28960;29016.839326426707;29031.56452653254;49016.50983490262;49163.754181230295;49466.01067978692;49549.75225123851;49741.50258497513;36526.90419287426;39962;40697.79651101726;42032;42838.78580607202;40794.592054079076;41038.79480602578;41326;42608.5739142617;42665.14669706526;32646.83676581602;38845.02887427724;39438;39712.80143599264;40430.595694042684;27393.178204653894;34768.47847282344;35839.64160358363;35934.460983085795;36013.81993090018;26699.866500668148;26870.731292687604;26915.192544222922;27006.919723210853;27009 13:11:13 INFO - PROCESS | 1914 | |2;jquery.html;380.34010990930733;388.6871068789623;388.7550842968929;396.9980150099249;418.55214920035553;20674.6898796518;20901.372958811222;22042.88978555105;22184.667229991563;22185.223517176903;21269.57460850786;21727.804970726604;21875;22362.10551577939;22537;5978.4918281945975;6356.173697419329;6357.523185761086;6386.2655794583525;6392.264889537693;5931.88136237275;6189.783357582485;6255.40573645503;6256.09286653435;6404.135441715379;6312.274088479815;6317.24193096829;6317.810465686037;6320.273168585602;6323.272823625296;6072.908906366386;6273.3726627337355;6343.873122537523;6350.428461438447;6359.904601430959;5185.766640501187;5691.260136182311;6182.1345011698395;6185.721642526097;6189.81430557084;13959.302034898214;13995.930020349935;14224;14229.217393043482;14231.501897433644;2139.4330502416874;2335.427820184049;2383.880805959695;2453.4234454903085;2574.4207553300544;10420;11008.944955275172;11494.482748276349;13365.465381384733;15577.143257120853;1950.9024548772504;1951.4048215294329;1953.3749200255925;2004.9298274560467;2020.2424090965887;106689.46655266751;107975.92024079738;113315;117020.41489792582;124560;9657.90342096584;10030.29787914839;10312.535935882903;10407.739806504747;11568.88431115695;12659.810102848465;12768.74462510763;12773.489060437665;12774.68063298425;12778.808317875239;6958.826029349307;8429.831403371898;8581.27059199975;8647.956760216284;8682;9060.093990601019;9065.184133428023;9079.636814527477;9108.635654573874;9245.676401325922;3999.0402303447545;4027.5368332641533;4033.072393349546;4088.652464540488;4103.261412945699;1923.6630541773613;1928.9421317360502;1931.0399944056794;1956.5695546979925;1998.4604156877563;854.645322191296;891.4651209274383;946.4463288975888;963.5856581669949;1019.2508506247901;20533.691994620094;21473.248436304966;21572.029258683397;22059.89700514968;22131.668024979637;879.6437442835662;990.5393991793851;991.980160396788;1002.9097381235724;1051.8579991701022;10210.030047145508;10840.837387439195;10988.780224395467;11495.310281383145;11697.76604467906;624530;642680;650898;656587;656885;133310;135405;146374;149853;154483.68274475893;439.9032212913154;463.9048994956026;464.7165229210179;465.3694244298926;468.76093192471404;11096.833547496633;11244.212905096565;11698.590549330733;11864.644060678194;12057.638270851889;52306.47693523168;55872.72063639656;56535.71732141313;56733.432665672815;58864.70567647134;79838;81347;82293.3541329158;83720;88488;8286.58567071656;8369.0375606806;8651.740447786577;8710.259627931697;8756;12598.55905043319;13437.596872093462;13510.256935868621;13747.175169489863;13976.790348144583;11597.6520704379;11642.53429862796;11766.764664706829;12023.75952480963;12027;9457.810843782949;11287.661370158909;11422.428878555873;11630;11683.474243658886;10086.949565252127;11668.358240296866;11792.05663546897;12082.395880205779;12106.697332566757;8454.535000575028;8478.660853565789;8479.872801907853;8808.11918808114;8824.294056475595;11537.942310288396;11558.826617600575;11721.882781172078;11802.291862488279;11870.762584748429 13:11:13 INFO - PROCESS | 1914 | |3;mootools.html;1373.6977864869737;1527.595187275372;1561.0009593859932;1756.841884230419;1912.8565357598184;8125.2281033301815;8658.350623703216;8960.775980600489;9175.770605734844;9207;9066.909330906688;9158.58786354614;9165.77085572861;9169.083091690827;9185.448873067604;2433.86613736244;2468.0004598137693;2468.6420469031978;2469.6665950096776;2469.777720005199;2396.928092157238;2461.0155937624913;2461.6307553866886;2461.79074778644;2464.2730394533564;2417.9758202418016;2437.4393889405446;2450.3016640257442;2454.361865914866;2455.5457240410583;2383.285014495662;2396.18529699902;2401.927942161738;2405.230326295586;2411.819113566472;2332.755060718617;2359.634256690216;2378.2389635316704;2383.1897154967396;2394.2458125690528;8966.955165224197;9161.587728552164;9277.628894844198;9310.301727370474;9310.767230819283;5393.541548968343;5625.746841392147;5628.352739434977;5629.408912064257;5642.943570564283;3663;3700.833462494167;3719.702423806089;3773.2453509298252;3791.4312853071983;1121.2599684208465;1121.725177331559;1126.442411006557;1138.5332013874272;1148.2019996102713;12172.208806427554;12183.756324873542;12259.570915018021;12281.631551053482;12293;4537.387452693844;4621.30680397943;4733.644976626767;4736.597389221886;4811.78346974387;9569.138777510057;9573.32986690925;9574.712758617252;9580.808383832424;9583.089606487372;5472.015037293246;5480.3971563128025;5487.560995120461;5488.313960754906;5490;4640.396748422683;4778.450478195052;4895.828645997373;5083.161278389099;5144.562712169508;4084.4281800547947;4119.299719047769;4222.493300803923;4254.149444991439;4267.16790225903;1297.54585894936;1318.5187406596715;1320.5246111399888;1329.3884812985941;1336.9331533423485;916.5417291354323;926.8702381666573;949.1220620925616;957.30595318395;966.4587830814767;5758.712064396847;5881.5882888198275;5906.143609176731;6110.175126357974;6210.9068363974575;462.64607575204997;463.25184826505625;468.657879747786;469.6031853084207;472.5439950447766;4003.8999025024023;4025.7584544926813;4041.1715598302276;4044.6966477513715;4056.533498647634;9431.811363772686;10701.464926753632;11116.722081948015;11130.777384452427;11142.888571114347;9168.954155229181;10981.725456863642;11000;11039;11050.557977680963;8062.55655938929;8413.621387037598;8426.789330266793;8506.106858779864;8526.232639062515;6048.516118710405;6070.969645151746;6116.052011938156;6135.417135372132;6136.570440069152;10223.7444063899;10480.68557943263;10498;10502.317349372266;10507.159427245955;10045.196384289093;10582.629607963685;10596.576136954744;10613.787724245318;10613.787724245318;7181.030560874424;7387.852242955219;7388.741394051182;7790.961045194737;7916.722914697958;8056.556889370906;8133.471324363897;8144.470609410369;8394.87407688873;8605.526696031779;7573.318401343906;7804.375649948104;7815.570143641927;7914.564698941614;7947.562884041433;6361.236651601837;7526.32263096324;7685.23147685227;7708.922910770821;7714.768556943076;6161.815145545641;6222.719977600928;6935.716892374927;7155.534890232118;7297.562146271029;5042.663694120987;5057.721825299496;5069.377799104252;5250.501202385767;5353.357597088374;5123.103456895103;5142.820001299937;5150.630709873501;5172.7413629319135;5222.112240918977 13:11:13 INFO - PROCESS | 1914 | |4;prototype.html;279.82790583790967;315.73320544140194;318.47928636679023;321.8487310963846;327.2603915151756;4954.1330267203275;5322.494363035516;5421.322334708161;5479.643823151498;5490.643108197969;4343.087951530175;4859.209816343258;5309.0709125903;5372.206452644622;5420.4850539198715;3369.848356823949;3915.3343931531567;3920.7255492115564;3936.724429289951;4154.854580089697;4119.279126152926;4124.175164967003;4127.596617150169;4128.0299129704645;4209.600087991651;4073.4704488416464;4085.611866872657;4108.609682080212;4119.979400102995;4121;3296.7362610991063;3926.8625598104213;4095.344744840826;4108.856190033364;4122.319817230168;2648.6556747622685;3222.3716375306826;3513.49054387115;3537.168765340143;3537.3102245062223;4667.953320466786;5225.843224703265;5230.947690523122;5254.947450525484;5312.574994000471;3383.5432216650684;4694.0611877624615;4695.741734204617;4717.127331443659;4720.527947205286;5643.871225754824;5657.6322539035245;5658.981383350995;5660.160447854422;5662.688552129631;3884.679209068902;3897.4153876918404;3909.6872250219913;3909.843606255746;3916.060145565072;5781.768729250825;5964.314103878023;5966.612170208966;6015.578909476339;6042.577019608585;3898.3567711327314;3937.468441760383;3943.5859234779937;3949.269385163754;3954.090559171349;4003.479547658844;4010.27814993304;4022.6982976276895;4039.171969746195;4068.450759147477;4592.747398893026;4655.697379670379;4673.275642275453;4697.78859951303;4702.177119004229;4691.483936766953;5378.3058336623835;5548.528375088082;5709;5791.536677065825;1248.7075876467993;1302.2251760202664;1333.7599232138114;1370.787527933172;1372.4510195921512;752.751591974647;780.6487080813656;801.9719309824245;820.4625969989667;843.8945131858518;5180.818671346485;5280.310300703738;5444.869200209816;5466.972665136728;5486.216979481685;4450.46594408673;5834.824955251349;5870.765169393177;5892.528597712173;5911.083782013795;5201.45384734605;5390.434004429557;5436.483534064258;5446.91829622556;5476.67139971603;2781.9443611127663;2848.686644469107;2855.8148368427287;3057.4496590613903;3059.0669845697275;6013.398660133952;6038.63768173911;6042.909356359658;6046.788362407295;6075.817725468155;5451.67447856807;5604.97197514018;5928.7332070056955;5933.495652869555;5983.611065280743;5657.67044744493;6016.578839481369;6034.2155519782145;6071.51427885768;6108.938910610926;4509.376624415274;4963.528464795839;5236.842894713165;5768.480836724715;5859.677717725566;5703.800366987136;5712.428757124254;5731.455511726379;5733;5741.0767392923835;4770.7853146607795;5146.867689108391;5638.577106716931;5768.451997060272;5981.342052374148;3870.903227419337;3897.7466464679705;3974.9591562455325;4102.384642303678;4169.624733773853;4322.330038843984;4871.902561948812;5670.149477578396;5897.228302697725;5910.349861515316;5130.922506273575;5351.441291541081;5756.971215143897;5789.1895134680335;5830.358660547421;4981.352424184977;5221.128379391395;5308.946910530845;5769.509591684754;5798.739056742373;5294.326365185557;5466.2620546227345;5634.690092044813;5646.475451627955;5655.236543066633;4735.21868891629;4766.523347665206;4907.68100073494;5541.168824676331;5634.971825140848;5100.826809833833;5255.500727430888;5632.324121105494;5634.295713035871;5650.180723794944 13:11:13 INFO - PROCESS | 1914 | |5;yui.html;725.1805459830391;801.6232370785729;808.4744915804727;825.1130035212146;870.7997160653053;16137;16756.748648770277;17301.221445035004;17335.39326123586;17589.648207035883;15718.528444146694;15934.920325398385;15940.760888586681;15944.760828587581;15967.121808300539;717.3436305780205;736.3262614707563;888.7511496780879;899.6131663384742;901.0133903375826;884.1865483754929;903.408267584733;919.7470695558742;921.1433366968716;921.6083164655029;968.1480297338368;970.7718686108759;970.9029097090305;973.2797729680021;978.2027647467291;964.5081008685551;966.2511553545988;966.5843687214496;967.1778987860368;967.9225661947028;710.449401713676;710.9217986021533;710.9822254443628;712.3339677401646;714.4784307455535;15859.048457092496;15967.962082464603;16065.91967040169;16072;16090.5977350566;13638.795418068737;13647.249401282925;13660.248686322248;14224.857751422456;15668;13251.204927704368;13358.933205334008;13586.25275609841;13729.519466818614;13750.724985500334;4622.474722393245;4750.691205071694;4845.53967373099;4858.246971719389;4869.902601947942;115979;117734.41132794367;119760;120329;121739.3913030438;11383.715407114889;11395.829062564067;11529.596464123715;11536.480858361394;11565.653030409101;21952.231671891408;22048;22057.558848822933;22100.447488812908;22101;6582.341765823379;8077.838443231102;8099.109097999215;8103.230193131643;8112;4476.216662084123;4560.429946256718;4580.725156490621;4614.238650622609;4721.7403042832975;3546;3643.3441980443245;3644.908877278089;3652.086978255436;3666.8533258669354;567.2059117235902;655.1744801549986;663.9867202656017;664.1631544254275;664.3356643356643;597.3429227849331;615.2340336281359;634.787346239015;660.7059858363078;673.1451057157383;9121.90878091224;9284.350095493386;9300.767480812898;9320.30097742672;9341.392809467363;536.6404508978993;576.8903908257417;641.425923798198;677.8745932002595;682.0281099433288;4221.788045558718;4762.857114286577;4791.664583479123;4906.779194936236;4923.876903077452;94307;132404;143861;150021;150168;102042.48978755058;134767;138083.30958345145;139934;140512.461565383;109577;111783;113629.86370136357;116149.8385016156;116535.41732291284;9482.620695172116;10013.6486587092;10051.648192313527;10199.643012494527;10354.378737275787;50709;58696;64495.677521612095;65821;68980.3101968994;67533.31166720872;71310;81788;91013;97765;13918.443262269397;13973.510927117502;14043.1574105554;14108.858911411166;14221.715565688835;14545.709085818437;15341.923290383476;15472.690546189238;15617.141057241506;16050.753370341185;13760.31198440094;14679.70640587161;15032.924835375754;15314.310856011283;15529.45646902353;14381.568552943429;14408.639784005483;14712.705745885236;14848.85151148518;15005.949583529049;12127.696807579528;12367.93816030914;13396.988037701061;13410.061295709207;13983.295217261852;11283.830742538705;11356.94321528387;11610.477528511068;12101.443854268044;12106.213096148722;11140.944295278472;11771.293722376684;12271.877281227073;12281.69295767613;12369.752604947671 13:11:13 INFO - PROCESS | 1914 | __end_tp_report 13:11:13 INFO - PROCESS | 1914 | __start_cc_report 13:11:13 INFO - PROCESS | 1914 | _x_x_mozilla_cycle_collect,1413 13:11:13 INFO - PROCESS | 1914 | __end_cc_report 13:11:13 INFO - PROCESS | 1914 | __startTimestamp1481922673434__endTimestamp 13:11:13 INFO - PROCESS | 1914 | 13:11:13 INFO - PROCESS | 1914 | ------- Summary: start ------- 13:11:13 INFO - PROCESS | 1914 | Number of tests: 6 13:11:13 INFO - PROCESS | 1914 | 13:11:13 INFO - PROCESS | 1914 | [#0] dojo.html Cycles:165 Average:5853.24 Median:6154.60 stddev:646.56 (10.5%) stddev-sans-first:620.71 13:11:13 INFO - PROCESS | 1914 | Values: 3461.0 3461.9 3487.9 3509.2 3559.8 5762.4 5905.1 5913.0 5930.7 5945.9 5765.7 5829.9 5837.0 5932.1 5940.6 5308.1 5329.1 5339.8 5394.1 5480.5 5285.3 5297.1 5314.3 5380.8 5444.6 4455.3 4661.8 5394.4 5427.8 5436.6 5405.0 5409.7 5420.5 5424.5 5425.0 5228.6 5283.0 5352.9 5373.6 5427.9 5742.5 5745.0 5824.0 5831.5 5848.3 6242.9 6255.8 6288.0 6299.6 6300.7 6246.9 6301.5 6307.4 6310.5 6334.8 5148.4 5805.6 5892.2 5941.6 6048.2 6345.3 6432.1 6446.0 6468.6 6474.9 6302.7 6304.9 6318.3 6324.6 6326.2 6252.0 6301.7 6304.0 6325.5 6331.2 6204.9 6272.6 6283.5 6313.0 6361.2 6234.7 6266.5 6321.4 6338.7 6362.6 5134.2 5143.7 5149.3 5157.2 5163.7 4149.9 4509.7 4537.9 4551.9 4591.3 5950.0 6033.6 6046.8 6078.3 6082.6 6231.1 6255.7 6269.6 6278.6 6310.4 5695.6 5724.9 5910.1 6070.1 6074.8 5425.0 5515.4 5541.5 5563.9 5640.6 5109.6 6497.7 6500.7 6508.4 6534.4 6238.7 6252.1 6265.4 6282.2 6288.6 6217.0 6294.9 6352.4 6377.6 6379.8 6317.3 6319.3 6332.6 6335.7 6346.3 6252.4 6271.2 6272.6 6286.7 6305.1 6137.0 6140.2 6194.0 6203.9 6248.7 6227.3 6279.6 6297.4 6303.8 6314.7 6169.3 6189.8 6191.3 6213.3 6218.6 6075.2 6146.1 6158.3 6170.5 6288.2 5146.5 6133.5 6154.6 6190.0 6191.3 13:11:13 INFO - PROCESS | 1914 | 13:11:13 INFO - PROCESS | 1914 | [#1] ext.html Cycles:180 Average:76798.94 Median:3440.60 stddev:177088.74 (5147.0%) stddev-sans-first:177492.76 13:11:13 INFO - PROCESS | 1914 | Values: 461.2 484.9 492.0 527.4 533.9 32532.3 33421.0 34941.3 34965.0 35171.5 43887.3 45466.0 45536.8 47953.0 48031.8 10144.5 10307.5 10319.9 10325.5 10334.8 9379.3 10065.4 10124.8 10158.3 10173.9 9573.4 12425.2 12682.8 12695.7 12812.7 12649.7 12721.5 12732.8 12749.7 12751.2 12516.2 12538.1 12592.6 12599.2 12604.6 43309.8 43663.8 43754.3 43772.6 43786.2 3344.3 3438.7 3468.4 3501.9 4332.3 31224.5 31253.8 31290.8 31671.0 32065.5 3372.1 3373.6 3414.6 3442.5 3505.5 530571.0 533373.3 534690.0 536235.0 536293.0 35537.8 35930.8 36329.5 66713.7 67259.0 37987.0 38172.0 38218.4 38232.2 38274.4 15868.3 16031.4 16056.7 16059.8 16064.7 13293.7 13384.5 13398.0 13406.2 13414.2 7725.5 7886.1 7896.1 8398.7 8444.2 3191.4 3249.7 3331.1 3432.6 3437.5 733.9 1000.2 1036.4 1080.3 1107.0 31388.4 31831.0 31838.7 32236.0 32552.7 1078.8 1111.1 1148.9 1165.8 1177.3 16308.6 16659.9 16715.8 16758.8 16967.2 725560.0 730157.0 731072.0 731928.0 732269.0 55184.2 63539.7 64317.7 64411.4 64600.4 1317.4 1401.4 1402.2 1439.7 1451.3 31551.8 33336.3 33398.0 33532.7 34215.1 53947.5 54628.0 54690.5 54824.7 54863.0 591889.0 596077.0 665042.0 790763.0 809477.0 27623.4 28881.7 28960.0 29016.8 29031.6 49016.5 49163.8 49466.0 49549.8 49741.5 36526.9 39962.0 40697.8 42032.0 42838.8 40794.6 41038.8 41326.0 42608.6 42665.1 32646.8 38845.0 39438.0 39712.8 40430.6 27393.2 34768.5 35839.6 35934.5 36013.8 26699.9 26870.7 26915.2 27006.9 27009.0 13:11:13 INFO - PROCESS | 1914 | 13:11:13 INFO - PROCESS | 1914 | [#2] jquery.html Cycles:180 Average:36637.81 Median:22449.55 stddev:107918.27 (480.7%) stddev-sans-first:108186.67 13:11:13 INFO - PROCESS | 1914 | Values: 380.3 388.7 388.8 397.0 418.6 20674.7 20901.4 22042.9 22184.7 22185.2 21269.6 21727.8 21875.0 22362.1 22537.0 5978.5 6356.2 6357.5 6386.3 6392.3 5931.9 6189.8 6255.4 6256.1 6404.1 6312.3 6317.2 6317.8 6320.3 6323.3 6072.9 6273.4 6343.9 6350.4 6359.9 5185.8 5691.3 6182.1 6185.7 6189.8 13959.3 13995.9 14224.0 14229.2 14231.5 2139.4 2335.4 2383.9 2453.4 2574.4 10420.0 11008.9 11494.5 13365.5 15577.1 1950.9 1951.4 1953.4 2004.9 2020.2 106689.5 107975.9 113315.0 117020.4 124560.0 9657.9 10030.3 10312.5 10407.7 11568.9 12659.8 12768.7 12773.5 12774.7 12778.8 6958.8 8429.8 8581.3 8648.0 8682.0 9060.1 9065.2 9079.6 9108.6 9245.7 3999.0 4027.5 4033.1 4088.7 4103.3 1923.7 1928.9 1931.0 1956.6 1998.5 854.6 891.5 946.4 963.6 1019.3 20533.7 21473.2 21572.0 22059.9 22131.7 879.6 990.5 992.0 1002.9 1051.9 10210.0 10840.8 10988.8 11495.3 11697.8 624530.0 642680.0 650898.0 656587.0 656885.0 133310.0 135405.0 146374.0 149853.0 154483.7 439.9 463.9 464.7 465.4 468.8 11096.8 11244.2 11698.6 11864.6 12057.6 52306.5 55872.7 56535.7 56733.4 58864.7 79838.0 81347.0 82293.4 83720.0 88488.0 8286.6 8369.0 8651.7 8710.3 8756.0 12598.6 13437.6 13510.3 13747.2 13976.8 11597.7 11642.5 11766.8 12023.8 12027.0 9457.8 11287.7 11422.4 11630.0 11683.5 10086.9 11668.4 11792.1 12082.4 12106.7 8454.5 8478.7 8479.9 8808.1 8824.3 11537.9 11558.8 11721.9 11802.3 11870.8 13:11:13 INFO - PROCESS | 1914 | 13:11:13 INFO - PROCESS | 1914 | [#3] mootools.html Cycles:180 Average:5834.84 Median:4969.25 stddev:3281.33 (66.0%) stddev-sans-first:3273.41 13:11:13 INFO - PROCESS | 1914 | Values: 1373.7 1527.6 1561.0 1756.8 1912.9 8125.2 8658.4 8960.8 9175.8 9207.0 9066.9 9158.6 9165.8 9169.1 9185.4 2433.9 2468.0 2468.6 2469.7 2469.8 2396.9 2461.0 2461.6 2461.8 2464.3 2418.0 2437.4 2450.3 2454.4 2455.5 2383.3 2396.2 2401.9 2405.2 2411.8 2332.8 2359.6 2378.2 2383.2 2394.2 8967.0 9161.6 9277.6 9310.3 9310.8 5393.5 5625.7 5628.4 5629.4 5642.9 3663.0 3700.8 3719.7 3773.2 3791.4 1121.3 1121.7 1126.4 1138.5 1148.2 12172.2 12183.8 12259.6 12281.6 12293.0 4537.4 4621.3 4733.6 4736.6 4811.8 9569.1 9573.3 9574.7 9580.8 9583.1 5472.0 5480.4 5487.6 5488.3 5490.0 4640.4 4778.5 4895.8 5083.2 5144.6 4084.4 4119.3 4222.5 4254.1 4267.2 1297.5 1318.5 1320.5 1329.4 1336.9 916.5 926.9 949.1 957.3 966.5 5758.7 5881.6 5906.1 6110.2 6210.9 462.6 463.3 468.7 469.6 472.5 4003.9 4025.8 4041.2 4044.7 4056.5 9431.8 10701.5 11116.7 11130.8 11142.9 9169.0 10981.7 11000.0 11039.0 11050.6 8062.6 8413.6 8426.8 8506.1 8526.2 6048.5 6071.0 6116.1 6135.4 6136.6 10223.7 10480.7 10498.0 10502.3 10507.2 10045.2 10582.6 10596.6 10613.8 10613.8 7181.0 7387.9 7388.7 7791.0 7916.7 8056.6 8133.5 8144.5 8394.9 8605.5 7573.3 7804.4 7815.6 7914.6 7947.6 6361.2 7526.3 7685.2 7708.9 7714.8 6161.8 6222.7 6935.7 7155.5 7297.6 5042.7 5057.7 5069.4 5250.5 5353.4 5123.1 5142.8 5150.6 5172.7 5222.1 13:11:13 INFO - PROCESS | 1914 | 13:11:13 INFO - PROCESS | 1914 | [#4] prototype.html Cycles:180 Average:4590.33 Median:5223.49 stddev:1424.30 (27.3%) stddev-sans-first:1391.07 13:11:13 INFO - PROCESS | 1914 | Values: 279.8 315.7 318.5 321.8 327.3 4954.1 5322.5 5421.3 5479.6 5490.6 4343.1 4859.2 5309.1 5372.2 5420.5 3369.8 3915.3 3920.7 3936.7 4154.9 4119.3 4124.2 4127.6 4128.0 4209.6 4073.5 4085.6 4108.6 4120.0 4121.0 3296.7 3926.9 4095.3 4108.9 4122.3 2648.7 3222.4 3513.5 3537.2 3537.3 4668.0 5225.8 5230.9 5254.9 5312.6 3383.5 4694.1 4695.7 4717.1 4720.5 5643.9 5657.6 5659.0 5660.2 5662.7 3884.7 3897.4 3909.7 3909.8 3916.1 5781.8 5964.3 5966.6 6015.6 6042.6 3898.4 3937.5 3943.6 3949.3 3954.1 4003.5 4010.3 4022.7 4039.2 4068.5 4592.7 4655.7 4673.3 4697.8 4702.2 4691.5 5378.3 5548.5 5709.0 5791.5 1248.7 1302.2 1333.8 1370.8 1372.5 752.8 780.6 802.0 820.5 843.9 5180.8 5280.3 5444.9 5467.0 5486.2 4450.5 5834.8 5870.8 5892.5 5911.1 5201.5 5390.4 5436.5 5446.9 5476.7 2781.9 2848.7 2855.8 3057.4 3059.1 6013.4 6038.6 6042.9 6046.8 6075.8 5451.7 5605.0 5928.7 5933.5 5983.6 5657.7 6016.6 6034.2 6071.5 6108.9 4509.4 4963.5 5236.8 5768.5 5859.7 5703.8 5712.4 5731.5 5733.0 5741.1 4770.8 5146.9 5638.6 5768.5 5981.3 3870.9 3897.7 3975.0 4102.4 4169.6 4322.3 4871.9 5670.1 5897.2 5910.3 5130.9 5351.4 5757.0 5789.2 5830.4 4981.4 5221.1 5308.9 5769.5 5798.7 5294.3 5466.3 5634.7 5646.5 5655.2 4735.2 4766.5 4907.7 5541.2 5635.0 5100.8 5255.5 5632.3 5634.3 5650.2 13:11:13 INFO - PROCESS | 1914 | 13:11:13 INFO - PROCESS | 1914 | [#5] yui.html Cycles:180 Average:24980.22 Median:22079.00 stddev:39052.73 (176.9%) stddev-sans-first:39119.81 13:11:13 INFO - PROCESS | 1914 | Values: 725.2 801.6 808.5 825.1 870.8 16137.0 16756.7 17301.2 17335.4 17589.6 15718.5 15934.9 15940.8 15944.8 15967.1 717.3 736.3 888.8 899.6 901.0 884.2 903.4 919.7 921.1 921.6 968.1 970.8 970.9 973.3 978.2 964.5 966.3 966.6 967.2 967.9 710.4 710.9 711.0 712.3 714.5 15859.0 15968.0 16065.9 16072.0 16090.6 13638.8 13647.2 13660.2 14224.9 15668.0 13251.2 13358.9 13586.3 13729.5 13750.7 4622.5 4750.7 4845.5 4858.2 4869.9 115979.0 117734.4 119760.0 120329.0 121739.4 11383.7 11395.8 11529.6 11536.5 11565.7 21952.2 22048.0 22057.6 22100.4 22101.0 6582.3 8077.8 8099.1 8103.2 8112.0 4476.2 4560.4 4580.7 4614.2 4721.7 3546.0 3643.3 3644.9 3652.1 3666.9 567.2 655.2 664.0 664.2 664.3 597.3 615.2 634.8 660.7 673.1 9121.9 9284.4 9300.8 9320.3 9341.4 536.6 576.9 641.4 677.9 682.0 4221.8 4762.9 4791.7 4906.8 4923.9 94307.0 132404.0 143861.0 150021.0 150168.0 102042.5 134767.0 138083.3 139934.0 140512.5 109577.0 111783.0 113629.9 116149.8 116535.4 9482.6 10013.6 10051.6 10199.6 10354.4 50709.0 58696.0 64495.7 65821.0 68980.3 67533.3 71310.0 81788.0 91013.0 97765.0 13918.4 13973.5 14043.2 14108.9 14221.7 14545.7 15341.9 15472.7 15617.1 16050.8 13760.3 14679.7 15032.9 15314.3 15529.5 14381.6 14408.6 14712.7 14848.9 15005.9 12127.7 12367.9 13397.0 13410.1 13983.3 11283.8 11356.9 11610.5 12101.4 12106.2 11140.9 11771.3 12271.9 12281.7 12369.8 13:11:13 INFO - PROCESS | 1914 | -------- Summary: end -------- 13:11:13 INFO - PROCESS | 1914 | 13:11:14 INFO - TEST-INFO | 1914: exit 0 13:11:14 INFO - TEST-OK | dromaeo_css | took 1114826ms 13:11:14 INFO - TEST-START | kraken 13:11:14 INFO - operating with platform_type : mac_ 13:11:14 INFO - Initialising browser for kraken test... 13:11:14 INFO - TEST-INFO | started process 1918 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/tmpjhUOm9/profile http://localhost:52427/getInfo.html) 13:11:16 INFO - PROCESS | 1918 | __metrics Screen width/height:1600/1200 13:11:16 INFO - PROCESS | 1918 | colorDepth:24 13:11:16 INFO - PROCESS | 1918 | Browser inner width/height: 1024/689 13:11:16 INFO - PROCESS | 1918 | __metrics 13:11:16 INFO - PROCESS | 1918 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:11:16 INFO - PROCESS | 1918 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:11:17 INFO - TEST-INFO | 1918: exit 0 13:11:17 INFO - Browser initialized. 13:11:17 INFO - Running cycle 1/1 for kraken test... 13:11:17 INFO - TEST-INFO | started process 1920 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/tmpjhUOm9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:11:29 INFO - PROCESS | 1920 | RSS: Main: 168808448 13:11:29 INFO - PROCESS | 1920 | 13:11:31 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:52427/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52427/tests/kraken/driver.html?testName=audio-beat-detection) 13:11:32 INFO - PROCESS | 1920 | RSS: Main: 218820608 13:11:32 INFO - PROCESS | 1920 | 13:11:35 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:52427/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52427/tests/kraken/driver.html?testName=audio-dft) 13:11:35 INFO - PROCESS | 1920 | RSS: Main: 232091648 13:11:35 INFO - PROCESS | 1920 | 13:11:39 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:52427/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52427/tests/kraken/driver.html?testName=audio-fft) 13:11:39 INFO - PROCESS | 1920 | RSS: Main: 329461760 13:11:39 INFO - PROCESS | 1920 | 13:11:41 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:52427/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52427/tests/kraken/driver.html?testName=audio-oscillator) 13:11:42 INFO - PROCESS | 1920 | RSS: Main: 227790848 13:11:42 INFO - PROCESS | 1920 | 13:11:44 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:52427/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52427/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:11:44 INFO - PROCESS | 1920 | RSS: Main: 229883904 13:11:44 INFO - PROCESS | 1920 | 13:11:47 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:52427/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52427/tests/kraken/driver.html?testName=imaging-darkroom) 13:11:48 INFO - PROCESS | 1920 | RSS: Main: 267476992 13:11:48 INFO - PROCESS | 1920 | 13:11:51 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:52427/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52427/tests/kraken/driver.html?testName=imaging-desaturate) 13:11:51 INFO - PROCESS | 1920 | RSS: Main: 268066816 13:11:51 INFO - PROCESS | 1920 | 13:11:54 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:52427/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52427/tests/kraken/driver.html?testName=json-parse-financial) 13:11:54 INFO - PROCESS | 1920 | RSS: Main: 267526144 13:11:54 INFO - PROCESS | 1920 | 13:11:56 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:52427/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52427/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:11:57 INFO - PROCESS | 1920 | RSS: Main: 243978240 13:11:57 INFO - PROCESS | 1920 | 13:11:58 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:52427/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52427/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:11:59 INFO - PROCESS | 1920 | RSS: Main: 247558144 13:11:59 INFO - PROCESS | 1920 | 13:12:01 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:52427/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52427/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:12:02 INFO - PROCESS | 1920 | RSS: Main: 252592128 13:12:02 INFO - PROCESS | 1920 | 13:12:05 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:52427/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52427/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:12:05 INFO - PROCESS | 1920 | RSS: Main: 267100160 13:12:05 INFO - PROCESS | 1920 | 13:12:08 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:52427/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52427/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:12:09 INFO - PROCESS | 1920 | RSS: Main: 261537792 13:12:09 INFO - PROCESS | 1920 | 13:12:11 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:52427/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52427/tests/kraken/driver.html?testName=ai-astar) 13:12:11 INFO - PROCESS | 1920 | RSS: Main: 305463296 13:12:11 INFO - PROCESS | 1920 | 13:12:11 INFO - PROCESS | 1920 | __start_tp_report 13:12:11 INFO - PROCESS | 1920 | _x_x_mozilla_page_load 13:12:11 INFO - PROCESS | 1920 | _x_x_mozilla_page_load_details 13:12:11 INFO - PROCESS | 1920 | |i|pagename|runs| 13:12:11 INFO - PROCESS | 1920 | |0;ai-astar;113;112;113;112;112;112;112;113;112;113 13:12:11 INFO - PROCESS | 1920 | |1;audio-beat-detection;144;110;112;168;138;139;93;127;173;138 13:12:11 INFO - PROCESS | 1920 | |2;audio-dft;182;183;184;181;182;181;182;183;184;185 13:12:11 INFO - PROCESS | 1920 | |3;audio-fft;84;58;60;88;58;57;57;61;81;57 13:12:11 INFO - PROCESS | 1920 | |4;audio-oscillator;84;71;93;69;68;90;129;98;73;91 13:12:11 INFO - PROCESS | 1920 | |5;imaging-gaussian-blur;88;86;88;85;88;85;89;85;88;84 13:12:11 INFO - PROCESS | 1920 | |6;imaging-darkroom;93;92;93;93;94;92;94;93;92;93 13:12:11 INFO - PROCESS | 1920 | |7;imaging-desaturate;86;84;84;84;86;83;83;84;85;84 13:12:11 INFO - PROCESS | 1920 | |8;json-parse-financial;54;54;54;51;56;56;56;55;56;55 13:12:11 INFO - PROCESS | 1920 | |9;json-stringify-tinderbox;64;65;73;71;72;66;69;68;67;69 13:12:11 INFO - PROCESS | 1920 | |10;stanford-crypto-aes;81;80;82;81;82;81;83;84;85;84 13:12:11 INFO - PROCESS | 1920 | |11;stanford-crypto-ccm;138;154;147;147;134;137;139;137;168;156 13:12:11 INFO - PROCESS | 1920 | |12;stanford-crypto-pbkdf2;164;164;161;159;161;160;161;161;164;159 13:12:11 INFO - PROCESS | 1920 | |13;stanford-crypto-sha256-iterative;65;66;65;67;69;81;83;87;84;66 13:12:11 INFO - PROCESS | 1920 | __end_tp_report 13:12:11 INFO - PROCESS | 1920 | __start_cc_report 13:12:11 INFO - PROCESS | 1920 | _x_x_mozilla_cycle_collect,1880 13:12:11 INFO - PROCESS | 1920 | __end_cc_report 13:12:11 INFO - PROCESS | 1920 | __startTimestamp1481922731393__endTimestamp 13:12:11 INFO - PROCESS | 1920 | 13:12:11 INFO - PROCESS | 1920 | ------- Summary: start ------- 13:12:11 INFO - PROCESS | 1920 | Number of tests: 14 13:12:11 INFO - PROCESS | 1920 | 13:12:11 INFO - PROCESS | 1920 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 13:12:11 INFO - PROCESS | 1920 | Values: 113.0 112.0 113.0 112.0 112.0 112.0 112.0 113.0 112.0 113.0 13:12:11 INFO - PROCESS | 1920 | 13:12:11 INFO - PROCESS | 1920 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:141.50 stddev:25.00 (17.7%) stddev-sans-first:26.26 13:12:11 INFO - PROCESS | 1920 | Values: 144.0 110.0 112.0 168.0 138.0 139.0 93.0 127.0 173.0 138.0 13:12:11 INFO - PROCESS | 1920 | 13:12:11 INFO - PROCESS | 1920 | [#2] audio-dft Cycles:10 Average:182.70 Median:183.00 stddev:1.34 (0.7%) stddev-sans-first:1.39 13:12:11 INFO - PROCESS | 1920 | Values: 182.0 183.0 184.0 181.0 182.0 181.0 182.0 183.0 184.0 185.0 13:12:11 INFO - PROCESS | 1920 | 13:12:11 INFO - PROCESS | 1920 | [#3] audio-fft Cycles:10 Average:66.10 Median:60.50 stddev:12.76 (21.1%) stddev-sans-first:11.77 13:12:11 INFO - PROCESS | 1920 | Values: 84.0 58.0 60.0 88.0 58.0 57.0 57.0 61.0 81.0 57.0 13:12:11 INFO - PROCESS | 1920 | 13:12:11 INFO - PROCESS | 1920 | [#4] audio-oscillator Cycles:10 Average:86.60 Median:87.00 stddev:18.53 (21.3%) stddev-sans-first:19.63 13:12:11 INFO - PROCESS | 1920 | Values: 84.0 71.0 93.0 69.0 68.0 90.0 129.0 98.0 73.0 91.0 13:12:11 INFO - PROCESS | 1920 | 13:12:11 INFO - PROCESS | 1920 | [#5] imaging-gaussian-blur Cycles:10 Average:86.60 Median:88.00 stddev:1.78 (2.0%) stddev-sans-first:1.81 13:12:11 INFO - PROCESS | 1920 | Values: 88.0 86.0 88.0 85.0 88.0 85.0 89.0 85.0 88.0 84.0 13:12:11 INFO - PROCESS | 1920 | 13:12:11 INFO - PROCESS | 1920 | [#6] imaging-darkroom Cycles:10 Average:92.90 Median:93.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 13:12:11 INFO - PROCESS | 1920 | Values: 93.0 92.0 93.0 93.0 94.0 92.0 94.0 93.0 92.0 93.0 13:12:11 INFO - PROCESS | 1920 | 13:12:11 INFO - PROCESS | 1920 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:1.06 (1.3%) stddev-sans-first:0.93 13:12:11 INFO - PROCESS | 1920 | Values: 86.0 84.0 84.0 84.0 86.0 83.0 83.0 84.0 85.0 84.0 13:12:11 INFO - PROCESS | 1920 | 13:12:11 INFO - PROCESS | 1920 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.50 stddev:1.57 (2.8%) stddev-sans-first:1.64 13:12:11 INFO - PROCESS | 1920 | Values: 54.0 54.0 54.0 51.0 56.0 56.0 56.0 55.0 56.0 55.0 13:12:11 INFO - PROCESS | 1920 | 13:12:11 INFO - PROCESS | 1920 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:69.00 stddev:2.99 (4.3%) stddev-sans-first:2.71 13:12:11 INFO - PROCESS | 1920 | Values: 64.0 65.0 73.0 71.0 72.0 66.0 69.0 68.0 67.0 69.0 13:12:11 INFO - PROCESS | 1920 | 13:12:11 INFO - PROCESS | 1920 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.50 stddev:1.64 (2.0%) stddev-sans-first:1.67 13:12:11 INFO - PROCESS | 1920 | Values: 81.0 80.0 82.0 81.0 82.0 81.0 83.0 84.0 85.0 84.0 13:12:11 INFO - PROCESS | 1920 | 13:12:11 INFO - PROCESS | 1920 | [#11] stanford-crypto-ccm Cycles:10 Average:145.70 Median:147.00 stddev:10.89 (7.4%) stddev-sans-first:11.19 13:12:11 INFO - PROCESS | 1920 | Values: 138.0 154.0 147.0 147.0 134.0 137.0 139.0 137.0 168.0 156.0 13:12:11 INFO - PROCESS | 1920 | 13:12:11 INFO - PROCESS | 1920 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:161.00 stddev:1.96 (1.2%) stddev-sans-first:1.83 13:12:11 INFO - PROCESS | 1920 | Values: 164.0 164.0 161.0 159.0 161.0 160.0 161.0 161.0 164.0 159.0 13:12:11 INFO - PROCESS | 1920 | 13:12:11 INFO - PROCESS | 1920 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:75.00 stddev:9.18 (12.2%) stddev-sans-first:9.23 13:12:11 INFO - PROCESS | 1920 | Values: 65.0 66.0 65.0 67.0 69.0 81.0 83.0 87.0 84.0 66.0 13:12:11 INFO - PROCESS | 1920 | -------- Summary: end -------- 13:12:11 INFO - PROCESS | 1920 | 13:12:12 INFO - TEST-INFO | 1920: exit 0 13:12:12 INFO - TEST-OK | kraken | took 58162ms 13:12:12 INFO - SUITE-END | took 1172s 13:12:12 INFO - Completed test suite (00:19:33) 13:12:12 INFO - javascript benchmark 13:12:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3461.0482117417705, 3461.896143115706, 3487.895363139105, 3509.2279698466327, 3559.822008899556, 5762.3949485304065, 5905.114232865072, 5913.0, 5930.673812940292, 5945.881082378355, 5765.682887441189, 5829.941700583004, 5837.0, 5932.11018347247, 5940.613860099091, 5308.0710875596715, 5329.067413202693, 5339.786408543673, 5394.136938089907, 5480.534154596864, 5285.339332583427, 5297.12597421425, 5314.335708036496, 5380.784768609251, 5444.6188766786345, 4455.2871540553515, 4661.813527458915, 5394.406615272317, 5427.782888684448, 5436.619436639437, 5404.972975135139, 5409.7295135243085, 5420.512153906128, 5424.457554244584, 5425.02349577076, 5228.581713462914, 5283.0, 5352.946470535284, 5373.596980226499, 5427.9185812212845, 5742.454466825645, 5745.0, 5823.970880145572, 5831.475167234969, 5848.327442344143, 6242.906356404657, 6255.812325630239, 6288.025356069817, 6299.559030867841, 6300.716467758962, 6246.87506249877, 6301.464375528039, 6307.432331090224, 6310.526710496685, 6334.778282760081, 5148.407933087743, 5805.564582656233, 5892.204552385373, 5941.613795103304, 6048.243969503856, 6345.302016778151, 6432.099506069154, 6446.0, 6468.6442245676935, 6474.902876456857, 6302.71637776292, 6304.905426418607, 6318.273398559132, 6324.620522768649, 6326.177596912372, 6251.9687401562705, 6301.653409062454, 6304.0, 6325.462335701517, 6331.2085989251345, 6204.937950620526, 6272.560920735505, 6283.5287353448675, 6313.0, 6361.2048493938255, 6234.719437625317, 6266.49868010558, 6321.399467050623, 6338.714757835908, 6362.554621176566, 5134.2298655201275, 5143.691378517226, 5149.253358263031, 5157.226416037624, 5163.741812909339, 4149.8962525937095, 4509.6843220974215, 4537.909241815145, 4551.908961820745, 4591.288350305708, 5949.970250148722, 6033.637981721111, 6046.848828779316, 6078.270607527125, 6082.604630699079, 6231.1276421300145, 6255.6872156392, 6269.561130720897, 6278.560500764994, 6310.368963103745, 5695.601307908407, 5724.912266669319, 5910.113482977587, 6070.086985980606, 6074.848128796815, 5424.972875135678, 5515.448455154453, 5541.473560011793, 5563.916541251884, 5640.633358831663, 5109.565686916654, 6497.675116244263, 6500.707468163944, 6508.414242718272, 6534.379233972765, 6238.656873871981, 6252.062190671254, 6265.4361107500545, 6282.1519094921605, 6288.622682639057, 6217.036359364306, 6294.905576416449, 6352.428281454507, 6377.553571250153, 6379.840503987438, 6317.305096439296, 6319.3364696706185, 6332.556721029484, 6335.65153916539, 6346.3019067903415, 6252.406021427957, 6271.153394291712, 6272.5922815016875, 6286.654234017173, 6305.117283580211, 6137.039921714347, 6140.228185505611, 6194.0, 6203.937960620517, 6248.718807653758, 6227.314995350417, 6279.623222606659, 6297.4017468340435, 6303.810885673437, 6314.747410103728, 6169.321374648875, 6189.752409903554, 6191.318954914866, 6213.254409470893, 6218.595791273553, 6075.2405949256345, 6146.139540464428, 6158.261008678987, 6170.50635949132, 6288.151099601495, 5146.485351464824, 6133.51829027926, 6154.599951003171, 6190.0, 6191.25704915413], "value": 5813.56052969784, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [461.2274440312478, 484.907867505174, 492.02578893790314, 527.3987654074356, 533.8718707510196, 32532.349353012956, 33420.997370078905, 34941.301173976535, 34965.0, 35171.4724279136, 43887.3416898746, 45466.0, 45536.77231613846, 47953.0, 48031.75984120083, 10144.492775361221, 10307.536160872742, 10319.896801032006, 10325.535350909227, 10334.844977325347, 9379.296552758537, 10065.396076235413, 10124.797504049915, 10158.339707918962, 10173.94913025434, 9573.42559446432, 12425.19236249641, 12682.80975785364, 12695.68260793483, 12812.743745125092, 12649.68375790608, 12721.491140354376, 12732.809007864937, 12749.74500509994, 12751.171173873761, 12516.186447880858, 12538.122331436804, 12592.559260425842, 12599.181053231603, 12604.55884044054, 43309.78345108286, 43663.78168109171, 43754.34368484475, 43772.56227437749, 43786.24855005796, 3344.347852168828, 3438.6905178534053, 3468.3930312195266, 3501.9474707879403, 4332.263515202391, 31224.531632025537, 31253.843730781427, 31290.843545782354, 31671.0, 32065.519017214527, 3372.089535825338, 3373.628900820908, 3414.641462646411, 3442.5008373785663, 3505.5267538882435, 530571.0, 533373.3331333357, 534690.0, 536235.0, 536293.0, 35537.82231088828, 35930.8203458981, 36329.45505817362, 66713.6664316685, 67258.9911151333, 37987.0, 38172.0, 38218.426723599165, 38232.23535529274, 38274.425883611766, 15868.285927133307, 16031.358745650277, 16056.67886642284, 16059.839401605834, 16064.678706425806, 13293.66765830862, 13384.464621415034, 13398.0, 13406.195628262336, 13414.195148290939, 7725.536467811837, 7886.132525422199, 7896.131425543185, 8398.706045288385, 8444.155584441507, 3191.361727654432, 3249.675032496779, 3331.133905184621, 3432.6052503962364, 3437.4671925851535, 733.9155997060407, 1000.1598657128047, 1036.3522798251092, 1080.330195278932, 1106.9557217711201, 31388.372232555223, 31831.0, 31838.681613184035, 32236.0, 32552.674473254963, 1078.8435676826816, 1111.0611533254387, 1148.8851114888444, 1165.7501023025643, 1177.2936238256978, 16308.592285192964, 16659.916700416663, 16715.832841671672, 16758.832411675972, 16967.236474358437, 725560.0, 730157.0, 731072.0, 731928.0, 732269.0, 55184.17223741647, 63539.6823015882, 64317.67841160858, 64411.355886440535, 64600.38499037562, 1317.4203350525738, 1401.3833913078213, 1402.207752619787, 1439.7264519741216, 1451.3033743802823, 31551.84224078865, 33336.33327333488, 33398.0, 33532.66467335393, 34215.144621384665, 53947.46052539424, 54628.0, 54690.453095470126, 54824.72587637196, 54863.0, 591889.0, 596077.0, 665042.0, 790763.0, 809477.0, 27623.447531048863, 28881.711182888743, 28960.0, 29016.839326426707, 29031.56452653254, 49016.50983490262, 49163.754181230295, 49466.01067978692, 49549.75225123851, 49741.50258497513, 36526.90419287426, 39962.0, 40697.79651101726, 42032.0, 42838.78580607202, 40794.592054079076, 41038.79480602578, 41326.0, 42608.5739142617, 42665.14669706526, 32646.83676581602, 38845.02887427724, 39438.0, 39712.80143599264, 40430.595694042684, 27393.178204653894, 34768.47847282344, 35839.64160358363, 35934.460983085795, 36013.81993090018, 26699.866500668148, 26870.731292687604, 26915.192544222922, 27006.919723210853, 27009.0], "value": 19931.907918399535, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.34010990930733, 388.6871068789623, 388.7550842968929, 396.9980150099249, 418.55214920035553, 20674.6898796518, 20901.372958811222, 22042.88978555105, 22184.667229991563, 22185.223517176903, 21269.57460850786, 21727.804970726604, 21875.0, 22362.10551577939, 22537.0, 5978.4918281945975, 6356.173697419329, 6357.523185761086, 6386.2655794583525, 6392.264889537693, 5931.88136237275, 6189.783357582485, 6255.40573645503, 6256.09286653435, 6404.135441715379, 6312.274088479815, 6317.24193096829, 6317.810465686037, 6320.273168585602, 6323.272823625296, 6072.908906366386, 6273.3726627337355, 6343.873122537523, 6350.428461438447, 6359.904601430959, 5185.766640501187, 5691.260136182311, 6182.1345011698395, 6185.721642526097, 6189.81430557084, 13959.302034898214, 13995.930020349935, 14224.0, 14229.217393043482, 14231.501897433644, 2139.4330502416874, 2335.427820184049, 2383.880805959695, 2453.4234454903085, 2574.4207553300544, 10420.0, 11008.944955275172, 11494.482748276349, 13365.465381384733, 15577.143257120853, 1950.9024548772504, 1951.4048215294329, 1953.3749200255925, 2004.9298274560467, 2020.2424090965887, 106689.46655266751, 107975.92024079738, 113315.0, 117020.41489792582, 124560.0, 9657.90342096584, 10030.29787914839, 10312.535935882903, 10407.739806504747, 11568.88431115695, 12659.810102848465, 12768.74462510763, 12773.489060437665, 12774.68063298425, 12778.808317875239, 6958.826029349307, 8429.831403371898, 8581.27059199975, 8647.956760216284, 8682.0, 9060.093990601019, 9065.184133428023, 9079.636814527477, 9108.635654573874, 9245.676401325922, 3999.0402303447545, 4027.5368332641533, 4033.072393349546, 4088.652464540488, 4103.261412945699, 1923.6630541773613, 1928.9421317360502, 1931.0399944056794, 1956.5695546979925, 1998.4604156877563, 854.645322191296, 891.4651209274383, 946.4463288975888, 963.5856581669949, 1019.2508506247901, 20533.691994620094, 21473.248436304966, 21572.029258683397, 22059.89700514968, 22131.668024979637, 879.6437442835662, 990.5393991793851, 991.980160396788, 1002.9097381235724, 1051.8579991701022, 10210.030047145508, 10840.837387439195, 10988.780224395467, 11495.310281383145, 11697.76604467906, 624530.0, 642680.0, 650898.0, 656587.0, 656885.0, 133310.0, 135405.0, 146374.0, 149853.0, 154483.68274475893, 439.9032212913154, 463.9048994956026, 464.7165229210179, 465.3694244298926, 468.76093192471404, 11096.833547496633, 11244.212905096565, 11698.590549330733, 11864.644060678194, 12057.638270851889, 52306.47693523168, 55872.72063639656, 56535.71732141313, 56733.432665672815, 58864.70567647134, 79838.0, 81347.0, 82293.3541329158, 83720.0, 88488.0, 8286.58567071656, 8369.0375606806, 8651.740447786577, 8710.259627931697, 8756.0, 12598.55905043319, 13437.596872093462, 13510.256935868621, 13747.175169489863, 13976.790348144583, 11597.6520704379, 11642.53429862796, 11766.764664706829, 12023.75952480963, 12027.0, 9457.810843782949, 11287.661370158909, 11422.428878555873, 11630.0, 11683.474243658886, 10086.949565252127, 11668.358240296866, 11792.05663546897, 12082.395880205779, 12106.697332566757, 8454.535000575028, 8478.660853565789, 8479.872801907853, 8808.11918808114, 8824.294056475595, 11537.942310288396, 11558.826617600575, 11721.882781172078, 11802.291862488279, 11870.762584748429], "value": 9411.275041827597, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1373.6977864869737, 1527.595187275372, 1561.0009593859932, 1756.841884230419, 1912.8565357598184, 8125.2281033301815, 8658.350623703216, 8960.775980600489, 9175.770605734844, 9207.0, 9066.909330906688, 9158.58786354614, 9165.77085572861, 9169.083091690827, 9185.448873067604, 2433.86613736244, 2468.0004598137693, 2468.6420469031978, 2469.6665950096776, 2469.777720005199, 2396.928092157238, 2461.0155937624913, 2461.6307553866886, 2461.79074778644, 2464.2730394533564, 2417.9758202418016, 2437.4393889405446, 2450.3016640257442, 2454.361865914866, 2455.5457240410583, 2383.285014495662, 2396.18529699902, 2401.927942161738, 2405.230326295586, 2411.819113566472, 2332.755060718617, 2359.634256690216, 2378.2389635316704, 2383.1897154967396, 2394.2458125690528, 8966.955165224197, 9161.587728552164, 9277.628894844198, 9310.301727370474, 9310.767230819283, 5393.541548968343, 5625.746841392147, 5628.352739434977, 5629.408912064257, 5642.943570564283, 3663.0, 3700.833462494167, 3719.702423806089, 3773.2453509298252, 3791.4312853071983, 1121.2599684208465, 1121.725177331559, 1126.442411006557, 1138.5332013874272, 1148.2019996102713, 12172.208806427554, 12183.756324873542, 12259.570915018021, 12281.631551053482, 12293.0, 4537.387452693844, 4621.30680397943, 4733.644976626767, 4736.597389221886, 4811.78346974387, 9569.138777510057, 9573.32986690925, 9574.712758617252, 9580.808383832424, 9583.089606487372, 5472.015037293246, 5480.3971563128025, 5487.560995120461, 5488.313960754906, 5490.0, 4640.396748422683, 4778.450478195052, 4895.828645997373, 5083.161278389099, 5144.562712169508, 4084.4281800547947, 4119.299719047769, 4222.493300803923, 4254.149444991439, 4267.16790225903, 1297.54585894936, 1318.5187406596715, 1320.5246111399888, 1329.3884812985941, 1336.9331533423485, 916.5417291354323, 926.8702381666573, 949.1220620925616, 957.30595318395, 966.4587830814767, 5758.712064396847, 5881.5882888198275, 5906.143609176731, 6110.175126357974, 6210.9068363974575, 462.64607575204997, 463.25184826505625, 468.657879747786, 469.6031853084207, 472.5439950447766, 4003.8999025024023, 4025.7584544926813, 4041.1715598302276, 4044.6966477513715, 4056.533498647634, 9431.811363772686, 10701.464926753632, 11116.722081948015, 11130.777384452427, 11142.888571114347, 9168.954155229181, 10981.725456863642, 11000.0, 11039.0, 11050.557977680963, 8062.55655938929, 8413.621387037598, 8426.789330266793, 8506.106858779864, 8526.232639062515, 6048.516118710405, 6070.969645151746, 6116.052011938156, 6135.417135372132, 6136.570440069152, 10223.7444063899, 10480.68557943263, 10498.0, 10502.317349372266, 10507.159427245955, 10045.196384289093, 10582.629607963685, 10596.576136954744, 10613.787724245318, 10613.787724245318, 7181.030560874424, 7387.852242955219, 7388.741394051182, 7790.961045194737, 7916.722914697958, 8056.556889370906, 8133.471324363897, 8144.470609410369, 8394.87407688873, 8605.526696031779, 7573.318401343906, 7804.375649948104, 7815.570143641927, 7914.564698941614, 7947.562884041433, 6361.236651601837, 7526.32263096324, 7685.23147685227, 7708.922910770821, 7714.768556943076, 6161.815145545641, 6222.719977600928, 6935.716892374927, 7155.534890232118, 7297.562146271029, 5042.663694120987, 5057.721825299496, 5069.377799104252, 5250.501202385767, 5353.357597088374, 5123.103456895103, 5142.820001299937, 5150.630709873501, 5172.7413629319135, 5222.112240918977], "value": 4622.242950995126, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.82790583790967, 315.73320544140194, 318.47928636679023, 321.8487310963846, 327.2603915151756, 4954.1330267203275, 5322.494363035516, 5421.322334708161, 5479.643823151498, 5490.643108197969, 4343.087951530175, 4859.209816343258, 5309.0709125903, 5372.206452644622, 5420.4850539198715, 3369.848356823949, 3915.3343931531567, 3920.7255492115564, 3936.724429289951, 4154.854580089697, 4119.279126152926, 4124.175164967003, 4127.596617150169, 4128.0299129704645, 4209.600087991651, 4073.4704488416464, 4085.611866872657, 4108.609682080212, 4119.979400102995, 4121.0, 3296.7362610991063, 3926.8625598104213, 4095.344744840826, 4108.856190033364, 4122.319817230168, 2648.6556747622685, 3222.3716375306826, 3513.49054387115, 3537.168765340143, 3537.3102245062223, 4667.953320466786, 5225.843224703265, 5230.947690523122, 5254.947450525484, 5312.574994000471, 3383.5432216650684, 4694.0611877624615, 4695.741734204617, 4717.127331443659, 4720.527947205286, 5643.871225754824, 5657.6322539035245, 5658.981383350995, 5660.160447854422, 5662.688552129631, 3884.679209068902, 3897.4153876918404, 3909.6872250219913, 3909.843606255746, 3916.060145565072, 5781.768729250825, 5964.314103878023, 5966.612170208966, 6015.578909476339, 6042.577019608585, 3898.3567711327314, 3937.468441760383, 3943.5859234779937, 3949.269385163754, 3954.090559171349, 4003.479547658844, 4010.27814993304, 4022.6982976276895, 4039.171969746195, 4068.450759147477, 4592.747398893026, 4655.697379670379, 4673.275642275453, 4697.78859951303, 4702.177119004229, 4691.483936766953, 5378.3058336623835, 5548.528375088082, 5709.0, 5791.536677065825, 1248.7075876467993, 1302.2251760202664, 1333.7599232138114, 1370.787527933172, 1372.4510195921512, 752.751591974647, 780.6487080813656, 801.9719309824245, 820.4625969989667, 843.8945131858518, 5180.818671346485, 5280.310300703738, 5444.869200209816, 5466.972665136728, 5486.216979481685, 4450.46594408673, 5834.824955251349, 5870.765169393177, 5892.528597712173, 5911.083782013795, 5201.45384734605, 5390.434004429557, 5436.483534064258, 5446.91829622556, 5476.67139971603, 2781.9443611127663, 2848.686644469107, 2855.8148368427287, 3057.4496590613903, 3059.0669845697275, 6013.398660133952, 6038.63768173911, 6042.909356359658, 6046.788362407295, 6075.817725468155, 5451.67447856807, 5604.97197514018, 5928.7332070056955, 5933.495652869555, 5983.611065280743, 5657.67044744493, 6016.578839481369, 6034.2155519782145, 6071.51427885768, 6108.938910610926, 4509.376624415274, 4963.528464795839, 5236.842894713165, 5768.480836724715, 5859.677717725566, 5703.800366987136, 5712.428757124254, 5731.455511726379, 5733.0, 5741.0767392923835, 4770.7853146607795, 5146.867689108391, 5638.577106716931, 5768.451997060272, 5981.342052374148, 3870.903227419337, 3897.7466464679705, 3974.9591562455325, 4102.384642303678, 4169.624733773853, 4322.330038843984, 4871.902561948812, 5670.149477578396, 5897.228302697725, 5910.349861515316, 5130.922506273575, 5351.441291541081, 5756.971215143897, 5789.1895134680335, 5830.358660547421, 4981.352424184977, 5221.128379391395, 5308.946910530845, 5769.509591684754, 5798.739056742373, 5294.326365185557, 5466.2620546227345, 5634.690092044813, 5646.475451627955, 5655.236543066633, 4735.21868891629, 4766.523347665206, 4907.68100073494, 5541.168824676331, 5634.971825140848, 5100.826809833833, 5255.500727430888, 5632.324121105494, 5634.295713035871, 5650.180723794944], "value": 4128.828927090452, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.1805459830391, 801.6232370785729, 808.4744915804727, 825.1130035212146, 870.7997160653053, 16137.0, 16756.748648770277, 17301.221445035004, 17335.39326123586, 17589.648207035883, 15718.528444146694, 15934.920325398385, 15940.760888586681, 15944.760828587581, 15967.121808300539, 717.3436305780205, 736.3262614707563, 888.7511496780879, 899.6131663384742, 901.0133903375826, 884.1865483754929, 903.408267584733, 919.7470695558742, 921.1433366968716, 921.6083164655029, 968.1480297338368, 970.7718686108759, 970.9029097090305, 973.2797729680021, 978.2027647467291, 964.5081008685551, 966.2511553545988, 966.5843687214496, 967.1778987860368, 967.9225661947028, 710.449401713676, 710.9217986021533, 710.9822254443628, 712.3339677401646, 714.4784307455535, 15859.048457092496, 15967.962082464603, 16065.91967040169, 16072.0, 16090.5977350566, 13638.795418068737, 13647.249401282925, 13660.248686322248, 14224.857751422456, 15668.0, 13251.204927704368, 13358.933205334008, 13586.25275609841, 13729.519466818614, 13750.724985500334, 4622.474722393245, 4750.691205071694, 4845.53967373099, 4858.246971719389, 4869.902601947942, 115979.0, 117734.41132794367, 119760.0, 120329.0, 121739.3913030438, 11383.715407114889, 11395.829062564067, 11529.596464123715, 11536.480858361394, 11565.653030409101, 21952.231671891408, 22048.0, 22057.558848822933, 22100.447488812908, 22101.0, 6582.341765823379, 8077.838443231102, 8099.109097999215, 8103.230193131643, 8112.0, 4476.216662084123, 4560.429946256718, 4580.725156490621, 4614.238650622609, 4721.7403042832975, 3546.0, 3643.3441980443245, 3644.908877278089, 3652.086978255436, 3666.8533258669354, 567.2059117235902, 655.1744801549986, 663.9867202656017, 664.1631544254275, 664.3356643356643, 597.3429227849331, 615.2340336281359, 634.787346239015, 660.7059858363078, 673.1451057157383, 9121.90878091224, 9284.350095493386, 9300.767480812898, 9320.30097742672, 9341.392809467363, 536.6404508978993, 576.8903908257417, 641.425923798198, 677.8745932002595, 682.0281099433288, 4221.788045558718, 4762.857114286577, 4791.664583479123, 4906.779194936236, 4923.876903077452, 94307.0, 132404.0, 143861.0, 150021.0, 150168.0, 102042.48978755058, 134767.0, 138083.30958345145, 139934.0, 140512.461565383, 109577.0, 111783.0, 113629.86370136357, 116149.8385016156, 116535.41732291284, 9482.620695172116, 10013.6486587092, 10051.648192313527, 10199.643012494527, 10354.378737275787, 50709.0, 58696.0, 64495.677521612095, 65821.0, 68980.3101968994, 67533.31166720872, 71310.0, 81788.0, 91013.0, 97765.0, 13918.443262269397, 13973.510927117502, 14043.1574105554, 14108.858911411166, 14221.715565688835, 14545.709085818437, 15341.923290383476, 15472.690546189238, 15617.141057241506, 16050.753370341185, 13760.31198440094, 14679.70640587161, 15032.924835375754, 15314.310856011283, 15529.45646902353, 14381.568552943429, 14408.639784005483, 14712.705745885236, 14848.85151148518, 15005.949583529049, 12127.696807579528, 12367.93816030914, 13396.988037701061, 13410.061295709207, 13983.295217261852, 11283.830742538705, 11356.94321528387, 11610.477528511068, 12101.443854268044, 12106.213096148722, 11140.944295278472, 11771.293722376684, 12271.877281227073, 12281.69295767613, 12369.752604947671], "value": 8146.356634377541, "unit": "score"}], "name": "dromaeo_css", "value": 7439.685445955608, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 113.0, 112.0, 112.0, 112.0, 112.0, 113.0, 112.0, 113.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 110.0, 112.0, 168.0, 138.0, 139.0, 93.0, 127.0, 173.0, 138.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 184.0, 181.0, 182.0, 181.0, 182.0, 183.0, 184.0, 185.0], "value": 182.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 58.0, 60.0, 88.0, 58.0, 57.0, 57.0, 61.0, 81.0, 57.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 93.0, 69.0, 68.0, 90.0, 129.0, 98.0, 73.0, 91.0], "value": 86.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 85.0, 88.0, 85.0, 89.0, 85.0, 88.0, 84.0], "value": 86.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 93.0, 93.0, 94.0, 92.0, 94.0, 93.0, 92.0, 93.0], "value": 92.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 84.0, 86.0, 83.0, 83.0, 84.0, 85.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 51.0, 56.0, 56.0, 56.0, 55.0, 56.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 73.0, 71.0, 72.0, 66.0, 69.0, 68.0, 67.0, 69.0], "value": 68.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 82.0, 81.0, 82.0, 81.0, 83.0, 84.0, 85.0, 84.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 154.0, 147.0, 147.0, 134.0, 137.0, 139.0, 137.0, 168.0, 156.0], "value": 145.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 161.0, 159.0, 161.0, 160.0, 161.0, 161.0, 164.0, 159.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 67.0, 69.0, 81.0, 83.0, 87.0, 84.0, 66.0], "value": 73.3, "unit": "score"}], "name": "kraken", "value": 1431.6000000000001, "alertThreshold": 2.0}]} 13:12:12 INFO - Return code: 0 13:12:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:12:12 INFO - # TBPL SUCCESS # 13:12:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:12:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:12:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:12:12 INFO - 2016-12-16 13:12:12.713 screenresolution[1924:17683] starting screenresolution argv=screenresolution get 13:12:12 INFO - 2016-12-16 13:12:12.716 screenresolution[1924:17683] Display 0: 1600x1200x32@60 13:12:12 INFO - 2016-12-16 13:12:12.722 screenresolution[1925:17686] starting screenresolution argv=screenresolution list 13:12:12 INFO - Available Modes on Display 0 13:12:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:12:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:12:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:12:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:12:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:12:12 INFO - Intel Iris: 13:12:12 INFO - Chipset Model: Intel Iris 13:12:12 INFO - Type: GPU 13:12:12 INFO - Bus: Built-In 13:12:12 INFO - VRAM (Dynamic, Max): 1536 MB 13:12:12 INFO - Vendor: Intel (0x8086) 13:12:12 INFO - Device ID: 0x0a2e 13:12:12 INFO - Revision ID: 0x0009 13:12:12 INFO - Displays: 13:12:12 INFO - Display: 13:12:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:12:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:12:12 INFO - Display Serial Number: 1600x1200 60 13:12:12 INFO - Main Display: Yes 13:12:12 INFO - Mirror: Off 13:12:12 INFO - Online: Yes 13:12:12 INFO - Rotation: Supported 13:12:12 INFO - Return code: 0 13:12:12 INFO - Running post-action listener: _resource_record_post_action 13:12:12 INFO - [mozharness: 2016-12-16 21:12:12.964391Z] Finished run-tests step (success) 13:12:12 INFO - Running post-run listener: _resource_record_post_run 13:12:13 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 1589248; Write bytes: 491417600; Read time: 16; Write time: 1562 13:12:13 INFO - TinderboxPrint: CPU usage
53.2% 13:12:13 INFO - TinderboxPrint: I/O read bytes / time
1,589,248 / 16 13:12:13 INFO - TinderboxPrint: I/O write bytes / time
491,417,600 / 1,562 13:12:13 INFO - TinderboxPrint: CPU idle
2,239.4 (46.8%) 13:12:13 INFO - TinderboxPrint: CPU system
954.9 (20.0%) 13:12:13 INFO - TinderboxPrint: CPU user
1,587.3 (33.2%) 13:12:13 INFO - TinderboxPrint: Swap in / out
196,952,064 / 0 13:12:13 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 195947008; Write bytes: 197424640; Read time: 17756; Write time: 440 13:12:13 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 606208; Write bytes: 292624896; Read time: 11; Write time: 1112 13:12:13 INFO - Running post-run listener: _upload_blobber_files 13:12:13 INFO - Blob upload gear active. 13:12:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:12:13 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 13:12:13 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:12:13 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:12:13 INFO - (blobuploader) - INFO - Open directory for files ... 13:12:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:12:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:12:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:12:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:12:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:12:14 INFO - (blobuploader) - INFO - Done attempting. 13:12:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:12:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:12:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:12:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:12:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:12:15 INFO - (blobuploader) - INFO - Done attempting. 13:12:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:12:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:12:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:12:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:12:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:12:17 INFO - (blobuploader) - INFO - Done attempting. 13:12:17 INFO - (blobuploader) - INFO - Iteration through files over. 13:12:17 INFO - Return code: 0 13:12:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:12:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:12:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3b6094535274c2e76153e199755b45baad9ed4932e6a49c126b3295cb28f80f7816cbce833f9e06f82b45f446efd001586c1a87bf42a297dbc990b0367954357", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6c5b5fc727ae049b3bf838abf1e308676396550ec739190c7856df14e4ad6bd708b221fead57dcc7d286d5b1985d49480f7ced0c35ab22403cd4233d4f728427", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/230d117893cf622036d00554cbbd51d93193673f950ec10693838d92f45f22e0f146af9219015f1bd2106733116fb21a3ee35efa94b636192f18efb71c900eb2"} 13:12:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:12:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:12:17 INFO - Contents: 13:12:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3b6094535274c2e76153e199755b45baad9ed4932e6a49c126b3295cb28f80f7816cbce833f9e06f82b45f446efd001586c1a87bf42a297dbc990b0367954357", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6c5b5fc727ae049b3bf838abf1e308676396550ec739190c7856df14e4ad6bd708b221fead57dcc7d286d5b1985d49480f7ced0c35ab22403cd4233d4f728427", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/230d117893cf622036d00554cbbd51d93193673f950ec10693838d92f45f22e0f146af9219015f1bd2106733116fb21a3ee35efa94b636192f18efb71c900eb2"} 13:12:17 INFO - Running post-run listener: copy_logs_to_upload_dir 13:12:17 INFO - Copying logs to upload dir... 13:12:17 INFO - mkdir: /builds/slave/test/build/upload/logs 13:12:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.702985 ========= master_lag: 0.51 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-12-16 13:12:18.522878) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-16 13:12:18.526579) ========= 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.5W3zUCroH1/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.Irr11I3BM0/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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/Mozilla-Beta/sha512/3b6094535274c2e76153e199755b45baad9ed4932e6a49c126b3295cb28f80f7816cbce833f9e06f82b45f446efd001586c1a87bf42a297dbc990b0367954357", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6c5b5fc727ae049b3bf838abf1e308676396550ec739190c7856df14e4ad6bd708b221fead57dcc7d286d5b1985d49480f7ced0c35ab22403cd4233d4f728427", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/230d117893cf622036d00554cbbd51d93193673f950ec10693838d92f45f22e0f146af9219015f1bd2106733116fb21a3ee35efa94b636192f18efb71c900eb2"} build_url:https://queue.taskcluster.net/v1/task/H9zWEq1-QwGDRbWOahZt9g/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011146 build_url: 'https://queue.taskcluster.net/v1/task/H9zWEq1-QwGDRbWOahZt9g/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3b6094535274c2e76153e199755b45baad9ed4932e6a49c126b3295cb28f80f7816cbce833f9e06f82b45f446efd001586c1a87bf42a297dbc990b0367954357", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6c5b5fc727ae049b3bf838abf1e308676396550ec739190c7856df14e4ad6bd708b221fead57dcc7d286d5b1985d49480f7ced0c35ab22403cd4233d4f728427", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/230d117893cf622036d00554cbbd51d93193673f950ec10693838d92f45f22e0f146af9219015f1bd2106733116fb21a3ee35efa94b636192f18efb71c900eb2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-16 13:12:18.562182) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 13:12:18.562535) ========= 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.5W3zUCroH1/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.Irr11I3BM0/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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.004594 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 13:12:18.610987) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-16 13:12:18.611313) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-16 13:12:18.611648) ========= ========= Total master_lag: 0.66 =========