builder: jamun_yosemite_r7_devedition_test-dromaeojs slave: t-yosemite-r7-0256 starttime: 1495246607.97 results: success (0) buildid: 20170519111123 builduid: afc8dff692c24a1ea1ef90675fb7bc81 revision: c3d5dc1002044b0b5c4fdc38de4db8a7f70429a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-19 19:16:47.974149) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-19 19:16:47.974571) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-19 19:16:47.974855) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-19 19:16:48.001182) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 19:16:48.001483) ========= 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.7QgnG65V6B/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.5UARR63kx0/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-05-19 19:16:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 143M=0s 2017-05-19 19:16:48 (143 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115087 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 19:16:48.138434) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 19:16:48.138747) ========= 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.7QgnG65V6B/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.5UARR63kx0/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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.027500 ========= master_lag: 0.16 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 19:16:48.330471) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-05-19 19:16:48.330864) ========= bash -c 'python archiver_client.py mozharness --repo projects/jamun --rev c3d5dc1002044b0b5c4fdc38de4db8a7f70429a7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/jamun --rev c3d5dc1002044b0b5c4fdc38de4db8a7f70429a7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7QgnG65V6B/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.5UARR63kx0/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-05-19 19:16:48,582 truncating revision to first 12 chars 2017-05-19 19:16:48,583 Setting DEBUG logging. 2017-05-19 19:16:48,583 attempt 1/10 2017-05-19 19:16:48,583 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/jamun/c3d5dc100204?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-19 19:16:50,348 unpacking tar archive at: jamun-c3d5dc100204/testing/mozharness/ program finished with exit code 0 elapsedTime=2.035687 ========= master_lag: 2.60 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-05-19 19:16:52.967527) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-19 19:16:52.968087) ========= script_repo_revision: c3d5dc1002044b0b5c4fdc38de4db8a7f70429a7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-19 19:16:52.968692) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-19 19:16:52.969926) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-19 19:16:53.900525) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 41 mins, 27 secs) (at 2017-05-19 19:16:53.900841) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Jamun --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Jamun 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', 'Jamun', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Jamun'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7QgnG65V6B/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.5UARR63kx0/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 19:16:54 INFO - MultiFileLogger online at 20170519 19:16:54 in /builds/slave/test 19:16:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Jamun --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Jamun 19:16:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:16:54 INFO - {'append_to_log': False, 19:16:54 INFO - 'base_work_dir': '/builds/slave/test', 19:16:54 INFO - 'blob_upload_branch': 'Jamun', 19:16:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:16:54 INFO - 'branch': 'Jamun', 19:16:54 INFO - 'buildbot_json_path': 'buildprops.json', 19:16:54 INFO - 'config_files': ('talos/mac_config.py',), 19:16:54 INFO - 'default_actions': ('clobber', 19:16:54 INFO - 'read-buildbot-config', 19:16:54 INFO - 'download-and-extract', 19:16:54 INFO - 'populate-webroot', 19:16:54 INFO - 'create-virtualenv', 19:16:54 INFO - 'install', 19:16:54 INFO - 'run-tests'), 19:16:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:16:54 INFO - 'download_minidump_stackwalk': True, 19:16:54 INFO - 'download_symbols': 'ondemand', 19:16:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:16:54 INFO - 'tooltool.py': '/tools/tooltool.py', 19:16:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:16:54 INFO - '/tools/misc-python/virtualenv.py')}, 19:16:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:16:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:16:54 INFO - 'gecko_profile': False, 19:16:54 INFO - 'gecko_profile_interval': 0, 19:16:54 INFO - 'installer_path': 'installer.exe', 19:16:54 INFO - 'log_level': 'info', 19:16:54 INFO - 'log_name': 'talos', 19:16:54 INFO - 'log_to_console': True, 19:16:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:16:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:16:54 INFO - 'opt_config_files': (), 19:16:54 INFO - 'pip_index': False, 19:16:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:16:54 INFO - 'cmd': ('bash', 19:16:54 INFO - '-c', 19:16:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:16:54 INFO - 'enabled': True, 19:16:54 INFO - 'halt_on_failure': False, 19:16:54 INFO - 'name': 'check_screen_resolution'},), 19:16:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:16:54 INFO - 'cmd': ('bash', 19:16:54 INFO - '-c', 19:16:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:16:54 INFO - 'enabled': True, 19:16:54 INFO - 'halt_on_failure': False, 19:16:54 INFO - 'name': 'check_screen_resolution'},), 19:16:54 INFO - 'run_cmd_checks_enabled': True, 19:16:54 INFO - 'suite': 'dromaeojs', 19:16:54 INFO - 'system_bits': '32', 19:16:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:16:54 INFO - 'title': 't-yosemite-r7-0256', 19:16:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:16:54 INFO - 'use_talos_json': True, 19:16:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:16:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:16:54 INFO - 'work_dir': 'build'} 19:16:54 INFO - [mozharness: 2017-05-20 02:16:54.149112Z] Running clobber step. 19:16:54 INFO - Running pre-action listener: _resource_record_pre_action 19:16:54 INFO - Running main action method: clobber 19:16:54 INFO - rmtree: /builds/slave/test/build 19:16:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:16:56 INFO - Running post-action listener: _resource_record_post_action 19:16:56 INFO - [mozharness: 2017-05-20 02:16:56.451193Z] Finished clobber step (success) 19:16:56 INFO - [mozharness: 2017-05-20 02:16:56.451428Z] Running read-buildbot-config step. 19:16:56 INFO - Running pre-action listener: _resource_record_pre_action 19:16:56 INFO - Running main action method: read_buildbot_config 19:16:56 INFO - Using buildbot properties: 19:16:56 INFO - { 19:16:56 INFO - "project": "", 19:16:56 INFO - "product": "firefox", 19:16:56 INFO - "script_repo_revision": "production", 19:16:56 INFO - "builddir": "jamun_yosemite_r7_devedition_test-dromaeojs", 19:16:56 INFO - "repository": "", 19:16:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 DevEdition jamun talos dromaeojs", 19:16:56 INFO - "buildid": "20170519111123", 19:16:56 INFO - "pgo_build": "False", 19:16:56 INFO - "basedir": "/builds/slave/test", 19:16:56 INFO - "buildnumber": 0, 19:16:56 INFO - "slavename": "t-yosemite-r7-0256", 19:16:56 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 19:16:56 INFO - "platform": "yosemite_r7_devedition", 19:16:56 INFO - "scheduler": "tests-jamun-macosx64-devedition-talos", 19:16:56 INFO - "branch": "jamun", 19:16:56 INFO - "repo_path": "projects/jamun", 19:16:56 INFO - "revision": "c3d5dc1002044b0b5c4fdc38de4db8a7f70429a7", 19:16:56 INFO - "stage_platform": "macosx64-devedition", 19:16:56 INFO - "builduid": "afc8dff692c24a1ea1ef90675fb7bc81", 19:16:56 INFO - "slavebuilddir": "test" 19:16:56 INFO - } 19:16:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 19:16:56 INFO - Running post-action listener: _resource_record_post_action 19:16:56 INFO - [mozharness: 2017-05-20 02:16:56.457168Z] Finished read-buildbot-config step (success) 19:16:56 INFO - [mozharness: 2017-05-20 02:16:56.457387Z] Running download-and-extract step. 19:16:56 INFO - Running pre-action listener: _resource_record_pre_action 19:16:56 INFO - Running main action method: download_and_extract 19:16:56 INFO - mkdir: /builds/slave/test/build/tests 19:16: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')]} 19:16:56 INFO - trying https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 19:16:56 INFO - Downloading https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 19:16:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 19:16:57 INFO - Downloaded 1287 bytes. 19:16:57 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 19:16:57 INFO - Using the following test package requirements: 19:16:57 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:16:57 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 19:16:57 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 19:16:57 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:16:57 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 19:16:57 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:16:57 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 19:16:57 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 19:16:57 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:16:57 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 19:16:57 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 19:16:57 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:16:57 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 19:16:57 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:16:57 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 19:16:57 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:16:57 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 19:16:57 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:16:57 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 19:16:57 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 19:16:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 19:16:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 19:16:57 INFO - Fetch https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 19:16:59 INFO - Expected file size: 51793962 19:16:59 INFO - Obtained file size: 51793962 19:17:14 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 19:17:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 19:17:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 19:17:14 INFO - Fetch https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 19:17:16 INFO - Expected file size: 51793962 19:17:16 INFO - Obtained file size: 51793962 19:17:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 19:17:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 19:17:31 INFO - Fetch https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 19:17:32 INFO - Expected file size: 14404449 19:17:32 INFO - Obtained file size: 14404449 19:17:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:32 INFO - trying https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 19:17:32 INFO - Downloading https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 19:17:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 19:17:34 INFO - Downloaded 74763169 bytes. 19:17:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 19:17:34 INFO - mkdir: /builds/slave/test/properties 19:17:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:17:34 INFO - Writing to file /builds/slave/test/properties/build_url 19:17:34 INFO - Contents: 19:17:34 INFO - build_url:https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 19:17:36 INFO - Running post-action listener: _resource_record_post_action 19:17:36 INFO - Running post-action listener: set_extra_try_arguments 19:17:36 INFO - [mozharness: 2017-05-20 02:17:36.333895Z] Finished download-and-extract step (success) 19:17:36 INFO - [mozharness: 2017-05-20 02:17:36.334071Z] Running populate-webroot step. 19:17:36 INFO - Running pre-action listener: _resource_record_pre_action 19:17:36 INFO - Running main action method: populate_webroot 19:17:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:17:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:17:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:17:36 INFO - '--tppagecycles', 19:17:36 INFO - '7'], 19:17:36 INFO - 'tests': ['tsvgm']}}, 19:17:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:17:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:17:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:17:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:17:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:17:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:17:36 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:17:36 INFO - 'talos_options': ['--disable-e10s'], 19:17:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:17:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:17:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:17:36 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:17:36 INFO - 'talos_options': ['--disable-e10s'], 19:17:36 INFO - 'tests': ['damp', 'tps']}, 19:17:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:17:36 INFO - 'tests': ['damp', 'tps']}, 19:17:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:17:36 INFO - 'tests': ['dromaeo_dom']}, 19:17:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:17:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:17:36 INFO - 'tests': ['basic_compositor_video']}, 19:17:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:17:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:17:36 INFO - 'tests': ['a11yr', 19:17:36 INFO - 'ts_paint', 19:17:36 INFO - 'tpaint', 19:17:36 INFO - 'sessionrestore', 19:17:36 INFO - 'sessionrestore_no_auto_restore', 19:17:36 INFO - 'tabpaint']}, 19:17:36 INFO - 'other-e10s': {'tests': ['a11yr', 19:17:36 INFO - 'ts_paint', 19:17:36 INFO - 'tpaint', 19:17:36 INFO - 'sessionrestore', 19:17:36 INFO - 'sessionrestore_no_auto_restore', 19:17:36 INFO - 'tabpaint']}, 19:17:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:17:36 INFO - 'ts_paint', 19:17:36 INFO - 'tpaint', 19:17:36 INFO - 'sessionrestore', 19:17:36 INFO - 'sessionrestore_no_auto_restore', 19:17:36 INFO - 'tabpaint']}, 19:17:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:17:36 INFO - 'ts_paint', 19:17:36 INFO - 'tpaint', 19:17:36 INFO - 'sessionrestore', 19:17:36 INFO - 'sessionrestore_no_auto_restore', 19:17:36 INFO - 'tabpaint']}, 19:17:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:17:36 INFO - 'tests': ['a11yr', 19:17:36 INFO - 'ts_paint', 19:17:36 INFO - 'tpaint', 19:17:36 INFO - 'sessionrestore', 19:17:36 INFO - 'sessionrestore_no_auto_restore', 19:17:36 INFO - 'tabpaint']}, 19:17:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:17:36 INFO - 'tests': ['a11yr', 19:17:36 INFO - 'ts_paint', 19:17:36 INFO - 'tpaint', 19:17:36 INFO - 'sessionrestore', 19:17:36 INFO - 'sessionrestore_no_auto_restore', 19:17:36 INFO - 'tabpaint']}, 19:17:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:17:36 INFO - 'tests': ['tsvgx', 19:17:36 INFO - 'tsvgr_opacity', 19:17:36 INFO - 'tart', 19:17:36 INFO - 'tscrollx', 19:17:36 INFO - 'cart', 19:17:36 INFO - 'tsvg_static']}, 19:17:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:17:36 INFO - 'tsvgr_opacity', 19:17:36 INFO - 'tart', 19:17:36 INFO - 'tscrollx', 19:17:36 INFO - 'cart', 19:17:36 INFO - 'tsvg_static']}, 19:17:36 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:17:36 INFO - 'talos_options': ['--disable-e10s'], 19:17:36 INFO - 'tests': ['tp5o']}, 19:17:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:17:36 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:17:36 INFO - 'talos_options': ['--disable-e10s', 19:17:36 INFO - '--xperf_path', 19:17:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:17:36 INFO - 'tests': ['tp5n']}, 19:17:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:17:36 INFO - 'talos_options': ['--xperf_path', 19:17:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:17:36 INFO - 'tests': ['tp5n']}}, 19:17:36 INFO - 'talos.zip': {'path': '', 19:17:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:17:36 INFO - Running post-action listener: _resource_record_post_action 19:17:36 INFO - [mozharness: 2017-05-20 02:17:36.352421Z] Finished populate-webroot step (success) 19:17:36 INFO - [mozharness: 2017-05-20 02:17:36.352506Z] Running create-virtualenv step. 19:17:36 INFO - Running pre-action listener: _resource_record_pre_action 19:17:36 INFO - Running main action method: create_virtualenv 19:17:36 INFO - Creating virtualenv /builds/slave/test/build/venv 19:17:36 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 19:17:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:17:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:17:36 INFO - Using real prefix '/tools/python27' 19:17:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:17:37 INFO - Installing distribute.............................................................................................................................................................................................done. 19:17:40 INFO - Installing pip.................done. 19:17:40 INFO - Return code: 0 19:17:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:17:40 INFO - Reading from file tmpfile_stdout 19:17:40 INFO - Output received: 19:17:40 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 19:17:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:17:40 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')]} 19:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:40 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')]} 19:17:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:41 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 0x102870b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102873768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd962c89810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10264ed30>, '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 0x102575db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102643be8>, '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.7QgnG65V6B/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.5UARR63kx0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 19:17:41 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 19:17:41 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 19:17:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7QgnG65V6B/Render', 19:17:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:17:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:17:41 INFO - 'HOME': '/Users/cltbld', 19:17:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:17:41 INFO - 'LOGNAME': 'cltbld', 19:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:41 INFO - 'MOZ_NO_REMOTE': '1', 19:17:41 INFO - 'NO_EM_RESTART': '1', 19:17:41 INFO - 'PAGER': '/bin/cat', 19:17:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:41 INFO - 'PWD': '/builds/slave/test', 19:17:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:17:41 INFO - 'SHELL': '/bin/bash', 19:17:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5UARR63kx0/Listeners', 19:17:41 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 19:17:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:17:41 INFO - 'USER': 'cltbld', 19:17:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:17:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:41 INFO - 'XPC_FLAGS': '0x0', 19:17:41 INFO - 'XPC_SERVICE_NAME': '0', 19:17:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:41 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 19:17:41 INFO - Cleaning up... 19:17:41 INFO - Return code: 0 19:17:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:17: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')]} 19:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17: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')]} 19:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:41 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 0x102870b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102873768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd962c89810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10264ed30>, '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 0x102575db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102643be8>, '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.7QgnG65V6B/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.5UARR63kx0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 19:17:41 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 19:17:41 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 19:17:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7QgnG65V6B/Render', 19:17:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:17:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:17:41 INFO - 'HOME': '/Users/cltbld', 19:17:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:17:41 INFO - 'LOGNAME': 'cltbld', 19:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:41 INFO - 'MOZ_NO_REMOTE': '1', 19:17:41 INFO - 'NO_EM_RESTART': '1', 19:17:41 INFO - 'PAGER': '/bin/cat', 19:17:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:41 INFO - 'PWD': '/builds/slave/test', 19:17:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:17:41 INFO - 'SHELL': '/bin/bash', 19:17:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5UARR63kx0/Listeners', 19:17:41 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 19:17:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:17:41 INFO - 'USER': 'cltbld', 19:17:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:17:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:41 INFO - 'XPC_FLAGS': '0x0', 19:17:41 INFO - 'XPC_SERVICE_NAME': '0', 19:17:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:41 INFO - Downloading/unpacking psutil>=3.1.1 19:17:41 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 19:17:41 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 19:17:41 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 19:17:41 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 19:17:41 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 19:17:41 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 19:20:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:20:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:20:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:20:15 INFO - Installing collected packages: psutil 19:20:15 INFO - Running setup.py install for psutil 19:20:15 INFO - building 'psutil._psutil_osx' extension 19:20:15 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 19:20:15 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 19:20:15 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 19:20:15 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 19:20:15 INFO - building 'psutil._psutil_posix' extension 19:20:15 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 19:20:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:20:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:20:15 INFO - ^ 19:20:16 INFO - 1 warning generated. 19:20:16 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 19:20:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:20:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:20:16 INFO - Successfully installed psutil 19:20:16 INFO - Cleaning up... 19:20:16 INFO - Return code: 0 19:20:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:20: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')]} 19:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:20:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:20: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')]} 19:20:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:20:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:20: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102870b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102873768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd962c89810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10264ed30>, '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 0x102575db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102643be8>, '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.7QgnG65V6B/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.5UARR63kx0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 19:20: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:20: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 mozsystemmonitor==0.3 19:20:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7QgnG65V6B/Render', 19:20:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:20:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:20:16 INFO - 'HOME': '/Users/cltbld', 19:20:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:20:16 INFO - 'LOGNAME': 'cltbld', 19:20:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:20:16 INFO - 'MOZ_NO_REMOTE': '1', 19:20:16 INFO - 'NO_EM_RESTART': '1', 19:20:16 INFO - 'PAGER': '/bin/cat', 19:20:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:20:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:20:16 INFO - 'PWD': '/builds/slave/test', 19:20:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:20:16 INFO - 'SHELL': '/bin/bash', 19:20:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5UARR63kx0/Listeners', 19:20:16 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 19:20:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:20:16 INFO - 'USER': 'cltbld', 19:20:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:20:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:20:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:20:16 INFO - 'XPC_FLAGS': '0x0', 19:20:16 INFO - 'XPC_SERVICE_NAME': '0', 19:20:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:20:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:20:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:20:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:20:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:20:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:20:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:22:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:22:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:22:49 INFO - Installing collected packages: mozsystemmonitor 19:22:49 INFO - Running setup.py install for mozsystemmonitor 19:22:49 INFO - Successfully installed mozsystemmonitor 19:22:49 INFO - Cleaning up... 19:22:49 INFO - Return code: 0 19:22:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:22: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')]} 19:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22: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')]} 19:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102870b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102873768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd962c89810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10264ed30>, '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 0x102575db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102643be8>, '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.7QgnG65V6B/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.5UARR63kx0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 19:22:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:22:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7QgnG65V6B/Render', 19:22:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:22:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:22:51 INFO - 'HOME': '/Users/cltbld', 19:22:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:22:51 INFO - 'LOGNAME': 'cltbld', 19:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:51 INFO - 'MOZ_NO_REMOTE': '1', 19:22:51 INFO - 'NO_EM_RESTART': '1', 19:22:51 INFO - 'PAGER': '/bin/cat', 19:22:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:51 INFO - 'PWD': '/builds/slave/test', 19:22:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:22:51 INFO - 'SHELL': '/bin/bash', 19:22:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5UARR63kx0/Listeners', 19:22:51 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 19:22:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:22:51 INFO - 'USER': 'cltbld', 19:22:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:22:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:51 INFO - 'XPC_FLAGS': '0x0', 19:22:51 INFO - 'XPC_SERVICE_NAME': '0', 19:22:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:51 INFO - Downloading/unpacking jsonschema==2.5.1 19:22:51 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 19:22:51 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 19:22:51 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 19:22:51 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 19:22:51 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 19:22:51 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 19:25:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:25:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:25:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:25:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:54 INFO - Downloading functools32-3.2.3-2.tar.gz 19:27:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:27:54 INFO - warning: no files found matching '*.txt' 19:27:54 INFO - no previously-included directories found matching 'build' 19:27:54 INFO - no previously-included directories found matching 'dist' 19:27:54 INFO - no previously-included directories found matching '.git*' 19:27:54 INFO - Installing collected packages: jsonschema, functools32 19:27:54 INFO - Running setup.py install for functools32 19:27:54 INFO - warning: no files found matching '*.txt' 19:27:54 INFO - no previously-included directories found matching 'build' 19:27:54 INFO - no previously-included directories found matching 'dist' 19:27:54 INFO - no previously-included directories found matching '.git*' 19:27:55 INFO - Successfully installed jsonschema functools32 19:27:55 INFO - Cleaning up... 19:27:55 INFO - Return code: 0 19:27:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:27:55 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')]} 19:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:55 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')]} 19:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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', '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 0x102870b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102873768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd962c89810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10264ed30>, '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 0x102575db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102643be8>, '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.7QgnG65V6B/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.5UARR63kx0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 19:27: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:27: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 functools32==3.2.3-2 19:27:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7QgnG65V6B/Render', 19:27:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:56 INFO - 'HOME': '/Users/cltbld', 19:27:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:56 INFO - 'LOGNAME': 'cltbld', 19:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:56 INFO - 'MOZ_NO_REMOTE': '1', 19:27:56 INFO - 'NO_EM_RESTART': '1', 19:27:56 INFO - 'PAGER': '/bin/cat', 19:27:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:56 INFO - 'PWD': '/builds/slave/test', 19:27:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:56 INFO - 'SHELL': '/bin/bash', 19:27:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5UARR63kx0/Listeners', 19:27:56 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 19:27:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:56 INFO - 'USER': 'cltbld', 19:27:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:56 INFO - 'XPC_FLAGS': '0x0', 19:27:56 INFO - 'XPC_SERVICE_NAME': '0', 19:27:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:27:57 INFO - Cleaning up... 19:27:57 INFO - Return code: 0 19:27:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:57 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 0x102870b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102873768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd962c89810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10264ed30>, '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 0x102575db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102643be8>, '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.7QgnG65V6B/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.5UARR63kx0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 19:27:57 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 19:27:57 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 19:27:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7QgnG65V6B/Render', 19:27:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:57 INFO - 'HOME': '/Users/cltbld', 19:27:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:57 INFO - 'LOGNAME': 'cltbld', 19:27:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:57 INFO - 'MOZ_NO_REMOTE': '1', 19:27:57 INFO - 'NO_EM_RESTART': '1', 19:27:57 INFO - 'PAGER': '/bin/cat', 19:27:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:57 INFO - 'PWD': '/builds/slave/test', 19:27:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:57 INFO - 'SHELL': '/bin/bash', 19:27:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5UARR63kx0/Listeners', 19:27:57 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 19:27:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:57 INFO - 'USER': 'cltbld', 19:27:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:57 INFO - 'XPC_FLAGS': '0x0', 19:27:57 INFO - 'XPC_SERVICE_NAME': '0', 19:27:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:57 INFO - Downloading/unpacking blobuploader==1.2.4 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:30:29 INFO - Downloading blobuploader-1.2.4.tar.gz 19:30:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:30:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:33:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:33:00 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 19:33:00 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 19:33:00 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 19:33:00 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 19:33:00 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 19:33:00 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 19:35:31 INFO - Downloading docopt-0.6.1.tar.gz 19:35:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:35:31 INFO - Installing collected packages: blobuploader, requests, docopt 19:35:31 INFO - Running setup.py install for blobuploader 19:35:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:35:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:35:31 INFO - Running setup.py install for requests 19:35:31 INFO - Running setup.py install for docopt 19:35:32 INFO - Successfully installed blobuploader requests docopt 19:35:32 INFO - Cleaning up... 19:35:32 INFO - Return code: 0 19:35:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:33 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 0x102870b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102873768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd962c89810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10264ed30>, '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 0x102575db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102643be8>, '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.7QgnG65V6B/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.5UARR63kx0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 19:35:33 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 19:35:33 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 19:35:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7QgnG65V6B/Render', 19:35:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:35:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:35:33 INFO - 'HOME': '/Users/cltbld', 19:35:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:35:33 INFO - 'LOGNAME': 'cltbld', 19:35:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:33 INFO - 'MOZ_NO_REMOTE': '1', 19:35:33 INFO - 'NO_EM_RESTART': '1', 19:35:33 INFO - 'PAGER': '/bin/cat', 19:35:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:35:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:33 INFO - 'PWD': '/builds/slave/test', 19:35:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:35:33 INFO - 'SHELL': '/bin/bash', 19:35:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5UARR63kx0/Listeners', 19:35:33 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 19:35:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:35:33 INFO - 'USER': 'cltbld', 19:35:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:35:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:35:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:33 INFO - 'XPC_FLAGS': '0x0', 19:35:33 INFO - 'XPC_SERVICE_NAME': '0', 19:35:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:35:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:35:33 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-LXNaGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:35:33 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-WvgJ1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:35:33 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-pcRpo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:35:33 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-1IPA7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:35:33 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-7b8gqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:35:33 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-_7uef3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:35:34 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-mu1cfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:35:34 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-dp78IM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:35:34 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-t5V2xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:35:34 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-j9HQCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:35:34 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-H4T9V7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:35:34 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-Pzo3R_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:35:34 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-kFW7my-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:35:34 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-h0IfZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:35:34 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-1r_brU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:35:35 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-BgIk1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:35:35 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-qu78Sq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:35:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:35:35 INFO - Running setup.py install for manifestparser 19:35:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:35:35 INFO - Running setup.py install for mozcrash 19:35:35 INFO - Running setup.py install for mozdebug 19:35:35 INFO - Running setup.py install for mozdevice 19:35:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:35:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:35:35 INFO - Running setup.py install for mozfile 19:35:36 INFO - Running setup.py install for mozhttpd 19:35:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:35:36 INFO - Running setup.py install for mozinfo 19:35:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:35:36 INFO - Running setup.py install for mozInstall 19:35:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:35:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:35:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:35:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:35:36 INFO - Running setup.py install for mozleak 19:35:36 INFO - Running setup.py install for mozlog 19:35:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:35:36 INFO - Running setup.py install for moznetwork 19:35:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:35:36 INFO - Running setup.py install for mozprocess 19:35:37 INFO - Running setup.py install for mozprofile 19:35:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:35:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:35:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:35:37 INFO - Running setup.py install for mozrunner 19:35:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:35:37 INFO - Running setup.py install for mozscreenshot 19:35:37 INFO - Running setup.py install for moztest 19:35:37 INFO - Running setup.py install for mozversion 19:35:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:35:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:35:37 INFO - Cleaning up... 19:35:37 INFO - Return code: 0 19:35:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:35:37 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')]} 19:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:37 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')]} 19:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:37 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 0x102870b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102873768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd962c89810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10264ed30>, '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 0x102575db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102643be8>, '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.7QgnG65V6B/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.5UARR63kx0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 19:35:37 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 19:35:37 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 19:35:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7QgnG65V6B/Render', 19:35:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:35:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:35:37 INFO - 'HOME': '/Users/cltbld', 19:35:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:35:37 INFO - 'LOGNAME': 'cltbld', 19:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:37 INFO - 'MOZ_NO_REMOTE': '1', 19:35:37 INFO - 'NO_EM_RESTART': '1', 19:35:37 INFO - 'PAGER': '/bin/cat', 19:35:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:37 INFO - 'PWD': '/builds/slave/test', 19:35:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:35:37 INFO - 'SHELL': '/bin/bash', 19:35:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5UARR63kx0/Listeners', 19:35:37 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 19:35:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:35:37 INFO - 'USER': 'cltbld', 19:35:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:35:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:37 INFO - 'XPC_FLAGS': '0x0', 19:35:37 INFO - 'XPC_SERVICE_NAME': '0', 19:35:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:35:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:35:38 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-LzUWTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:35:38 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)) 19:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:35:38 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-wdGddA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:35:38 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-eDTGL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:35:38 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)) 19:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:35:38 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-9oe6PP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:35:38 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-M0MMqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:35:38 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)) 19:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:35:38 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-62wdVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:35:38 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)) 19:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:35:38 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-n0M6_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:35:38 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)) 19:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:35:38 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-1vS0TD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:35:38 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)) 19:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:35:38 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-iva4LS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:35:39 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)) 19:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:35:39 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-5RkekR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:35:39 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)) 19:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:35:39 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-7XdSm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:35:39 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)) 19:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:35:39 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-RMCSFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:35:39 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-re1Zxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:35:39 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)) 19:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:35:39 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-CHUBBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:35:39 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-IN8HWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:35:39 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)) 19:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:35:39 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-ub3to6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:35:39 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-6bwklM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:35:39 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)) 19:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:35:39 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)) 19:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:35:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:35:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:35:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:35:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:35:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:38:12 INFO - Downloading blessings-1.6.tar.gz 19:38:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:38:12 INFO - Installing collected packages: blessings 19:38:12 INFO - Running setup.py install for blessings 19:38:13 INFO - Successfully installed blessings 19:38:13 INFO - Cleaning up... 19:38:13 INFO - Return code: 0 19:38:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:38:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:38:13 INFO - Reading from file tmpfile_stdout 19:38:13 INFO - Current package versions: 19:38:13 INFO - blessings == 1.6 19:38:13 INFO - blobuploader == 1.2.4 19:38:13 INFO - docopt == 0.6.1 19:38:13 INFO - functools32 == 3.2.3-2 19:38:13 INFO - jsonschema == 2.5.1 19:38:13 INFO - manifestparser == 1.1 19:38:13 INFO - mozInstall == 1.12 19:38:13 INFO - mozcrash == 1.0 19:38:13 INFO - mozdebug == 0.1 19:38:13 INFO - mozdevice == 0.49 19:38:13 INFO - mozfile == 1.2 19:38:13 INFO - mozhttpd == 0.7 19:38:13 INFO - mozinfo == 0.9 19:38:13 INFO - mozleak == 0.1 19:38:13 INFO - mozlog == 3.4 19:38:13 INFO - moznetwork == 0.27 19:38:13 INFO - mozprocess == 0.25 19:38:13 INFO - mozprofile == 0.28 19:38:13 INFO - mozrunner == 6.13 19:38:13 INFO - mozscreenshot == 0.1 19:38:13 INFO - mozsystemmonitor == 0.3 19:38:13 INFO - moztest == 0.8 19:38:13 INFO - mozversion == 1.4 19:38:13 INFO - psutil == 3.1.1 19:38:13 INFO - requests == 1.2.3 19:38:13 INFO - wsgiref == 0.1.2 19:38:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:38:13 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')]} 19:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:38:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38:13 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')]} 19:38:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:38:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38:14 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 0x102870b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102873768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd962c89810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10264ed30>, '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 0x102575db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102643be8>, '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.7QgnG65V6B/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.5UARR63kx0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 19:38:14 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 19:38:14 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 19:38:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7QgnG65V6B/Render', 19:38:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:38:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:38:14 INFO - 'HOME': '/Users/cltbld', 19:38:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:38:14 INFO - 'LOGNAME': 'cltbld', 19:38:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:14 INFO - 'MOZ_NO_REMOTE': '1', 19:38:14 INFO - 'NO_EM_RESTART': '1', 19:38:14 INFO - 'PAGER': '/bin/cat', 19:38:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:38:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:38:14 INFO - 'PWD': '/builds/slave/test', 19:38:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:38:14 INFO - 'SHELL': '/bin/bash', 19:38:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5UARR63kx0/Listeners', 19:38:14 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 19:38:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:38:14 INFO - 'USER': 'cltbld', 19:38:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:38:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:38:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:14 INFO - 'XPC_FLAGS': '0x0', 19:38:14 INFO - 'XPC_SERVICE_NAME': '0', 19:38:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:38:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:38:14 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)) 19:38:14 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)) 19:38:14 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)) 19:38:14 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)) 19:38:14 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)) 19:38:14 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)) 19:38:14 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)) 19:38:14 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)) 19:38:14 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)) 19:38:14 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)) 19:38:14 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)) 19:38:14 INFO - Cleaning up... 19:38:14 INFO - Return code: 0 19:38:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:38:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:38:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:38:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38:14 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 0x102870b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102873768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd962c89810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10264ed30>, '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 0x102575db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102643be8>, '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.7QgnG65V6B/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.5UARR63kx0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 19:38:14 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 19:38:14 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 19:38:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7QgnG65V6B/Render', 19:38:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:38:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:38:14 INFO - 'HOME': '/Users/cltbld', 19:38:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:38:14 INFO - 'LOGNAME': 'cltbld', 19:38:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:14 INFO - 'MOZ_NO_REMOTE': '1', 19:38:14 INFO - 'NO_EM_RESTART': '1', 19:38:14 INFO - 'PAGER': '/bin/cat', 19:38:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:38:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:38:14 INFO - 'PWD': '/builds/slave/test', 19:38:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:38:14 INFO - 'SHELL': '/bin/bash', 19:38:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5UARR63kx0/Listeners', 19:38:14 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 19:38:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:38:14 INFO - 'USER': 'cltbld', 19:38:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:38:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:38:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:14 INFO - 'XPC_FLAGS': '0x0', 19:38:14 INFO - 'XPC_SERVICE_NAME': '0', 19:38:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:38:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:38:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:38:14 INFO - Cleaning up... 19:38:14 INFO - Return code: 0 19:38:14 INFO - Running post-action listener: _resource_record_post_action 19:38:14 INFO - Running post-action listener: _start_resource_monitoring 19:38:14 INFO - Starting resource monitoring. 19:38:14 INFO - [mozharness: 2017-05-20 02:38:14.874375Z] Finished create-virtualenv step (success) 19:38:14 INFO - [mozharness: 2017-05-20 02:38:14.875326Z] Running install step. 19:38:14 INFO - Running pre-action listener: _resource_record_pre_action 19:38:14 INFO - Running main action method: install 19:38:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:38:15 INFO - Reading from file tmpfile_stdout 19:38:15 INFO - Detecting whether we're running mozinstall >=1.0... 19:38:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:38:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:38:15 INFO - Reading from file tmpfile_stdout 19:38:15 INFO - Output received: 19:38:15 INFO - Usage: mozinstall [options] installer 19:38:15 INFO - Options: 19:38:15 INFO - -h, --help show this help message and exit 19:38:15 INFO - -d DEST, --destination=DEST 19:38:15 INFO - Directory to install application into. [default: 19:38:15 INFO - "/builds/slave/test"] 19:38:15 INFO - --app=APP Application being installed. [default: firefox] 19:38:15 INFO - mkdir: /builds/slave/test/build/application 19:38:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:38:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 19:38:35 INFO - Reading from file tmpfile_stdout 19:38:35 INFO - Output received: 19:38:35 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 19:38:35 INFO - Running post-action listener: _resource_record_post_action 19:38:35 INFO - [mozharness: 2017-05-20 02:38:35.444677Z] Finished install step (success) 19:38:35 INFO - [mozharness: 2017-05-20 02:38:35.444833Z] Running run-tests step. 19:38:35 INFO - Running pre-action listener: _resource_record_pre_action 19:38:35 INFO - Running main action method: run_tests 19:38:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:38:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:38:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:38:35 INFO - 2017-05-19 19:38:35.459 screenresolution[1624:8434] starting screenresolution argv=screenresolution get 19:38:35 INFO - 2017-05-19 19:38:35.461 screenresolution[1624:8434] Display 0: 1600x1200x32@60 19:38:35 INFO - 2017-05-19 19:38:35.468 screenresolution[1625:8436] starting screenresolution argv=screenresolution list 19:38:35 INFO - Available Modes on Display 0 19:38:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:38:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:38:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:38:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:38:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:38:35 INFO - Intel Iris: 19:38:35 INFO - Chipset Model: Intel Iris 19:38:35 INFO - Type: GPU 19:38:35 INFO - Bus: Built-In 19:38:35 INFO - VRAM (Dynamic, Max): 1536 MB 19:38:35 INFO - Vendor: Intel (0x8086) 19:38:35 INFO - Device ID: 0x0a2e 19:38:35 INFO - Revision ID: 0x0009 19:38:35 INFO - Displays: 19:38:35 INFO - Display: 19:38:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:38:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:38:35 INFO - Display Serial Number: 1600x1200 60 19:38:35 INFO - Main Display: Yes 19:38:35 INFO - Mirror: Off 19:38:35 INFO - Online: Yes 19:38:35 INFO - Rotation: Supported 19:38:35 INFO - Return code: 0 19:38:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:38:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:38:35 INFO - Python 2.7.3 19:38:35 INFO - Return code: 0 19:38:35 INFO - grabbing minidump binary from tooltool 19:38:35 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')]} 19:38:35 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 0x10264ed30>, '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 0x102575db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102643be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:38:35 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 19:38:35 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 19:38:35 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 19:38:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:38:35 INFO - Return code: 0 19:38:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:38:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:38:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:38:35 INFO - ENV: RUST_BACKTRACE is now 1 19:38:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:38:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:38:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Jamun', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0256', '--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 19:38:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Jamun --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0256 --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 19:38:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7QgnG65V6B/Render', 19:38:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:38:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:38:35 INFO - 'HOME': '/Users/cltbld', 19:38:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:38:35 INFO - 'LOGNAME': 'cltbld', 19:38:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:38:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:38:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:35 INFO - 'MOZ_NO_REMOTE': '1', 19:38:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:38:35 INFO - 'NO_EM_RESTART': '1', 19:38:35 INFO - 'PAGER': '/bin/cat', 19:38:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:38:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:38:35 INFO - 'PWD': '/builds/slave/test', 19:38:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:38:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:38:35 INFO - 'RUST_BACKTRACE': '1', 19:38:35 INFO - 'SHELL': '/bin/bash', 19:38:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5UARR63kx0/Listeners', 19:38:35 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 19:38:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:38:35 INFO - 'USER': 'cltbld', 19:38:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:38:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:38:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:35 INFO - 'XPC_FLAGS': '0x0', 19:38:35 INFO - 'XPC_SERVICE_NAME': '0', 19:38:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:38:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Jamun', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0256', '--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 19:38:36 INFO - mozversion application_buildid: 20170519111123 19:38:36 INFO - mozversion application_changeset: c3d5dc1002044b0b5c4fdc38de4db8a7f70429a7 19:38:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:38:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:38:36 INFO - mozversion application_name: Firefox 19:38:36 INFO - mozversion application_remotingname: firefox-dev 19:38:36 INFO - mozversion application_repository: https://hg.mozilla.org/projects/jamun 19:38:36 INFO - mozversion application_vendor: Mozilla 19:38:36 INFO - mozversion application_version: 54.0 19:38:36 INFO - mozversion platform_buildid: 20170519111123 19:38:36 INFO - mozversion platform_changeset: c3d5dc1002044b0b5c4fdc38de4db8a7f70429a7 19:38:36 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/jamun 19:38:36 INFO - mozversion platform_version: 54.0 19:38:36 INFO - using testdate: 1495247916 19:38:36 INFO - actual date: 1495247916 19:38:36 INFO - starting webserver on 'localhost:49244' 19:38:36 INFO - SUITE-START | Running 2 tests 19:38:36 INFO - TEST-START | dromaeo_css 19:38:36 INFO - operating with platform_type : mac_ 19:38:36 INFO - Initialising browser for dromaeo_css test... 19:38:36 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmpJmVebJ/profile http://localhost:49244/getInfo.html) 19:38:38 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 19:38:38 INFO - PROCESS | 1635 | colorDepth:24 19:38:38 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 19:38:38 INFO - PROCESS | 1635 | __metrics 19:38:38 INFO - PROCESS | 1635 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:38:38 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:38:39 INFO - TEST-INFO | 1635: exit 0 19:38:39 INFO - Browser initialized. 19:38:39 INFO - Running cycle 1/1 for dromaeo_css test... 19:38:39 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmpJmVebJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:38:51 INFO - PROCESS | 1639 | RSS: Main: 193474560 19:38:51 INFO - PROCESS | 1639 | 19:41:55 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 19:41:57 INFO - PROCESS | 1639 | RSS: Main: 376377344 19:41:57 INFO - PROCESS | 1639 | 19:45:00 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 19:45:01 INFO - PROCESS | 1639 | RSS: Main: 332468224 19:45:01 INFO - PROCESS | 1639 | 19:48:03 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 19:48:03 INFO - PROCESS | 1639 | RSS: Main: 323522560 19:48:03 INFO - PROCESS | 1639 | 19:51:06 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 19:51:06 INFO - PROCESS | 1639 | RSS: Main: 300621824 19:51:06 INFO - PROCESS | 1639 | 19:54:10 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 19:54:10 INFO - PROCESS | 1639 | RSS: Main: 296722432 19:54:10 INFO - PROCESS | 1639 | 19:57:13 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 19:57:14 INFO - PROCESS | 1639 | RSS: Main: 574283776 19:57:14 INFO - PROCESS | 1639 | 19:57:14 INFO - PROCESS | 1639 | __start_tp_report 19:57:14 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 19:57:14 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 19:57:14 INFO - PROCESS | 1639 | |i|pagename|runs| 19:57:14 INFO - PROCESS | 1639 | |0;dojo.html;3351.1454579082333;3372.932541349173;3378.7128094112;3398.8640454381834;3411.7270618350535;5302.443243459435;5943.138244954479;5946.970265148668;5979.402059794018;6015.969920150398;5957.612755170921;6006.339302676702;6006.519478441725;6018.518518518519;6019.608725432844;4601.815927362902;5321.52106310432;5340.599455040888;5352.545033672142;5451.809186678467;5310.70791106489;5327.30745003151;5345.919811202835;5387.380451248117;5449.073657478219;5476.534494567966;5477.1510415885405;5489.752961116739;5503.559715222793;5511.559075273988;5474.945250547523;5481.890362192774;5483.945160548404;5489.615726899118;5494.340679118492;5110.156824124015;5222.582193424517;5227.451117632631;5390.8921821563345;5403.756830942578;5779.88440231193;5787.797427090074;5794.942050579482;5804.59367844251;5830.7959221427045;6255.74977000924;6317.368263173692;6320.273168585625;6324.209473815773;6324.810255692337;6281.277653069909;6286.968565157145;6331.366863313678;6338.334474880117;6338.87322253557;5779.930712818142;6146.631202127886;6153.292371377304;6156.507479401637;6157.0456579230295;5915.142304365843;6437;6493.253275873335;6494.642794646245;6494.837629059311;6166.1983942087245;6231.657258850807;6333.524985626096;6382.042693595998;6400.743970241138;6372.55392122547;6391.1371964785085;6391.58454700443;6392.4886009119155;6413.29453760086;6219.098230756515;6293.1504246927;6321.431071203614;6342.429181373698;6359.586626869239;6244;6275.717592708248;6291.96854015727;6316.968415157895;6370.490360771128;5135.922961155586;5137.640365174402;5139.12634852076;5148.4079330876675;5165.9999999999245;4573.817047318136;4579;4587.1513769952;4596.4024676791805;4600.953990460052;5717.2281741965135;5797.826065218051;5805.88388232233;5904.911426328608;5987.520998320124;6343.619382837044;6374.617522948545;6403.96798016007;6410.711517981702;6414.61512309263;5990.131430942489;5990.700464976734;6001.369856165127;6004.759809607567;6046.818595442144;5431.185322201702;5596.2165296858475;5632;5640.802571910045;5653.971730141405;6326.335734747877;6331;6337.8732425352155;6345.587536810092;6347.428731414195;6291.213598300213;6323.114763932961;6334.113224148531;6355.713992870239;6368.64972426521;6515.73937042513;6563.671816409256;6566.770163044271;6567.507436942344;6578.572392794453;6325.272593651789;6336.556441049082;6337.65142917144;6352.68236588178;6353.936460635519;6223.96888015557;6360.968195158995;6363.5545511813725;6365.2361716594305;6366.045093235866;4957.909259962802;5998.550108741774;6153.876922461615;6154.076888466587;6166.907496387647;5987.461128498282;6121.8493044937295;6135.447809697149;6136.304638670978;6280.497560195265;6256.655883926428;6269.843253918506;6283.874322513616;6291.182146320949;6300.653464059337;6313.40022697843;6338.366163383809;6356.936430635635;6358.078078678658;6367.044943258548;6011.308699499614;6024.367441418588;6111.327753946974;6161.722722477589;6191.040388739752 19:57:14 INFO - PROCESS | 1639 | |1;ext.html;750.2385079144666;794.2057942057943;820.5486982159813;875.1248751248747;895.2837729816154;27631.447371052567;28019.719802801992;28739.56890646642;28782.712172878266;39875.60124398762;41058.7947060265;41312;41413.58586414135;41433;41440.585594144046;9267.768305792359;9406.717798466023;9408.29437792165;9411.388259763093;9414.62341506339;7373.668184931691;7529.0212272404515;9204.493752843591;9268.768280793;9292.767680808;11336.149788765875;11547.30716157029;11662.650120496399;11684.707882302968;11690.941545292262;11365.488553015093;11426.999999999958;11430.542778288858;11432.37121958292;11445.484953177043;9461.38500997433;11197.888021119767;11204.887951120467;11213.66359009231;11223.158263130215;38781.41827872584;39037;39088;39121.60878391208;39240.803795981126;3850.84596616135;3855.63371479709;3901.395283731026;3902.7268091233627;3934.8622798202214;24257.029718811227;24328.78356082189;28379.716202837913;29044.27389315263;29216.8539157305;3074.339017111332;3155.290059736541;3164.5095010273444;3187.7449804015855;3254.170186602425;320568;340916;341420.9999999975;341428;341744;50330.74834625877;50621.240681389805;50684.986300274526;50896.98206035858;50940.235896461585;54081.72959135179;54093;54135.729321353145;54204.18693719598;54245;13761.655958601115;14275.14349139055;14297.141371621623;14310;14419.206943617992;12201.14591978553;12230.388480575935;12284.385780710929;12305;12350.88842004206;10214.978502149726;10386.169106471616;10401.5839366426;11494.482748276349;12113.122466017781;4662.883427914329;5588.497035266845;5606.1030235163;5632.690202038845;5668.574856885668;1036.838740610521;1045.3362115056993;1057.962971296001;1067.6636859389423;1096.2545469081101;26487.735122648526;27919.58120628192;27975.160745177676;28229.576556351672;28352;1107.5625128074366;1128.351198061118;1150.0799360511558;1150.1201580790703;1152.6945359479744;10506.947465262625;11248.94375528117;14284;14505.854941450661;14626.122432654074;450707.7464612656;451717;451762;451876;451947;45435;46146.76926615345;53154.46845531573;53293.46706532885;53555.73222133942;1126.2397881430165;1453.2878889344356;1479.5857159995219;1499.2953311943152;1506.4200282891165;28823.5676464849;29768.255793605334;29840.403191936475;30431.54352684667;30500.08499745011;33856.83071584626;40864;41065.79467102645;41148.79425602853;41173.176536468505;432528;434360;468028;470968;477628;33748;33979.81070662515;33984.830075849466;34014;34095.48856767101;44784.77607612072;45745.77127114343;47558.762206188745;47698.52301476941;49287;32785.672143278265;32843.50734738933;33483.66516334806;33582.83208584039;34694.13264668403;33447.33105337928;33568.83215583907;34471;34505.82747086349;34549;38675.806620966716;39422.80288598539;40186.39720404138;41223.381649274685;41529.58470415378;33493.16267093342;33936.66063339335;34012.31975360528;34608.30783384368;35226.64773352234;26484.470310594064;26666;26668.59997100006;26673.32817066711;27023.594646080717 19:57:14 INFO - PROCESS | 1639 | |2;jquery.html;402.119358604656;432.1098537013752;433.4047447453378;437.4793995145776;443.3770552373914;16784.664306713858;19445.805541944577;20543.897280513596;22065.558688826233;22789.658155127687;17020.48938531843;19907.800921990776;20161.891095989715;20509.384718458434;20671.86304753238;6512.7069281882195;7023;7038.718451261969;7041.683124259395;7042.4718146138985;6612.867742645144;6761.695723692421;6839.589624622538;6842.726290948356;6935.653217339112;6501.544891857572;6848.315168483162;6850.109485766869;6857.72569097238;6868.210155832068;6737.124173857392;6801.18385793708;6812.863742725167;6904.344087311697;6935.895961560581;6285.968570157165;6580.638064906429;6618.139641846577;6687.899681504781;6696.263411024784;26546.33634159142;26597.73402265972;26647.733522664912;26678.466430671473;26871.731282687117;2513.8114641401967;2537.7335379785227;2542.2627438042946;2618.698849632279;2619.4213949315954;17012.660746710495;17171.484855454233;17172;17296.308147674205;17301.826981730148;1668.8498035176892;2035.9796402035938;2040.9183632654676;2045.1512622261744;2045.9590808183902;130211.34894325562;132427;137376;150773.24613376864;165163.9999999988;20019.39941801748;20538;20650.690239646417;20735.377938661863;20744.688829667568;31922.042338729876;32328.676713232566;32587.34825303481;32608.673913260565;32654.183645409055;9774.804503909882;10007.498875168783;10111.494425278706;10255.435951022766;10425.0096240857;8374.330053595697;8400.747977560683;8491.108433614505;8587;8619;9190.586423610954;9406.43561386319;9548.37935534188;9554.856677149848;9569.186619137312;3320.3896110386445;3321.983390083034;3864.246471937945;3928.4107383892647;3998.7400818946676;1012.71643939697;1015.5277795824977;1024.3546565663585;1025.9435731034864;1067.6690226029955;20921;21185.68221476679;21280.93595320228;21319;21401.46496337573;847.741438861141;858.7337925243195;1046.7592453735683;1052.8157572424795;1055.7307886488895;9365.11031452011;9583.802024746907;10373.585056597802;10979.945100274606;11013.614523491638;745543;762576;766047;774510;784343;114130.22332407061;123189;161451;168938.24550205568;172924;1074.1836204484648;1098.6923661374667;1116.748731535398;1119.4906317625623;1119.6081371519904;15503.922480387977;17661.735073974156;19624.705629415286;20445.182192712124;20500.282490112775;49564.50435495599;50810.745946270035;52096;62296.37703623087;62727;84356.57821710852;85373.57313213394;92278;92279;94957.05042949758;11213.439328033728;11713.297202167898;11819.349935753617;11961;12154.574589889311;11134.830842761394;12925.28910909909;13035.804462932874;13173.60479185626;13464.865351346361;11161.497732602214;11514.654560363202;11520.868639301756;11584.710382240175;11612.76774464489;10263.948680256552;10459.378796286588;10540.841887371542;10747.570097196338;10757.246992710436;11372.658820235076;11441.942790285995;11574.479148438171;11604.94197529007;11766.705832354259;11406.54373825071;11895.82156267674;11956.76086478283;12015.519379224734;12268.079894008164;11482.82775758381;11485.48315325829;11547.942260288644;11830;11831.112666550216 19:57:14 INFO - PROCESS | 1639 | |3;mootools.html;1323.2722002898406;1538.2616344154812;1574.5040312301624;1601.4234875444845;1608.284313480501;10842.891571084287;11402.429878506084;11415;11419.771604567914;11419.828702569448;11096.667099986993;11175.720606984809;11522.423878806068;11550.480228389722;11553.422328883564;2075.56413153238;2358.4103974006457;2422.515496900618;2433.415980164765;2436.6466862304956;2345.8240631952585;2415.0943396226417;2420.818438617102;2424.7696468835434;2427.2960841355984;2082.916683332665;2289.7939185473306;2324.755900630435;2350.635651474024;2377.5720370333333;2021.9797802021938;2346.4368551547677;2354.6114891042957;2365.597848365773;2369.336585755991;2336.906523739048;2396.364963284731;2402.711674599042;2402.8558286502866;2404.603240465321;11257.155713321534;11339;11343.092552595856;11347.546098156065;11367.147463940237;5571.303587051619;5615.410381909923;5826.329972053226;5853.5902486825935;5885.411458854123;3314.4696848504122;3501.7023552998025;3510.4207805712026;3529.2412131391875;3572.4105522588743;1112.7162573543694;1135.1883403366633;1186.0630102219236;1187.453771265219;1191.559123124441;13945.442182312696;14349;14569.562913112517;15611;15906.52280431589;4358.815440336251;4815.398075240595;4975.477574854661;5001.24981252815;5009;12574.748505029847;13284.73430531384;13293.80059299092;13309.134906231064;13327.600171994856;5928.140419639214;6012.579119461683;6016.127661489147;6024.367441418675;6028.608140470943;5268.209768534751;5286.3392075990505;5344.6258761887075;5353.491418315254;5385.380681221632;4020.6582440492884;4068.389741538793;4100.097978444737;4140.648044916215;4170.457840480718;1056.2553399853239;1084.804735147681;1086.093112251279;1099.1646348774989;1100.0429626225075;922.1976880114344;939.7086903060073;957.9281553883486;962.7833737409027;1008.8486726990864;5171.741412929338;5223.320968274176;5370.758315875795;5585.413531579207;6411.4229719325485;989.2086330935223;1019.4953498018529;1038.5015192707542;1040.354979912444;1048.3866937841296;3419.076849250688;4001.519817621846;4262.87211383659;4287.690870674952;4301.612854843017;13540.25528595917;14127.293635318192;14219.715605687828;14412.639684007983;14450.060746051684;11854.466549005316;13815.240161790996;14082.71834563303;14200.147991120566;14348.713025739635;10338.741531461774;10429.530671119817;10476.738081548023;10571.312864663925;10602.098821600097;5375.462453754593;5745.6552606843725;6573.145491086319;6707.061011458497;6897.517173797786;11973.221740586834;11977.101717371406;12147.149699520949;12147.453364598437;12350.197237179555;12329;12379.814302785286;12421.378931053592;12595.811062834247;12606.369681516071;9206.815863682823;9246.352755307333;9283.48940808235;9405.482698451377;9419.905800941902;10215.233857460571;10302.175825934057;10392.37645741258;10461.424621645883;10485.737856553647;8799.384043117176;8811.471311721318;8850.203481686422;8866.202041816268;8926.509042002752;8534.78663033429;8605;8620.956895215484;8715.607797649247;8882.333824963283;7676.731314403969;7754.534727916343;7858;7861.331786797958;7880.802979925547;5961.850953726192;5966.19456373384;6029.216201893726;6032.638041717511;6067.908981365194;5046.444891061907;5967.433093856077;6160.815175544741;6177.135201071764;6287.528435367457 19:57:14 INFO - PROCESS | 1639 | |4;prototype.html;346.95489586353773;380.9371453710138;385.63750074929567;393.88971088095343;394.5521832719863;4223.725457845242;4766.404199475066;4815.879603009922;5029.918567507985;5040;4238.745675259479;4679;4886.144924638192;4957;4975.552200301972;3680.650338217865;3681.263747250547;4002.459667944819;4137.358709400048;4184.0125940178405;3690.280395322913;3862.555806082308;4178.874633760992;4186.204621121992;4197.349410841324;3569.4651299941015;3959.78221197834;4175.206710724968;4201.936970945439;4224.704270701052;3587.982060089696;3788.7307751903145;3860.7297489175767;4142.730722503027;4191.937120943188;3457.9827100864336;3554.8091389384585;3820.541535015788;3844.884653460401;3863.0684657671163;4459.350040485009;4529.327696658987;4848.393950756155;4889.315495830587;4891.5353041461;4034.6570541504007;4132.855350062733;4456.665750068725;4817.277408388734;4820.879478013043;4794.137055330039;4946.356973593446;5246.632735708502;5315.920261196085;5339.332583427072;3729.6083911189476;3996.9008522656504;4310.676699247569;4339.587739164775;4348.7390756554705;4747.768548782067;5026.667932997795;5084.79660813567;5177.948220517822;5653.547716182696;3749.3063783200196;4157.069266167345;4330.848420305338;4344.891377715582;4353.782310884443;3972.503437070366;4407.184670835905;4411.514733379326;4419.469663640384;4460.375547423363;4378;4719.976400117977;4775.797298377405;4793.736344501016;4820.493848145964;4705.788239529229;4955.752212389366;5042.899142017139;5262.552683021986;5379.811706590251;1375.4841934274648;1471.6688745032282;1473.6463248820205;1494;1500.6698526324192;1032.4579595712312;1047.204124865108;1071.1912506057877;1091.858058452396;1162.8371628371629;4059.837606495707;4620.8151673933335;4738.763061846894;4772.427308722976;4895;4955.0675236657735;5249.897521520447;5268.420473747885;5463.9180412293845;5514.779408823682;4191.868195587174;4196.643285320721;4599.195140850405;4816.8554943351755;4971.825986090542;2428.672129262527;2607.0093364521363;2614.3856193794445;2694.8922043118446;2804.5232310507263;5400.081986062379;5482.780688772485;5657.2928383952;5718.139581355815;5743.167240750068;4789.568938795525;4915.5330243626795;5202.3497062867145;5693.572982026365;5694.9850355499275;5450.91823622646;5467.58993075513;5506.8072617459;5508.042761514669;5511.669299841942;4898.8775280618265;4947.678400903929;4967.652264341606;5329.08312390385;5333.17341808842;5106.617003724661;5395.892082158413;5418.729063546728;5429.429909859566;5435.755391007493;4958.801647934042;5640.85897852557;5649;5694.544436445157;5719.456651618089;4186.455760751083;4768.785404656868;4769.020856344717;4827.493113223201;4834.927476087932;4317.330813723878;4399.92201910534;4898.652870460652;4957.429895561912;5350;4885.682430641997;5241.475852414728;5272.868178295574;5279;5286.841394758163;4389.934150987674;4461.665375096816;5082.364704411949;5274.235235890697;5358.464153584766;4698.553637404441;4906.828261010847;5010.244365598979;5186.014657215117;5207.3230480037355;5228.666689994027;5280.0463828383745;5290.735463226746;5297.364316282071;5335.199720042025;4479.484859241229;4747.905041899212;5169.457206993212;5186.351706036746;5187.974060129675 19:57:14 INFO - PROCESS | 1639 | |5;yui.html;740.1968863782795;747.5029105644745;756.2890882570387;802.5265093594778;869.6173683579227;14592.92703536482;15648.217589120555;15699.450519231828;15714;15716.528504144879;13617.251051192205;14440.638984025405;14456.277186140704;14474;14527.564173074798;952.8475443928955;969.8642190093393;986.309583291695;986.585634033704;990.5542505872351;980.7695191629962;984.2126298960839;987.1609132237612;988.2686811759319;988.5106872098286;1041.0994489766335;1041.1098510773293;1042.353740680779;1042.7758032023114;1044.1177205261579;1035.1563475767225;1035.5133087448924;1035.9482025898674;1036.0727149201498;1039.6517166749147;767.1446337333888;769.2038739904173;769.5882702754055;770.8419773946327;771.1863983497408;15448;15562.37750489979;15576.922115389463;16094.356225750957;16409.83590164095;13978.650533736636;14309.427622895071;14401.135931844017;14479.855201447956;14514.491992780202;10211.619432997171;11738.178327517076;11899;11926.344051077187;12058.638240852788;3633.1643721943838;3672.320620685155;3724.776513409204;3880.6805686066873;3913.5695073541888;113527;116058.41970790176;116473.41763291214;118724;119081.40459297648;10648.201384896163;10733.731656708489;10899.455027248607;11043.558257669763;11147.996680298813;23481.412964675677;23612.29163125109;23612.763872361058;23733;23838.642420363707;7693.038370203724;7841.529508229524;7842.058952925686;7962.243586859239;8101.513909165469;4186.581341865789;4364.170807546556;4478.373027776114;4645.674802763774;4655.604273636711;3511.648835116519;3549.165946002687;3568.7858728476376;3617.4212126059706;3637.5453068366455;634.7334119669749;639.5011890725149;645.7998020613625;647.7020570537511;655.7475371981822;605.5337390209514;675.8040168351222;686.9003994420781;691.2327316678483;738.9482736208521;10315.690529284133;10330.535125919352;10463.94768026155;10670.946645266878;10676.786464270672;665.4443539644451;679.6262055869253;689.2142957028991;711.1892442615423;741.7033186725353;4674.2988551716835;5068.923966140511;5070.7464626768515;5076.695398276115;5093.388793344822;90179.29462116148;104217;109239;109677;110078;74211;88004.11995880087;90536.54731726299;91274;92915;66999.66500167469;67483;73512;77028.22971770211;79224.41551169059;9676.612935482503;9698.224142068759;9705.805883882424;9721.611135554498;9749.463779492196;47615.047699045135;50315.496845031084;51631.19290824803;53130;54029;64548;64881;65432;65749.69453656758;66076.33923660702;11888.881111189123;13361.198328100345;13913.58259252224;14503.274836258355;14759.409623615365;14461.276936153361;15038.131553861132;15971.041737495787;16021.279042442884;16644.50066498007;13476.393562289524;13790.517331893336;14368.928155359155;14887.702245954804;15091.342335186673;13333.732278124113;14365.764651923311;14660.780088298898;14801.703965920837;15144.16707081121;13325.400356983766;13816.101953372998;14100.224487653277;14242.789362903855;14447.566573002827;9437.858432123661;9905.950470247602;9934.205263578751;10091.495425228562;10100;8982.416142950688;9460.810783784149;10253.538590763583;10861.587993560786;11973.221740586834 19:57:14 INFO - PROCESS | 1639 | __end_tp_report 19:57:14 INFO - PROCESS | 1639 | __start_cc_report 19:57:14 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,1926 19:57:14 INFO - PROCESS | 1639 | __end_cc_report 19:57:14 INFO - PROCESS | 1639 | __startTimestamp1495249034041__endTimestamp 19:57:14 INFO - PROCESS | 1639 | 19:57:14 INFO - PROCESS | 1639 | ------- Summary: start ------- 19:57:14 INFO - PROCESS | 1639 | Number of tests: 6 19:57:14 INFO - PROCESS | 1639 | 19:57:14 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5891.96 Median:6153.29 stddev:652.81 (10.6%) stddev-sans-first:623.64 19:57:14 INFO - PROCESS | 1639 | Values: 3351.1 3372.9 3378.7 3398.9 3411.7 5302.4 5943.1 5947.0 5979.4 6016.0 5957.6 6006.3 6006.5 6018.5 6019.6 4601.8 5321.5 5340.6 5352.5 5451.8 5310.7 5327.3 5345.9 5387.4 5449.1 5476.5 5477.2 5489.8 5503.6 5511.6 5474.9 5481.9 5483.9 5489.6 5494.3 5110.2 5222.6 5227.5 5390.9 5403.8 5779.9 5787.8 5794.9 5804.6 5830.8 6255.7 6317.4 6320.3 6324.2 6324.8 6281.3 6287.0 6331.4 6338.3 6338.9 5779.9 6146.6 6153.3 6156.5 6157.0 5915.1 6437.0 6493.3 6494.6 6494.8 6166.2 6231.7 6333.5 6382.0 6400.7 6372.6 6391.1 6391.6 6392.5 6413.3 6219.1 6293.2 6321.4 6342.4 6359.6 6244.0 6275.7 6292.0 6317.0 6370.5 5135.9 5137.6 5139.1 5148.4 5166.0 4573.8 4579.0 4587.2 4596.4 4601.0 5717.2 5797.8 5805.9 5904.9 5987.5 6343.6 6374.6 6404.0 6410.7 6414.6 5990.1 5990.7 6001.4 6004.8 6046.8 5431.2 5596.2 5632.0 5640.8 5654.0 6326.3 6331.0 6337.9 6345.6 6347.4 6291.2 6323.1 6334.1 6355.7 6368.6 6515.7 6563.7 6566.8 6567.5 6578.6 6325.3 6336.6 6337.7 6352.7 6353.9 6224.0 6361.0 6363.6 6365.2 6366.0 4957.9 5998.6 6153.9 6154.1 6166.9 5987.5 6121.8 6135.4 6136.3 6280.5 6256.7 6269.8 6283.9 6291.2 6300.7 6313.4 6338.4 6356.9 6358.1 6367.0 6011.3 6024.4 6111.3 6161.7 6191.0 19:57:14 INFO - PROCESS | 1639 | 19:57:14 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:55691.49 Median:33998.57 stddev:111069.86 (326.7%) stddev-sans-first:111304.84 19:57:14 INFO - PROCESS | 1639 | Values: 750.2 794.2 820.5 875.1 895.3 27631.4 28019.7 28739.6 28782.7 39875.6 41058.8 41312.0 41413.6 41433.0 41440.6 9267.8 9406.7 9408.3 9411.4 9414.6 7373.7 7529.0 9204.5 9268.8 9292.8 11336.1 11547.3 11662.7 11684.7 11690.9 11365.5 11427.0 11430.5 11432.4 11445.5 9461.4 11197.9 11204.9 11213.7 11223.2 38781.4 39037.0 39088.0 39121.6 39240.8 3850.8 3855.6 3901.4 3902.7 3934.9 24257.0 24328.8 28379.7 29044.3 29216.9 3074.3 3155.3 3164.5 3187.7 3254.2 320568.0 340916.0 341421.0 341428.0 341744.0 50330.7 50621.2 50685.0 50897.0 50940.2 54081.7 54093.0 54135.7 54204.2 54245.0 13761.7 14275.1 14297.1 14310.0 14419.2 12201.1 12230.4 12284.4 12305.0 12350.9 10215.0 10386.2 10401.6 11494.5 12113.1 4662.9 5588.5 5606.1 5632.7 5668.6 1036.8 1045.3 1058.0 1067.7 1096.3 26487.7 27919.6 27975.2 28229.6 28352.0 1107.6 1128.4 1150.1 1150.1 1152.7 10506.9 11248.9 14284.0 14505.9 14626.1 450707.7 451717.0 451762.0 451876.0 451947.0 45435.0 46146.8 53154.5 53293.5 53555.7 1126.2 1453.3 1479.6 1499.3 1506.4 28823.6 29768.3 29840.4 30431.5 30500.1 33856.8 40864.0 41065.8 41148.8 41173.2 432528.0 434360.0 468028.0 470968.0 477628.0 33748.0 33979.8 33984.8 34014.0 34095.5 44784.8 45745.8 47558.8 47698.5 49287.0 32785.7 32843.5 33483.7 33582.8 34694.1 33447.3 33568.8 34471.0 34505.8 34549.0 38675.8 39422.8 40186.4 41223.4 41529.6 33493.2 33936.7 34012.3 34608.3 35226.6 26484.5 26666.0 26668.6 26673.3 27023.6 19:57:14 INFO - PROCESS | 1639 | 19:57:14 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:42935.94 Median:20703.62 stddev:127456.73 (615.6%) stddev-sans-first:127774.27 19:57:14 INFO - PROCESS | 1639 | Values: 402.1 432.1 433.4 437.5 443.4 16784.7 19445.8 20543.9 22065.6 22789.7 17020.5 19907.8 20161.9 20509.4 20671.9 6512.7 7023.0 7038.7 7041.7 7042.5 6612.9 6761.7 6839.6 6842.7 6935.7 6501.5 6848.3 6850.1 6857.7 6868.2 6737.1 6801.2 6812.9 6904.3 6935.9 6286.0 6580.6 6618.1 6687.9 6696.3 26546.3 26597.7 26647.7 26678.5 26871.7 2513.8 2537.7 2542.3 2618.7 2619.4 17012.7 17171.5 17172.0 17296.3 17301.8 1668.8 2036.0 2040.9 2045.2 2046.0 130211.3 132427.0 137376.0 150773.2 165164.0 20019.4 20538.0 20650.7 20735.4 20744.7 31922.0 32328.7 32587.3 32608.7 32654.2 9774.8 10007.5 10111.5 10255.4 10425.0 8374.3 8400.7 8491.1 8587.0 8619.0 9190.6 9406.4 9548.4 9554.9 9569.2 3320.4 3322.0 3864.2 3928.4 3998.7 1012.7 1015.5 1024.4 1025.9 1067.7 20921.0 21185.7 21280.9 21319.0 21401.5 847.7 858.7 1046.8 1052.8 1055.7 9365.1 9583.8 10373.6 10979.9 11013.6 745543.0 762576.0 766047.0 774510.0 784343.0 114130.2 123189.0 161451.0 168938.2 172924.0 1074.2 1098.7 1116.7 1119.5 1119.6 15503.9 17661.7 19624.7 20445.2 20500.3 49564.5 50810.7 52096.0 62296.4 62727.0 84356.6 85373.6 92278.0 92279.0 94957.1 11213.4 11713.3 11819.3 11961.0 12154.6 11134.8 12925.3 13035.8 13173.6 13464.9 11161.5 11514.7 11520.9 11584.7 11612.8 10263.9 10459.4 10540.8 10747.6 10757.2 11372.7 11441.9 11574.5 11604.9 11766.7 11406.5 11895.8 11956.8 12015.5 12268.1 11482.8 11485.5 11547.9 11830.0 11831.1 19:57:14 INFO - PROCESS | 1639 | 19:57:14 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:6797.80 Median:2402.78 stddev:4322.43 (179.9%) stddev-sans-first:4314.98 19:57:14 INFO - PROCESS | 1639 | Values: 1323.3 1538.3 1574.5 1601.4 1608.3 10842.9 11402.4 11415.0 11419.8 11419.8 11096.7 11175.7 11522.4 11550.5 11553.4 2075.6 2358.4 2422.5 2433.4 2436.6 2345.8 2415.1 2420.8 2424.8 2427.3 2082.9 2289.8 2324.8 2350.6 2377.6 2022.0 2346.4 2354.6 2365.6 2369.3 2336.9 2396.4 2402.7 2402.9 2404.6 11257.2 11339.0 11343.1 11347.5 11367.1 5571.3 5615.4 5826.3 5853.6 5885.4 3314.5 3501.7 3510.4 3529.2 3572.4 1112.7 1135.2 1186.1 1187.5 1191.6 13945.4 14349.0 14569.6 15611.0 15906.5 4358.8 4815.4 4975.5 5001.2 5009.0 12574.7 13284.7 13293.8 13309.1 13327.6 5928.1 6012.6 6016.1 6024.4 6028.6 5268.2 5286.3 5344.6 5353.5 5385.4 4020.7 4068.4 4100.1 4140.6 4170.5 1056.3 1084.8 1086.1 1099.2 1100.0 922.2 939.7 957.9 962.8 1008.8 5171.7 5223.3 5370.8 5585.4 6411.4 989.2 1019.5 1038.5 1040.4 1048.4 3419.1 4001.5 4262.9 4287.7 4301.6 13540.3 14127.3 14219.7 14412.6 14450.1 11854.5 13815.2 14082.7 14200.1 14348.7 10338.7 10429.5 10476.7 10571.3 10602.1 5375.5 5745.7 6573.1 6707.1 6897.5 11973.2 11977.1 12147.1 12147.5 12350.2 12329.0 12379.8 12421.4 12595.8 12606.4 9206.8 9246.4 9283.5 9405.5 9419.9 10215.2 10302.2 10392.4 10461.4 10485.7 8799.4 8811.5 8850.2 8866.2 8926.5 8534.8 8605.0 8621.0 8715.6 8882.3 7676.7 7754.5 7858.0 7861.3 7880.8 5961.9 5966.2 6029.2 6032.6 6067.9 5046.4 5967.4 6160.8 6177.1 6287.5 19:57:14 INFO - PROCESS | 1639 | 19:57:14 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4393.61 Median:4782.68 stddev:1224.59 (25.6%) stddev-sans-first:1189.76 19:57:14 INFO - PROCESS | 1639 | Values: 347.0 380.9 385.6 393.9 394.6 4223.7 4766.4 4815.9 5029.9 5040.0 4238.7 4679.0 4886.1 4957.0 4975.6 3680.7 3681.3 4002.5 4137.4 4184.0 3690.3 3862.6 4178.9 4186.2 4197.3 3569.5 3959.8 4175.2 4201.9 4224.7 3588.0 3788.7 3860.7 4142.7 4191.9 3458.0 3554.8 3820.5 3844.9 3863.1 4459.4 4529.3 4848.4 4889.3 4891.5 4034.7 4132.9 4456.7 4817.3 4820.9 4794.1 4946.4 5246.6 5315.9 5339.3 3729.6 3996.9 4310.7 4339.6 4348.7 4747.8 5026.7 5084.8 5177.9 5653.5 3749.3 4157.1 4330.8 4344.9 4353.8 3972.5 4407.2 4411.5 4419.5 4460.4 4378.0 4720.0 4775.8 4793.7 4820.5 4705.8 4955.8 5042.9 5262.6 5379.8 1375.5 1471.7 1473.6 1494.0 1500.7 1032.5 1047.2 1071.2 1091.9 1162.8 4059.8 4620.8 4738.8 4772.4 4895.0 4955.1 5249.9 5268.4 5463.9 5514.8 4191.9 4196.6 4599.2 4816.9 4971.8 2428.7 2607.0 2614.4 2694.9 2804.5 5400.1 5482.8 5657.3 5718.1 5743.2 4789.6 4915.5 5202.3 5693.6 5695.0 5450.9 5467.6 5506.8 5508.0 5511.7 4898.9 4947.7 4967.7 5329.1 5333.2 5106.6 5395.9 5418.7 5429.4 5435.8 4958.8 5640.9 5649.0 5694.5 5719.5 4186.5 4768.8 4769.0 4827.5 4834.9 4317.3 4399.9 4898.7 4957.4 5350.0 4885.7 5241.5 5272.9 5279.0 5286.8 4389.9 4461.7 5082.4 5274.2 5358.5 4698.6 4906.8 5010.2 5186.0 5207.3 5228.7 5280.0 5290.7 5297.4 5335.2 4479.5 4747.9 5169.5 5186.4 5188.0 19:57:14 INFO - PROCESS | 1639 | 19:57:14 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:20811.50 Median:3558.98 stddev:30034.51 (843.9%) stddev-sans-first:30080.95 19:57:14 INFO - PROCESS | 1639 | Values: 740.2 747.5 756.3 802.5 869.6 14592.9 15648.2 15699.5 15714.0 15716.5 13617.3 14440.6 14456.3 14474.0 14527.6 952.8 969.9 986.3 986.6 990.6 980.8 984.2 987.2 988.3 988.5 1041.1 1041.1 1042.4 1042.8 1044.1 1035.2 1035.5 1035.9 1036.1 1039.7 767.1 769.2 769.6 770.8 771.2 15448.0 15562.4 15576.9 16094.4 16409.8 13978.7 14309.4 14401.1 14479.9 14514.5 10211.6 11738.2 11899.0 11926.3 12058.6 3633.2 3672.3 3724.8 3880.7 3913.6 113527.0 116058.4 116473.4 118724.0 119081.4 10648.2 10733.7 10899.5 11043.6 11148.0 23481.4 23612.3 23612.8 23733.0 23838.6 7693.0 7841.5 7842.1 7962.2 8101.5 4186.6 4364.2 4478.4 4645.7 4655.6 3511.6 3549.2 3568.8 3617.4 3637.5 634.7 639.5 645.8 647.7 655.7 605.5 675.8 686.9 691.2 738.9 10315.7 10330.5 10463.9 10670.9 10676.8 665.4 679.6 689.2 711.2 741.7 4674.3 5068.9 5070.7 5076.7 5093.4 90179.3 104217.0 109239.0 109677.0 110078.0 74211.0 88004.1 90536.5 91274.0 92915.0 66999.7 67483.0 73512.0 77028.2 79224.4 9676.6 9698.2 9705.8 9721.6 9749.5 47615.0 50315.5 51631.2 53130.0 54029.0 64548.0 64881.0 65432.0 65749.7 66076.3 11888.9 13361.2 13913.6 14503.3 14759.4 14461.3 15038.1 15971.0 16021.3 16644.5 13476.4 13790.5 14368.9 14887.7 15091.3 13333.7 14365.8 14660.8 14801.7 15144.2 13325.4 13816.1 14100.2 14242.8 14447.6 9437.9 9906.0 9934.2 10091.5 10100.0 8982.4 9460.8 10253.5 10861.6 11973.2 19:57:14 INFO - PROCESS | 1639 | -------- Summary: end -------- 19:57:14 INFO - PROCESS | 1639 | 19:57:14 INFO - TEST-INFO | 1639: exit 0 19:57:14 INFO - TEST-OK | dromaeo_css | took 1118530ms 19:57:14 INFO - TEST-START | kraken 19:57:14 INFO - operating with platform_type : mac_ 19:57:14 INFO - Initialising browser for kraken test... 19:57:14 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmpoVsbsr/profile http://localhost:49244/getInfo.html) 19:57:16 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 19:57:16 INFO - PROCESS | 1645 | colorDepth:24 19:57:16 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 19:57:16 INFO - PROCESS | 1645 | __metrics 19:57:16 INFO - PROCESS | 1645 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:57:16 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:57:17 INFO - TEST-INFO | 1645: exit 0 19:57:17 INFO - Browser initialized. 19:57:17 INFO - Running cycle 1/1 for kraken test... 19:57:17 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmpoVsbsr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:57:29 INFO - PROCESS | 1647 | RSS: Main: 193716224 19:57:29 INFO - PROCESS | 1647 | 19:57:32 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 19:57:33 INFO - PROCESS | 1647 | RSS: Main: 244707328 19:57:33 INFO - PROCESS | 1647 | 19:57:36 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 19:57:36 INFO - PROCESS | 1647 | RSS: Main: 260198400 19:57:36 INFO - PROCESS | 1647 | 19:57:39 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 19:57:40 INFO - PROCESS | 1647 | RSS: Main: 357502976 19:57:40 INFO - PROCESS | 1647 | 19:57:42 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 19:57:43 INFO - PROCESS | 1647 | RSS: Main: 259010560 19:57:43 INFO - PROCESS | 1647 | 19:57:45 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:57:45 INFO - PROCESS | 1647 | RSS: Main: 261541888 19:57:45 INFO - PROCESS | 1647 | 19:57:48 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 19:57:49 INFO - PROCESS | 1647 | RSS: Main: 301195264 19:57:49 INFO - PROCESS | 1647 | 19:57:52 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 19:57:52 INFO - PROCESS | 1647 | RSS: Main: 302395392 19:57:52 INFO - PROCESS | 1647 | 19:57:55 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 19:57:56 INFO - PROCESS | 1647 | RSS: Main: 299130880 19:57:56 INFO - PROCESS | 1647 | 19:57:57 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:57:58 INFO - PROCESS | 1647 | RSS: Main: 277209088 19:57:58 INFO - PROCESS | 1647 | 19:58:00 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:58:01 INFO - PROCESS | 1647 | RSS: Main: 280555520 19:58:01 INFO - PROCESS | 1647 | 19:58:03 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:58:03 INFO - PROCESS | 1647 | RSS: Main: 286195712 19:58:03 INFO - PROCESS | 1647 | 19:58:06 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:58:07 INFO - PROCESS | 1647 | RSS: Main: 298930176 19:58:07 INFO - PROCESS | 1647 | 19:58:10 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:58:10 INFO - PROCESS | 1647 | RSS: Main: 292139008 19:58:10 INFO - PROCESS | 1647 | 19:58:12 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 19:58:12 INFO - PROCESS | 1647 | RSS: Main: 337006592 19:58:12 INFO - PROCESS | 1647 | 19:58:12 INFO - PROCESS | 1647 | __start_tp_report 19:58:12 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 19:58:12 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 19:58:12 INFO - PROCESS | 1647 | |i|pagename|runs| 19:58:12 INFO - PROCESS | 1647 | |0;ai-astar;104;116;116;115;114;117;114;115;114;115 19:58:12 INFO - PROCESS | 1647 | |1;audio-beat-detection;137;106;107;142;110;107;107;103;107;125 19:58:12 INFO - PROCESS | 1647 | |2;audio-dft;184;181;184;187;198;257;200;185;185;184 19:58:12 INFO - PROCESS | 1647 | |3;audio-fft;81;59;62;93;62;61;60;61;76;61 19:58:12 INFO - PROCESS | 1647 | |4;audio-oscillator;89;68;86;68;69;68;81;68;68;83 19:58:12 INFO - PROCESS | 1647 | |5;imaging-gaussian-blur;86;86;86;86;87;86;86;86;87;86 19:58:12 INFO - PROCESS | 1647 | |6;imaging-darkroom;93;94;93;94;93;94;96;93;92;92 19:58:12 INFO - PROCESS | 1647 | |7;imaging-desaturate;84;84;86;86;83;85;84;86;83;101 19:58:12 INFO - PROCESS | 1647 | |8;json-parse-financial;64;63;61;59;61;64;63;63;63;65 19:58:12 INFO - PROCESS | 1647 | |9;json-stringify-tinderbox;54;61;62;63;59;58;59;58;58;61 19:58:12 INFO - PROCESS | 1647 | |10;stanford-crypto-aes;85;82;82;85;84;89;97;97;83;86 19:58:12 INFO - PROCESS | 1647 | |11;stanford-crypto-ccm;136;136;136;138;135;138;140;138;180;147 19:58:12 INFO - PROCESS | 1647 | |12;stanford-crypto-pbkdf2;164;162;162;163;164;164;163;163;162;166 19:58:12 INFO - PROCESS | 1647 | |13;stanford-crypto-sha256-iterative;65;64;65;63;63;67;76;78;79;55 19:58:12 INFO - PROCESS | 1647 | __end_tp_report 19:58:12 INFO - PROCESS | 1647 | __start_cc_report 19:58:12 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,2170 19:58:12 INFO - PROCESS | 1647 | __end_cc_report 19:58:12 INFO - PROCESS | 1647 | __startTimestamp1495249092863__endTimestamp 19:58:12 INFO - PROCESS | 1647 | 19:58:12 INFO - PROCESS | 1647 | ------- Summary: start ------- 19:58:12 INFO - PROCESS | 1647 | Number of tests: 14 19:58:12 INFO - PROCESS | 1647 | 19:58:12 INFO - PROCESS | 1647 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.00 stddev:3.65 (3.2%) stddev-sans-first:1.05 19:58:12 INFO - PROCESS | 1647 | Values: 104.0 116.0 116.0 115.0 114.0 117.0 114.0 115.0 114.0 115.0 19:58:12 INFO - PROCESS | 1647 | 19:58:12 INFO - PROCESS | 1647 | [#1] audio-beat-detection Cycles:10 Average:115.10 Median:108.50 stddev:14.22 (13.1%) stddev-sans-first:12.68 19:58:12 INFO - PROCESS | 1647 | Values: 137.0 106.0 107.0 142.0 110.0 107.0 107.0 103.0 107.0 125.0 19:58:12 INFO - PROCESS | 1647 | 19:58:12 INFO - PROCESS | 1647 | [#2] audio-dft Cycles:10 Average:194.50 Median:186.00 stddev:22.85 (12.3%) stddev-sans-first:23.92 19:58:12 INFO - PROCESS | 1647 | Values: 184.0 181.0 184.0 187.0 198.0 257.0 200.0 185.0 185.0 184.0 19:58:12 INFO - PROCESS | 1647 | 19:58:12 INFO - PROCESS | 1647 | [#3] audio-fft Cycles:10 Average:67.60 Median:62.00 stddev:11.64 (18.8%) stddev-sans-first:11.30 19:58:12 INFO - PROCESS | 1647 | Values: 81.0 59.0 62.0 93.0 62.0 61.0 60.0 61.0 76.0 61.0 19:58:12 INFO - PROCESS | 1647 | 19:58:12 INFO - PROCESS | 1647 | [#4] audio-oscillator Cycles:10 Average:74.80 Median:75.00 stddev:8.80 (11.7%) stddev-sans-first:7.69 19:58:12 INFO - PROCESS | 1647 | Values: 89.0 68.0 86.0 68.0 69.0 68.0 81.0 68.0 68.0 83.0 19:58:12 INFO - PROCESS | 1647 | 19:58:12 INFO - PROCESS | 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:86.20 Median:86.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 19:58:12 INFO - PROCESS | 1647 | Values: 86.0 86.0 86.0 86.0 87.0 86.0 86.0 86.0 87.0 86.0 19:58:12 INFO - PROCESS | 1647 | 19:58:12 INFO - PROCESS | 1647 | [#6] imaging-darkroom Cycles:10 Average:93.40 Median:93.50 stddev:1.17 (1.3%) stddev-sans-first:1.24 19:58:12 INFO - PROCESS | 1647 | Values: 93.0 94.0 93.0 94.0 93.0 94.0 96.0 93.0 92.0 92.0 19:58:12 INFO - PROCESS | 1647 | 19:58:12 INFO - PROCESS | 1647 | [#7] imaging-desaturate Cycles:10 Average:86.20 Median:84.50 stddev:5.33 (6.3%) stddev-sans-first:5.59 19:58:12 INFO - PROCESS | 1647 | Values: 84.0 84.0 86.0 86.0 83.0 85.0 84.0 86.0 83.0 101.0 19:58:12 INFO - PROCESS | 1647 | 19:58:12 INFO - PROCESS | 1647 | [#8] json-parse-financial Cycles:10 Average:62.60 Median:63.00 stddev:1.78 (2.8%) stddev-sans-first:1.81 19:58:12 INFO - PROCESS | 1647 | Values: 64.0 63.0 61.0 59.0 61.0 64.0 63.0 63.0 63.0 65.0 19:58:12 INFO - PROCESS | 1647 | 19:58:12 INFO - PROCESS | 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:60.00 stddev:2.58 (4.3%) stddev-sans-first:1.90 19:58:12 INFO - PROCESS | 1647 | Values: 54.0 61.0 62.0 63.0 59.0 58.0 59.0 58.0 58.0 61.0 19:58:12 INFO - PROCESS | 1647 | 19:58:12 INFO - PROCESS | 1647 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:85.50 stddev:5.66 (6.6%) stddev-sans-first:5.95 19:58:12 INFO - PROCESS | 1647 | Values: 85.0 82.0 82.0 85.0 84.0 89.0 97.0 97.0 83.0 86.0 19:58:12 INFO - PROCESS | 1647 | 19:58:12 INFO - PROCESS | 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:142.40 Median:138.00 stddev:13.65 (9.9%) stddev-sans-first:14.28 19:58:12 INFO - PROCESS | 1647 | Values: 136.0 136.0 136.0 138.0 135.0 138.0 140.0 138.0 180.0 147.0 19:58:12 INFO - PROCESS | 1647 | 19:58:12 INFO - PROCESS | 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.30 Median:163.50 stddev:1.25 (0.8%) stddev-sans-first:1.30 19:58:12 INFO - PROCESS | 1647 | Values: 164.0 162.0 162.0 163.0 164.0 164.0 163.0 163.0 162.0 166.0 19:58:12 INFO - PROCESS | 1647 | 19:58:12 INFO - PROCESS | 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:66.00 stddev:7.72 (11.7%) stddev-sans-first:8.14 19:58:12 INFO - PROCESS | 1647 | Values: 65.0 64.0 65.0 63.0 63.0 67.0 76.0 78.0 79.0 55.0 19:58:12 INFO - PROCESS | 1647 | -------- Summary: end -------- 19:58:12 INFO - PROCESS | 1647 | 19:58:13 INFO - TEST-INFO | 1647: exit 0 19:58:13 INFO - TEST-OK | kraken | took 59073ms 19:58:13 INFO - SUITE-END | took 1177s 19:58:14 INFO - Completed test suite (00:19:37) 19:58:14 INFO - javascript benchmark 19:58:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7670.000545161928, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3351.1454579082333, 3372.932541349173, 3378.7128094112, 3398.8640454381834, 3411.7270618350535, 5302.443243459435, 5943.138244954479, 5946.970265148668, 5979.402059794018, 6015.969920150398, 5957.612755170921, 6006.339302676702, 6006.519478441725, 6018.518518518519, 6019.608725432844, 4601.815927362902, 5321.52106310432, 5340.599455040888, 5352.545033672142, 5451.809186678467, 5310.70791106489, 5327.30745003151, 5345.919811202835, 5387.380451248117, 5449.073657478219, 5476.534494567966, 5477.1510415885405, 5489.752961116739, 5503.559715222793, 5511.559075273988, 5474.945250547523, 5481.890362192774, 5483.945160548404, 5489.615726899118, 5494.340679118492, 5110.156824124015, 5222.582193424517, 5227.451117632631, 5390.8921821563345, 5403.756830942578, 5779.88440231193, 5787.797427090074, 5794.942050579482, 5804.59367844251, 5830.7959221427045, 6255.74977000924, 6317.368263173692, 6320.273168585625, 6324.209473815773, 6324.810255692337, 6281.277653069909, 6286.968565157145, 6331.366863313678, 6338.334474880117, 6338.87322253557, 5779.930712818142, 6146.631202127886, 6153.292371377304, 6156.507479401637, 6157.0456579230295, 5915.142304365843, 6437.0, 6493.253275873335, 6494.642794646245, 6494.837629059311, 6166.1983942087245, 6231.657258850807, 6333.524985626096, 6382.042693595998, 6400.743970241138, 6372.55392122547, 6391.1371964785085, 6391.58454700443, 6392.4886009119155, 6413.29453760086, 6219.098230756515, 6293.1504246927, 6321.431071203614, 6342.429181373698, 6359.586626869239, 6244.0, 6275.717592708248, 6291.96854015727, 6316.968415157895, 6370.490360771128, 5135.922961155586, 5137.640365174402, 5139.12634852076, 5148.4079330876675, 5165.9999999999245, 4573.817047318136, 4579.0, 4587.1513769952, 4596.4024676791805, 4600.953990460052, 5717.2281741965135, 5797.826065218051, 5805.88388232233, 5904.911426328608, 5987.520998320124, 6343.619382837044, 6374.617522948545, 6403.96798016007, 6410.711517981702, 6414.61512309263, 5990.131430942489, 5990.700464976734, 6001.369856165127, 6004.759809607567, 6046.818595442144, 5431.185322201702, 5596.2165296858475, 5632.0, 5640.802571910045, 5653.971730141405, 6326.335734747877, 6331.0, 6337.8732425352155, 6345.587536810092, 6347.428731414195, 6291.213598300213, 6323.114763932961, 6334.113224148531, 6355.713992870239, 6368.64972426521, 6515.73937042513, 6563.671816409256, 6566.770163044271, 6567.507436942344, 6578.572392794453, 6325.272593651789, 6336.556441049082, 6337.65142917144, 6352.68236588178, 6353.936460635519, 6223.96888015557, 6360.968195158995, 6363.5545511813725, 6365.2361716594305, 6366.045093235866, 4957.909259962802, 5998.550108741774, 6153.876922461615, 6154.076888466587, 6166.907496387647, 5987.461128498282, 6121.8493044937295, 6135.447809697149, 6136.304638670978, 6280.497560195265, 6256.655883926428, 6269.843253918506, 6283.874322513616, 6291.182146320949, 6300.653464059337, 6313.40022697843, 6338.366163383809, 6356.936430635635, 6358.078078678658, 6367.044943258548, 6011.308699499614, 6024.367441418588, 6111.327753946974, 6161.722722477589, 6191.040388739752], "value": 5849.927016973126, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.2385079144666, 794.2057942057943, 820.5486982159813, 875.1248751248747, 895.2837729816154, 27631.447371052567, 28019.719802801992, 28739.56890646642, 28782.712172878266, 39875.60124398762, 41058.7947060265, 41312.0, 41413.58586414135, 41433.0, 41440.585594144046, 9267.768305792359, 9406.717798466023, 9408.29437792165, 9411.388259763093, 9414.62341506339, 7373.668184931691, 7529.0212272404515, 9204.493752843591, 9268.768280793, 9292.767680808, 11336.149788765875, 11547.30716157029, 11662.650120496399, 11684.707882302968, 11690.941545292262, 11365.488553015093, 11426.999999999958, 11430.542778288858, 11432.37121958292, 11445.484953177043, 9461.38500997433, 11197.888021119767, 11204.887951120467, 11213.66359009231, 11223.158263130215, 38781.41827872584, 39037.0, 39088.0, 39121.60878391208, 39240.803795981126, 3850.84596616135, 3855.63371479709, 3901.395283731026, 3902.7268091233627, 3934.8622798202214, 24257.029718811227, 24328.78356082189, 28379.716202837913, 29044.27389315263, 29216.8539157305, 3074.339017111332, 3155.290059736541, 3164.5095010273444, 3187.7449804015855, 3254.170186602425, 320568.0, 340916.0, 341420.9999999975, 341428.0, 341744.0, 50330.74834625877, 50621.240681389805, 50684.986300274526, 50896.98206035858, 50940.235896461585, 54081.72959135179, 54093.0, 54135.729321353145, 54204.18693719598, 54245.0, 13761.655958601115, 14275.14349139055, 14297.141371621623, 14310.0, 14419.206943617992, 12201.14591978553, 12230.388480575935, 12284.385780710929, 12305.0, 12350.88842004206, 10214.978502149726, 10386.169106471616, 10401.5839366426, 11494.482748276349, 12113.122466017781, 4662.883427914329, 5588.497035266845, 5606.1030235163, 5632.690202038845, 5668.574856885668, 1036.838740610521, 1045.3362115056993, 1057.962971296001, 1067.6636859389423, 1096.2545469081101, 26487.735122648526, 27919.58120628192, 27975.160745177676, 28229.576556351672, 28352.0, 1107.5625128074366, 1128.351198061118, 1150.0799360511558, 1150.1201580790703, 1152.6945359479744, 10506.947465262625, 11248.94375528117, 14284.0, 14505.854941450661, 14626.122432654074, 450707.7464612656, 451717.0, 451762.0, 451876.0, 451947.0, 45435.0, 46146.76926615345, 53154.46845531573, 53293.46706532885, 53555.73222133942, 1126.2397881430165, 1453.2878889344356, 1479.5857159995219, 1499.2953311943152, 1506.4200282891165, 28823.5676464849, 29768.255793605334, 29840.403191936475, 30431.54352684667, 30500.08499745011, 33856.83071584626, 40864.0, 41065.79467102645, 41148.79425602853, 41173.176536468505, 432528.0, 434360.0, 468028.0, 470968.0, 477628.0, 33748.0, 33979.81070662515, 33984.830075849466, 34014.0, 34095.48856767101, 44784.77607612072, 45745.77127114343, 47558.762206188745, 47698.52301476941, 49287.0, 32785.672143278265, 32843.50734738933, 33483.66516334806, 33582.83208584039, 34694.13264668403, 33447.33105337928, 33568.83215583907, 34471.0, 34505.82747086349, 34549.0, 38675.806620966716, 39422.80288598539, 40186.39720404138, 41223.381649274685, 41529.58470415378, 33493.16267093342, 33936.66063339335, 34012.31975360528, 34608.30783384368, 35226.64773352234, 26484.470310594064, 26666.0, 26668.59997100006, 26673.32817066711, 27023.594646080717], "value": 18817.825675823733, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.119358604656, 432.1098537013752, 433.4047447453378, 437.4793995145776, 443.3770552373914, 16784.664306713858, 19445.805541944577, 20543.897280513596, 22065.558688826233, 22789.658155127687, 17020.48938531843, 19907.800921990776, 20161.891095989715, 20509.384718458434, 20671.86304753238, 6512.7069281882195, 7023.0, 7038.718451261969, 7041.683124259395, 7042.4718146138985, 6612.867742645144, 6761.695723692421, 6839.589624622538, 6842.726290948356, 6935.653217339112, 6501.544891857572, 6848.315168483162, 6850.109485766869, 6857.72569097238, 6868.210155832068, 6737.124173857392, 6801.18385793708, 6812.863742725167, 6904.344087311697, 6935.895961560581, 6285.968570157165, 6580.638064906429, 6618.139641846577, 6687.899681504781, 6696.263411024784, 26546.33634159142, 26597.73402265972, 26647.733522664912, 26678.466430671473, 26871.731282687117, 2513.8114641401967, 2537.7335379785227, 2542.2627438042946, 2618.698849632279, 2619.4213949315954, 17012.660746710495, 17171.484855454233, 17172.0, 17296.308147674205, 17301.826981730148, 1668.8498035176892, 2035.9796402035938, 2040.9183632654676, 2045.1512622261744, 2045.9590808183902, 130211.34894325562, 132427.0, 137376.0, 150773.24613376864, 165163.9999999988, 20019.39941801748, 20538.0, 20650.690239646417, 20735.377938661863, 20744.688829667568, 31922.042338729876, 32328.676713232566, 32587.34825303481, 32608.673913260565, 32654.183645409055, 9774.804503909882, 10007.498875168783, 10111.494425278706, 10255.435951022766, 10425.0096240857, 8374.330053595697, 8400.747977560683, 8491.108433614505, 8587.0, 8619.0, 9190.586423610954, 9406.43561386319, 9548.37935534188, 9554.856677149848, 9569.186619137312, 3320.3896110386445, 3321.983390083034, 3864.246471937945, 3928.4107383892647, 3998.7400818946676, 1012.71643939697, 1015.5277795824977, 1024.3546565663585, 1025.9435731034864, 1067.6690226029955, 20921.0, 21185.68221476679, 21280.93595320228, 21319.0, 21401.46496337573, 847.741438861141, 858.7337925243195, 1046.7592453735683, 1052.8157572424795, 1055.7307886488895, 9365.11031452011, 9583.802024746907, 10373.585056597802, 10979.945100274606, 11013.614523491638, 745543.0, 762576.0, 766047.0, 774510.0, 784343.0, 114130.22332407061, 123189.0, 161451.0, 168938.24550205568, 172924.0, 1074.1836204484648, 1098.6923661374667, 1116.748731535398, 1119.4906317625623, 1119.6081371519904, 15503.922480387977, 17661.735073974156, 19624.705629415286, 20445.182192712124, 20500.282490112775, 49564.50435495599, 50810.745946270035, 52096.0, 62296.37703623087, 62727.0, 84356.57821710852, 85373.57313213394, 92278.0, 92279.0, 94957.05042949758, 11213.439328033728, 11713.297202167898, 11819.349935753617, 11961.0, 12154.574589889311, 11134.830842761394, 12925.28910909909, 13035.804462932874, 13173.60479185626, 13464.865351346361, 11161.497732602214, 11514.654560363202, 11520.868639301756, 11584.710382240175, 11612.76774464489, 10263.948680256552, 10459.378796286588, 10540.841887371542, 10747.570097196338, 10757.246992710436, 11372.658820235076, 11441.942790285995, 11574.479148438171, 11604.94197529007, 11766.705832354259, 11406.54373825071, 11895.82156267674, 11956.76086478283, 12015.519379224734, 12268.079894008164, 11482.82775758381, 11485.48315325829, 11547.942260288644, 11830.0, 11831.112666550216], "value": 11427.769197005638, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.2722002898406, 1538.2616344154812, 1574.5040312301624, 1601.4234875444845, 1608.284313480501, 10842.891571084287, 11402.429878506084, 11415.0, 11419.771604567914, 11419.828702569448, 11096.667099986993, 11175.720606984809, 11522.423878806068, 11550.480228389722, 11553.422328883564, 2075.56413153238, 2358.4103974006457, 2422.515496900618, 2433.415980164765, 2436.6466862304956, 2345.8240631952585, 2415.0943396226417, 2420.818438617102, 2424.7696468835434, 2427.2960841355984, 2082.916683332665, 2289.7939185473306, 2324.755900630435, 2350.635651474024, 2377.5720370333333, 2021.9797802021938, 2346.4368551547677, 2354.6114891042957, 2365.597848365773, 2369.336585755991, 2336.906523739048, 2396.364963284731, 2402.711674599042, 2402.8558286502866, 2404.603240465321, 11257.155713321534, 11339.0, 11343.092552595856, 11347.546098156065, 11367.147463940237, 5571.303587051619, 5615.410381909923, 5826.329972053226, 5853.5902486825935, 5885.411458854123, 3314.4696848504122, 3501.7023552998025, 3510.4207805712026, 3529.2412131391875, 3572.4105522588743, 1112.7162573543694, 1135.1883403366633, 1186.0630102219236, 1187.453771265219, 1191.559123124441, 13945.442182312696, 14349.0, 14569.562913112517, 15611.0, 15906.52280431589, 4358.815440336251, 4815.398075240595, 4975.477574854661, 5001.24981252815, 5009.0, 12574.748505029847, 13284.73430531384, 13293.80059299092, 13309.134906231064, 13327.600171994856, 5928.140419639214, 6012.579119461683, 6016.127661489147, 6024.367441418675, 6028.608140470943, 5268.209768534751, 5286.3392075990505, 5344.6258761887075, 5353.491418315254, 5385.380681221632, 4020.6582440492884, 4068.389741538793, 4100.097978444737, 4140.648044916215, 4170.457840480718, 1056.2553399853239, 1084.804735147681, 1086.093112251279, 1099.1646348774989, 1100.0429626225075, 922.1976880114344, 939.7086903060073, 957.9281553883486, 962.7833737409027, 1008.8486726990864, 5171.741412929338, 5223.320968274176, 5370.758315875795, 5585.413531579207, 6411.4229719325485, 989.2086330935223, 1019.4953498018529, 1038.5015192707542, 1040.354979912444, 1048.3866937841296, 3419.076849250688, 4001.519817621846, 4262.87211383659, 4287.690870674952, 4301.612854843017, 13540.25528595917, 14127.293635318192, 14219.715605687828, 14412.639684007983, 14450.060746051684, 11854.466549005316, 13815.240161790996, 14082.71834563303, 14200.147991120566, 14348.713025739635, 10338.741531461774, 10429.530671119817, 10476.738081548023, 10571.312864663925, 10602.098821600097, 5375.462453754593, 5745.6552606843725, 6573.145491086319, 6707.061011458497, 6897.517173797786, 11973.221740586834, 11977.101717371406, 12147.149699520949, 12147.453364598437, 12350.197237179555, 12329.0, 12379.814302785286, 12421.378931053592, 12595.811062834247, 12606.369681516071, 9206.815863682823, 9246.352755307333, 9283.48940808235, 9405.482698451377, 9419.905800941902, 10215.233857460571, 10302.175825934057, 10392.37645741258, 10461.424621645883, 10485.737856553647, 8799.384043117176, 8811.471311721318, 8850.203481686422, 8866.202041816268, 8926.509042002752, 8534.78663033429, 8605.0, 8620.956895215484, 8715.607797649247, 8882.333824963283, 7676.731314403969, 7754.534727916343, 7858.0, 7861.331786797958, 7880.802979925547, 5961.850953726192, 5966.19456373384, 6029.216201893726, 6032.638041717511, 6067.908981365194, 5046.444891061907, 5967.433093856077, 6160.815175544741, 6177.135201071764, 6287.528435367457], "value": 5153.903701126842, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.95489586353773, 380.9371453710138, 385.63750074929567, 393.88971088095343, 394.5521832719863, 4223.725457845242, 4766.404199475066, 4815.879603009922, 5029.918567507985, 5040.0, 4238.745675259479, 4679.0, 4886.144924638192, 4957.0, 4975.552200301972, 3680.650338217865, 3681.263747250547, 4002.459667944819, 4137.358709400048, 4184.0125940178405, 3690.280395322913, 3862.555806082308, 4178.874633760992, 4186.204621121992, 4197.349410841324, 3569.4651299941015, 3959.78221197834, 4175.206710724968, 4201.936970945439, 4224.704270701052, 3587.982060089696, 3788.7307751903145, 3860.7297489175767, 4142.730722503027, 4191.937120943188, 3457.9827100864336, 3554.8091389384585, 3820.541535015788, 3844.884653460401, 3863.0684657671163, 4459.350040485009, 4529.327696658987, 4848.393950756155, 4889.315495830587, 4891.5353041461, 4034.6570541504007, 4132.855350062733, 4456.665750068725, 4817.277408388734, 4820.879478013043, 4794.137055330039, 4946.356973593446, 5246.632735708502, 5315.920261196085, 5339.332583427072, 3729.6083911189476, 3996.9008522656504, 4310.676699247569, 4339.587739164775, 4348.7390756554705, 4747.768548782067, 5026.667932997795, 5084.79660813567, 5177.948220517822, 5653.547716182696, 3749.3063783200196, 4157.069266167345, 4330.848420305338, 4344.891377715582, 4353.782310884443, 3972.503437070366, 4407.184670835905, 4411.514733379326, 4419.469663640384, 4460.375547423363, 4378.0, 4719.976400117977, 4775.797298377405, 4793.736344501016, 4820.493848145964, 4705.788239529229, 4955.752212389366, 5042.899142017139, 5262.552683021986, 5379.811706590251, 1375.4841934274648, 1471.6688745032282, 1473.6463248820205, 1494.0, 1500.6698526324192, 1032.4579595712312, 1047.204124865108, 1071.1912506057877, 1091.858058452396, 1162.8371628371629, 4059.837606495707, 4620.8151673933335, 4738.763061846894, 4772.427308722976, 4895.0, 4955.0675236657735, 5249.897521520447, 5268.420473747885, 5463.9180412293845, 5514.779408823682, 4191.868195587174, 4196.643285320721, 4599.195140850405, 4816.8554943351755, 4971.825986090542, 2428.672129262527, 2607.0093364521363, 2614.3856193794445, 2694.8922043118446, 2804.5232310507263, 5400.081986062379, 5482.780688772485, 5657.2928383952, 5718.139581355815, 5743.167240750068, 4789.568938795525, 4915.5330243626795, 5202.3497062867145, 5693.572982026365, 5694.9850355499275, 5450.91823622646, 5467.58993075513, 5506.8072617459, 5508.042761514669, 5511.669299841942, 4898.8775280618265, 4947.678400903929, 4967.652264341606, 5329.08312390385, 5333.17341808842, 5106.617003724661, 5395.892082158413, 5418.729063546728, 5429.429909859566, 5435.755391007493, 4958.801647934042, 5640.85897852557, 5649.0, 5694.544436445157, 5719.456651618089, 4186.455760751083, 4768.785404656868, 4769.020856344717, 4827.493113223201, 4834.927476087932, 4317.330813723878, 4399.92201910534, 4898.652870460652, 4957.429895561912, 5350.0, 4885.682430641997, 5241.475852414728, 5272.868178295574, 5279.0, 5286.841394758163, 4389.934150987674, 4461.665375096816, 5082.364704411949, 5274.235235890697, 5358.464153584766, 4698.553637404441, 4906.828261010847, 5010.244365598979, 5186.014657215117, 5207.3230480037355, 5228.666689994027, 5280.0463828383745, 5290.735463226746, 5297.364316282071, 5335.199720042025, 4479.484859241229, 4747.905041899212, 5169.457206993212, 5186.351706036746, 5187.974060129675], "value": 4039.3342412851575, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.1968863782795, 747.5029105644745, 756.2890882570387, 802.5265093594778, 869.6173683579227, 14592.92703536482, 15648.217589120555, 15699.450519231828, 15714.0, 15716.528504144879, 13617.251051192205, 14440.638984025405, 14456.277186140704, 14474.0, 14527.564173074798, 952.8475443928955, 969.8642190093393, 986.309583291695, 986.585634033704, 990.5542505872351, 980.7695191629962, 984.2126298960839, 987.1609132237612, 988.2686811759319, 988.5106872098286, 1041.0994489766335, 1041.1098510773293, 1042.353740680779, 1042.7758032023114, 1044.1177205261579, 1035.1563475767225, 1035.5133087448924, 1035.9482025898674, 1036.0727149201498, 1039.6517166749147, 767.1446337333888, 769.2038739904173, 769.5882702754055, 770.8419773946327, 771.1863983497408, 15448.0, 15562.37750489979, 15576.922115389463, 16094.356225750957, 16409.83590164095, 13978.650533736636, 14309.427622895071, 14401.135931844017, 14479.855201447956, 14514.491992780202, 10211.619432997171, 11738.178327517076, 11899.0, 11926.344051077187, 12058.638240852788, 3633.1643721943838, 3672.320620685155, 3724.776513409204, 3880.6805686066873, 3913.5695073541888, 113527.0, 116058.41970790176, 116473.41763291214, 118724.0, 119081.40459297648, 10648.201384896163, 10733.731656708489, 10899.455027248607, 11043.558257669763, 11147.996680298813, 23481.412964675677, 23612.29163125109, 23612.763872361058, 23733.0, 23838.642420363707, 7693.038370203724, 7841.529508229524, 7842.058952925686, 7962.243586859239, 8101.513909165469, 4186.581341865789, 4364.170807546556, 4478.373027776114, 4645.674802763774, 4655.604273636711, 3511.648835116519, 3549.165946002687, 3568.7858728476376, 3617.4212126059706, 3637.5453068366455, 634.7334119669749, 639.5011890725149, 645.7998020613625, 647.7020570537511, 655.7475371981822, 605.5337390209514, 675.8040168351222, 686.9003994420781, 691.2327316678483, 738.9482736208521, 10315.690529284133, 10330.535125919352, 10463.94768026155, 10670.946645266878, 10676.786464270672, 665.4443539644451, 679.6262055869253, 689.2142957028991, 711.1892442615423, 741.7033186725353, 4674.2988551716835, 5068.923966140511, 5070.7464626768515, 5076.695398276115, 5093.388793344822, 90179.29462116148, 104217.0, 109239.0, 109677.0, 110078.0, 74211.0, 88004.11995880087, 90536.54731726299, 91274.0, 92915.0, 66999.66500167469, 67483.0, 73512.0, 77028.22971770211, 79224.41551169059, 9676.612935482503, 9698.224142068759, 9705.805883882424, 9721.611135554498, 9749.463779492196, 47615.047699045135, 50315.496845031084, 51631.19290824803, 53130.0, 54029.0, 64548.0, 64881.0, 65432.0, 65749.69453656758, 66076.33923660702, 11888.881111189123, 13361.198328100345, 13913.58259252224, 14503.274836258355, 14759.409623615365, 14461.276936153361, 15038.131553861132, 15971.041737495787, 16021.279042442884, 16644.50066498007, 13476.393562289524, 13790.517331893336, 14368.928155359155, 14887.702245954804, 15091.342335186673, 13333.732278124113, 14365.764651923311, 14660.780088298898, 14801.703965920837, 15144.16707081121, 13325.400356983766, 13816.101953372998, 14100.224487653277, 14242.789362903855, 14447.566573002827, 9437.858432123661, 9905.950470247602, 9934.205263578751, 10091.495425228562, 10100.0, 8982.416142950688, 9460.810783784149, 10253.538590763583, 10861.587993560786, 11973.221740586834], "value": 7773.23328415393, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1413.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 116.0, 116.0, 115.0, 114.0, 117.0, 114.0, 115.0, 114.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 106.0, 107.0, 142.0, 110.0, 107.0, 107.0, 103.0, 107.0, 125.0], "value": 115.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 181.0, 184.0, 187.0, 198.0, 257.0, 200.0, 185.0, 185.0, 184.0], "value": 194.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 62.0, 93.0, 62.0, 61.0, 60.0, 61.0, 76.0, 61.0], "value": 67.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 68.0, 86.0, 68.0, 69.0, 68.0, 81.0, 68.0, 68.0, 83.0], "value": 74.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 86.0, 87.0, 86.0, 86.0, 86.0, 87.0, 86.0], "value": 86.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 94.0, 93.0, 94.0, 96.0, 93.0, 92.0, 92.0], "value": 93.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 86.0, 86.0, 83.0, 85.0, 84.0, 86.0, 83.0, 101.0], "value": 86.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 61.0, 59.0, 61.0, 64.0, 63.0, 63.0, 63.0, 65.0], "value": 62.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 61.0, 62.0, 63.0, 59.0, 58.0, 59.0, 58.0, 58.0, 61.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 82.0, 85.0, 84.0, 89.0, 97.0, 97.0, 83.0, 86.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 136.0, 136.0, 138.0, 135.0, 138.0, 140.0, 138.0, 180.0, 147.0], "value": 142.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 162.0, 163.0, 164.0, 164.0, 163.0, 163.0, 162.0, 166.0], "value": 163.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 63.0, 63.0, 67.0, 76.0, 78.0, 79.0, 55.0], "value": 67.5, "unit": "score"}]}]} 19:58:14 INFO - Return code: 0 19:58:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:58:14 INFO - # TBPL SUCCESS # 19:58:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:58:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:58:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:58:14 INFO - 2017-05-19 19:58:14.193 screenresolution[1651:10590] starting screenresolution argv=screenresolution get 19:58:14 INFO - 2017-05-19 19:58:14.196 screenresolution[1651:10590] Display 0: 1600x1200x32@60 19:58:14 INFO - 2017-05-19 19:58:14.202 screenresolution[1652:10593] starting screenresolution argv=screenresolution list 19:58:14 INFO - Available Modes on Display 0 19:58:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:58:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:58:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:58:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:58:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:58:14 INFO - Intel Iris: 19:58:14 INFO - Chipset Model: Intel Iris 19:58:14 INFO - Type: GPU 19:58:14 INFO - Bus: Built-In 19:58:14 INFO - VRAM (Dynamic, Max): 1536 MB 19:58:14 INFO - Vendor: Intel (0x8086) 19:58:14 INFO - Device ID: 0x0a2e 19:58:14 INFO - Revision ID: 0x0009 19:58:14 INFO - Displays: 19:58:14 INFO - Display: 19:58:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:58:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:58:14 INFO - Display Serial Number: 1600x1200 60 19:58:14 INFO - Main Display: Yes 19:58:14 INFO - Mirror: Off 19:58:14 INFO - Online: Yes 19:58:14 INFO - Rotation: Supported 19:58:14 INFO - Return code: 0 19:58:14 INFO - Running post-action listener: _resource_record_post_action 19:58:14 INFO - [mozharness: 2017-05-20 02:58:14.437613Z] Finished run-tests step (success) 19:58:14 INFO - Running post-run listener: _resource_record_post_run 19:58:14 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 33070080; Write bytes: 510511104; Read time: 201; Write time: 1589 19:58:14 INFO - TinderboxPrint: CPU usage
53.9% 19:58:14 INFO - TinderboxPrint: I/O read bytes / time
33,070,080 / 201 19:58:14 INFO - TinderboxPrint: I/O write bytes / time
510,511,104 / 1,589 19:58:14 INFO - TinderboxPrint: CPU idle
2,214.0 (46.1%) 19:58:14 INFO - TinderboxPrint: CPU system
959.1 (20.0%) 19:58:14 INFO - TinderboxPrint: CPU user
1,624.6 (33.9%) 19:58:14 INFO - TinderboxPrint: Swap in / out
238,034,944 / 0 19:58:14 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201828864; Write bytes: 201684992; Read time: 15406; Write time: 473 19:58:14 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 31153152; Write bytes: 298037248; Read time: 185; Write time: 1085 19:58:14 INFO - Running post-run listener: _upload_blobber_files 19:58:14 INFO - Blob upload gear active. 19:58:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:58:14 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 19:58:14 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', 'Jamun', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:58:14 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 Jamun -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:58:15 INFO - (blobuploader) - INFO - Open directory for files ... 19:58:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:58:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:58:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:58:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:58:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:58:16 INFO - (blobuploader) - INFO - Done attempting. 19:58:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:58:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:58:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:58:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:58:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:58:17 INFO - (blobuploader) - INFO - Done attempting. 19:58:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:58:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:58:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:58:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:58:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:58:18 INFO - (blobuploader) - INFO - Done attempting. 19:58:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:58:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:58:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:58:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:58:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:58:21 INFO - (blobuploader) - INFO - Done attempting. 19:58:21 INFO - (blobuploader) - INFO - Iteration through files over. 19:58:21 INFO - Return code: 0 19:58:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:58:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:58:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/c840ed773b7d7d9d4c33d0c15c37b00e95c086677592d48d9a9017f35c670240fff838b5e14444fde3f66019972a915b32de5475bb84d1b13f3c11b487cb07b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/0b23d1f170d7d5a5a0f33c18e004dca28d16c076ee8341fae66a453a96d505792a88314cc3bd40d6a7087c2361df1a99472f73fd170725d6d7d177c9d6712fb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/1dab80448d95ee29b09d88c27cd32e9b650ad0181a49ae7a2b99724c344bf22eb26c6fbcf3b47f2f51c17ca5868d8b809ef54736427479858f3aa8f55ba51cf3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/a983db614ab6e1aec0f0dc7449ae9fc1d94b918f38c9df9ecd4c7c87f7fca8a435aa5150ee01f19414490bdaddd4fd4d1ecb80aee9a570e72fe7313f8cd1d3f3"} 19:58:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:58:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:58:21 INFO - Contents: 19:58:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/c840ed773b7d7d9d4c33d0c15c37b00e95c086677592d48d9a9017f35c670240fff838b5e14444fde3f66019972a915b32de5475bb84d1b13f3c11b487cb07b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/0b23d1f170d7d5a5a0f33c18e004dca28d16c076ee8341fae66a453a96d505792a88314cc3bd40d6a7087c2361df1a99472f73fd170725d6d7d177c9d6712fb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/1dab80448d95ee29b09d88c27cd32e9b650ad0181a49ae7a2b99724c344bf22eb26c6fbcf3b47f2f51c17ca5868d8b809ef54736427479858f3aa8f55ba51cf3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/a983db614ab6e1aec0f0dc7449ae9fc1d94b918f38c9df9ecd4c7c87f7fca8a435aa5150ee01f19414490bdaddd4fd4d1ecb80aee9a570e72fe7313f8cd1d3f3"} 19:58:21 INFO - Running post-run listener: copy_logs_to_upload_dir 19:58:21 INFO - Copying logs to upload dir... 19:58:21 INFO - mkdir: /builds/slave/test/build/upload/logs 19:58:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=2487.921820 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 41 mins, 27 secs) (at 2017-05-19 19:58:21.898653) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-19 19:58:21.905292) ========= 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.7QgnG65V6B/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.5UARR63kx0/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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/Jamun/sha512/c840ed773b7d7d9d4c33d0c15c37b00e95c086677592d48d9a9017f35c670240fff838b5e14444fde3f66019972a915b32de5475bb84d1b13f3c11b487cb07b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/0b23d1f170d7d5a5a0f33c18e004dca28d16c076ee8341fae66a453a96d505792a88314cc3bd40d6a7087c2361df1a99472f73fd170725d6d7d177c9d6712fb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/1dab80448d95ee29b09d88c27cd32e9b650ad0181a49ae7a2b99724c344bf22eb26c6fbcf3b47f2f51c17ca5868d8b809ef54736427479858f3aa8f55ba51cf3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/a983db614ab6e1aec0f0dc7449ae9fc1d94b918f38c9df9ecd4c7c87f7fca8a435aa5150ee01f19414490bdaddd4fd4d1ecb80aee9a570e72fe7313f8cd1d3f3"} build_url:https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010904 build_url: 'https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/c840ed773b7d7d9d4c33d0c15c37b00e95c086677592d48d9a9017f35c670240fff838b5e14444fde3f66019972a915b32de5475bb84d1b13f3c11b487cb07b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/0b23d1f170d7d5a5a0f33c18e004dca28d16c076ee8341fae66a453a96d505792a88314cc3bd40d6a7087c2361df1a99472f73fd170725d6d7d177c9d6712fb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/1dab80448d95ee29b09d88c27cd32e9b650ad0181a49ae7a2b99724c344bf22eb26c6fbcf3b47f2f51c17ca5868d8b809ef54736427479858f3aa8f55ba51cf3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/a983db614ab6e1aec0f0dc7449ae9fc1d94b918f38c9df9ecd4c7c87f7fca8a435aa5150ee01f19414490bdaddd4fd4d1ecb80aee9a570e72fe7313f8cd1d3f3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-19 19:58:21.938449) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 19:58:21.938796) ========= 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.7QgnG65V6B/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.5UARR63kx0/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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.005059 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 19:58:21.995319) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-19 19:58:22.000989) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-19 19:58:22.001526) ========= ========= Total master_lag: 2.94 =========