builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0159 starttime: 1473818347.14 results: success (0) buildid: 20160913170427 builduid: bef410afc63f40dea9f9c4f927eaa243 revision: 46f83778b4bb441770406754db09ada5911600fd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-13 18:59:07.139823) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-13 18:59:07.140412) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-13 18:59:07.140730) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-13 18:59:07.191192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 18:59:07.191557) ========= 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.oMNY3u8NM3/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.Yn2yaWbMiW/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-13 18:59:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 154M=0s 2016-09-13 18:59:07 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156309 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 18:59:07.370718) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 18:59:07.371168) ========= 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.oMNY3u8NM3/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.Yn2yaWbMiW/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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.021150 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 18:59:07.421703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-13 18:59:07.422437) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 46f83778b4bb441770406754db09ada5911600fd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 46f83778b4bb441770406754db09ada5911600fd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oMNY3u8NM3/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.Yn2yaWbMiW/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-13 18:59:07,500 truncating revision to first 12 chars 2016-09-13 18:59:07,500 Setting DEBUG logging. 2016-09-13 18:59:07,500 attempt 1/10 2016-09-13 18:59:07,501 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/46f83778b4bb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-13 18:59:09,129 unpacking tar archive at: fx-team-46f83778b4bb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.902168 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-13 18:59:09.348353) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-13 18:59:09.348706) ========= script_repo_revision: 46f83778b4bb441770406754db09ada5911600fd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-13 18:59:09.349135) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-13 18:59:09.349461) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-13 18:59:09.371440) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-13 18:59:09.371768) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oMNY3u8NM3/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.Yn2yaWbMiW/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 18:59:09 INFO - MultiFileLogger online at 20160913 18:59:09 in /builds/slave/test 18:59:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:59:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:59:09 INFO - {'append_to_log': False, 18:59:09 INFO - 'base_work_dir': '/builds/slave/test', 18:59:09 INFO - 'blob_upload_branch': 'Fx-Team', 18:59:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:59:09 INFO - 'branch': 'Fx-Team', 18:59:09 INFO - 'buildbot_json_path': 'buildprops.json', 18:59:09 INFO - 'config_files': ('talos/mac_config.py',), 18:59:09 INFO - 'default_actions': ('clobber', 18:59:09 INFO - 'read-buildbot-config', 18:59:09 INFO - 'download-and-extract', 18:59:09 INFO - 'populate-webroot', 18:59:09 INFO - 'create-virtualenv', 18:59:09 INFO - 'install', 18:59:09 INFO - 'run-tests'), 18:59:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:59:09 INFO - 'download_minidump_stackwalk': True, 18:59:09 INFO - 'download_symbols': 'ondemand', 18:59:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:59:09 INFO - 'tooltool.py': '/tools/tooltool.py', 18:59:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:59:09 INFO - '/tools/misc-python/virtualenv.py')}, 18:59:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:59:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:59:09 INFO - 'installer_path': 'installer.exe', 18:59:09 INFO - 'log_level': 'info', 18:59:09 INFO - 'log_name': 'talos', 18:59:09 INFO - 'log_to_console': True, 18:59:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:59:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:59:09 INFO - 'opt_config_files': (), 18:59:09 INFO - 'pip_index': False, 18:59:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:59:09 INFO - 'cmd': ('bash', 18:59:09 INFO - '-c', 18:59:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:59:09 INFO - 'enabled': True, 18:59:09 INFO - 'halt_on_failure': False, 18:59:09 INFO - 'name': 'check_screen_resolution'},), 18:59:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:59:09 INFO - 'cmd': ('bash', 18:59:09 INFO - '-c', 18:59:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:59:09 INFO - 'enabled': True, 18:59:09 INFO - 'halt_on_failure': False, 18:59:09 INFO - 'name': 'check_screen_resolution'},), 18:59:09 INFO - 'run_cmd_checks_enabled': True, 18:59:09 INFO - 'sps_profile': False, 18:59:09 INFO - 'sps_profile_interval': 0, 18:59:09 INFO - 'suite': 'dromaeojs', 18:59:09 INFO - 'system_bits': '32', 18:59:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:59:09 INFO - 'title': 't-yosemite-r7-0159', 18:59:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:59:09 INFO - 'use_talos_json': True, 18:59:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:59:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:59:09 INFO - 'work_dir': 'build'} 18:59:09 INFO - [mozharness: 2016-09-14 01:59:09.564538Z] Running clobber step. 18:59:09 INFO - Running pre-action listener: _resource_record_pre_action 18:59:09 INFO - Running main action method: clobber 18:59:09 INFO - rmtree: /builds/slave/test/build 18:59:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:59:11 INFO - Running post-action listener: _resource_record_post_action 18:59:11 INFO - [mozharness: 2016-09-14 01:59:11.123676Z] Finished clobber step (success) 18:59:11 INFO - [mozharness: 2016-09-14 01:59:11.123809Z] Running read-buildbot-config step. 18:59:11 INFO - Running pre-action listener: _resource_record_pre_action 18:59:11 INFO - Running main action method: read_buildbot_config 18:59:11 INFO - Using buildbot properties: 18:59:11 INFO - { 18:59:11 INFO - "project": "", 18:59:11 INFO - "product": "firefox", 18:59:11 INFO - "script_repo_revision": "production", 18:59:11 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 18:59:11 INFO - "repository": "", 18:59:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 18:59:11 INFO - "buildid": "20160913170427", 18:59:11 INFO - "pgo_build": "False", 18:59:11 INFO - "basedir": "/builds/slave/test", 18:59:11 INFO - "buildnumber": 151, 18:59:11 INFO - "slavename": "t-yosemite-r7-0159", 18:59:11 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 18:59:11 INFO - "platform": "yosemite_r7", 18:59:11 INFO - "scheduler": "tests-fx-team-macosx64-talos", 18:59:11 INFO - "branch": "fx-team", 18:59:11 INFO - "repo_path": "integration/fx-team", 18:59:11 INFO - "revision": "46f83778b4bb441770406754db09ada5911600fd", 18:59:11 INFO - "stage_platform": "macosx64", 18:59:11 INFO - "builduid": "bef410afc63f40dea9f9c4f927eaa243", 18:59:11 INFO - "slavebuilddir": "test" 18:59:11 INFO - } 18:59:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/I2f_d2qBTVScpUr0bLn2iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 18:59:11 INFO - Running post-action listener: _resource_record_post_action 18:59:11 INFO - [mozharness: 2016-09-14 01:59:11.127222Z] Finished read-buildbot-config step (success) 18:59:11 INFO - [mozharness: 2016-09-14 01:59:11.127334Z] Running download-and-extract step. 18:59:11 INFO - Running pre-action listener: _resource_record_pre_action 18:59:11 INFO - Running main action method: download_and_extract 18:59:11 INFO - mkdir: /builds/slave/test/build/tests 18:59:11 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')]} 18:59:11 INFO - trying https://queue.taskcluster.net/v1/task/I2f_d2qBTVScpUr0bLn2iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 18:59:11 INFO - Downloading https://queue.taskcluster.net/v1/task/I2f_d2qBTVScpUr0bLn2iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 18:59:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I2f_d2qBTVScpUr0bLn2iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 18:59:12 INFO - Downloaded 1199 bytes. 18:59:12 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 18:59:12 INFO - Using the following test package requirements: 18:59:12 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 18:59:12 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:59:12 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 18:59:12 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:59:12 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 18:59:12 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:59:12 INFO - u'jsshell-mac.zip'], 18:59:12 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:59:12 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 18:59:12 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 18:59:12 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:59:12 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 18:59:12 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:59:12 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 18:59:12 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:59:12 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 18:59:12 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:59:12 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 18:59:12 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:59:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I2f_d2qBTVScpUr0bLn2iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 18:59:12 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 18:59:20 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:59:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I2f_d2qBTVScpUr0bLn2iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 18:59:21 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 18:59:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I2f_d2qBTVScpUr0bLn2iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 18:59:28 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 18:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:29 INFO - trying https://queue.taskcluster.net/v1/task/I2f_d2qBTVScpUr0bLn2iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 18:59:29 INFO - Downloading https://queue.taskcluster.net/v1/task/I2f_d2qBTVScpUr0bLn2iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 18:59:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I2f_d2qBTVScpUr0bLn2iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 18:59:32 INFO - Downloaded 111384630 bytes. 18:59:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I2f_d2qBTVScpUr0bLn2iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 18:59:32 INFO - mkdir: /builds/slave/test/properties 18:59:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:59:32 INFO - Writing to file /builds/slave/test/properties/build_url 18:59:32 INFO - Contents: 18:59:32 INFO - build_url:https://queue.taskcluster.net/v1/task/I2f_d2qBTVScpUr0bLn2iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 18:59:33 INFO - Running post-action listener: _resource_record_post_action 18:59:33 INFO - Running post-action listener: set_extra_try_arguments 18:59:33 INFO - [mozharness: 2016-09-14 01:59:33.159005Z] Finished download-and-extract step (success) 18:59:33 INFO - [mozharness: 2016-09-14 01:59:33.159155Z] Running populate-webroot step. 18:59:33 INFO - Running pre-action listener: _resource_record_pre_action 18:59:33 INFO - Running main action method: populate_webroot 18:59:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:59:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:59:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:59:33 INFO - '--tppagecycles', 18:59:33 INFO - '7'], 18:59:33 INFO - 'tests': ['tsvgm']}}, 18:59:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:59:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:59:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:59:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:59:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:59:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:59:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:33 INFO - 'talos_options': ['--disable-e10s'], 18:59:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:59:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:59:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:33 INFO - 'talos_options': ['--disable-e10s'], 18:59:33 INFO - 'tests': ['damp', 'tps']}, 18:59:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:33 INFO - 'tests': ['damp', 'tps']}, 18:59:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:59:33 INFO - 'tests': ['dromaeo_dom']}, 18:59:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:59:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:59:33 INFO - 'tests': ['basic_compositor_video']}, 18:59:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:59:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:59:33 INFO - 'tests': ['a11yr', 18:59:33 INFO - 'ts_paint', 18:59:33 INFO - 'tpaint', 18:59:33 INFO - 'sessionrestore', 18:59:33 INFO - 'sessionrestore_no_auto_restore', 18:59:33 INFO - 'tabpaint']}, 18:59:33 INFO - 'other-e10s': {'tests': ['a11yr', 18:59:33 INFO - 'ts_paint', 18:59:33 INFO - 'tpaint', 18:59:33 INFO - 'sessionrestore', 18:59:33 INFO - 'sessionrestore_no_auto_restore', 18:59:33 INFO - 'tabpaint']}, 18:59:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:59:33 INFO - 'ts_paint', 18:59:33 INFO - 'tpaint', 18:59:33 INFO - 'sessionrestore', 18:59:33 INFO - 'sessionrestore_no_auto_restore', 18:59:33 INFO - 'tabpaint']}, 18:59:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:59:33 INFO - 'ts_paint', 18:59:33 INFO - 'tpaint', 18:59:33 INFO - 'sessionrestore', 18:59:33 INFO - 'sessionrestore_no_auto_restore', 18:59:33 INFO - 'tabpaint']}, 18:59:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:59:33 INFO - 'tests': ['a11yr', 18:59:33 INFO - 'ts_paint', 18:59:33 INFO - 'tpaint', 18:59:33 INFO - 'sessionrestore', 18:59:33 INFO - 'sessionrestore_no_auto_restore', 18:59:33 INFO - 'tabpaint']}, 18:59:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:59:33 INFO - 'tests': ['a11yr', 18:59:33 INFO - 'ts_paint', 18:59:33 INFO - 'tpaint', 18:59:33 INFO - 'sessionrestore', 18:59:33 INFO - 'sessionrestore_no_auto_restore', 18:59:33 INFO - 'tabpaint']}, 18:59:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:59:33 INFO - 'tests': ['tsvgx', 18:59:33 INFO - 'tsvgr_opacity', 18:59:33 INFO - 'tart', 18:59:33 INFO - 'tscrollx', 18:59:33 INFO - 'cart']}, 18:59:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:59:33 INFO - 'tsvgr_opacity', 18:59:33 INFO - 'tart', 18:59:33 INFO - 'tscrollx', 18:59:33 INFO - 'cart']}, 18:59:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:33 INFO - 'talos_options': ['--disable-e10s'], 18:59:33 INFO - 'tests': ['tp5o']}, 18:59:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:33 INFO - 'tests': ['tp5o']}, 18:59:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:33 INFO - 'talos_options': ['--disable-e10s', 18:59:33 INFO - '--xperf_path', 18:59:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:59:33 INFO - 'tests': ['tp5n']}, 18:59:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:33 INFO - 'talos_options': ['--xperf_path', 18:59:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:59:33 INFO - 'tests': ['tp5n']}}, 18:59:33 INFO - 'talos.zip': {'path': '', 18:59:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:59:33 INFO - Running post-action listener: _resource_record_post_action 18:59:33 INFO - [mozharness: 2016-09-14 01:59:33.178636Z] Finished populate-webroot step (success) 18:59:33 INFO - [mozharness: 2016-09-14 01:59:33.178751Z] Running create-virtualenv step. 18:59:33 INFO - Running pre-action listener: _resource_record_pre_action 18:59:33 INFO - Running main action method: create_virtualenv 18:59:33 INFO - Creating virtualenv /builds/slave/test/build/venv 18:59:33 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 18:59:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:59:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:59:33 INFO - Using real prefix '/tools/python27' 18:59:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:59:34 INFO - Installing distribute.............................................................................................................................................................................................done. 18:59:36 INFO - Installing pip.................done. 18:59:36 INFO - Return code: 0 18:59:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10816d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080e3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa83ad88c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f81d30>, '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 0x107da7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f79b20>, '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.oMNY3u8NM3/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.Yn2yaWbMiW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 18:59:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:59:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:59:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oMNY3u8NM3/Render', 18:59:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:36 INFO - 'HOME': '/Users/cltbld', 18:59:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:36 INFO - 'LOGNAME': 'cltbld', 18:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:36 INFO - 'MOZ_NO_REMOTE': '1', 18:59:36 INFO - 'NO_EM_RESTART': '1', 18:59:36 INFO - 'PAGER': '/bin/cat', 18:59:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:36 INFO - 'PWD': '/builds/slave/test', 18:59:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:36 INFO - 'SHELL': '/bin/bash', 18:59:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yn2yaWbMiW/Listeners', 18:59:36 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 18:59:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:36 INFO - 'USER': 'cltbld', 18:59:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:36 INFO - 'XPC_FLAGS': '0x0', 18:59:36 INFO - 'XPC_SERVICE_NAME': '0', 18:59:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:37 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 18:59:37 INFO - Cleaning up... 18:59:37 INFO - Return code: 0 18:59:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:59: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')]} 18:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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')]} 18:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:37 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 0x10816d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080e3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa83ad88c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f81d30>, '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 0x107da7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f79b20>, '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.oMNY3u8NM3/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.Yn2yaWbMiW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 18:59:37 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 18:59:37 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 18:59:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oMNY3u8NM3/Render', 18:59:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:37 INFO - 'HOME': '/Users/cltbld', 18:59:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:37 INFO - 'LOGNAME': 'cltbld', 18:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:37 INFO - 'MOZ_NO_REMOTE': '1', 18:59:37 INFO - 'NO_EM_RESTART': '1', 18:59:37 INFO - 'PAGER': '/bin/cat', 18:59:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:37 INFO - 'PWD': '/builds/slave/test', 18:59:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:37 INFO - 'SHELL': '/bin/bash', 18:59:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yn2yaWbMiW/Listeners', 18:59:37 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 18:59:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:37 INFO - 'USER': 'cltbld', 18:59:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:37 INFO - 'XPC_FLAGS': '0x0', 18:59:37 INFO - 'XPC_SERVICE_NAME': '0', 18:59:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:37 INFO - Downloading/unpacking psutil>=3.1.1 18:59:37 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 18:59:37 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 18:59:37 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 18:59:37 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 18:59:37 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 18:59:37 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 18:59:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:59:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:59:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:59:41 INFO - Installing collected packages: psutil 18:59:41 INFO - Running setup.py install for psutil 18:59:41 INFO - building 'psutil._psutil_osx' extension 18:59:41 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 18:59:41 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 18:59:41 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 18:59:41 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 18:59:41 INFO - building 'psutil._psutil_posix' extension 18:59:41 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 18:59:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:59:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:59:41 INFO - ^ 18:59:41 INFO - 1 warning generated. 18:59:41 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 18:59:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:59:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:59:42 INFO - Successfully installed psutil 18:59:42 INFO - Cleaning up... 18:59:42 INFO - Return code: 0 18:59:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:42 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 0x10816d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080e3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa83ad88c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f81d30>, '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 0x107da7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f79b20>, '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.oMNY3u8NM3/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.Yn2yaWbMiW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 18:59:42 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 18:59:42 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 18:59:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oMNY3u8NM3/Render', 18:59:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:42 INFO - 'HOME': '/Users/cltbld', 18:59:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:42 INFO - 'LOGNAME': 'cltbld', 18:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:42 INFO - 'MOZ_NO_REMOTE': '1', 18:59:42 INFO - 'NO_EM_RESTART': '1', 18:59:42 INFO - 'PAGER': '/bin/cat', 18:59:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:42 INFO - 'PWD': '/builds/slave/test', 18:59:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:42 INFO - 'SHELL': '/bin/bash', 18:59:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yn2yaWbMiW/Listeners', 18:59:42 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 18:59:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:42 INFO - 'USER': 'cltbld', 18:59:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:42 INFO - 'XPC_FLAGS': '0x0', 18:59:42 INFO - 'XPC_SERVICE_NAME': '0', 18:59:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:59:42 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 18:59:42 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 18:59:42 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 18:59:42 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 18:59:42 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 18:59:42 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 18:59:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:59:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:59:44 INFO - Installing collected packages: mozsystemmonitor 18:59:44 INFO - Running setup.py install for mozsystemmonitor 18:59:45 INFO - Successfully installed mozsystemmonitor 18:59:45 INFO - Cleaning up... 18:59:45 INFO - Return code: 0 18:59:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:59:45 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')]} 18:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:45 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')]} 18:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:45 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 0x10816d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080e3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa83ad88c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f81d30>, '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 0x107da7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f79b20>, '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.oMNY3u8NM3/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.Yn2yaWbMiW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 18:59:45 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 18:59:45 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 18:59:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oMNY3u8NM3/Render', 18:59:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:45 INFO - 'HOME': '/Users/cltbld', 18:59:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:45 INFO - 'LOGNAME': 'cltbld', 18:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:45 INFO - 'MOZ_NO_REMOTE': '1', 18:59:45 INFO - 'NO_EM_RESTART': '1', 18:59:45 INFO - 'PAGER': '/bin/cat', 18:59:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:45 INFO - 'PWD': '/builds/slave/test', 18:59:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:45 INFO - 'SHELL': '/bin/bash', 18:59:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yn2yaWbMiW/Listeners', 18:59:45 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 18:59:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:45 INFO - 'USER': 'cltbld', 18:59:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:45 INFO - 'XPC_FLAGS': '0x0', 18:59:45 INFO - 'XPC_SERVICE_NAME': '0', 18:59:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:45 INFO - Downloading/unpacking jsonschema==2.5.1 18:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:59:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:59:47 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 18:59:47 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 18:59:47 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 18:59:47 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 18:59:47 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 18:59:47 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 18:59:48 INFO - Downloading functools32-3.2.3-2.tar.gz 18:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:59:48 INFO - warning: no files found matching '*.txt' 18:59:48 INFO - no previously-included directories found matching 'build' 18:59:48 INFO - no previously-included directories found matching 'dist' 18:59:48 INFO - no previously-included directories found matching '.git*' 18:59:48 INFO - Installing collected packages: jsonschema, functools32 18:59:48 INFO - Running setup.py install for functools32 18:59:48 INFO - warning: no files found matching '*.txt' 18:59:48 INFO - no previously-included directories found matching 'build' 18:59:48 INFO - no previously-included directories found matching 'dist' 18:59:48 INFO - no previously-included directories found matching '.git*' 18:59:48 INFO - Successfully installed jsonschema functools32 18:59:48 INFO - Cleaning up... 18:59:48 INFO - Return code: 0 18:59:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10816d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080e3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa83ad88c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f81d30>, '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 0x107da7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f79b20>, '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.oMNY3u8NM3/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.Yn2yaWbMiW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 18:59:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:59:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oMNY3u8NM3/Render', 18:59:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:48 INFO - 'HOME': '/Users/cltbld', 18:59:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:48 INFO - 'LOGNAME': 'cltbld', 18:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:48 INFO - 'MOZ_NO_REMOTE': '1', 18:59:48 INFO - 'NO_EM_RESTART': '1', 18:59:48 INFO - 'PAGER': '/bin/cat', 18:59:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:48 INFO - 'PWD': '/builds/slave/test', 18:59:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:48 INFO - 'SHELL': '/bin/bash', 18:59:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yn2yaWbMiW/Listeners', 18:59:48 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 18:59:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:48 INFO - 'USER': 'cltbld', 18:59:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:48 INFO - 'XPC_FLAGS': '0x0', 18:59:48 INFO - 'XPC_SERVICE_NAME': '0', 18:59:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:59:48 INFO - Cleaning up... 18:59:48 INFO - Return code: 0 18:59:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10816d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080e3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa83ad88c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f81d30>, '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 0x107da7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f79b20>, '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.oMNY3u8NM3/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.Yn2yaWbMiW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 18:59:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:59:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oMNY3u8NM3/Render', 18:59:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:48 INFO - 'HOME': '/Users/cltbld', 18:59:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:48 INFO - 'LOGNAME': 'cltbld', 18:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:48 INFO - 'MOZ_NO_REMOTE': '1', 18:59:48 INFO - 'NO_EM_RESTART': '1', 18:59:48 INFO - 'PAGER': '/bin/cat', 18:59:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:48 INFO - 'PWD': '/builds/slave/test', 18:59:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:48 INFO - 'SHELL': '/bin/bash', 18:59:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yn2yaWbMiW/Listeners', 18:59:48 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 18:59:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:48 INFO - 'USER': 'cltbld', 18:59:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:48 INFO - 'XPC_FLAGS': '0x0', 18:59:48 INFO - 'XPC_SERVICE_NAME': '0', 18:59:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:49 INFO - Downloading/unpacking blobuploader==1.2.4 18:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:51 INFO - Downloading blobuploader-1.2.4.tar.gz 18:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:59:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 18:59:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:59:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:52 INFO - Downloading docopt-0.6.1.tar.gz 18:59:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:59:52 INFO - Installing collected packages: blobuploader, requests, docopt 18:59:52 INFO - Running setup.py install for blobuploader 18:59:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:59:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:59:53 INFO - Running setup.py install for requests 18:59:53 INFO - Running setup.py install for docopt 18:59:53 INFO - Successfully installed blobuploader requests docopt 18:59:53 INFO - Cleaning up... 18:59:53 INFO - Return code: 0 18:59:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:53 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 0x10816d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080e3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa83ad88c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f81d30>, '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 0x107da7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f79b20>, '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.oMNY3u8NM3/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.Yn2yaWbMiW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 18:59:53 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 18:59:53 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 18:59:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oMNY3u8NM3/Render', 18:59:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:53 INFO - 'HOME': '/Users/cltbld', 18:59:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:53 INFO - 'LOGNAME': 'cltbld', 18:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:53 INFO - 'MOZ_NO_REMOTE': '1', 18:59:53 INFO - 'NO_EM_RESTART': '1', 18:59:53 INFO - 'PAGER': '/bin/cat', 18:59:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:53 INFO - 'PWD': '/builds/slave/test', 18:59:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:53 INFO - 'SHELL': '/bin/bash', 18:59:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yn2yaWbMiW/Listeners', 18:59:53 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 18:59:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:53 INFO - 'USER': 'cltbld', 18:59:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:53 INFO - 'XPC_FLAGS': '0x0', 18:59:53 INFO - 'XPC_SERVICE_NAME': '0', 18:59:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:59:54 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-VM5iWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:59:54 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-2Z__TU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:59:54 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-dETtg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:59:54 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-JgeiW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:59:54 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-7QZARi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:59:54 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-aXNruf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:59:54 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-wGipRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:59:54 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-a14F14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:59:54 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-HcAtl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:59:55 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-HgujQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:59:55 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-zx9FyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:59:55 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-iWg6qa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:59:55 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-oedEn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:59:55 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-wTPCOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:55 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-jcMf24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:59:55 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Dq04Qe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:59:55 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-f_bDkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:59:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:59:55 INFO - Running setup.py install for manifestparser 18:59:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:59:56 INFO - Running setup.py install for mozcrash 18:59:56 INFO - Running setup.py install for mozdebug 18:59:56 INFO - Running setup.py install for mozdevice 18:59:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:59:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:59:56 INFO - Running setup.py install for mozfile 18:59:56 INFO - Running setup.py install for mozhttpd 18:59:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:59:56 INFO - Running setup.py install for mozinfo 18:59:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:59:56 INFO - Running setup.py install for mozInstall 18:59:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:59:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:59:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:59:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:59:57 INFO - Running setup.py install for mozleak 18:59:57 INFO - Running setup.py install for mozlog 18:59:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:59:57 INFO - Running setup.py install for moznetwork 18:59:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:59:57 INFO - Running setup.py install for mozprocess 18:59:57 INFO - Running setup.py install for mozprofile 18:59:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:59:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:59:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:59:57 INFO - Running setup.py install for mozrunner 18:59:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:59:58 INFO - Running setup.py install for mozscreenshot 18:59:58 INFO - Running setup.py install for moztest 18:59:58 INFO - Running setup.py install for mozversion 18:59:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:59:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:59:58 INFO - Cleaning up... 18:59:58 INFO - Return code: 0 18:59:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:58 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 0x10816d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080e3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa83ad88c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f81d30>, '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 0x107da7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f79b20>, '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.oMNY3u8NM3/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.Yn2yaWbMiW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 18:59:58 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 18:59:58 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 18:59:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oMNY3u8NM3/Render', 18:59:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:58 INFO - 'HOME': '/Users/cltbld', 18:59:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:58 INFO - 'LOGNAME': 'cltbld', 18:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:58 INFO - 'MOZ_NO_REMOTE': '1', 18:59:58 INFO - 'NO_EM_RESTART': '1', 18:59:58 INFO - 'PAGER': '/bin/cat', 18:59:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:58 INFO - 'PWD': '/builds/slave/test', 18:59:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:58 INFO - 'SHELL': '/bin/bash', 18:59:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yn2yaWbMiW/Listeners', 18:59:58 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 18:59:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:58 INFO - 'USER': 'cltbld', 18:59:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:58 INFO - 'XPC_FLAGS': '0x0', 18:59:58 INFO - 'XPC_SERVICE_NAME': '0', 18:59:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:59:58 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-tm7pLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:59:58 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)) 18:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:59:58 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-76MzOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:59:59 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-9ffy1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:59:59 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)) 18:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:59:59 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-1w9mA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:59:59 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-WW26vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:59:59 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)) 18:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:59:59 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-gEyesD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:59:59 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)) 18:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:59:59 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-0pPWwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:59:59 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)) 18:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:59:59 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-x3atkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:59:59 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)) 18:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:59:59 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-tnvmCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:59:59 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)) 18:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:59:59 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-SkA_KK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 18:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:59:59 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-V9fNWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:59:59 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)) 18:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:00:00 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Rvu3yC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:00:00 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-9Pf8aW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:00:00 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:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:00:00 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-eGRM5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:00 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-wxmaQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:00 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:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:00:00 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Wy80Yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:00:00 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-U7lrw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:00:00 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:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:00:00 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:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:00:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:00: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:00: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:00: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:00: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:00: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:00: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:00:03 INFO - Downloading blessings-1.6.tar.gz 19:00:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:00:03 INFO - Installing collected packages: blessings 19:00:03 INFO - Running setup.py install for blessings 19:00:03 INFO - Successfully installed blessings 19:00:03 INFO - Cleaning up... 19:00:03 INFO - Return code: 0 19:00:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:00:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:00:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:00:03 INFO - Reading from file tmpfile_stdout 19:00:03 INFO - Current package versions: 19:00:03 INFO - blessings == 1.6 19:00:03 INFO - blobuploader == 1.2.4 19:00:03 INFO - docopt == 0.6.1 19:00:03 INFO - functools32 == 3.2.3-2 19:00:03 INFO - jsonschema == 2.5.1 19:00:03 INFO - manifestparser == 1.1 19:00:03 INFO - mozInstall == 1.12 19:00:03 INFO - mozcrash == 0.17 19:00:03 INFO - mozdebug == 0.1 19:00:03 INFO - mozdevice == 0.48 19:00:03 INFO - mozfile == 1.2 19:00:03 INFO - mozhttpd == 0.7 19:00:03 INFO - mozinfo == 0.9 19:00:03 INFO - mozleak == 0.1 19:00:03 INFO - mozlog == 3.3 19:00:03 INFO - moznetwork == 0.27 19:00:03 INFO - mozprocess == 0.23 19:00:03 INFO - mozprofile == 0.28 19:00:03 INFO - mozrunner == 6.12 19:00:03 INFO - mozscreenshot == 0.1 19:00:03 INFO - mozsystemmonitor == 0.3 19:00:03 INFO - moztest == 0.7 19:00:03 INFO - mozversion == 1.4 19:00:03 INFO - psutil == 3.1.1 19:00:03 INFO - requests == 1.2.3 19:00:03 INFO - wsgiref == 0.1.2 19:00:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00:03 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:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:03 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:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:03 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 0x10816d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080e3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa83ad88c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f81d30>, '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 0x107da7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f79b20>, '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.oMNY3u8NM3/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.Yn2yaWbMiW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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:00:03 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:00:03 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:00:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oMNY3u8NM3/Render', 19:00:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:03 INFO - 'HOME': '/Users/cltbld', 19:00:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:03 INFO - 'LOGNAME': 'cltbld', 19:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:03 INFO - 'MOZ_NO_REMOTE': '1', 19:00:03 INFO - 'NO_EM_RESTART': '1', 19:00:03 INFO - 'PAGER': '/bin/cat', 19:00:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:03 INFO - 'PWD': '/builds/slave/test', 19:00:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:03 INFO - 'SHELL': '/bin/bash', 19:00:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yn2yaWbMiW/Listeners', 19:00:03 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 19:00:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:03 INFO - 'USER': 'cltbld', 19:00:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:03 INFO - 'XPC_FLAGS': '0x0', 19:00:03 INFO - 'XPC_SERVICE_NAME': '0', 19:00:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:04 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:00:04 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:00:04 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:00:04 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:00:04 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:00:04 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:00:04 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:00:04 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:00:04 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:00:04 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:00:04 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:00:04 INFO - Cleaning up... 19:00:04 INFO - Return code: 0 19:00:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:04 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 0x10816d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080e3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa83ad88c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f81d30>, '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 0x107da7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f79b20>, '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.oMNY3u8NM3/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.Yn2yaWbMiW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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:00:04 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:00:04 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:00:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oMNY3u8NM3/Render', 19:00:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:04 INFO - 'HOME': '/Users/cltbld', 19:00:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:04 INFO - 'LOGNAME': 'cltbld', 19:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:04 INFO - 'MOZ_NO_REMOTE': '1', 19:00:04 INFO - 'NO_EM_RESTART': '1', 19:00:04 INFO - 'PAGER': '/bin/cat', 19:00:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:04 INFO - 'PWD': '/builds/slave/test', 19:00:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:04 INFO - 'SHELL': '/bin/bash', 19:00:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yn2yaWbMiW/Listeners', 19:00:04 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 19:00:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:04 INFO - 'USER': 'cltbld', 19:00:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:04 INFO - 'XPC_FLAGS': '0x0', 19:00:04 INFO - 'XPC_SERVICE_NAME': '0', 19:00:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:00:04 INFO - Cleaning up... 19:00:04 INFO - Return code: 0 19:00:04 INFO - Running post-action listener: _resource_record_post_action 19:00:04 INFO - Running post-action listener: _start_resource_monitoring 19:00:04 INFO - Starting resource monitoring. 19:00:04 INFO - [mozharness: 2016-09-14 02:00:04.335751Z] Finished create-virtualenv step (success) 19:00:04 INFO - [mozharness: 2016-09-14 02:00:04.336791Z] Running install step. 19:00:04 INFO - Running pre-action listener: _resource_record_pre_action 19:00:04 INFO - Running main action method: install 19:00:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:00:04 INFO - Reading from file tmpfile_stdout 19:00:04 INFO - Detecting whether we're running mozinstall >=1.0... 19:00:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:00:04 INFO - Reading from file tmpfile_stdout 19:00:04 INFO - Output received: 19:00:04 INFO - Usage: mozinstall [options] installer 19:00:04 INFO - Options: 19:00:04 INFO - -h, --help show this help message and exit 19:00:04 INFO - -d DEST, --destination=DEST 19:00:04 INFO - Directory to install application into. [default: 19:00:04 INFO - "/builds/slave/test"] 19:00:04 INFO - --app=APP Application being installed. [default: firefox] 19:00:04 INFO - mkdir: /builds/slave/test/build/application 19:00:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:00:39 INFO - Reading from file tmpfile_stdout 19:00:39 INFO - Output received: 19:00:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:00:39 INFO - Running post-action listener: _resource_record_post_action 19:00:39 INFO - [mozharness: 2016-09-14 02:00:39.013466Z] Finished install step (success) 19:00:39 INFO - [mozharness: 2016-09-14 02:00:39.013641Z] Running run-tests step. 19:00:39 INFO - Running pre-action listener: _resource_record_pre_action 19:00:39 INFO - Running main action method: run_tests 19:00:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:00:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:00:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:00:39 INFO - 2016-09-13 19:00:39.028 screenresolution[1934:19543] starting screenresolution argv=screenresolution get 19:00:39 INFO - 2016-09-13 19:00:39.031 screenresolution[1934:19543] Display 0: 1600x1200x32@60 19:00:39 INFO - 2016-09-13 19:00:39.037 screenresolution[1935:19545] starting screenresolution argv=screenresolution list 19:00:39 INFO - Available Modes on Display 0 19:00:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:00:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:00:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:00:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:00:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:00:39 INFO - Intel Iris: 19:00:39 INFO - Chipset Model: Intel Iris 19:00:39 INFO - Type: GPU 19:00:39 INFO - Bus: Built-In 19:00:39 INFO - VRAM (Dynamic, Max): 1536 MB 19:00:39 INFO - Vendor: Intel (0x8086) 19:00:39 INFO - Device ID: 0x0a2e 19:00:39 INFO - Revision ID: 0x0009 19:00:39 INFO - Displays: 19:00:39 INFO - Display: 19:00:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:00:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:00:39 INFO - Display Serial Number: 1600x1200 60 19:00:39 INFO - Main Display: Yes 19:00:39 INFO - Mirror: Off 19:00:39 INFO - Online: Yes 19:00:39 INFO - Rotation: Supported 19:00:39 INFO - Return code: 0 19:00:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:00:39 INFO - Python 2.7.3 19:00:39 INFO - Return code: 0 19:00:39 INFO - grabbing minidump binary from tooltool 19:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:39 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f81d30>, '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 0x107da7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f79b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:00:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:00:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 19:00:39 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:00:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:00:39 INFO - Return code: 0 19:00:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:00:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:00:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:00:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:00:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:00:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I2f_d2qBTVScpUr0bLn2iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0159', '--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:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I2f_d2qBTVScpUr0bLn2iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0159 --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:00:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oMNY3u8NM3/Render', 19:00:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:39 INFO - 'HOME': '/Users/cltbld', 19:00:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:39 INFO - 'LOGNAME': 'cltbld', 19:00:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:00:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:39 INFO - 'MOZ_NO_REMOTE': '1', 19:00:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:00:39 INFO - 'NO_EM_RESTART': '1', 19:00:39 INFO - 'PAGER': '/bin/cat', 19:00:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:39 INFO - 'PWD': '/builds/slave/test', 19:00:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:00:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:39 INFO - 'SHELL': '/bin/bash', 19:00:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yn2yaWbMiW/Listeners', 19:00:39 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 19:00:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:39 INFO - 'USER': 'cltbld', 19:00:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:39 INFO - 'XPC_FLAGS': '0x0', 19:00:39 INFO - 'XPC_SERVICE_NAME': '0', 19:00:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I2f_d2qBTVScpUr0bLn2iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0159', '--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:00:39 INFO - mozversion application_buildid: 20160913170427 19:00:39 INFO - mozversion application_changeset: 46f83778b4bb441770406754db09ada5911600fd 19:00:39 INFO - mozversion application_display_name: Nightly 19:00:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:00:39 INFO - mozversion application_name: Firefox 19:00:39 INFO - mozversion application_remotingname: firefox 19:00:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:00:39 INFO - mozversion application_vendor: Mozilla 19:00:39 INFO - mozversion application_version: 51.0a1 19:00:39 INFO - mozversion platform_buildid: 20160913170427 19:00:39 INFO - mozversion platform_changeset: 46f83778b4bb441770406754db09ada5911600fd 19:00:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:00:39 INFO - mozversion platform_version: 51.0a1 19:00:39 INFO - using testdate: 1473818439 19:00:39 INFO - actual date: 1473818439 19:00:39 INFO - starting webserver on 'localhost:54632' 19:00:39 INFO - SUITE-START | Running 2 tests 19:00:39 INFO - TEST-START | dromaeo_css 19:00:39 INFO - operating with platform_type : mac_ 19:00:39 INFO - Initialising browser for dromaeo_css test... 19:00:39 INFO - TEST-INFO | started process 1945 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmp09ZIHt/profile http://localhost:54632/getInfo.html) 19:00:41 INFO - PROCESS | 1945 | __metrics Screen width/height:1600/1200 19:00:41 INFO - PROCESS | 1945 | colorDepth:24 19:00:41 INFO - PROCESS | 1945 | Browser inner width/height: 1024/689 19:00:41 INFO - PROCESS | 1945 | __metrics 19:00:42 INFO - PROCESS | 1945 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:00:42 INFO - PROCESS | 1945 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:00:42 INFO - TEST-INFO | 1945: exit 0 19:00:42 INFO - Browser initialized. 19:00:42 INFO - Running cycle 1/1 for dromaeo_css test... 19:00:42 INFO - TEST-INFO | started process 1947 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmp09ZIHt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:00:54 INFO - PROCESS | 1947 | RSS: Main: 229371904 19:00:54 INFO - PROCESS | 1947 | 19:01:45 INFO - PROCESS | 1947 | 1473818505900 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:03:57 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:54632/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54632/tests/dromaeo/cssquery-ext.html) 19:03:59 INFO - PROCESS | 1947 | RSS: Main: 345960448 19:03:59 INFO - PROCESS | 1947 | 19:07:01 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:54632/tests/dromaeo/cssquery-ext.html (next: http://localhost:54632/tests/dromaeo/cssquery-jquery.html) 19:07:02 INFO - PROCESS | 1947 | RSS: Main: 371195904 19:07:02 INFO - PROCESS | 1947 | 19:10:04 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:54632/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54632/tests/dromaeo/cssquery-mootools.html) 19:10:05 INFO - PROCESS | 1947 | RSS: Main: 340692992 19:10:05 INFO - PROCESS | 1947 | 19:13:07 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:54632/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54632/tests/dromaeo/cssquery-prototype.html) 19:13:08 INFO - PROCESS | 1947 | RSS: Main: 331915264 19:13:08 INFO - PROCESS | 1947 | 19:16:11 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:54632/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54632/tests/dromaeo/cssquery-yui.html) 19:16:12 INFO - PROCESS | 1947 | RSS: Main: 326279168 19:16:12 INFO - PROCESS | 1947 | 19:19:15 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:54632/tests/dromaeo/cssquery-yui.html (next: http://localhost:54632/tests/dromaeo/cssquery-dojo.html) 19:19:16 INFO - PROCESS | 1947 | RSS: Main: 399286272 19:19:16 INFO - PROCESS | 1947 | 19:19:16 INFO - PROCESS | 1947 | __start_tp_report 19:19:16 INFO - PROCESS | 1947 | _x_x_mozilla_page_load 19:19:16 INFO - PROCESS | 1947 | _x_x_mozilla_page_load_details 19:19:16 INFO - PROCESS | 1947 | |i|pagename|runs| 19:19:16 INFO - PROCESS | 1947 | |0;dojo.html;2934.281101130223;3325.933481330375;3368.9663103368957;3369.5451114099606;3378.6959173674363;5545.944540554593;5660.858478538039;5692.288463942007;5766.077427611583;5803.361630220672;5586.162075688649;5596.0206963781275;5596.86007849804;5620.522255608268;5631.8028868989595;5088.135017047092;5123.180291153416;5135.537801597874;5138.768755406016;5185.429602743695;5307.416184219733;5326.547243484309;5333.146696528556;5333.306670132877;5339.252504649352;5235.528802407783;5273.129933560957;5275.736213189344;5294.655847369928;5310.283111779899;5329.893402131955;5334.4398838122215;5337.626366154371;5360.597955153379;5438.619296649236;5135.64050516464;5154.38147422308;5197.298364720752;5253.159494480903;5285.154375299933;5670.092785154397;5765.942340576583;5816.447437493432;5828.096645019987;5833.066709326487;6335.303116657164;6337.302896681362;6338.39785220408;6342.556021078526;6352.110704501373;6148.047052706793;6216.378362163793;6227.408396202399;6246.281677607088;6294.8111556653375;5869.413058694139;5888.263967004124;5908.172855800191;5944.643321400643;6001.729922153513;6304.988995962607;6311.33730958252;6312.810615681537;6323.620582765049;6330.050492426173;6205.875882482325;6219.378062193835;6229.5327850410495;6248.656323902229;6275.121482992385;6158.630482171084;6210.689465526796;6220.222472190976;6246.968765156145;6251.374862513712;6299.96850015747;6307.306196318401;6320.115183874262;6320.304766475684;6325.9051114233325;6244.2819075806865;6292.069940654008;6335.968320158369;6342.587731797418;6343.904841427382;4940.654154209171;4948.257761335828;4989.25161225819;4993.176125939252;5092.949070509321;4511.075229577928;4513.435820522434;4526.343680166357;4537.3647689323525;4546.363509108727;5805.477507024388;5810.070388737781;5811.912821307684;5814.796482123105;5836.9124463133085;6156.353582873823;6252.062190671436;6252.155958945576;6256.874862502725;6276.497880169575;5696.430356964271;5752.539796816244;5788;5801.274840644919;5830.125481177773;5531.059719847635;5539.750711218005;5541.833744987657;5549.778008879681;5553.8333849984565;6369;6385.233771947396;6394;6397.360263973658;6401.519886008568;6121.788327166137;6213.316535181217;6236.501079913687;6285.5600107992;6305.40098690642;6340.49276057905;6382.6170429774365;6385.7126429309865;6391.265004524539;6396.71214795326;4616.607588354893;6251.023720535397;6271.498280137669;6298.748050077946;6305.243370795534;6170.938290617037;6236.688165591611;6242.063690446469;6256.217972753406;6266.780662676784;5730.627509211888;5979.594795223032;6131.866048757656;6230;6238.625682459067;6039.63762174271;6242.157308763259;6248.937510624835;6268.091126786499;6273.466755325849;5944.554158438048;5989.131575921554;6080.300765412034;6120.846978825565;6125.081237814364;6122.916604401471;6142.57002009855;6177.62934223948;6243.406876346739;6251.249850018027;6097;6110.633361998294;6113.144159817718;6120.816375508742;6128.050152226412 19:19:16 INFO - PROCESS | 1947 | |1;ext.html;476.84025851339794;506.95437410633036;524.7822153806171;525.3039722367862;527.3750605532447;24437.511249774994;40099;40628;40887.386689199615;43128;42128;42558;42558.93602659935;42621.7868910655;42812;9705.951470242639;9874.456904870265;9877;9882.703518894408;9891.55488003038;8739.126087391274;8876.023637399881;9646.517674116301;11983.760324793499;12120.212186207913;10904.745954215288;11510.597129100483;12033.157678962476;12126.211796233261;12131.939340303286;10013.799724005552;11977.281363118154;12000.219985700945;12001.51993920242;12016.798320168;11850.644480665595;11929.105317101252;11930.164888457812;11932.522699092026;11949;34119.82940085284;40054.99862503431;40428;40432.39351409731;40460.39309410361;3332.266901281714;3393.490976353542;3504.0539054455153;3610.837512311952;3633.654802793757;30128.397432051235;31300.37399252002;31353.529697054564;31457.8427107863;31627.367452651048;3138.3880143372053;3145.3552021835467;3258.332041931398;3290.917727056819;3364.243045314809;447376.99999999674;449202;449497;450101;450612;57401.42598573961;57559.71220143873;57696;57754.42245577575;58065.838683226946;60937.39062609317;61087.694561527795;61166;61259.6937015321;61307.6934615333;16130.274137663833;16382.426615068416;16402.589935251475;16419.343226271056;16424.468739221124;11579.247348922294;12671.619851404472;12759.979201663844;12761.680957976125;12774.489020439078;14632.561023169323;16049.919750401406;16431.671366572602;16470.341186352412;16937.407190748265;6025.578209525379;6099.84750381244;7158.821029474305;7276.998825323079;7283.490155689157;839.689314953459;910.7632015675972;911.7902882337099;925.8287216864901;952.4475804033644;25530.23409297724;28609.57085643717;28767.56848647272;29703.702962970525;29942.251443713645;1018.3573626439378;1030.860833787444;1037.5642230263309;1048.9580416783242;1094.3816743540033;12583.559575414816;15135.470258540898;15500.92249538745;15609;15640.921795391178;636855;676578;679615;682488;925814;49346;50296.24555631669;50341.993160137325;55305.1704224437;57095.85808283811;1347.1176379471462;1356.6811799227173;1376.1330361871956;1378.152436251698;1379.7792353223435;30128.230735429024;30462.390752185274;30829.69170308268;30977;31114;49218.26172607485;49535.25697114474;49689.50310496993;49786;49962.25056624081;600941;611446;613234;817108;818045;25191.622125668495;25198.62202067007;25322.74677253204;25368.619470708323;25376.74623253744;45227.54772452233;45566.31650525179;45844.31233531433;47149.821254468916;49541.50458495513;38245;38356.808215959856;38657.613423865405;40007.39988900227;40131.59868401279;32599.859004934715;33920.1519961993;37500.30956378691;38715.225695485366;38945.41581876331;35720.64279357173;35894.002677911274;36671.266574667825;36837.44743828791;36954.26091478209;27069.86465067662;32979;33189.50215746718;33607.32785344328;33891.3221735559;23764.762352376256;24143;24151.879240603685;24696.382590434663;24739.134130305352 19:19:16 INFO - PROCESS | 1947 | |2;jquery.html;288.59596564809266;350.8228344685933;370.86648806429696;371.2500748488054;401.9939700904485;15138.318775655094;15241.390344386225;16255.024698518082;18164;20910.477238069056;19677.50806229845;20301.5913184572;20602.484937876525;20827.062782174802;21227.57544849102;5671.63134396265;5994.340622531518;6015.789447369343;6016.067509536007;6019.067044608071;5073.934473760496;5341.1988201769655;5924.822255332326;5985.790497332594;5993.910091348612;5648.209250704905;5923.28920529537;5936.762529498837;5941.2276404067625;5942.881142377149;5743.282089738783;5833.300003999526;5855.824325270249;5866.061430171195;5873.030949893284;4881.243407271879;5113.335266415379;5128.794848206067;5136.152534831748;5139.460356662571;22217;22462.663060054114;22758.748268845207;25674.871625641754;26075.348116297053;2136.113512892148;2234.731832180149;2303.7926586607286;2347.354477518696;2363.3618922890723;14992;15993.840831487716;16093.953892996919;16120.919395403065;16326.673466530721;1841.6040551281405;1852.2128095559333;1882.5481884347794;1923.6152769446167;1973.7138114973393;113536.45081897646;117534.99999999914;117728.23407648892;118448.8155118455;118780;10662.41356725372;10783.6225732099;11122.944385278022;11200.815840910944;11360.261582997078;12684.682882927817;13001.284929328789;14032.85967140336;14050.859491404955;14088.506902258372;8366.916330836735;8611.61247743853;8634.136586341441;8800.515971621622;8830.646774128963;8605.440646358093;8630.913690863137;8640.956795216109;8786.560671966376;8831.867521987175;6609.570377925419;6714.160729908762;6724.831879203059;6736.972643658906;6739.730410783513;1822.7312287364591;1848.3438379375398;1849.2048419179612;1855.5082903030707;1858.3774435564237;714.6891102370486;763.393102483527;877.2893955895745;940.2853831088422;944.9763755906157;18116.54840834034;21210.787892120883;22226.888865555567;22227;22360.105595775985;914.2229105260475;965.1603105298435;1008.6671398438498;1015.1269907879218;1035.171862509989;11072.11151996887;11806.881931180578;11935.224210426295;11937.641870743892;11970.940145299217;506577;566298;575710;576495;578578;114190.42904785422;115439.2684109739;118611.40694296474;121342;122521;907.856101312338;973.8733964584559;1063.4948399510172;1087.983680244797;1089.1939964426267;19130.90434547874;19777.70333445028;19793.30723424673;19829.801701982797;19856.30502932448;34394.31211375808;40850;44057.069727449365;49322.75338623284;50004.499954999985;71359;71483;72552;72582.54834903378;73218.63390683226;7814.452988290993;7921.217726011601;7954.778314782522;7974.362051036019;8234.382421318305;12717.682057948625;12812.61562153137;12876.420561074961;13105.737885242432;13142.802857956947;9134.406263592846;10694.749450988034;10997.670069897917;11086;11283.717907052389;10216.693499195037;10558.736031599272;10760.300580462244;11129.666110016713;11279.32324060559;10870.184736144663;11164.944175279072;11232.775344493228;11358.26171298863;11598.130140239347;7834.030035609082;7916.060565161342;7934.778262086625;8161;8237.835243294981;10934.617288394868;11166.939140781613;11274.943625281821;11294.94352528232;11311.321320720783 19:19:16 INFO - PROCESS | 1947 | |3;mootools.html;1421.232534431407;1462.7367073926691;1651.1331550935765;1804.4767017564907;1868.6636405447023;8485.490870547772;9053.185213330808;9069.047749986255;9074.500902450363;9080.909190908089;7822.139564647884;8091.514509129442;8103.149169337208;8541.530215838126;8759.781005474866;2358.8938497767554;2400.1719406804623;2403.0868270057354;2412.8793560322;2414.987925060381;2364.6216605343147;2367.5975084235633;2411.46947671512;2413.3001429585397;2415.903363865443;2377.667126602277;2396.9640455393182;2409.2410890569504;2415.9973610951433;2416.1664225842146;2371.1582388252095;2388.4028992751814;2394.6408038794234;2397.3287479505766;2405.1101092595677;2360.1031607989025;2381.868997205153;2384.8926798293946;2388.605880029793;2395.113807891074;8870.246029087535;8877.156670116328;8981.730548083568;8989.910100899038;8991;5175.585953123741;5327;5328.6802791832615;5331.999999999961;5333.813316533902;3013.6383633963846;3565.7682250653625;3666.9633303667156;3668.064643515913;3674.393725035393;1070.8554345163382;1083.853679753231;1088.4775307852276;1094.316052467208;1105.9447027648666;11175.944120279346;11280.717982050432;11289.717757056058;11301.434928253637;11321.603743868925;4345.760983145958;4361.258586040381;4479.46246450428;4479.910401791946;4733.786979585927;9680.031996800264;9683.370580912218;9683.806323873483;9695.563699633534;9699.709008729607;5281.947180528223;5283.260343551906;5286.735663216824;5290.338707661543;5317.202419637086;4398.69209155356;4543.4775000875325;4751.3348131261655;4862.343583616166;4877.7073375596865;3855.845766169378;3892.5328960524353;3980.800959951991;4021.1354558770004;4025.275450418953;1277.1251692590606;1292.4184117147133;1292.6445227562308;1302.8892544133855;1303.4720938020116;812.9430939834155;881.9294456443469;893.7140115163086;917.020578260041;933.6358820060182;5732.512736417451;5763.452472015236;5870.148828419855;5957.3449314685495;6031.9698401508585;450.34249995007656;456.8857785553612;459.20328230520687;968.8885778135605;971.3928794503436;3824;3862.4592557042038;3972.2254160439015;4001.47980762499;4029.2747305485295;10689.30519516229;10962.780744385227;11016.283941543774;11016.944915275373;11041.282316649553;10621.097206737513;10859.402732849769;11033.779324413466;11058.778824423627;11072.889271107348;8162.959185204036;8184.877226841602;8218.424710270223;8356.206160414751;8367.079621241659;5807.8548036299435;5839.474447299764;5846.123081537803;5894.0274854650215;5943.846476426255;9334.346595738232;10014.449205293779;10046.296759227076;10108.39349639024;10126.544305506122;10076.647317343857;10248.333858299187;10282.691519254435;10396.688099357032;10405.387164989439;6553.442957348679;6727.058211850247;6911.965440172767;7077.292270772881;7245.855082898207;8257.83484330322;8533.658653653783;8534.957325213334;8543;8558.101399353227;7391.445641577011;7426.8143296415865;7498.287662672037;7580.317771400601;7667.846643067219;7017.806972814736;7219.2780721929485;7432;7566.962165189138;7619.65711542993;6512.6092434454085;6931.272216417204;6933.5493192942295;6933.930660693329;6944.652767361713;4916.655834091579;4988.301637770787;4993.17612593918;5028.472010438852;5089.898202036013;4304.096139810675;4310.568943105664;4376.956230437782;4384.224389122411;4524.5927866492175 19:19:16 INFO - PROCESS | 1947 | |4;prototype.html;301.2814437566404;304.57359696425004;308.8193406856989;313.72549019607857;315.3566723883275;4042.3532234842432;4238.936415953759;5194.844154675357;5195.714235717034;5272.499112584298;4511.789223280593;4747.643926705502;5159.561437277826;5188.15820383764;5242.737863106839;3694.8891533254045;3841.4045822897497;3842.2507611015862;3902.2195560887794;3998.600139985993;3472.5138480612736;3510.9291666041845;3914.7472808701227;3924.4701965234613;3941.9802900985455;3872.0900588361715;3890.3386424307796;3897.7661340319673;3910.0674494129403;3917.1382295895;3191.2021994501374;3380.695737383635;3517.8241087945757;3645.8359373827975;3944.9408258876138;3119.2357872321427;3310.817905015223;3385.8137802420856;3397.1846756778195;3418.3676019936393;4127.504699436057;4904.72477155942;4956.207006878882;5005.599552035828;5016;4259.637930775888;4463.642908567339;4475.261581838992;4482.238019536687;4490.316131450706;5372.650777699476;5384.40771515133;5391.649542779707;5396;5476;3169.41365847319;3811.923761524754;3815.7138214634015;3819.3316169670475;3822.2928758179823;5268.683878967313;5623.634463759842;5703.914441283384;5717.342505611867;5717.742701578439;3456.4100513763447;3789.5263092113487;3817.274717803664;3821.923561528754;3844.9231015380096;3908.804559772057;3914.0214946263436;3934.940975885364;3940.6650434712797;3960.20795840833;4510.8421205257655;4519.751413672279;4533.455985281787;4537.09258148365;4545.8408955687055;4786.569208771228;5183.766730497136;5325.547328477045;5457.426970168154;5486.588505862076;1146.0487795130023;1305.8628843971437;1326.8390158611214;1327.422571181539;1334.639647295225;789.814393617511;793.6349279331572;837.9497230166088;845.5053793530853;845.9534725590152;3714.9442758358646;4318.978405108017;4554.973036998504;4571.428571428572;4978.755311172207;4964;5395.433479484597;5524.475174858382;5614.578906582023;5639.436056394327;4733.763311834395;5053.267276244924;5055.368078990126;5057.848264552069;5087.364079490064;2447;2465.409810672142;2918.124562631202;2938.706968933705;2968.3321252717965;4787.390871974782;5777.006932608243;5782.421757824268;5809.758876020529;5819.53443724501;5009.674371165863;5445.863853403696;5525.834224973257;5714.228579141846;5753.626014309057;4495.538949841314;4990.700557966534;5164.586833053422;5747.936631723061;5813.476787089097;4837.346958160744;5559.777608895599;5574.829285850017;5579.944200557942;5592.608517403743;5080.568151707146;5237.764300606558;5417.268668729828;5506.972465137648;5518.392976772632;5808.780156167252;5887.3523912370465;5890.4979230296;5897.764089436375;5902.7343769531335;3405.829708514614;3651.744377893522;3804.6005169456807;3835.602748282324;3845.5577608575372;5365.3293338332705;5507.614466987273;5632.662040277596;5634.464725851038;5738.799142030009;4447.6219521341045;4802.615790736662;5215.722148073594;5462.541856164821;5487.396386397573;5332.5467335276935;5485.369182544058;5499.175123731472;5503.147012213113;5511.4213007633625;4380.496242932104;4953.356063711694;5193.5722423200505;5307.787688492417;5465.918011229755;4462.754548499734;5416.83749487516;5538.252335934597;5552.916706249329;5553.4724201200825;4496.865094047183;5081.983603279433;5144.76848541824;5377.2740680009265;5394.354721809886 19:19:16 INFO - PROCESS | 1947 | |5;yui.html;645.2031740800109;660.534323302072;760.0727112922233;768.4812751392816;792.8176519400539;15509;16280.430184943529;16299.91850040748;16308;16359.263833127508;14578.343974521145;14831.629209269746;14836.629084272898;14841.55475335739;14849.703005939902;680.6188534420728;700;701.3897908819334;823.2508417340222;846.4624963148415;835.0188528479043;842.3303473738362;844.6874656377149;844.8732690096473;844.9788755281137;881.2377293641018;883.4434306386967;883.8983516895543;885.9689910853122;886.5965985476593;713.425692317684;735.7939776862487;870.0472982084607;880.4233227236139;881.3389957531883;673.9595624262511;674.6559254780049;677.6306912732523;680.0581195044898;680.669875110571;14994.47519336829;15057.849421505864;15058.698826023528;15068.849311506854;15079.095254284777;13640;13710.794338084937;13797.034207605471;13945;13961.162330260217;12646.999063368829;12849.293288869108;12929.224246545238;12953.676158096028;13016.934915325362;4406.823727050914;4492.213862574069;4561.703489273186;4632.559906808848;4733.219018861883;120715.28030783279;122591;123276;123304.38347808293;126166.36916815449;10891.509882055327;10921.453927303603;10965.945170274097;11055.889441105646;11084.833727494093;22119;22154.003069861894;22183.11267549312;22208.333749987527;22222.333330000125;7784.2215778421705;7883.487573307717;7939.325157361689;7939.404544659174;8123.3095186908595;4342.413774140514;4371.825126994948;4431.4903786065015;4540.341650460665;4541.227991241497;3425.53755243044;3527.6648718372226;3529.699975502111;3533.4876442915634;3540.5220295260324;539.940606533281;649.7498463091744;656.6125985668479;656.6322859198864;658.0622612776774;585.487698264019;587.5270407322147;595.7795615622248;599.7720866070953;602.4607975861579;8348.622477291301;8601.268892144113;8725.956370218235;8814.735557933273;8863.734087977371;567.2455634006843;568.3833041150316;609.2567068176817;622.8474023864183;638.4892086330917;4172.290710579209;4503.414556107685;4980.869565217391;4987.800487980513;5008.223725322581;151133;151761.68834090975;153252;154040.45959540486;157584;108990;126866;130574;132747;135909;78675.60662196652;110502.99999999838;111675;116027.41986290184;116331.41834290774;9344.15902568772;9451.480168590793;9549.09283618055;9557.904420955701;9606.711798646053;49122.75438622784;61247.69376153091;62669.059964099666;62928.37071629225;64195.67902160459;91508.40818028871;97639.0472190538;98133.01866981524;98572;100802.4959875196;12753.61739147827;13093.410796513988;13143.934280328536;13324.467021319038;13548.119372240773;14651.487197948021;14867.107973521623;14920.179390133648;14960.32678529447;15426.768598471257;13626.659333516742;13910.930445347709;14146.92926535402;14182.503612373517;14375.28123593837;13539.932300338436;13678.458326257132;13874.445022199;13993.580192594238;14146.22195779242;11188.608398706332;13453.932730336286;13631.04582679203;13672.453101875813;14148.292585370897;10893.836592451278;11143.554257829595;11242.718932026764;11621.709457263636;11977.940110299742;11340.344329579726;11403.714907127056;11569.132315076571;11576.131790115607;11619.883801161881 19:19:16 INFO - PROCESS | 1947 | __end_tp_report 19:19:16 INFO - PROCESS | 1947 | __start_cc_report 19:19:16 INFO - PROCESS | 1947 | _x_x_mozilla_cycle_collect,1092 19:19:16 INFO - PROCESS | 1947 | __end_cc_report 19:19:16 INFO - PROCESS | 1947 | __startTimestamp1473819556021__endTimestamp 19:19:16 INFO - PROCESS | 1947 | 19:19:16 INFO - PROCESS | 1947 | ------- Summary: start ------- 19:19:16 INFO - PROCESS | 1947 | Number of tests: 6 19:19:16 INFO - PROCESS | 1947 | 19:19:16 INFO - PROCESS | 1947 | [#0] dojo.html Cycles:165 Average:5795.63 Median:6097.00 stddev:659.96 (10.8%) stddev-sans-first:622.64 19:19:16 INFO - PROCESS | 1947 | Values: 2934.3 3325.9 3369.0 3369.5 3378.7 5545.9 5660.9 5692.3 5766.1 5803.4 5586.2 5596.0 5596.9 5620.5 5631.8 5088.1 5123.2 5135.5 5138.8 5185.4 5307.4 5326.5 5333.1 5333.3 5339.3 5235.5 5273.1 5275.7 5294.7 5310.3 5329.9 5334.4 5337.6 5360.6 5438.6 5135.6 5154.4 5197.3 5253.2 5285.2 5670.1 5765.9 5816.4 5828.1 5833.1 6335.3 6337.3 6338.4 6342.6 6352.1 6148.0 6216.4 6227.4 6246.3 6294.8 5869.4 5888.3 5908.2 5944.6 6001.7 6305.0 6311.3 6312.8 6323.6 6330.1 6205.9 6219.4 6229.5 6248.7 6275.1 6158.6 6210.7 6220.2 6247.0 6251.4 6300.0 6307.3 6320.1 6320.3 6325.9 6244.3 6292.1 6336.0 6342.6 6343.9 4940.7 4948.3 4989.3 4993.2 5092.9 4511.1 4513.4 4526.3 4537.4 4546.4 5805.5 5810.1 5811.9 5814.8 5836.9 6156.4 6252.1 6252.2 6256.9 6276.5 5696.4 5752.5 5788.0 5801.3 5830.1 5531.1 5539.8 5541.8 5549.8 5553.8 6369.0 6385.2 6394.0 6397.4 6401.5 6121.8 6213.3 6236.5 6285.6 6305.4 6340.5 6382.6 6385.7 6391.3 6396.7 4616.6 6251.0 6271.5 6298.7 6305.2 6170.9 6236.7 6242.1 6256.2 6266.8 5730.6 5979.6 6131.9 6230.0 6238.6 6039.6 6242.2 6248.9 6268.1 6273.5 5944.6 5989.1 6080.3 6120.8 6125.1 6122.9 6142.6 6177.6 6243.4 6251.2 6097.0 6110.6 6113.1 6120.8 6128.1 19:19:16 INFO - PROCESS | 1947 | 19:19:16 INFO - PROCESS | 1947 | [#1] ext.html Cycles:180 Average:74039.32 Median:19752.42 stddev:171574.14 (868.6%) stddev-sans-first:171966.55 19:19:16 INFO - PROCESS | 1947 | Values: 476.8 507.0 524.8 525.3 527.4 24437.5 40099.0 40628.0 40887.4 43128.0 42128.0 42558.0 42558.9 42621.8 42812.0 9706.0 9874.5 9877.0 9882.7 9891.6 8739.1 8876.0 9646.5 11983.8 12120.2 10904.7 11510.6 12033.2 12126.2 12131.9 10013.8 11977.3 12000.2 12001.5 12016.8 11850.6 11929.1 11930.2 11932.5 11949.0 34119.8 40055.0 40428.0 40432.4 40460.4 3332.3 3393.5 3504.1 3610.8 3633.7 30128.4 31300.4 31353.5 31457.8 31627.4 3138.4 3145.4 3258.3 3290.9 3364.2 447377.0 449202.0 449497.0 450101.0 450612.0 57401.4 57559.7 57696.0 57754.4 58065.8 60937.4 61087.7 61166.0 61259.7 61307.7 16130.3 16382.4 16402.6 16419.3 16424.5 11579.2 12671.6 12760.0 12761.7 12774.5 14632.6 16049.9 16431.7 16470.3 16937.4 6025.6 6099.8 7158.8 7277.0 7283.5 839.7 910.8 911.8 925.8 952.4 25530.2 28609.6 28767.6 29703.7 29942.3 1018.4 1030.9 1037.6 1049.0 1094.4 12583.6 15135.5 15500.9 15609.0 15640.9 636855.0 676578.0 679615.0 682488.0 925814.0 49346.0 50296.2 50342.0 55305.2 57095.9 1347.1 1356.7 1376.1 1378.2 1379.8 30128.2 30462.4 30829.7 30977.0 31114.0 49218.3 49535.3 49689.5 49786.0 49962.3 600941.0 611446.0 613234.0 817108.0 818045.0 25191.6 25198.6 25322.7 25368.6 25376.7 45227.5 45566.3 45844.3 47149.8 49541.5 38245.0 38356.8 38657.6 40007.4 40131.6 32599.9 33920.2 37500.3 38715.2 38945.4 35720.6 35894.0 36671.3 36837.4 36954.3 27069.9 32979.0 33189.5 33607.3 33891.3 23764.8 24143.0 24151.9 24696.4 24739.1 19:19:16 INFO - PROCESS | 1947 | 19:19:16 INFO - PROCESS | 1947 | [#2] jquery.html Cycles:180 Average:33374.14 Median:12230.87 stddev:93652.01 (765.7%) stddev-sans-first:93881.78 19:19:16 INFO - PROCESS | 1947 | Values: 288.6 350.8 370.9 371.3 402.0 15138.3 15241.4 16255.0 18164.0 20910.5 19677.5 20301.6 20602.5 20827.1 21227.6 5671.6 5994.3 6015.8 6016.1 6019.1 5073.9 5341.2 5924.8 5985.8 5993.9 5648.2 5923.3 5936.8 5941.2 5942.9 5743.3 5833.3 5855.8 5866.1 5873.0 4881.2 5113.3 5128.8 5136.2 5139.5 22217.0 22462.7 22758.7 25674.9 26075.3 2136.1 2234.7 2303.8 2347.4 2363.4 14992.0 15993.8 16094.0 16120.9 16326.7 1841.6 1852.2 1882.5 1923.6 1973.7 113536.5 117535.0 117728.2 118448.8 118780.0 10662.4 10783.6 11122.9 11200.8 11360.3 12684.7 13001.3 14032.9 14050.9 14088.5 8366.9 8611.6 8634.1 8800.5 8830.6 8605.4 8630.9 8641.0 8786.6 8831.9 6609.6 6714.2 6724.8 6737.0 6739.7 1822.7 1848.3 1849.2 1855.5 1858.4 714.7 763.4 877.3 940.3 945.0 18116.5 21210.8 22226.9 22227.0 22360.1 914.2 965.2 1008.7 1015.1 1035.2 11072.1 11806.9 11935.2 11937.6 11970.9 506577.0 566298.0 575710.0 576495.0 578578.0 114190.4 115439.3 118611.4 121342.0 122521.0 907.9 973.9 1063.5 1088.0 1089.2 19130.9 19777.7 19793.3 19829.8 19856.3 34394.3 40850.0 44057.1 49322.8 50004.5 71359.0 71483.0 72552.0 72582.5 73218.6 7814.5 7921.2 7954.8 7974.4 8234.4 12717.7 12812.6 12876.4 13105.7 13142.8 9134.4 10694.7 10997.7 11086.0 11283.7 10216.7 10558.7 10760.3 11129.7 11279.3 10870.2 11164.9 11232.8 11358.3 11598.1 7834.0 7916.1 7934.8 8161.0 8237.8 10934.6 11166.9 11274.9 11294.9 11311.3 19:19:16 INFO - PROCESS | 1947 | 19:19:16 INFO - PROCESS | 1947 | [#3] mootools.html Cycles:180 Average:5678.25 Median:2500.18 stddev:3208.87 (128.3%) stddev-sans-first:3201.92 19:19:16 INFO - PROCESS | 1947 | Values: 1421.2 1462.7 1651.1 1804.5 1868.7 8485.5 9053.2 9069.0 9074.5 9080.9 7822.1 8091.5 8103.1 8541.5 8759.8 2358.9 2400.2 2403.1 2412.9 2415.0 2364.6 2367.6 2411.5 2413.3 2415.9 2377.7 2397.0 2409.2 2416.0 2416.2 2371.2 2388.4 2394.6 2397.3 2405.1 2360.1 2381.9 2384.9 2388.6 2395.1 8870.2 8877.2 8981.7 8989.9 8991.0 5175.6 5327.0 5328.7 5332.0 5333.8 3013.6 3565.8 3667.0 3668.1 3674.4 1070.9 1083.9 1088.5 1094.3 1105.9 11175.9 11280.7 11289.7 11301.4 11321.6 4345.8 4361.3 4479.5 4479.9 4733.8 9680.0 9683.4 9683.8 9695.6 9699.7 5281.9 5283.3 5286.7 5290.3 5317.2 4398.7 4543.5 4751.3 4862.3 4877.7 3855.8 3892.5 3980.8 4021.1 4025.3 1277.1 1292.4 1292.6 1302.9 1303.5 812.9 881.9 893.7 917.0 933.6 5732.5 5763.5 5870.1 5957.3 6032.0 450.3 456.9 459.2 968.9 971.4 3824.0 3862.5 3972.2 4001.5 4029.3 10689.3 10962.8 11016.3 11016.9 11041.3 10621.1 10859.4 11033.8 11058.8 11072.9 8163.0 8184.9 8218.4 8356.2 8367.1 5807.9 5839.5 5846.1 5894.0 5943.8 9334.3 10014.4 10046.3 10108.4 10126.5 10076.6 10248.3 10282.7 10396.7 10405.4 6553.4 6727.1 6912.0 7077.3 7245.9 8257.8 8533.7 8535.0 8543.0 8558.1 7391.4 7426.8 7498.3 7580.3 7667.8 7017.8 7219.3 7432.0 7567.0 7619.7 6512.6 6931.3 6933.5 6933.9 6944.7 4916.7 4988.3 4993.2 5028.5 5089.9 4304.1 4310.6 4377.0 4384.2 4524.6 19:19:16 INFO - PROCESS | 1947 | 19:19:16 INFO - PROCESS | 1947 | [#4] prototype.html Cycles:180 Average:4383.92 Median:4954.78 stddev:1360.35 (27.5%) stddev-sans-first:1329.21 19:19:16 INFO - PROCESS | 1947 | Values: 301.3 304.6 308.8 313.7 315.4 4042.4 4238.9 5194.8 5195.7 5272.5 4511.8 4747.6 5159.6 5188.2 5242.7 3694.9 3841.4 3842.3 3902.2 3998.6 3472.5 3510.9 3914.7 3924.5 3942.0 3872.1 3890.3 3897.8 3910.1 3917.1 3191.2 3380.7 3517.8 3645.8 3944.9 3119.2 3310.8 3385.8 3397.2 3418.4 4127.5 4904.7 4956.2 5005.6 5016.0 4259.6 4463.6 4475.3 4482.2 4490.3 5372.7 5384.4 5391.6 5396.0 5476.0 3169.4 3811.9 3815.7 3819.3 3822.3 5268.7 5623.6 5703.9 5717.3 5717.7 3456.4 3789.5 3817.3 3821.9 3844.9 3908.8 3914.0 3934.9 3940.7 3960.2 4510.8 4519.8 4533.5 4537.1 4545.8 4786.6 5183.8 5325.5 5457.4 5486.6 1146.0 1305.9 1326.8 1327.4 1334.6 789.8 793.6 837.9 845.5 846.0 3714.9 4319.0 4555.0 4571.4 4978.8 4964.0 5395.4 5524.5 5614.6 5639.4 4733.8 5053.3 5055.4 5057.8 5087.4 2447.0 2465.4 2918.1 2938.7 2968.3 4787.4 5777.0 5782.4 5809.8 5819.5 5009.7 5445.9 5525.8 5714.2 5753.6 4495.5 4990.7 5164.6 5747.9 5813.5 4837.3 5559.8 5574.8 5579.9 5592.6 5080.6 5237.8 5417.3 5507.0 5518.4 5808.8 5887.4 5890.5 5897.8 5902.7 3405.8 3651.7 3804.6 3835.6 3845.6 5365.3 5507.6 5632.7 5634.5 5738.8 4447.6 4802.6 5215.7 5462.5 5487.4 5332.5 5485.4 5499.2 5503.1 5511.4 4380.5 4953.4 5193.6 5307.8 5465.9 4462.8 5416.8 5538.3 5552.9 5553.5 4496.9 5082.0 5144.8 5377.3 5394.4 19:19:16 INFO - PROCESS | 1947 | 19:19:16 INFO - PROCESS | 1947 | [#5] yui.html Cycles:180 Average:25434.52 Median:3476.60 stddev:40802.67 (1173.6%) stddev-sans-first:40874.68 19:19:16 INFO - PROCESS | 1947 | Values: 645.2 660.5 760.1 768.5 792.8 15509.0 16280.4 16299.9 16308.0 16359.3 14578.3 14831.6 14836.6 14841.6 14849.7 680.6 700.0 701.4 823.3 846.5 835.0 842.3 844.7 844.9 845.0 881.2 883.4 883.9 886.0 886.6 713.4 735.8 870.0 880.4 881.3 674.0 674.7 677.6 680.1 680.7 14994.5 15057.8 15058.7 15068.8 15079.1 13640.0 13710.8 13797.0 13945.0 13961.2 12647.0 12849.3 12929.2 12953.7 13016.9 4406.8 4492.2 4561.7 4632.6 4733.2 120715.3 122591.0 123276.0 123304.4 126166.4 10891.5 10921.5 10965.9 11055.9 11084.8 22119.0 22154.0 22183.1 22208.3 22222.3 7784.2 7883.5 7939.3 7939.4 8123.3 4342.4 4371.8 4431.5 4540.3 4541.2 3425.5 3527.7 3529.7 3533.5 3540.5 539.9 649.7 656.6 656.6 658.1 585.5 587.5 595.8 599.8 602.5 8348.6 8601.3 8726.0 8814.7 8863.7 567.2 568.4 609.3 622.8 638.5 4172.3 4503.4 4980.9 4987.8 5008.2 151133.0 151761.7 153252.0 154040.5 157584.0 108990.0 126866.0 130574.0 132747.0 135909.0 78675.6 110503.0 111675.0 116027.4 116331.4 9344.2 9451.5 9549.1 9557.9 9606.7 49122.8 61247.7 62669.1 62928.4 64195.7 91508.4 97639.0 98133.0 98572.0 100802.5 12753.6 13093.4 13143.9 13324.5 13548.1 14651.5 14867.1 14920.2 14960.3 15426.8 13626.7 13910.9 14146.9 14182.5 14375.3 13539.9 13678.5 13874.4 13993.6 14146.2 11188.6 13453.9 13631.0 13672.5 14148.3 10893.8 11143.6 11242.7 11621.7 11977.9 11340.3 11403.7 11569.1 11576.1 11619.9 19:19:16 INFO - PROCESS | 1947 | -------- Summary: end -------- 19:19:16 INFO - PROCESS | 1947 | 19:19:16 INFO - TEST-INFO | 1947: exit 0 19:19:16 INFO - TEST-OK | dromaeo_css | took 1116987ms 19:19:16 INFO - TEST-START | kraken 19:19:16 INFO - operating with platform_type : mac_ 19:19:16 INFO - Initialising browser for kraken test... 19:19:16 INFO - TEST-INFO | started process 1951 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpjkTMID/profile http://localhost:54632/getInfo.html) 19:19:18 INFO - PROCESS | 1951 | __metrics Screen width/height:1600/1200 19:19:18 INFO - PROCESS | 1951 | colorDepth:24 19:19:18 INFO - PROCESS | 1951 | Browser inner width/height: 1024/689 19:19:18 INFO - PROCESS | 1951 | __metrics 19:19:19 INFO - PROCESS | 1951 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:19:19 INFO - PROCESS | 1951 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:19:19 INFO - TEST-INFO | 1951: exit 0 19:19:19 INFO - Browser initialized. 19:19:19 INFO - Running cycle 1/1 for kraken test... 19:19:19 INFO - TEST-INFO | started process 1952 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpjkTMID/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:19:31 INFO - PROCESS | 1952 | RSS: Main: 229261312 19:19:31 INFO - PROCESS | 1952 | 19:19:34 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54632/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54632/tests/kraken/driver.html?testName=audio-beat-detection) 19:19:35 INFO - PROCESS | 1952 | RSS: Main: 290897920 19:19:35 INFO - PROCESS | 1952 | 19:19:38 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54632/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54632/tests/kraken/driver.html?testName=audio-dft) 19:19:38 INFO - PROCESS | 1952 | RSS: Main: 291151872 19:19:38 INFO - PROCESS | 1952 | 19:19:42 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54632/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54632/tests/kraken/driver.html?testName=audio-fft) 19:19:42 INFO - PROCESS | 1952 | RSS: Main: 378978304 19:19:42 INFO - PROCESS | 1952 | 19:19:44 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54632/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54632/tests/kraken/driver.html?testName=audio-oscillator) 19:19:45 INFO - PROCESS | 1952 | RSS: Main: 282755072 19:19:45 INFO - PROCESS | 1952 | 19:19:47 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54632/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54632/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:19:48 INFO - PROCESS | 1952 | RSS: Main: 287617024 19:19:48 INFO - PROCESS | 1952 | 19:19:51 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54632/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54632/tests/kraken/driver.html?testName=imaging-darkroom) 19:19:51 INFO - PROCESS | 1952 | RSS: Main: 326205440 19:19:51 INFO - PROCESS | 1952 | 19:19:54 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54632/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54632/tests/kraken/driver.html?testName=imaging-desaturate) 19:19:55 INFO - PROCESS | 1952 | RSS: Main: 326590464 19:19:55 INFO - PROCESS | 1952 | 19:19:58 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54632/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54632/tests/kraken/driver.html?testName=json-parse-financial) 19:19:59 INFO - PROCESS | 1952 | RSS: Main: 323100672 19:19:59 INFO - PROCESS | 1952 | 19:20:00 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54632/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54632/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:20:01 INFO - PROCESS | 1952 | RSS: Main: 297885696 19:20:01 INFO - PROCESS | 1952 | 19:20:03 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54632/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54632/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:20:03 INFO - PROCESS | 1952 | RSS: Main: 302551040 19:20:03 INFO - PROCESS | 1952 | 19:20:06 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54632/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54632/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:20:06 INFO - PROCESS | 1952 | RSS: Main: 305455104 19:20:06 INFO - PROCESS | 1952 | 19:20:09 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54632/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54632/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:20:10 INFO - PROCESS | 1952 | RSS: Main: 319832064 19:20:10 INFO - PROCESS | 1952 | 19:20:13 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54632/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54632/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:20:13 INFO - PROCESS | 1952 | RSS: Main: 316076032 19:20:13 INFO - PROCESS | 1952 | 19:20:15 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54632/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54632/tests/kraken/driver.html?testName=ai-astar) 19:20:15 INFO - PROCESS | 1952 | RSS: Main: 359800832 19:20:15 INFO - PROCESS | 1952 | 19:20:15 INFO - PROCESS | 1952 | __start_tp_report 19:20:15 INFO - PROCESS | 1952 | _x_x_mozilla_page_load 19:20:15 INFO - PROCESS | 1952 | _x_x_mozilla_page_load_details 19:20:15 INFO - PROCESS | 1952 | |i|pagename|runs| 19:20:15 INFO - PROCESS | 1952 | |0;ai-astar;144;168;114;113;112;111;114;113;113;113 19:20:15 INFO - PROCESS | 1952 | |1;audio-beat-detection;150;110;123;178;140;93;137;140;129;133 19:20:15 INFO - PROCESS | 1952 | |2;audio-dft;184;186;186;186;184;186;184;184;183;179 19:20:15 INFO - PROCESS | 1952 | |3;audio-fft;78;63;59;89;63;59;59;61;72;60 19:20:15 INFO - PROCESS | 1952 | |4;audio-oscillator;85;71;93;69;68;70;93;68;69;92 19:20:15 INFO - PROCESS | 1952 | |5;imaging-gaussian-blur;125;112;92;89;91;89;135;129;91;90 19:20:15 INFO - PROCESS | 1952 | |6;imaging-darkroom;98;99;99;129;129;99;98;100;98;99 19:20:15 INFO - PROCESS | 1952 | |7;imaging-desaturate;94;84;87;85;84;83;138;140;106;86 19:20:15 INFO - PROCESS | 1952 | |8;json-parse-financial;55;54;56;53;54;54;56;56;54;55 19:20:15 INFO - PROCESS | 1952 | |9;json-stringify-tinderbox;65;72;73;85;107;103;82;71;71;69 19:20:15 INFO - PROCESS | 1952 | |10;stanford-crypto-aes;88;88;84;88;84;84;87;84;86;86 19:20:15 INFO - PROCESS | 1952 | |11;stanford-crypto-ccm;150;149;148;139;150;138;124;152;187;138 19:20:15 INFO - PROCESS | 1952 | |12;stanford-crypto-pbkdf2;167;169;167;174;170;169;170;167;171;169 19:20:15 INFO - PROCESS | 1952 | |13;stanford-crypto-sha256-iterative;68;69;69;68;67;67;66;67;65;67 19:20:15 INFO - PROCESS | 1952 | __end_tp_report 19:20:15 INFO - PROCESS | 1952 | __start_cc_report 19:20:15 INFO - PROCESS | 1952 | _x_x_mozilla_cycle_collect,2056 19:20:15 INFO - PROCESS | 1952 | __end_cc_report 19:20:15 INFO - PROCESS | 1952 | __startTimestamp1473819615778__endTimestamp 19:20:15 INFO - PROCESS | 1952 | 19:20:15 INFO - PROCESS | 1952 | ------- Summary: start ------- 19:20:15 INFO - PROCESS | 1952 | Number of tests: 14 19:20:15 INFO - PROCESS | 1952 | 19:20:15 INFO - PROCESS | 1952 | [#0] ai-astar Cycles:10 Average:121.50 Median:113.50 stddev:19.06 (16.8%) stddev-sans-first:18.40 19:20:15 INFO - PROCESS | 1952 | Values: 144.0 168.0 114.0 113.0 112.0 111.0 114.0 113.0 113.0 113.0 19:20:15 INFO - PROCESS | 1952 | 19:20:15 INFO - PROCESS | 1952 | [#1] audio-beat-detection Cycles:10 Average:133.30 Median:140.00 stddev:22.78 (16.3%) stddev-sans-first:23.35 19:20:15 INFO - PROCESS | 1952 | Values: 150.0 110.0 123.0 178.0 140.0 93.0 137.0 140.0 129.0 133.0 19:20:15 INFO - PROCESS | 1952 | 19:20:15 INFO - PROCESS | 1952 | [#2] audio-dft Cycles:10 Average:184.20 Median:185.00 stddev:2.15 (1.2%) stddev-sans-first:2.28 19:20:15 INFO - PROCESS | 1952 | Values: 184.0 186.0 186.0 186.0 184.0 186.0 184.0 184.0 183.0 179.0 19:20:15 INFO - PROCESS | 1952 | 19:20:15 INFO - PROCESS | 1952 | [#3] audio-fft Cycles:10 Average:66.30 Median:63.00 stddev:10.19 (16.2%) stddev-sans-first:9.89 19:20:15 INFO - PROCESS | 1952 | Values: 78.0 63.0 59.0 89.0 63.0 59.0 59.0 61.0 72.0 60.0 19:20:15 INFO - PROCESS | 1952 | 19:20:15 INFO - PROCESS | 1952 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:78.00 stddev:11.40 (14.6%) stddev-sans-first:11.79 19:20:15 INFO - PROCESS | 1952 | Values: 85.0 71.0 93.0 69.0 68.0 70.0 93.0 68.0 69.0 92.0 19:20:15 INFO - PROCESS | 1952 | 19:20:15 INFO - PROCESS | 1952 | [#5] imaging-gaussian-blur Cycles:10 Average:104.30 Median:89.50 stddev:18.91 (21.1%) stddev-sans-first:18.51 19:20:15 INFO - PROCESS | 1952 | Values: 125.0 112.0 92.0 89.0 91.0 89.0 135.0 129.0 91.0 90.0 19:20:15 INFO - PROCESS | 1952 | 19:20:15 INFO - PROCESS | 1952 | [#6] imaging-darkroom Cycles:10 Average:104.80 Median:98.50 stddev:12.77 (13.0%) stddev-sans-first:13.31 19:20:15 INFO - PROCESS | 1952 | Values: 98.0 99.0 99.0 129.0 129.0 99.0 98.0 100.0 98.0 99.0 19:20:15 INFO - PROCESS | 1952 | 19:20:15 INFO - PROCESS | 1952 | [#7] imaging-desaturate Cycles:10 Average:98.70 Median:84.50 stddev:22.34 (26.4%) stddev-sans-first:23.63 19:20:15 INFO - PROCESS | 1952 | Values: 94.0 84.0 87.0 85.0 84.0 83.0 138.0 140.0 106.0 86.0 19:20:15 INFO - PROCESS | 1952 | 19:20:15 INFO - PROCESS | 1952 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.06 (1.9%) stddev-sans-first:1.12 19:20:15 INFO - PROCESS | 1952 | Values: 55.0 54.0 56.0 53.0 54.0 54.0 56.0 56.0 54.0 55.0 19:20:15 INFO - PROCESS | 1952 | 19:20:15 INFO - PROCESS | 1952 | [#9] json-stringify-tinderbox Cycles:10 Average:79.80 Median:71.50 stddev:14.56 (20.4%) stddev-sans-first:14.42 19:20:15 INFO - PROCESS | 1952 | Values: 65.0 72.0 73.0 85.0 107.0 103.0 82.0 71.0 71.0 69.0 19:20:15 INFO - PROCESS | 1952 | 19:20:15 INFO - PROCESS | 1952 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.50 stddev:1.79 (2.1%) stddev-sans-first:1.73 19:20:15 INFO - PROCESS | 1952 | Values: 88.0 88.0 84.0 88.0 84.0 84.0 87.0 84.0 86.0 86.0 19:20:15 INFO - PROCESS | 1952 | 19:20:15 INFO - PROCESS | 1952 | [#11] stanford-crypto-ccm Cycles:10 Average:147.50 Median:149.50 stddev:16.33 (10.9%) stddev-sans-first:17.30 19:20:15 INFO - PROCESS | 1952 | Values: 150.0 149.0 148.0 139.0 150.0 138.0 124.0 152.0 187.0 138.0 19:20:15 INFO - PROCESS | 1952 | 19:20:15 INFO - PROCESS | 1952 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:169.50 stddev:2.16 (1.3%) stddev-sans-first:2.13 19:20:15 INFO - PROCESS | 1952 | Values: 167.0 169.0 167.0 174.0 170.0 169.0 170.0 167.0 171.0 169.0 19:20:15 INFO - PROCESS | 1952 | 19:20:15 INFO - PROCESS | 1952 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.25 (1.9%) stddev-sans-first:1.30 19:20:15 INFO - PROCESS | 1952 | Values: 68.0 69.0 69.0 68.0 67.0 67.0 66.0 67.0 65.0 67.0 19:20:15 INFO - PROCESS | 1952 | -------- Summary: end -------- 19:20:15 INFO - PROCESS | 1952 | 19:20:16 INFO - TEST-INFO | 1952: exit 0 19:20:16 INFO - TEST-OK | kraken | took 59987ms 19:20:16 INFO - SUITE-END | took 1176s 19:20:16 INFO - Completed test suite (00:19:37) 19:20:16 INFO - javascript benchmark 19:20:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2934.281101130223, 3325.933481330375, 3368.9663103368957, 3369.5451114099606, 3378.6959173674363, 5545.944540554593, 5660.858478538039, 5692.288463942007, 5766.077427611583, 5803.361630220672, 5586.162075688649, 5596.0206963781275, 5596.86007849804, 5620.522255608268, 5631.8028868989595, 5088.135017047092, 5123.180291153416, 5135.537801597874, 5138.768755406016, 5185.429602743695, 5307.416184219733, 5326.547243484309, 5333.146696528556, 5333.306670132877, 5339.252504649352, 5235.528802407783, 5273.129933560957, 5275.736213189344, 5294.655847369928, 5310.283111779899, 5329.893402131955, 5334.4398838122215, 5337.626366154371, 5360.597955153379, 5438.619296649236, 5135.64050516464, 5154.38147422308, 5197.298364720752, 5253.159494480903, 5285.154375299933, 5670.092785154397, 5765.942340576583, 5816.447437493432, 5828.096645019987, 5833.066709326487, 6335.303116657164, 6337.302896681362, 6338.39785220408, 6342.556021078526, 6352.110704501373, 6148.047052706793, 6216.378362163793, 6227.408396202399, 6246.281677607088, 6294.8111556653375, 5869.413058694139, 5888.263967004124, 5908.172855800191, 5944.643321400643, 6001.729922153513, 6304.988995962607, 6311.33730958252, 6312.810615681537, 6323.620582765049, 6330.050492426173, 6205.875882482325, 6219.378062193835, 6229.5327850410495, 6248.656323902229, 6275.121482992385, 6158.630482171084, 6210.689465526796, 6220.222472190976, 6246.968765156145, 6251.374862513712, 6299.96850015747, 6307.306196318401, 6320.115183874262, 6320.304766475684, 6325.9051114233325, 6244.2819075806865, 6292.069940654008, 6335.968320158369, 6342.587731797418, 6343.904841427382, 4940.654154209171, 4948.257761335828, 4989.25161225819, 4993.176125939252, 5092.949070509321, 4511.075229577928, 4513.435820522434, 4526.343680166357, 4537.3647689323525, 4546.363509108727, 5805.477507024388, 5810.070388737781, 5811.912821307684, 5814.796482123105, 5836.9124463133085, 6156.353582873823, 6252.062190671436, 6252.155958945576, 6256.874862502725, 6276.497880169575, 5696.430356964271, 5752.539796816244, 5788.0, 5801.274840644919, 5830.125481177773, 5531.059719847635, 5539.750711218005, 5541.833744987657, 5549.778008879681, 5553.8333849984565, 6369.0, 6385.233771947396, 6394.0, 6397.360263973658, 6401.519886008568, 6121.788327166137, 6213.316535181217, 6236.501079913687, 6285.5600107992, 6305.40098690642, 6340.49276057905, 6382.6170429774365, 6385.7126429309865, 6391.265004524539, 6396.71214795326, 4616.607588354893, 6251.023720535397, 6271.498280137669, 6298.748050077946, 6305.243370795534, 6170.938290617037, 6236.688165591611, 6242.063690446469, 6256.217972753406, 6266.780662676784, 5730.627509211888, 5979.594795223032, 6131.866048757656, 6230.0, 6238.625682459067, 6039.63762174271, 6242.157308763259, 6248.937510624835, 6268.091126786499, 6273.466755325849, 5944.554158438048, 5989.131575921554, 6080.300765412034, 6120.846978825565, 6125.081237814364, 6122.916604401471, 6142.57002009855, 6177.62934223948, 6243.406876346739, 6251.249850018027, 6097.0, 6110.633361998294, 6113.144159817718, 6120.816375508742, 6128.050152226412], "value": 5751.986085580765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.84025851339794, 506.95437410633036, 524.7822153806171, 525.3039722367862, 527.3750605532447, 24437.511249774994, 40099.0, 40628.0, 40887.386689199615, 43128.0, 42128.0, 42558.0, 42558.93602659935, 42621.7868910655, 42812.0, 9705.951470242639, 9874.456904870265, 9877.0, 9882.703518894408, 9891.55488003038, 8739.126087391274, 8876.023637399881, 9646.517674116301, 11983.760324793499, 12120.212186207913, 10904.745954215288, 11510.597129100483, 12033.157678962476, 12126.211796233261, 12131.939340303286, 10013.799724005552, 11977.281363118154, 12000.219985700945, 12001.51993920242, 12016.798320168, 11850.644480665595, 11929.105317101252, 11930.164888457812, 11932.522699092026, 11949.0, 34119.82940085284, 40054.99862503431, 40428.0, 40432.39351409731, 40460.39309410361, 3332.266901281714, 3393.490976353542, 3504.0539054455153, 3610.837512311952, 3633.654802793757, 30128.397432051235, 31300.37399252002, 31353.529697054564, 31457.8427107863, 31627.367452651048, 3138.3880143372053, 3145.3552021835467, 3258.332041931398, 3290.917727056819, 3364.243045314809, 447376.99999999674, 449202.0, 449497.0, 450101.0, 450612.0, 57401.42598573961, 57559.71220143873, 57696.0, 57754.42245577575, 58065.838683226946, 60937.39062609317, 61087.694561527795, 61166.0, 61259.6937015321, 61307.6934615333, 16130.274137663833, 16382.426615068416, 16402.589935251475, 16419.343226271056, 16424.468739221124, 11579.247348922294, 12671.619851404472, 12759.979201663844, 12761.680957976125, 12774.489020439078, 14632.561023169323, 16049.919750401406, 16431.671366572602, 16470.341186352412, 16937.407190748265, 6025.578209525379, 6099.84750381244, 7158.821029474305, 7276.998825323079, 7283.490155689157, 839.689314953459, 910.7632015675972, 911.7902882337099, 925.8287216864901, 952.4475804033644, 25530.23409297724, 28609.57085643717, 28767.56848647272, 29703.702962970525, 29942.251443713645, 1018.3573626439378, 1030.860833787444, 1037.5642230263309, 1048.9580416783242, 1094.3816743540033, 12583.559575414816, 15135.470258540898, 15500.92249538745, 15609.0, 15640.921795391178, 636855.0, 676578.0, 679615.0, 682488.0, 925814.0, 49346.0, 50296.24555631669, 50341.993160137325, 55305.1704224437, 57095.85808283811, 1347.1176379471462, 1356.6811799227173, 1376.1330361871956, 1378.152436251698, 1379.7792353223435, 30128.230735429024, 30462.390752185274, 30829.69170308268, 30977.0, 31114.0, 49218.26172607485, 49535.25697114474, 49689.50310496993, 49786.0, 49962.25056624081, 600941.0, 611446.0, 613234.0, 817108.0, 818045.0, 25191.622125668495, 25198.62202067007, 25322.74677253204, 25368.619470708323, 25376.74623253744, 45227.54772452233, 45566.31650525179, 45844.31233531433, 47149.821254468916, 49541.50458495513, 38245.0, 38356.808215959856, 38657.613423865405, 40007.39988900227, 40131.59868401279, 32599.859004934715, 33920.1519961993, 37500.30956378691, 38715.225695485366, 38945.41581876331, 35720.64279357173, 35894.002677911274, 36671.266574667825, 36837.44743828791, 36954.26091478209, 27069.86465067662, 32979.0, 33189.50215746718, 33607.32785344328, 33891.3221735559, 23764.762352376256, 24143.0, 24151.879240603685, 24696.382590434663, 24739.134130305352], "value": 20006.998403633326, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.59596564809266, 350.8228344685933, 370.86648806429696, 371.2500748488054, 401.9939700904485, 15138.318775655094, 15241.390344386225, 16255.024698518082, 18164.0, 20910.477238069056, 19677.50806229845, 20301.5913184572, 20602.484937876525, 20827.062782174802, 21227.57544849102, 5671.63134396265, 5994.340622531518, 6015.789447369343, 6016.067509536007, 6019.067044608071, 5073.934473760496, 5341.1988201769655, 5924.822255332326, 5985.790497332594, 5993.910091348612, 5648.209250704905, 5923.28920529537, 5936.762529498837, 5941.2276404067625, 5942.881142377149, 5743.282089738783, 5833.300003999526, 5855.824325270249, 5866.061430171195, 5873.030949893284, 4881.243407271879, 5113.335266415379, 5128.794848206067, 5136.152534831748, 5139.460356662571, 22217.0, 22462.663060054114, 22758.748268845207, 25674.871625641754, 26075.348116297053, 2136.113512892148, 2234.731832180149, 2303.7926586607286, 2347.354477518696, 2363.3618922890723, 14992.0, 15993.840831487716, 16093.953892996919, 16120.919395403065, 16326.673466530721, 1841.6040551281405, 1852.2128095559333, 1882.5481884347794, 1923.6152769446167, 1973.7138114973393, 113536.45081897646, 117534.99999999914, 117728.23407648892, 118448.8155118455, 118780.0, 10662.41356725372, 10783.6225732099, 11122.944385278022, 11200.815840910944, 11360.261582997078, 12684.682882927817, 13001.284929328789, 14032.85967140336, 14050.859491404955, 14088.506902258372, 8366.916330836735, 8611.61247743853, 8634.136586341441, 8800.515971621622, 8830.646774128963, 8605.440646358093, 8630.913690863137, 8640.956795216109, 8786.560671966376, 8831.867521987175, 6609.570377925419, 6714.160729908762, 6724.831879203059, 6736.972643658906, 6739.730410783513, 1822.7312287364591, 1848.3438379375398, 1849.2048419179612, 1855.5082903030707, 1858.3774435564237, 714.6891102370486, 763.393102483527, 877.2893955895745, 940.2853831088422, 944.9763755906157, 18116.54840834034, 21210.787892120883, 22226.888865555567, 22227.0, 22360.105595775985, 914.2229105260475, 965.1603105298435, 1008.6671398438498, 1015.1269907879218, 1035.171862509989, 11072.11151996887, 11806.881931180578, 11935.224210426295, 11937.641870743892, 11970.940145299217, 506577.0, 566298.0, 575710.0, 576495.0, 578578.0, 114190.42904785422, 115439.2684109739, 118611.40694296474, 121342.0, 122521.0, 907.856101312338, 973.8733964584559, 1063.4948399510172, 1087.983680244797, 1089.1939964426267, 19130.90434547874, 19777.70333445028, 19793.30723424673, 19829.801701982797, 19856.30502932448, 34394.31211375808, 40850.0, 44057.069727449365, 49322.75338623284, 50004.499954999985, 71359.0, 71483.0, 72552.0, 72582.54834903378, 73218.63390683226, 7814.452988290993, 7921.217726011601, 7954.778314782522, 7974.362051036019, 8234.382421318305, 12717.682057948625, 12812.61562153137, 12876.420561074961, 13105.737885242432, 13142.802857956947, 9134.406263592846, 10694.749450988034, 10997.670069897917, 11086.0, 11283.717907052389, 10216.693499195037, 10558.736031599272, 10760.300580462244, 11129.666110016713, 11279.32324060559, 10870.184736144663, 11164.944175279072, 11232.775344493228, 11358.26171298863, 11598.130140239347, 7834.030035609082, 7916.060565161342, 7934.778262086625, 8161.0, 8237.835243294981, 10934.617288394868, 11166.939140781613, 11274.943625281821, 11294.94352528232, 11311.321320720783], "value": 9574.527331395926, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1421.232534431407, 1462.7367073926691, 1651.1331550935765, 1804.4767017564907, 1868.6636405447023, 8485.490870547772, 9053.185213330808, 9069.047749986255, 9074.500902450363, 9080.909190908089, 7822.139564647884, 8091.514509129442, 8103.149169337208, 8541.530215838126, 8759.781005474866, 2358.8938497767554, 2400.1719406804623, 2403.0868270057354, 2412.8793560322, 2414.987925060381, 2364.6216605343147, 2367.5975084235633, 2411.46947671512, 2413.3001429585397, 2415.903363865443, 2377.667126602277, 2396.9640455393182, 2409.2410890569504, 2415.9973610951433, 2416.1664225842146, 2371.1582388252095, 2388.4028992751814, 2394.6408038794234, 2397.3287479505766, 2405.1101092595677, 2360.1031607989025, 2381.868997205153, 2384.8926798293946, 2388.605880029793, 2395.113807891074, 8870.246029087535, 8877.156670116328, 8981.730548083568, 8989.910100899038, 8991.0, 5175.585953123741, 5327.0, 5328.6802791832615, 5331.999999999961, 5333.813316533902, 3013.6383633963846, 3565.7682250653625, 3666.9633303667156, 3668.064643515913, 3674.393725035393, 1070.8554345163382, 1083.853679753231, 1088.4775307852276, 1094.316052467208, 1105.9447027648666, 11175.944120279346, 11280.717982050432, 11289.717757056058, 11301.434928253637, 11321.603743868925, 4345.760983145958, 4361.258586040381, 4479.46246450428, 4479.910401791946, 4733.786979585927, 9680.031996800264, 9683.370580912218, 9683.806323873483, 9695.563699633534, 9699.709008729607, 5281.947180528223, 5283.260343551906, 5286.735663216824, 5290.338707661543, 5317.202419637086, 4398.69209155356, 4543.4775000875325, 4751.3348131261655, 4862.343583616166, 4877.7073375596865, 3855.845766169378, 3892.5328960524353, 3980.800959951991, 4021.1354558770004, 4025.275450418953, 1277.1251692590606, 1292.4184117147133, 1292.6445227562308, 1302.8892544133855, 1303.4720938020116, 812.9430939834155, 881.9294456443469, 893.7140115163086, 917.020578260041, 933.6358820060182, 5732.512736417451, 5763.452472015236, 5870.148828419855, 5957.3449314685495, 6031.9698401508585, 450.34249995007656, 456.8857785553612, 459.20328230520687, 968.8885778135605, 971.3928794503436, 3824.0, 3862.4592557042038, 3972.2254160439015, 4001.47980762499, 4029.2747305485295, 10689.30519516229, 10962.780744385227, 11016.283941543774, 11016.944915275373, 11041.282316649553, 10621.097206737513, 10859.402732849769, 11033.779324413466, 11058.778824423627, 11072.889271107348, 8162.959185204036, 8184.877226841602, 8218.424710270223, 8356.206160414751, 8367.079621241659, 5807.8548036299435, 5839.474447299764, 5846.123081537803, 5894.0274854650215, 5943.846476426255, 9334.346595738232, 10014.449205293779, 10046.296759227076, 10108.39349639024, 10126.544305506122, 10076.647317343857, 10248.333858299187, 10282.691519254435, 10396.688099357032, 10405.387164989439, 6553.442957348679, 6727.058211850247, 6911.965440172767, 7077.292270772881, 7245.855082898207, 8257.83484330322, 8533.658653653783, 8534.957325213334, 8543.0, 8558.101399353227, 7391.445641577011, 7426.8143296415865, 7498.287662672037, 7580.317771400601, 7667.846643067219, 7017.806972814736, 7219.2780721929485, 7432.0, 7566.962165189138, 7619.65711542993, 6512.6092434454085, 6931.272216417204, 6933.5493192942295, 6933.930660693329, 6944.652767361713, 4916.655834091579, 4988.301637770787, 4993.17612593918, 5028.472010438852, 5089.898202036013, 4304.096139810675, 4310.568943105664, 4376.956230437782, 4384.224389122411, 4524.5927866492175], "value": 4531.697305844375, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.2814437566404, 304.57359696425004, 308.8193406856989, 313.72549019607857, 315.3566723883275, 4042.3532234842432, 4238.936415953759, 5194.844154675357, 5195.714235717034, 5272.499112584298, 4511.789223280593, 4747.643926705502, 5159.561437277826, 5188.15820383764, 5242.737863106839, 3694.8891533254045, 3841.4045822897497, 3842.2507611015862, 3902.2195560887794, 3998.600139985993, 3472.5138480612736, 3510.9291666041845, 3914.7472808701227, 3924.4701965234613, 3941.9802900985455, 3872.0900588361715, 3890.3386424307796, 3897.7661340319673, 3910.0674494129403, 3917.1382295895, 3191.2021994501374, 3380.695737383635, 3517.8241087945757, 3645.8359373827975, 3944.9408258876138, 3119.2357872321427, 3310.817905015223, 3385.8137802420856, 3397.1846756778195, 3418.3676019936393, 4127.504699436057, 4904.72477155942, 4956.207006878882, 5005.599552035828, 5016.0, 4259.637930775888, 4463.642908567339, 4475.261581838992, 4482.238019536687, 4490.316131450706, 5372.650777699476, 5384.40771515133, 5391.649542779707, 5396.0, 5476.0, 3169.41365847319, 3811.923761524754, 3815.7138214634015, 3819.3316169670475, 3822.2928758179823, 5268.683878967313, 5623.634463759842, 5703.914441283384, 5717.342505611867, 5717.742701578439, 3456.4100513763447, 3789.5263092113487, 3817.274717803664, 3821.923561528754, 3844.9231015380096, 3908.804559772057, 3914.0214946263436, 3934.940975885364, 3940.6650434712797, 3960.20795840833, 4510.8421205257655, 4519.751413672279, 4533.455985281787, 4537.09258148365, 4545.8408955687055, 4786.569208771228, 5183.766730497136, 5325.547328477045, 5457.426970168154, 5486.588505862076, 1146.0487795130023, 1305.8628843971437, 1326.8390158611214, 1327.422571181539, 1334.639647295225, 789.814393617511, 793.6349279331572, 837.9497230166088, 845.5053793530853, 845.9534725590152, 3714.9442758358646, 4318.978405108017, 4554.973036998504, 4571.428571428572, 4978.755311172207, 4964.0, 5395.433479484597, 5524.475174858382, 5614.578906582023, 5639.436056394327, 4733.763311834395, 5053.267276244924, 5055.368078990126, 5057.848264552069, 5087.364079490064, 2447.0, 2465.409810672142, 2918.124562631202, 2938.706968933705, 2968.3321252717965, 4787.390871974782, 5777.006932608243, 5782.421757824268, 5809.758876020529, 5819.53443724501, 5009.674371165863, 5445.863853403696, 5525.834224973257, 5714.228579141846, 5753.626014309057, 4495.538949841314, 4990.700557966534, 5164.586833053422, 5747.936631723061, 5813.476787089097, 4837.346958160744, 5559.777608895599, 5574.829285850017, 5579.944200557942, 5592.608517403743, 5080.568151707146, 5237.764300606558, 5417.268668729828, 5506.972465137648, 5518.392976772632, 5808.780156167252, 5887.3523912370465, 5890.4979230296, 5897.764089436375, 5902.7343769531335, 3405.829708514614, 3651.744377893522, 3804.6005169456807, 3835.602748282324, 3845.5577608575372, 5365.3293338332705, 5507.614466987273, 5632.662040277596, 5634.464725851038, 5738.799142030009, 4447.6219521341045, 4802.615790736662, 5215.722148073594, 5462.541856164821, 5487.396386397573, 5332.5467335276935, 5485.369182544058, 5499.175123731472, 5503.147012213113, 5511.4213007633625, 4380.496242932104, 4953.356063711694, 5193.5722423200505, 5307.787688492417, 5465.918011229755, 4462.754548499734, 5416.83749487516, 5538.252335934597, 5552.916706249329, 5553.4724201200825, 4496.865094047183, 5081.983603279433, 5144.76848541824, 5377.2740680009265, 5394.354721809886], "value": 3952.824381013951, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.2031740800109, 660.534323302072, 760.0727112922233, 768.4812751392816, 792.8176519400539, 15509.0, 16280.430184943529, 16299.91850040748, 16308.0, 16359.263833127508, 14578.343974521145, 14831.629209269746, 14836.629084272898, 14841.55475335739, 14849.703005939902, 680.6188534420728, 700.0, 701.3897908819334, 823.2508417340222, 846.4624963148415, 835.0188528479043, 842.3303473738362, 844.6874656377149, 844.8732690096473, 844.9788755281137, 881.2377293641018, 883.4434306386967, 883.8983516895543, 885.9689910853122, 886.5965985476593, 713.425692317684, 735.7939776862487, 870.0472982084607, 880.4233227236139, 881.3389957531883, 673.9595624262511, 674.6559254780049, 677.6306912732523, 680.0581195044898, 680.669875110571, 14994.47519336829, 15057.849421505864, 15058.698826023528, 15068.849311506854, 15079.095254284777, 13640.0, 13710.794338084937, 13797.034207605471, 13945.0, 13961.162330260217, 12646.999063368829, 12849.293288869108, 12929.224246545238, 12953.676158096028, 13016.934915325362, 4406.823727050914, 4492.213862574069, 4561.703489273186, 4632.559906808848, 4733.219018861883, 120715.28030783279, 122591.0, 123276.0, 123304.38347808293, 126166.36916815449, 10891.509882055327, 10921.453927303603, 10965.945170274097, 11055.889441105646, 11084.833727494093, 22119.0, 22154.003069861894, 22183.11267549312, 22208.333749987527, 22222.333330000125, 7784.2215778421705, 7883.487573307717, 7939.325157361689, 7939.404544659174, 8123.3095186908595, 4342.413774140514, 4371.825126994948, 4431.4903786065015, 4540.341650460665, 4541.227991241497, 3425.53755243044, 3527.6648718372226, 3529.699975502111, 3533.4876442915634, 3540.5220295260324, 539.940606533281, 649.7498463091744, 656.6125985668479, 656.6322859198864, 658.0622612776774, 585.487698264019, 587.5270407322147, 595.7795615622248, 599.7720866070953, 602.4607975861579, 8348.622477291301, 8601.268892144113, 8725.956370218235, 8814.735557933273, 8863.734087977371, 567.2455634006843, 568.3833041150316, 609.2567068176817, 622.8474023864183, 638.4892086330917, 4172.290710579209, 4503.414556107685, 4980.869565217391, 4987.800487980513, 5008.223725322581, 151133.0, 151761.68834090975, 153252.0, 154040.45959540486, 157584.0, 108990.0, 126866.0, 130574.0, 132747.0, 135909.0, 78675.60662196652, 110502.99999999838, 111675.0, 116027.41986290184, 116331.41834290774, 9344.15902568772, 9451.480168590793, 9549.09283618055, 9557.904420955701, 9606.711798646053, 49122.75438622784, 61247.69376153091, 62669.059964099666, 62928.37071629225, 64195.67902160459, 91508.40818028871, 97639.0472190538, 98133.01866981524, 98572.0, 100802.4959875196, 12753.61739147827, 13093.410796513988, 13143.934280328536, 13324.467021319038, 13548.119372240773, 14651.487197948021, 14867.107973521623, 14920.179390133648, 14960.32678529447, 15426.768598471257, 13626.659333516742, 13910.930445347709, 14146.92926535402, 14182.503612373517, 14375.28123593837, 13539.932300338436, 13678.458326257132, 13874.445022199, 13993.580192594238, 14146.22195779242, 11188.608398706332, 13453.932730336286, 13631.04582679203, 13672.453101875813, 14148.292585370897, 10893.836592451278, 11143.554257829595, 11242.718932026764, 11621.709457263636, 11977.940110299742, 11340.344329579726, 11403.714907127056, 11569.132315076571, 11576.131790115607, 11619.883801161881], "value": 7863.191953095782, "unit": "score"}], "name": "dromaeo_css", "value": 7330.868116121879, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 168.0, 114.0, 113.0, 112.0, 111.0, 114.0, 113.0, 113.0, 113.0], "value": 121.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 110.0, 123.0, 178.0, 140.0, 93.0, 137.0, 140.0, 129.0, 133.0], "value": 133.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 186.0, 186.0, 186.0, 184.0, 186.0, 184.0, 184.0, 183.0, 179.0], "value": 184.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 63.0, 59.0, 89.0, 63.0, 59.0, 59.0, 61.0, 72.0, 60.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 93.0, 69.0, 68.0, 70.0, 93.0, 68.0, 69.0, 92.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 112.0, 92.0, 89.0, 91.0, 89.0, 135.0, 129.0, 91.0, 90.0], "value": 104.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 99.0, 99.0, 129.0, 129.0, 99.0, 98.0, 100.0, 98.0, 99.0], "value": 104.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 84.0, 87.0, 85.0, 84.0, 83.0, 138.0, 140.0, 106.0, 86.0], "value": 98.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 56.0, 53.0, 54.0, 54.0, 56.0, 56.0, 54.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 73.0, 85.0, 107.0, 103.0, 82.0, 71.0, 71.0, 69.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 84.0, 88.0, 84.0, 84.0, 87.0, 84.0, 86.0, 86.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 148.0, 139.0, 150.0, 138.0, 124.0, 152.0, 187.0, 138.0], "value": 147.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 169.0, 167.0, 174.0, 170.0, 169.0, 170.0, 167.0, 171.0, 169.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 68.0, 67.0, 67.0, 66.0, 67.0, 65.0, 67.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1495.4, "alertThreshold": 2.0}]} 19:20:17 INFO - Return code: 0 19:20:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:20:17 INFO - # TBPL SUCCESS # 19:20:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:20:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:20:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:20:17 INFO - 2016-09-13 19:20:17.088 screenresolution[1956:21552] starting screenresolution argv=screenresolution get 19:20:17 INFO - 2016-09-13 19:20:17.090 screenresolution[1956:21552] Display 0: 1600x1200x32@60 19:20:17 INFO - 2016-09-13 19:20:17.096 screenresolution[1957:21555] starting screenresolution argv=screenresolution list 19:20:17 INFO - Available Modes on Display 0 19:20:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:20:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:20:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:20:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:20:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:20:17 INFO - Intel Iris: 19:20:17 INFO - Chipset Model: Intel Iris 19:20:17 INFO - Type: GPU 19:20:17 INFO - Bus: Built-In 19:20:17 INFO - VRAM (Dynamic, Max): 1536 MB 19:20:17 INFO - Vendor: Intel (0x8086) 19:20:17 INFO - Device ID: 0x0a2e 19:20:17 INFO - Revision ID: 0x0009 19:20:17 INFO - Displays: 19:20:17 INFO - Display: 19:20:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:20:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:20:17 INFO - Display Serial Number: 1600x1200 60 19:20:17 INFO - Main Display: Yes 19:20:17 INFO - Mirror: Off 19:20:17 INFO - Online: Yes 19:20:17 INFO - Rotation: Supported 19:20:17 INFO - Return code: 0 19:20:17 INFO - Running post-action listener: _resource_record_post_action 19:20:17 INFO - [mozharness: 2016-09-14 02:20:17.338753Z] Finished run-tests step (success) 19:20:17 INFO - Running post-run listener: _resource_record_post_run 19:20:17 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 552960; Write bytes: 704739328; Read time: 5; Write time: 1990 19:20:17 INFO - TinderboxPrint: CPU usage
53.5% 19:20:17 INFO - TinderboxPrint: I/O read bytes / time
552,960 / 5 19:20:17 INFO - TinderboxPrint: I/O write bytes / time
704,739,328 / 1,990 19:20:17 INFO - TinderboxPrint: CPU idle
2,253.6 (46.5%) 19:20:17 INFO - TinderboxPrint: CPU system
969.2 (20.0%) 19:20:17 INFO - TinderboxPrint: CPU user
1,626.9 (33.5%) 19:20:17 INFO - TinderboxPrint: Swap in / out
405,159,936 / 0 19:20:17 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 393163264; Write bytes: 388998656; Read time: 29519; Write time: 734 19:20:17 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 552960; Write bytes: 294908416; Read time: 5; Write time: 1211 19:20:17 INFO - Running post-run listener: _upload_blobber_files 19:20:17 INFO - Blob upload gear active. 19:20:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:20:17 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:20:17 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:20:17 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:20:18 INFO - (blobuploader) - INFO - Open directory for files ... 19:20:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:20:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:20:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:19 INFO - (blobuploader) - INFO - Done attempting. 19:20:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:20:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:20:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:20 INFO - (blobuploader) - INFO - Done attempting. 19:20:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:20:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:20:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:23 INFO - (blobuploader) - INFO - Done attempting. 19:20:23 INFO - (blobuploader) - INFO - Iteration through files over. 19:20:23 INFO - Return code: 0 19:20:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:20:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:20:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1de779e4b49b2a5c7b29258aa88ae968262d0da0aa28fbbf828bdd0a4cc3294528aca35463652cb289dab547d8e2934333c1b27350129f1b975ff8dd26edb8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d94409bb992baa4b423f29741910e4cfe6a7d4e4dcbb8a4810190b43ace080d26c0bf58b28cd6445071bbdcab540b267b0e7945b7999ab40a796cf1eee3f91fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d7569cc225d49d1d518a4a4c660d857679b6982a8830e44b713de0cacbbddf3f57fee977ff96534a9b17077f4509a83fdde8683bd539d12d4f05ae5e55c1efa"} 19:20:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:20:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:20:23 INFO - Contents: 19:20:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1de779e4b49b2a5c7b29258aa88ae968262d0da0aa28fbbf828bdd0a4cc3294528aca35463652cb289dab547d8e2934333c1b27350129f1b975ff8dd26edb8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d94409bb992baa4b423f29741910e4cfe6a7d4e4dcbb8a4810190b43ace080d26c0bf58b28cd6445071bbdcab540b267b0e7945b7999ab40a796cf1eee3f91fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d7569cc225d49d1d518a4a4c660d857679b6982a8830e44b713de0cacbbddf3f57fee977ff96534a9b17077f4509a83fdde8683bd539d12d4f05ae5e55c1efa"} 19:20:23 INFO - Running post-run listener: copy_logs_to_upload_dir 19:20:23 INFO - Copying logs to upload dir... 19:20:23 INFO - mkdir: /builds/slave/test/build/upload/logs 19:20:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.992715 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-13 19:20:23.400410) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-13 19:20:23.404028) ========= 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.oMNY3u8NM3/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.Yn2yaWbMiW/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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/Fx-Team/sha512/f1de779e4b49b2a5c7b29258aa88ae968262d0da0aa28fbbf828bdd0a4cc3294528aca35463652cb289dab547d8e2934333c1b27350129f1b975ff8dd26edb8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d94409bb992baa4b423f29741910e4cfe6a7d4e4dcbb8a4810190b43ace080d26c0bf58b28cd6445071bbdcab540b267b0e7945b7999ab40a796cf1eee3f91fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d7569cc225d49d1d518a4a4c660d857679b6982a8830e44b713de0cacbbddf3f57fee977ff96534a9b17077f4509a83fdde8683bd539d12d4f05ae5e55c1efa"} build_url:https://queue.taskcluster.net/v1/task/I2f_d2qBTVScpUr0bLn2iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011116 build_url: 'https://queue.taskcluster.net/v1/task/I2f_d2qBTVScpUr0bLn2iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1de779e4b49b2a5c7b29258aa88ae968262d0da0aa28fbbf828bdd0a4cc3294528aca35463652cb289dab547d8e2934333c1b27350129f1b975ff8dd26edb8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d94409bb992baa4b423f29741910e4cfe6a7d4e4dcbb8a4810190b43ace080d26c0bf58b28cd6445071bbdcab540b267b0e7945b7999ab40a796cf1eee3f91fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d7569cc225d49d1d518a4a4c660d857679b6982a8830e44b713de0cacbbddf3f57fee977ff96534a9b17077f4509a83fdde8683bd539d12d4f05ae5e55c1efa"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-13 19:20:23.440938) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 19:20:23.441288) ========= 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.oMNY3u8NM3/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.Yn2yaWbMiW/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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.005271 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 19:20:23.490992) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-13 19:20:23.491314) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-13 19:20:23.491695) ========= ========= Total master_lag: 0.18 =========