builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0181 starttime: 1488717339.92 results: success (0) buildid: 20170305030210 builduid: 622dbb97ed5e4bee855d608442a35bfe revision: eb23648534779c110f3a1f2baae1849ae4a9c570 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-05 04:35:39.915922) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-05 04:35:39.916375) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-05 04:35:39.916653) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-05 04:35:39.944068) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 04:35:39.944647) ========= 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.d82oAMkrKP/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.jTEg8fJHfo/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-05 04:35:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.2M=0.001s 2017-03-05 04:35:40 (13.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.157425 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 04:35:40.150972) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 04:35:40.151294) ========= 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.d82oAMkrKP/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.jTEg8fJHfo/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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.027937 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 04:35:40.200986) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-05 04:35:40.201316) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev eb23648534779c110f3a1f2baae1849ae4a9c570 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev eb23648534779c110f3a1f2baae1849ae4a9c570 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.d82oAMkrKP/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.jTEg8fJHfo/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-05 04:35:40,306 truncating revision to first 12 chars 2017-03-05 04:35:40,306 Setting DEBUG logging. 2017-03-05 04:35:40,306 attempt 1/10 2017-03-05 04:35:40,306 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/eb2364853477?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-05 04:35:42,205 unpacking tar archive at: mozilla-central-eb2364853477/testing/mozharness/ program finished with exit code 0 elapsedTime=2.256715 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-05 04:35:42.481550) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-05 04:35:42.481870) ========= script_repo_revision: eb23648534779c110f3a1f2baae1849ae4a9c570 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-05 04:35:42.482260) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-05 04:35:42.482525) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-05 04:35:42.503012) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-05 04:35:42.503311) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.d82oAMkrKP/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.jTEg8fJHfo/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 04:35:42 INFO - MultiFileLogger online at 20170305 04:35:42 in /builds/slave/test 04:35:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:35:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:35:42 INFO - {'append_to_log': False, 04:35:42 INFO - 'base_work_dir': '/builds/slave/test', 04:35:42 INFO - 'blob_upload_branch': 'Firefox', 04:35:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:35:42 INFO - 'branch': 'Firefox', 04:35:42 INFO - 'buildbot_json_path': 'buildprops.json', 04:35:42 INFO - 'config_files': ('talos/mac_config.py',), 04:35:42 INFO - 'default_actions': ('clobber', 04:35:42 INFO - 'read-buildbot-config', 04:35:42 INFO - 'download-and-extract', 04:35:42 INFO - 'populate-webroot', 04:35:42 INFO - 'create-virtualenv', 04:35:42 INFO - 'install', 04:35:42 INFO - 'run-tests'), 04:35:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:35:42 INFO - 'download_minidump_stackwalk': True, 04:35:42 INFO - 'download_symbols': 'ondemand', 04:35:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:35:42 INFO - 'tooltool.py': '/tools/tooltool.py', 04:35:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:35:42 INFO - '/tools/misc-python/virtualenv.py')}, 04:35:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:35:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:35:42 INFO - 'gecko_profile': False, 04:35:42 INFO - 'gecko_profile_interval': 0, 04:35:42 INFO - 'installer_path': 'installer.exe', 04:35:42 INFO - 'log_level': 'info', 04:35:42 INFO - 'log_name': 'talos', 04:35:42 INFO - 'log_to_console': True, 04:35:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:35:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:35:42 INFO - 'opt_config_files': (), 04:35:42 INFO - 'pip_index': False, 04:35:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:35:42 INFO - 'cmd': ('bash', 04:35:42 INFO - '-c', 04:35:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:35:42 INFO - 'enabled': True, 04:35:42 INFO - 'halt_on_failure': False, 04:35:42 INFO - 'name': 'check_screen_resolution'},), 04:35:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:35:42 INFO - 'cmd': ('bash', 04:35:42 INFO - '-c', 04:35:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:35:42 INFO - 'enabled': True, 04:35:42 INFO - 'halt_on_failure': False, 04:35:42 INFO - 'name': 'check_screen_resolution'},), 04:35:42 INFO - 'run_cmd_checks_enabled': True, 04:35:42 INFO - 'suite': 'dromaeojs-e10s', 04:35:42 INFO - 'system_bits': '32', 04:35:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:35:42 INFO - 'title': 't-yosemite-r7-0181', 04:35:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:35:42 INFO - 'use_talos_json': True, 04:35:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:35:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:35:42 INFO - 'work_dir': 'build'} 04:35:42 INFO - [mozharness: 2017-03-05 12:35:42.722022Z] Running clobber step. 04:35:42 INFO - Running pre-action listener: _resource_record_pre_action 04:35:42 INFO - Running main action method: clobber 04:35:42 INFO - rmtree: /builds/slave/test/build 04:35:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:35:45 INFO - Running post-action listener: _resource_record_post_action 04:35:45 INFO - [mozharness: 2017-03-05 12:35:45.122237Z] Finished clobber step (success) 04:35:45 INFO - [mozharness: 2017-03-05 12:35:45.122371Z] Running read-buildbot-config step. 04:35:45 INFO - Running pre-action listener: _resource_record_pre_action 04:35:45 INFO - Running main action method: read_buildbot_config 04:35:45 INFO - Using buildbot properties: 04:35:45 INFO - { 04:35:45 INFO - "project": "", 04:35:45 INFO - "product": "firefox", 04:35:45 INFO - "script_repo_revision": "production", 04:35:45 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:35:45 INFO - "repository": "", 04:35:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:35:45 INFO - "buildid": "20170305030210", 04:35:45 INFO - "stage_platform": "macosx64", 04:35:45 INFO - "basedir": "/builds/slave/test", 04:35:45 INFO - "nightly_build": "True", 04:35:45 INFO - "buildnumber": 164, 04:35:45 INFO - "slavename": "t-yosemite-r7-0181", 04:35:45 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 04:35:45 INFO - "platform": "yosemite_r7", 04:35:45 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:35:45 INFO - "branch": "mozilla-central", 04:35:45 INFO - "repo_path": "mozilla-central", 04:35:45 INFO - "revision": "eb23648534779c110f3a1f2baae1849ae4a9c570", 04:35:45 INFO - "pgo_build": "False", 04:35:45 INFO - "builduid": "622dbb97ed5e4bee855d608442a35bfe", 04:35:45 INFO - "slavebuilddir": "test" 04:35:45 INFO - } 04:35:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 04:35:45 INFO - Running post-action listener: _resource_record_post_action 04:35:45 INFO - [mozharness: 2017-03-05 12:35:45.125846Z] Finished read-buildbot-config step (success) 04:35:45 INFO - [mozharness: 2017-03-05 12:35:45.125954Z] Running download-and-extract step. 04:35:45 INFO - Running pre-action listener: _resource_record_pre_action 04:35:45 INFO - Running main action method: download_and_extract 04:35:45 INFO - mkdir: /builds/slave/test/build/tests 04:35: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')]} 04:35:45 INFO - trying https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 04:35:45 INFO - Downloading https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:35:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 04:35:46 INFO - Downloaded 1199 bytes. 04:35:46 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:35:46 INFO - Using the following test package requirements: 04:35:46 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:35:46 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:35:46 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 04:35:46 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:35:46 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 04:35:46 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:35:46 INFO - u'jsshell-mac.zip'], 04:35:46 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:35:46 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 04:35:46 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:35:46 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:35:46 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 04:35:46 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:35:46 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 04:35:46 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:35:46 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 04:35:46 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:35:46 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 04:35:46 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:35:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:35:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:35:46 INFO - Fetch https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:35:47 INFO - Expected file size: 51775450 04:35:47 INFO - Obtained file size: 51775450 04:36:03 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:36:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:36:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:36:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:36:05 INFO - Expected file size: 51775450 04:36:05 INFO - Obtained file size: 51775450 04:36:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 04:36:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:36:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 04:36:22 INFO - Expected file size: 14404424 04:36:22 INFO - Obtained file size: 14404424 04:36:22 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')]} 04:36:22 INFO - trying https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:36:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 04:36:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 04:36:24 INFO - Downloaded 75197249 bytes. 04:36:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:36:24 INFO - mkdir: /builds/slave/test/properties 04:36:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:36:24 INFO - Writing to file /builds/slave/test/properties/build_url 04:36:24 INFO - Contents: 04:36:24 INFO - build_url:https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:36:25 INFO - Running post-action listener: _resource_record_post_action 04:36:25 INFO - Running post-action listener: set_extra_try_arguments 04:36:25 INFO - [mozharness: 2017-03-05 12:36:25.778648Z] Finished download-and-extract step (success) 04:36:25 INFO - [mozharness: 2017-03-05 12:36:25.778809Z] Running populate-webroot step. 04:36:25 INFO - Running pre-action listener: _resource_record_pre_action 04:36:25 INFO - Running main action method: populate_webroot 04:36:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:36:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:36:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:36:25 INFO - '--tppagecycles', 04:36:25 INFO - '7'], 04:36:25 INFO - 'tests': ['tsvgm']}}, 04:36:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:36:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:36:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:36:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:36:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:36:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:36:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:36:25 INFO - 'talos_options': ['--disable-e10s'], 04:36:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:36:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:36:25 INFO - 'talos_options': ['--disable-e10s'], 04:36:25 INFO - 'tests': ['damp', 'tps']}, 04:36:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:36:25 INFO - 'tests': ['damp', 'tps']}, 04:36:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:36:25 INFO - 'tests': ['dromaeo_dom']}, 04:36:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:36:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:36:25 INFO - 'tests': ['basic_compositor_video']}, 04:36:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:36:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:36:25 INFO - 'tests': ['a11yr', 04:36:25 INFO - 'ts_paint', 04:36:25 INFO - 'tpaint', 04:36:25 INFO - 'sessionrestore', 04:36:25 INFO - 'sessionrestore_no_auto_restore', 04:36:25 INFO - 'tabpaint']}, 04:36:25 INFO - 'other-e10s': {'tests': ['a11yr', 04:36:25 INFO - 'ts_paint', 04:36:25 INFO - 'tpaint', 04:36:25 INFO - 'sessionrestore', 04:36:25 INFO - 'sessionrestore_no_auto_restore', 04:36:25 INFO - 'tabpaint']}, 04:36:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:36:25 INFO - 'ts_paint', 04:36:25 INFO - 'tpaint', 04:36:25 INFO - 'sessionrestore', 04:36:25 INFO - 'sessionrestore_no_auto_restore', 04:36:25 INFO - 'tabpaint']}, 04:36:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:36:25 INFO - 'ts_paint', 04:36:25 INFO - 'tpaint', 04:36:25 INFO - 'sessionrestore', 04:36:25 INFO - 'sessionrestore_no_auto_restore', 04:36:25 INFO - 'tabpaint']}, 04:36:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:36:25 INFO - 'tests': ['a11yr', 04:36:25 INFO - 'ts_paint', 04:36:25 INFO - 'tpaint', 04:36:25 INFO - 'sessionrestore', 04:36:25 INFO - 'sessionrestore_no_auto_restore', 04:36:25 INFO - 'tabpaint']}, 04:36:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:36:25 INFO - 'tests': ['a11yr', 04:36:25 INFO - 'ts_paint', 04:36:25 INFO - 'tpaint', 04:36:25 INFO - 'sessionrestore', 04:36:25 INFO - 'sessionrestore_no_auto_restore', 04:36:25 INFO - 'tabpaint']}, 04:36:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:36:25 INFO - 'tests': ['tsvgx', 04:36:25 INFO - 'tsvgr_opacity', 04:36:25 INFO - 'tart', 04:36:25 INFO - 'tscrollx', 04:36:25 INFO - 'cart', 04:36:25 INFO - 'tsvg_static']}, 04:36:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:36:25 INFO - 'tsvgr_opacity', 04:36:25 INFO - 'tart', 04:36:25 INFO - 'tscrollx', 04:36:25 INFO - 'cart', 04:36:25 INFO - 'tsvg_static']}, 04:36:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:36:25 INFO - 'talos_options': ['--disable-e10s'], 04:36:25 INFO - 'tests': ['tp5o']}, 04:36:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:36:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:36:25 INFO - 'talos_options': ['--disable-e10s', 04:36:25 INFO - '--xperf_path', 04:36:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:25 INFO - 'tests': ['tp5n']}, 04:36:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:36:25 INFO - 'talos_options': ['--xperf_path', 04:36:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:25 INFO - 'tests': ['tp5n']}}, 04:36:25 INFO - 'talos.zip': {'path': '', 04:36:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:36:25 INFO - Running post-action listener: _resource_record_post_action 04:36:25 INFO - [mozharness: 2017-03-05 12:36:25.797357Z] Finished populate-webroot step (success) 04:36:25 INFO - [mozharness: 2017-03-05 12:36:25.797493Z] Running create-virtualenv step. 04:36:25 INFO - Running pre-action listener: _resource_record_pre_action 04:36:25 INFO - Running main action method: create_virtualenv 04:36:25 INFO - Creating virtualenv /builds/slave/test/build/venv 04:36:25 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 04:36:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:36:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:36:25 INFO - Using real prefix '/tools/python27' 04:36:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:36:26 INFO - Installing distribute.............................................................................................................................................................................................done. 04:36:29 INFO - Installing pip.................done. 04:36:29 INFO - Return code: 0 04:36:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:36:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:36:29 INFO - Reading from file tmpfile_stdout 04:36:29 INFO - Output received: 04:36:29 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:36:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:36: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')]} 04:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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')]} 04:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f88ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f88d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82324d15c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f668d30>, '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 0x10f58fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65dbe8>, '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.d82oAMkrKP/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.jTEg8fJHfo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 04:36:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:36:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:36:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d82oAMkrKP/Render', 04:36:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:29 INFO - 'HOME': '/Users/cltbld', 04:36:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:29 INFO - 'LOGNAME': 'cltbld', 04:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:29 INFO - 'MOZ_NO_REMOTE': '1', 04:36:29 INFO - 'NO_EM_RESTART': '1', 04:36:29 INFO - 'PAGER': '/bin/cat', 04:36:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:29 INFO - 'PWD': '/builds/slave/test', 04:36:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:29 INFO - 'SHELL': '/bin/bash', 04:36:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTEg8fJHfo/Listeners', 04:36:29 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 04:36:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:29 INFO - 'USER': 'cltbld', 04:36:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:29 INFO - 'XPC_FLAGS': '0x0', 04:36:29 INFO - 'XPC_SERVICE_NAME': '0', 04:36:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:30 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 04:36:30 INFO - Cleaning up... 04:36:30 INFO - Return code: 0 04:36:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:30 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 0x10f88ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f88d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82324d15c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f668d30>, '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 0x10f58fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65dbe8>, '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.d82oAMkrKP/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.jTEg8fJHfo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 04:36:30 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 04:36:30 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 04:36:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d82oAMkrKP/Render', 04:36:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:30 INFO - 'HOME': '/Users/cltbld', 04:36:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:30 INFO - 'LOGNAME': 'cltbld', 04:36:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:30 INFO - 'MOZ_NO_REMOTE': '1', 04:36:30 INFO - 'NO_EM_RESTART': '1', 04:36:30 INFO - 'PAGER': '/bin/cat', 04:36:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:30 INFO - 'PWD': '/builds/slave/test', 04:36:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:30 INFO - 'SHELL': '/bin/bash', 04:36:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTEg8fJHfo/Listeners', 04:36:30 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 04:36:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:30 INFO - 'USER': 'cltbld', 04:36:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:30 INFO - 'XPC_FLAGS': '0x0', 04:36:30 INFO - 'XPC_SERVICE_NAME': '0', 04:36:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:30 INFO - Downloading/unpacking psutil>=3.1.1 04:36:30 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 04:36:30 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 04:36:30 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 04:36:30 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 04:36:30 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 04:36:30 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 04:36:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:36:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:36:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:36:34 INFO - Installing collected packages: psutil 04:36:34 INFO - Running setup.py install for psutil 04:36:34 INFO - building 'psutil._psutil_osx' extension 04:36:34 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 04:36:35 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 04:36:35 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 04:36:35 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 04:36:35 INFO - building 'psutil._psutil_posix' extension 04:36:35 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 04:36:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:36:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:36:35 INFO - ^ 04:36:35 INFO - 1 warning generated. 04:36:35 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 04:36:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:36:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:36:35 INFO - Successfully installed psutil 04:36:35 INFO - Cleaning up... 04:36:35 INFO - Return code: 0 04:36:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:35 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 0x10f88ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f88d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82324d15c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f668d30>, '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 0x10f58fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65dbe8>, '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.d82oAMkrKP/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.jTEg8fJHfo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 04:36:35 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 04:36:35 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 04:36:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d82oAMkrKP/Render', 04:36:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:35 INFO - 'HOME': '/Users/cltbld', 04:36:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:35 INFO - 'LOGNAME': 'cltbld', 04:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:35 INFO - 'MOZ_NO_REMOTE': '1', 04:36:35 INFO - 'NO_EM_RESTART': '1', 04:36:35 INFO - 'PAGER': '/bin/cat', 04:36:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:35 INFO - 'PWD': '/builds/slave/test', 04:36:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:35 INFO - 'SHELL': '/bin/bash', 04:36:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTEg8fJHfo/Listeners', 04:36:35 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 04:36:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:35 INFO - 'USER': 'cltbld', 04:36:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:35 INFO - 'XPC_FLAGS': '0x0', 04:36:35 INFO - 'XPC_SERVICE_NAME': '0', 04:36:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:36:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:36:38 INFO - Installing collected packages: mozsystemmonitor 04:36:38 INFO - Running setup.py install for mozsystemmonitor 04:36:38 INFO - Successfully installed mozsystemmonitor 04:36:38 INFO - Cleaning up... 04:36:38 INFO - Return code: 0 04:36:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:38 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 0x10f88ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f88d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82324d15c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f668d30>, '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 0x10f58fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65dbe8>, '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.d82oAMkrKP/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.jTEg8fJHfo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 04:36:38 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 04:36:38 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 04:36:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d82oAMkrKP/Render', 04:36:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:38 INFO - 'HOME': '/Users/cltbld', 04:36:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:38 INFO - 'LOGNAME': 'cltbld', 04:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:38 INFO - 'MOZ_NO_REMOTE': '1', 04:36:38 INFO - 'NO_EM_RESTART': '1', 04:36:38 INFO - 'PAGER': '/bin/cat', 04:36:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:38 INFO - 'PWD': '/builds/slave/test', 04:36:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:38 INFO - 'SHELL': '/bin/bash', 04:36:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTEg8fJHfo/Listeners', 04:36:38 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 04:36:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:38 INFO - 'USER': 'cltbld', 04:36:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:38 INFO - 'XPC_FLAGS': '0x0', 04:36:38 INFO - 'XPC_SERVICE_NAME': '0', 04:36:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:39 INFO - Downloading/unpacking jsonschema==2.5.1 04:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:36:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:42 INFO - Downloading functools32-3.2.3-2.tar.gz 04:36:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:36:42 INFO - warning: no files found matching '*.txt' 04:36:42 INFO - no previously-included directories found matching 'build' 04:36:42 INFO - no previously-included directories found matching 'dist' 04:36:42 INFO - no previously-included directories found matching '.git*' 04:36:42 INFO - Installing collected packages: jsonschema, functools32 04:36:42 INFO - Running setup.py install for functools32 04:36:42 INFO - warning: no files found matching '*.txt' 04:36:42 INFO - no previously-included directories found matching 'build' 04:36:42 INFO - no previously-included directories found matching 'dist' 04:36:42 INFO - no previously-included directories found matching '.git*' 04:36:42 INFO - Successfully installed jsonschema functools32 04:36:42 INFO - Cleaning up... 04:36:42 INFO - Return code: 0 04:36:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:36: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')]} 04:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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')]} 04:36:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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', '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 0x10f88ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f88d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82324d15c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f668d30>, '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 0x10f58fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65dbe8>, '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.d82oAMkrKP/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.jTEg8fJHfo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 04:36: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:36: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 functools32==3.2.3-2 04:36:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d82oAMkrKP/Render', 04:36:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:42 INFO - 'HOME': '/Users/cltbld', 04:36:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:42 INFO - 'LOGNAME': 'cltbld', 04:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:42 INFO - 'MOZ_NO_REMOTE': '1', 04:36:42 INFO - 'NO_EM_RESTART': '1', 04:36:42 INFO - 'PAGER': '/bin/cat', 04:36:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:42 INFO - 'PWD': '/builds/slave/test', 04:36:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:42 INFO - 'SHELL': '/bin/bash', 04:36:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTEg8fJHfo/Listeners', 04:36:42 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 04:36:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:42 INFO - 'USER': 'cltbld', 04:36:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:42 INFO - 'XPC_FLAGS': '0x0', 04:36:42 INFO - 'XPC_SERVICE_NAME': '0', 04:36:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:36:42 INFO - Cleaning up... 04:36:42 INFO - Return code: 0 04:36:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:36: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')]} 04:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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')]} 04:36:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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', '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 0x10f88ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f88d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82324d15c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f668d30>, '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 0x10f58fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65dbe8>, '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.d82oAMkrKP/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.jTEg8fJHfo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 04:36: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:36: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 blobuploader==1.2.4 04:36:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d82oAMkrKP/Render', 04:36:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:42 INFO - 'HOME': '/Users/cltbld', 04:36:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:42 INFO - 'LOGNAME': 'cltbld', 04:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:42 INFO - 'MOZ_NO_REMOTE': '1', 04:36:42 INFO - 'NO_EM_RESTART': '1', 04:36:42 INFO - 'PAGER': '/bin/cat', 04:36:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:42 INFO - 'PWD': '/builds/slave/test', 04:36:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:42 INFO - 'SHELL': '/bin/bash', 04:36:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTEg8fJHfo/Listeners', 04:36:42 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 04:36:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:42 INFO - 'USER': 'cltbld', 04:36:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:42 INFO - 'XPC_FLAGS': '0x0', 04:36:42 INFO - 'XPC_SERVICE_NAME': '0', 04:36:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:43 INFO - Downloading/unpacking blobuploader==1.2.4 04:36:43 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 04:36:43 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 04:36:43 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 04:36:43 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 04:36:43 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 04:36:43 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 04:36:45 INFO - Downloading blobuploader-1.2.4.tar.gz 04:36:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:36:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:36:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:36:46 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 04:36:46 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 04:36:46 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 04:36:46 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 04:36:46 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 04:36:46 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 04:36:46 INFO - Downloading docopt-0.6.1.tar.gz 04:36:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:36:47 INFO - Installing collected packages: blobuploader, requests, docopt 04:36:47 INFO - Running setup.py install for blobuploader 04:36:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:36:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:36:47 INFO - Running setup.py install for requests 04:36:47 INFO - Running setup.py install for docopt 04:36:47 INFO - Successfully installed blobuploader requests docopt 04:36:47 INFO - Cleaning up... 04:36:48 INFO - Return code: 0 04:36:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36: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')]} 04:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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')]} 04:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:48 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 0x10f88ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f88d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82324d15c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f668d30>, '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 0x10f58fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65dbe8>, '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.d82oAMkrKP/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.jTEg8fJHfo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 04:36:48 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 04:36:48 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 04:36:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d82oAMkrKP/Render', 04:36:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:48 INFO - 'HOME': '/Users/cltbld', 04:36:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:48 INFO - 'LOGNAME': 'cltbld', 04:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:48 INFO - 'MOZ_NO_REMOTE': '1', 04:36:48 INFO - 'NO_EM_RESTART': '1', 04:36:48 INFO - 'PAGER': '/bin/cat', 04:36:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:48 INFO - 'PWD': '/builds/slave/test', 04:36:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:48 INFO - 'SHELL': '/bin/bash', 04:36:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTEg8fJHfo/Listeners', 04:36:48 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 04:36:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:48 INFO - 'USER': 'cltbld', 04:36:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:48 INFO - 'XPC_FLAGS': '0x0', 04:36:48 INFO - 'XPC_SERVICE_NAME': '0', 04:36:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:36:48 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-UDnMI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:36:48 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-BIgS8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:36:48 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-g1RwNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:36:48 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-s2F_T6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:36:48 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-GEwXP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:36:48 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-x1y7J_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:36:48 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-mvgaPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:36:49 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-ZTjO43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:36:49 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-lFotUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:36:49 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-sYEz3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:36:49 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-I0My8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:36:49 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-17456D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:36:49 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-Xxr87a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:36:49 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-q7F8dJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:49 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-bLFAfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:36:49 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-blQRVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:36:49 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-_pWJ7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:36:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:36:50 INFO - Running setup.py install for manifestparser 04:36:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:36:50 INFO - Running setup.py install for mozcrash 04:36:50 INFO - Running setup.py install for mozdebug 04:36:50 INFO - Running setup.py install for mozdevice 04:36:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:36:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:36:50 INFO - Running setup.py install for mozfile 04:36:50 INFO - Running setup.py install for mozhttpd 04:36:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:36:50 INFO - Running setup.py install for mozinfo 04:36:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:36:51 INFO - Running setup.py install for mozInstall 04:36:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:36:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:36:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:36:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:36:51 INFO - Running setup.py install for mozleak 04:36:51 INFO - Running setup.py install for mozlog 04:36:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:36:51 INFO - Running setup.py install for moznetwork 04:36:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:36:51 INFO - Running setup.py install for mozprocess 04:36:51 INFO - Running setup.py install for mozprofile 04:36:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:36:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:36:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:36:52 INFO - Running setup.py install for mozrunner 04:36:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:36:52 INFO - Running setup.py install for mozscreenshot 04:36:52 INFO - Running setup.py install for moztest 04:36:52 INFO - Running setup.py install for mozversion 04:36:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:36:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:36:52 INFO - Cleaning up... 04:36:52 INFO - Return code: 0 04:36:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:52 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 0x10f88ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f88d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82324d15c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f668d30>, '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 0x10f58fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65dbe8>, '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.d82oAMkrKP/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.jTEg8fJHfo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 04:36:52 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 04:36:52 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 04:36:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d82oAMkrKP/Render', 04:36:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:52 INFO - 'HOME': '/Users/cltbld', 04:36:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:52 INFO - 'LOGNAME': 'cltbld', 04:36:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:52 INFO - 'MOZ_NO_REMOTE': '1', 04:36:52 INFO - 'NO_EM_RESTART': '1', 04:36:52 INFO - 'PAGER': '/bin/cat', 04:36:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:52 INFO - 'PWD': '/builds/slave/test', 04:36:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:52 INFO - 'SHELL': '/bin/bash', 04:36:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTEg8fJHfo/Listeners', 04:36:52 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 04:36:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:52 INFO - 'USER': 'cltbld', 04:36:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:52 INFO - 'XPC_FLAGS': '0x0', 04:36:52 INFO - 'XPC_SERVICE_NAME': '0', 04:36:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:36:52 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-qqKyEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:36:53 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)) 04:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:36:53 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-3XIuoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:36:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:36:53 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-WOZcAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:36:53 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)) 04:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:36:53 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-HOmbR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:36:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:36:53 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-YYdwLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:36:53 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)) 04:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:36:53 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-oKvmj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:36:53 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)) 04:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:36:53 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-KBKM4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:36:53 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)) 04:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:36:53 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-m9gzRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:36:53 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)) 04:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:36:53 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-Z1vJfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:36:53 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)) 04:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:36:53 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-Bu8nc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:36:54 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-TiktUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:36:54 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)) 04:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:36:54 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-qi84et-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:36:54 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-lTzgAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:36:54 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)) 04:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:36:54 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-RDodAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:54 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-JW1mgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:54 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)) 04:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:36:54 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-F0KPQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:36:54 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-lDg4W2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:36:54 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)) 04:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:36:54 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)) 04:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:36:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:57 INFO - Downloading blessings-1.6.tar.gz 04:36:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:36:57 INFO - Installing collected packages: blessings 04:36:57 INFO - Running setup.py install for blessings 04:36:57 INFO - Successfully installed blessings 04:36:57 INFO - Cleaning up... 04:36:57 INFO - Return code: 0 04:36:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:36:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:36:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:36:58 INFO - Reading from file tmpfile_stdout 04:36:58 INFO - Current package versions: 04:36:58 INFO - blessings == 1.6 04:36:58 INFO - blobuploader == 1.2.4 04:36:58 INFO - docopt == 0.6.1 04:36:58 INFO - functools32 == 3.2.3-2 04:36:58 INFO - jsonschema == 2.5.1 04:36:58 INFO - manifestparser == 1.1 04:36:58 INFO - mozInstall == 1.12 04:36:58 INFO - mozcrash == 1.0 04:36:58 INFO - mozdebug == 0.1 04:36:58 INFO - mozdevice == 0.49 04:36:58 INFO - mozfile == 1.2 04:36:58 INFO - mozhttpd == 0.7 04:36:58 INFO - mozinfo == 0.9 04:36:58 INFO - mozleak == 0.1 04:36:58 INFO - mozlog == 3.4 04:36:58 INFO - moznetwork == 0.27 04:36:58 INFO - mozprocess == 0.25 04:36:58 INFO - mozprofile == 0.28 04:36:58 INFO - mozrunner == 6.13 04:36:58 INFO - mozscreenshot == 0.1 04:36:58 INFO - mozsystemmonitor == 0.3 04:36:58 INFO - moztest == 0.8 04:36:58 INFO - mozversion == 1.4 04:36:58 INFO - psutil == 3.1.1 04:36:58 INFO - requests == 1.2.3 04:36:58 INFO - wsgiref == 0.1.2 04:36:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36: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')]} 04:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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')]} 04:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:58 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 0x10f88ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f88d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82324d15c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f668d30>, '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 0x10f58fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65dbe8>, '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.d82oAMkrKP/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.jTEg8fJHfo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 04:36:58 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 04:36:58 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 04:36:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d82oAMkrKP/Render', 04:36:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:58 INFO - 'HOME': '/Users/cltbld', 04:36:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:58 INFO - 'LOGNAME': 'cltbld', 04:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:58 INFO - 'MOZ_NO_REMOTE': '1', 04:36:58 INFO - 'NO_EM_RESTART': '1', 04:36:58 INFO - 'PAGER': '/bin/cat', 04:36:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:58 INFO - 'PWD': '/builds/slave/test', 04:36:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:58 INFO - 'SHELL': '/bin/bash', 04:36:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTEg8fJHfo/Listeners', 04:36:58 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 04:36:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:58 INFO - 'USER': 'cltbld', 04:36:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:58 INFO - 'XPC_FLAGS': '0x0', 04:36:58 INFO - 'XPC_SERVICE_NAME': '0', 04:36:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:58 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)) 04:36:58 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)) 04:36:58 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)) 04:36:58 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)) 04:36:58 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)) 04:36:58 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)) 04:36:58 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)) 04:36:58 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)) 04:36:58 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)) 04:36:58 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)) 04:36:58 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)) 04:36:58 INFO - Cleaning up... 04:36:58 INFO - Return code: 0 04:36:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:36: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')]} 04:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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')]} 04:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:58 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 0x10f88ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f88d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82324d15c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f668d30>, '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 0x10f58fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65dbe8>, '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.d82oAMkrKP/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.jTEg8fJHfo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 04:36:58 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 04:36:58 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 04:36:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d82oAMkrKP/Render', 04:36:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:58 INFO - 'HOME': '/Users/cltbld', 04:36:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:58 INFO - 'LOGNAME': 'cltbld', 04:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:58 INFO - 'MOZ_NO_REMOTE': '1', 04:36:58 INFO - 'NO_EM_RESTART': '1', 04:36:58 INFO - 'PAGER': '/bin/cat', 04:36:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:58 INFO - 'PWD': '/builds/slave/test', 04:36:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:58 INFO - 'SHELL': '/bin/bash', 04:36:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTEg8fJHfo/Listeners', 04:36:58 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 04:36:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:58 INFO - 'USER': 'cltbld', 04:36:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:58 INFO - 'XPC_FLAGS': '0x0', 04:36:58 INFO - 'XPC_SERVICE_NAME': '0', 04:36:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:36:58 INFO - Cleaning up... 04:36:58 INFO - Return code: 0 04:36:58 INFO - Running post-action listener: _resource_record_post_action 04:36:58 INFO - Running post-action listener: _start_resource_monitoring 04:36:58 INFO - Starting resource monitoring. 04:36:58 INFO - [mozharness: 2017-03-05 12:36:58.661536Z] Finished create-virtualenv step (success) 04:36:58 INFO - [mozharness: 2017-03-05 12:36:58.662579Z] Running install step. 04:36:58 INFO - Running pre-action listener: _resource_record_pre_action 04:36:58 INFO - Running main action method: install 04:36:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:36:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:36:58 INFO - Reading from file tmpfile_stdout 04:36:58 INFO - Detecting whether we're running mozinstall >=1.0... 04:36:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:36:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:36:59 INFO - Reading from file tmpfile_stdout 04:36:59 INFO - Output received: 04:36:59 INFO - Usage: mozinstall [options] installer 04:36:59 INFO - Options: 04:36:59 INFO - -h, --help show this help message and exit 04:36:59 INFO - -d DEST, --destination=DEST 04:36:59 INFO - Directory to install application into. [default: 04:36:59 INFO - "/builds/slave/test"] 04:36:59 INFO - --app=APP Application being installed. [default: firefox] 04:36:59 INFO - mkdir: /builds/slave/test/build/application 04:36:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:36:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:37:19 INFO - Reading from file tmpfile_stdout 04:37:19 INFO - Output received: 04:37:19 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:37:19 INFO - Running post-action listener: _resource_record_post_action 04:37:19 INFO - [mozharness: 2017-03-05 12:37:19.064419Z] Finished install step (success) 04:37:19 INFO - [mozharness: 2017-03-05 12:37:19.064563Z] Running run-tests step. 04:37:19 INFO - Running pre-action listener: _resource_record_pre_action 04:37:19 INFO - Running main action method: run_tests 04:37:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:37:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:37:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:37:19 INFO - 2017-03-05 04:37:19.079 screenresolution[1657:9503] starting screenresolution argv=screenresolution get 04:37:19 INFO - 2017-03-05 04:37:19.081 screenresolution[1657:9503] Display 0: 1600x1200x32@60 04:37:19 INFO - 2017-03-05 04:37:19.087 screenresolution[1658:9505] starting screenresolution argv=screenresolution list 04:37:19 INFO - Available Modes on Display 0 04:37:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:37:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:37:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:37:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:37:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:37:19 INFO - Intel Iris: 04:37:19 INFO - Chipset Model: Intel Iris 04:37:19 INFO - Type: GPU 04:37:19 INFO - Bus: Built-In 04:37:19 INFO - VRAM (Dynamic, Max): 1536 MB 04:37:19 INFO - Vendor: Intel (0x8086) 04:37:19 INFO - Device ID: 0x0a2e 04:37:19 INFO - Revision ID: 0x0009 04:37:19 INFO - Displays: 04:37:19 INFO - Display: 04:37:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:37:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:37:19 INFO - Display Serial Number: 1600x1200 60 04:37:19 INFO - Main Display: Yes 04:37:19 INFO - Mirror: Off 04:37:19 INFO - Online: Yes 04:37:19 INFO - Rotation: Supported 04:37:19 INFO - Return code: 0 04:37:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:37:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:37:19 INFO - Python 2.7.3 04:37:19 INFO - Return code: 0 04:37:19 INFO - grabbing minidump binary from tooltool 04:37:19 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')]} 04:37:19 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 0x10f668d30>, '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 0x10f58fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:37:19 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 04:37:19 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 04:37:19 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 04:37:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:37:19 INFO - Return code: 0 04:37:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:37:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:37:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:37:19 INFO - ENV: RUST_BACKTRACE is now 1 04:37:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:37:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:37:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0181', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:37:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0181 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:37:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d82oAMkrKP/Render', 04:37:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:19 INFO - 'HOME': '/Users/cltbld', 04:37:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:19 INFO - 'LOGNAME': 'cltbld', 04:37:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:37:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:37:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:19 INFO - 'MOZ_NO_REMOTE': '1', 04:37:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:37:19 INFO - 'NO_EM_RESTART': '1', 04:37:19 INFO - 'PAGER': '/bin/cat', 04:37:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:19 INFO - 'PWD': '/builds/slave/test', 04:37:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:37:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:19 INFO - 'RUST_BACKTRACE': '1', 04:37:19 INFO - 'SHELL': '/bin/bash', 04:37:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTEg8fJHfo/Listeners', 04:37:19 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 04:37:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:19 INFO - 'USER': 'cltbld', 04:37:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:19 INFO - 'XPC_FLAGS': '0x0', 04:37:19 INFO - 'XPC_SERVICE_NAME': '0', 04:37:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0181', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:37:19 INFO - mozversion application_buildid: 20170305030210 04:37:19 INFO - mozversion application_changeset: eb23648534779c110f3a1f2baae1849ae4a9c570 04:37:19 INFO - mozversion application_display_name: Nightly 04:37:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:37:19 INFO - mozversion application_name: Firefox 04:37:19 INFO - mozversion application_remotingname: firefox 04:37:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:37:19 INFO - mozversion application_vendor: Mozilla 04:37:19 INFO - mozversion application_version: 54.0a1 04:37:19 INFO - mozversion platform_buildid: 20170305030210 04:37:19 INFO - mozversion platform_changeset: eb23648534779c110f3a1f2baae1849ae4a9c570 04:37:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:37:19 INFO - mozversion platform_version: 54.0a1 04:37:19 INFO - using testdate: 1488717439 04:37:19 INFO - actual date: 1488717439 04:37:19 INFO - starting webserver on 'localhost:49242' 04:37:19 INFO - SUITE-START | Running 2 tests 04:37:19 INFO - TEST-START | dromaeo_css 04:37:19 INFO - operating with platform_type : mac_ 04:37:19 INFO - Initialising browser for dromaeo_css test... 04:37:19 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmp6NGuGd/profile http://localhost:49242/getInfo.html) 04:37:23 INFO - PROCESS | 1668 | 2017-03-05 04:37:23.023 plugin-container[1672:9702] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b53, name = 'com.apple.tsm.portname' 04:37:23 INFO - PROCESS | 1668 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:37:23 INFO - PROCESS | 1668 | 2017-03-05 04:37:23.024 plugin-container[1672:9702] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 04:37:23 INFO - PROCESS | 1668 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:37:23 INFO - PROCESS | 1668 | 2017-03-05 04:37:23.024 plugin-container[1672:9702] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:37:23 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 04:37:23 INFO - PROCESS | 1668 | colorDepth:24 04:37:23 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 04:37:23 INFO - PROCESS | 1668 | __metrics 04:37:23 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3354: TypeError: this.tabs is undefined 04:37:23 INFO - TEST-INFO | 1668: exit 0 04:37:23 INFO - Browser initialized. 04:37:23 INFO - Running cycle 1/1 for dromaeo_css test... 04:37:23 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmp6NGuGd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:37:26 INFO - PROCESS | 1673 | 2017-03-05 04:37:26.459 plugin-container[1674:9824] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8843, name = 'com.apple.tsm.portname' 04:37:26 INFO - PROCESS | 1673 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:37:26 INFO - PROCESS | 1673 | 2017-03-05 04:37:26.459 plugin-container[1674:9824] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4313, name = 'com.apple.CFPasteboardClient' 04:37:26 INFO - PROCESS | 1673 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:37:26 INFO - PROCESS | 1673 | 2017-03-05 04:37:26.459 plugin-container[1674:9824] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:37:36 INFO - PROCESS | 1673 | RSS: Main: 227618816 04:37:36 INFO - PROCESS | 1673 | 04:40:39 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 04:40:41 INFO - PROCESS | 1673 | RSS: Main: 250281984 04:40:41 INFO - PROCESS | 1673 | 04:42:24 INFO - PROCESS | 1673 | ************************* 04:42:24 INFO - PROCESS | 1673 | A coding exception was thrown and uncaught in a Task. 04:42:24 INFO - PROCESS | 1673 | 04:42:24 ERROR - PROCESS | 1673 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:42:24 INFO - PROCESS | 1673 | Full stack: 04:42:24 INFO - PROCESS | 1673 | ************************* 04:43:43 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 04:43:44 INFO - PROCESS | 1673 | RSS: Main: 256176128 04:43:44 INFO - PROCESS | 1673 | 04:46:46 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 04:46:47 INFO - PROCESS | 1673 | RSS: Main: 267186176 04:46:47 INFO - PROCESS | 1673 | 04:49:49 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 04:49:49 INFO - PROCESS | 1673 | RSS: Main: 261791744 04:49:49 INFO - PROCESS | 1673 | 04:52:52 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 04:52:53 INFO - PROCESS | 1673 | RSS: Main: 271806464 04:52:53 INFO - PROCESS | 1673 | 04:55:56 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 04:55:56 INFO - PROCESS | 1673 | RSS: Main: 265728000 04:55:56 INFO - PROCESS | 1673 | 04:55:56 INFO - PROCESS | 1673 | __start_tp_report 04:55:56 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 04:55:56 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 04:55:56 INFO - PROCESS | 1673 | |i|pagename|runs| 04:55:56 INFO - PROCESS | 1673 | |0;dojo.html;2895.5367141257398;3236.7053178728506;3299.736021118311;3375.0718552398102;3440.3119376124782;5045.77294021769;5643.633163844347;5767.365589785126;5786.652800831947;5904.940950590493;4751.524847515247;5707.4577915098;5791.362950075489;5886.028805247129;5941.168236446901;5176.922346164792;5304.939012197557;5328.440513746059;5412.756425960822;5416.729163541827;4937.185364414885;5286.259923610698;5367.677939323634;5407.648502847303;5411.312657501442;4400.823967041314;5150.665206761549;5192.350956130484;5333.813316533941;5385.973070134643;3998.5601583825755;4432.53458386868;5238.1618940969265;5384.730763461811;5387.488188622075;5249.606279529051;5252.6323157379;5280.841574752763;5313.734313284359;5342.946570534284;4641.535846415365;5511.889762204733;5679;5909.054551271776;5994.6403215807195;6123.923256659767;6181.505479561669;6209;6256.15541901842;6301.212348456443;6271.059341098826;6294.464970477515;6304.054391841215;6314.747410103636;6316.431521163117;5150.330457040635;6009.969950150265;6013.308469525973;6054.8183554493435;6070.423309785563;6145.371476558716;6189.04069869171;6261.935470969946;6315.810525684236;6421;5756.769729210869;6217.937820621736;6229.470495007885;6264.906026409608;6320.968395158086;5055.620828437882;6136.090214303957;6295.937040629627;6302.716377763011;6315.305316415191;5167.689938603696;6171;6180.690965451709;6201.751929922752;6260.311365749764;6146.108814221912;6156.415140561639;6255.249370075529;6261.937380626136;6300.59046161998;5057.367829021372;5093.1087059764395;5094.006668699568;5105.744712764347;5141.331626888481;4532.524084971096;4546.1589605922345;4553.317002449593;4563.338315944236;4563.931541026821;5788.016037273674;5847.502962248172;5930.762769489172;6063.393660633901;6098.71926895348;6143.849652621547;6160.983437732813;6206.813795586139;6261.843453913689;6264.906026409608;6046.455818976226;6059.818205453844;6062.211912451353;6066.181065556182;6106.72519736613;5586.24585680936;5591.27313449249;5591.608587398924;5595.356533998643;5610.579206559524;5518.613697041169;6103.246756470893;6241.781537646342;6344.333844946214;6573.638449885302;5446.673199608036;6234.906476402948;6298.559100862895;6298.842528936813;6346.524010699124;6404.135441715495;6408.455281301141;6475.158229430144;6477.77327793525;6489.383508566679;6101.755929762938;6140.105498721277;6144.740328232612;6255.874882502416;6281.874362512633;6163.660998645118;6183.505319574333;6196.876062478635;6233.096201050732;6240.843978900564;5220.190870415092;5985.713071689607;6029.276486821434;6253.468455181361;6257.874842503215;6032.245969253843;6041.24484439445;6104.694765261808;6144.969275153596;6200.255969283715;6051.7579296827635;6075.301340345917;6157.384261573807;6161.045038019114;6184.165137706352;5982.7735314261345;6063.029915213545;6074.544409169418;6079.817605471843;6209.067446405416;5945.583809133319;5977.850553736192;6006.129111278928;6008.759649613967;6054.424829641177 04:55:56 INFO - PROCESS | 1673 | |1;ext.html;685.6366125953244;711.1785887300167;801.1027649033084;932.5150921520809;933.383966582056;36647.900562983086;38958.610413895854;38962.8051859741;39002.41496377553;39185.60814391859;37711;37911.81044094776;37995.24009519808;38014;38087.809560952155;7569.848603027936;7724.111727151365;10134.087932086148;10439.478026098703;10586.1531077514;10356.17150627948;10449.477526123663;10450.68647940563;10468.42423666698;10471.952804719544;10466.005729455728;10486.37081775096;10491.632792852251;10491.790164196711;10497.4226417547;10437.530311135979;10439.37363758177;10454.006869347475;10464.686059418229;10481.266311358208;9297.721068367891;9784.168345690625;10153.644622438253;10244.129249013842;10248.128909042665;32245.51631725526;32339.353212935846;32443.351132977445;32503;32524.512132318036;3634.8913581357674;3655.5065066215984;3681.7975011374365;3698.6301369863068;3758.7180961428003;22303.330900073022;24374.146904858422;25193.496130077478;25207.117750878813;25260.494790104094;3052.3742632760454;3060;3154.9842250788597;3189.740052679202;3191.6010498687665;256036;302993.42516437045;314474;315756;316162;41826.58173418288;41896.924945883286;41899.7905010473;41990.37014444786;42085.57914420817;43540.91147721269;43713.56286437158;43753.343699844525;43807.561924380345;43859;12684.42920068599;12764.234145951272;12787.424565894557;12806.231626102464;12830.743385132246;9129.77175570616;10886.67339979802;10929.890701093047;10934.617288395028;10941.398223097805;9198.310126740522;11199.496022678999;11294.830577541343;11311.83032254517;11340.319580825177;2764.585312203186;2844.445333160014;2887.581300711385;5474.589405794582;5526.557875370041;921.6221349246777;941.7880976780169;975.7267964969819;1028.8631062675636;1075.870895492546;27496.03763868255;27530.862345688143;27697.861510692317;27781;28233.576496352573;901.364538000708;1036.4196050211906;1043.1289872956015;1054.6572363981736;1055.963041293551;13193.73612527744;13584.660383490493;13928.51250206238;13958.58124256274;13978.930105349407;469510;472438;472886;473060;473841.63079185074;53774;54180;54202.45797541974;54211.72894135583;54231.72884135633;1382.0740104130257;1417.2134465371612;1420.3182472413093;1422.679897023182;1423.7294913966314;24997;25179.74820251774;25418.364540885887;26144.34639134037;26424.735752642995;37802.2439551202;40429.989250268976;42096.36855447232;44752.328715069954;44770.552294477944;400846;468530;468825;469418;470419;22785.974631141307;23173.42066448352;23173.884130579238;23279.53440931206;23358.76641233634;32781.672183277864;35365.1158721034;36511.63488365189;40509.797451013736;41818.37272440977;26861.462770744085;29636.666350014733;30804;31726.365472689955;32489.83755081304;25844.224673259832;31048.379032418772;31880.7247710089;32038.51942220822;32059.679403205668;30779;31207.531887021258;31408;31792;31830;22321;26008.73991260063;29361;29552.704472954996;30235.09294721162;17079.48761537156;22485.88757056204;22520.436989074748;22572.322830315115;22648.773512264666 04:55:56 INFO - PROCESS | 1673 | |2;jquery.html;398.6113539299184;401.20361083249765;412.2044454203388;415.19245068342076;446.00540794029314;19688.70466942997;20181.192752289928;20625.27811526597;20690.275840345592;20979.265725699603;17695.82304176961;20594.279200227957;20750.792492075074;21119.894400528014;21296.787032129672;6407.807765767035;6692.698828552702;6706.530542862001;6707.631080290582;6708.932910670904;6224.3153253142345;6467.353264673518;6472.611643301393;6564.179477565304;6583.93416065838;6550.344965503459;6552.443042341383;6562.573432726857;6565.80302590923;6571.474282057447;6381.872362552746;6449.967750161242;6472.967635161817;6580.670966451707;6600.108985287021;6041.939580604182;6377.5216858735785;6400.487960963112;6402.007688808196;6412.93587064128;20302.492437689176;24222.031118755403;24721;24817.00731970719;25110;2659.614355918381;2691.7308269173122;2770.3074231442138;2776.6806817216075;2782.3600571868583;14082.859171408258;14739.48800303231;14941.402343906231;15659.13874736889;15715.135667538281;1823.8996855172961;1864.9720254196197;1874.08169996702;1879.5958868843127;1927.6915693488975;100740;148083.25958370246;160991;172417.13791431213;173417;16737.82408286915;18068.728969065476;18283.268669253346;19114.044297785334;19220.615587688168;29533.409331813244;29704.851475742482;29752.85123574368;29797.851010745242;29803.85098074496;9657.372270802376;9669.371490853073;9840.261980351503;9876.160526355197;10013.749656258651;8162.428629995843;8189.7133600323705;8190.262876341158;8317.251447369767;8323.5005899645;7280.635968201569;7919.891215229873;8932.508712020901;8978.820423591622;9016.774580635536;3425.760196786251;3529.835154399042;3847.8460861565222;3872.7095467840027;3942.290387730236;805.2390490986079;813.341193633159;820.274057459141;838.6813011055759;854.5812551849673;19317.903410483137;20699.8965005174;21357;21418.250361237595;21580;829.722043115551;844.9016278837487;864.8540683594263;867.1112110087086;872.4634349874781;11003.944980275208;11137.498812553455;11167.664970050912;11247.606333778278;11275.718107047225;486627;627096;660269;667842;677130.614346935;141551;142655;143527;146395;147772.26113869576;1174.236746115015;1233.8827811357908;1274.254561081759;1283.371148137406;1286.1704200790625;16795.748063779298;19261.807381926003;19502.609947801247;19738.50653733668;19743.506412339808;49809;61827.6908615454;62128.689356552924;64445.67777161084;66697;89258;90010;90264;90511.54744226237;90609;9676.70969870905;11254.493547790205;11311.830322545004;11357.432128393713;11360.318380897173;12252.571160009356;12260.754784904073;12585.811212831632;12599;12614.873851261736;9720.368176068532;10644.254902156774;10889.618863339745;10939;10977.737560180682;9723.9027609723;9735.929047804877;10606.151507879506;10771.946140269249;10820.621278255223;9718.562664679965;11195.160362972647;11254.831177532507;11468.655940321803;11519.884801152217;10982.395968221825;11311.830322545004;11342.092632589538;11434.82847757301;11474.94262528682;10582.841257380991;10606.575736970435;10730.731731706457;10950.835737463785;10984.340939543654 04:55:56 INFO - PROCESS | 1673 | |3;mootools.html;1426.7645838436658;1496.147196098223;1545.1501674079261;1560.9609759756004;1561.882858785591;9193.77015574611;9450.81098378032;10355.844662330062;11022.889771102296;11099.611513597025;10332.17342612591;10629.362238265709;10666.200034997386;10681.78636427273;10683.679489615304;2243.5064285857165;2271.9432014199697;2286.27982185611;2293.1286111277773;2294.1167650454613;2243.371855880348;2276.9772302277015;2283.748787633359;2289.645105008718;2293.128611127769;2250.966235506469;2265.184533567914;2268.3308424014954;2273.3520946530243;2280.2247235939776;2211.756706762255;2217.81148602369;2218.4121207879843;2230.096810791632;2234.0728597632046;2197.2968650031994;2263.106073101132;2264.79616834484;2265.444965983328;2268.036084664011;10815.297005694605;10897.455127243606;10948.3978381189;10963.671089867237;10978.890211097867;5486.478784515464;5593.972030139864;5632.7746890124345;5651.2935883014625;5655.123455864347;3278.5573947517255;3331.600207975034;3542.5926018507685;3576.409892367756;3579.480975258599;1182.266994463438;1214.878512148787;1220.2861326124228;1234.2594443334017;1245.912786104973;14820.925895370561;14875.702485950329;14934.551963441114;14967.925160374238;14973.550793476214;4447.73313601185;4653.53464653532;4739.123262196505;4795.592374648194;4798.880027999258;10721.78556428867;12731.172473789175;12754.489820407265;12792.2964236966;12801.871981280254;5616.66300022;5621.381648018714;5623.775048998076;5624.409437009137;5629.211910332557;4404.317330813729;4885.145099607555;5007;5032.169692000779;5172.844814655567;3934.6655534279907;3981.1042515433796;4019.3167161582014;4042.4946881639794;4070.2673518766906;1130.971725706864;1137.1869113583662;1138.299945533491;1149.5574203931546;1149.816029435303;783.5572901310741;786.6971216081736;807.3057170833079;811.2638952641234;812.9674813007414;6380.723855228973;6430.839229019312;6577.144971153815;6782.118324617768;6797.2523022467485;871.7776966873407;873.6985739919718;1000.0849222960909;1025.738436698637;1034.7671773850973;3387.932241355159;3929.626685464876;4207.957920420818;4285.442892423965;4421.226285400042;12921.418536165895;13332.600021999355;13597.932010340082;13790.65523361904;13797.310134493235;12775.297358645177;13325.400356983959;13362.465501379836;13365.866341336656;13534.120282181626;9756.609735610497;9996.950015249877;10007.99920008008;10021.549030293654;10037.44794036335;5416.539594134542;5849.707514624167;6427.6786160690845;6786.150509759033;6790.728370865308;11760.529578816751;11917.284962902253;12135.271883687006;12331.260124392566;12362.847473894099;12258.325792081521;12477.875221247672;12501.687457813263;12525.812112818132;12541.686457838627;8810.559472026245;8818.823623527622;8833.249173820297;8883.555822208993;9017.188453039258;9691.030896910253;9776.755581110529;9850.014998500093;9857.30998830075;9946.254030947563;7491.838764991435;8785.956070219609;8834.558272086242;8902.243309318781;8930.062343453843;7088.751893683696;8573.014103378191;8627.6980305689;8646.740597782076;8713.695020674246;7603;7651.846963060596;7754.418418618513;7755.650995705094;7770.53376797394;5734.569907257056;5851.970740146272;5896.115582662635;5919.970400147971;5967.552433567413;5804.883902322014;5845.386234445492;5941.465268125889;6063.878722425615;6130.111133885651 04:55:56 INFO - PROCESS | 1673 | |4;prototype.html;323.5082674335011;343.8607364017572;348.39031694534566;355.7349774418059;355.8078637535731;4501.437320334958;4902.730349830758;5182.714950677711;5291.550218231455;5346.732663366831;4457.375967364572;4954.405471343435;5115.667481613693;5123.820666276681;5280.735963201843;3596.8021758803256;3798.3667023180024;4102.671786257107;4260.446142001535;4264.42430271914;3330.9840498648023;3976.8467144528195;4260.3810551990355;4290.957090429102;4330.870073897788;3654.579723331811;4201.894952626193;4275.8075886585175;4307.6123148916595;4343.630791382736;3475.8783442579643;4041.7574945503366;4279.277028984788;4297.720648157875;4462.486814016397;3497.965020349815;3626.5131296168443;3747.3254814133447;4171.270027745132;4262.573742625744;4862.17343051682;5050.797968081272;5055.898882022376;5058.822941197041;5059.316992206079;4430.468343798732;4554.8861278467975;4820.662553621248;5093.617978651616;5163.457836927144;4520.389747384094;4925.350007747409;5668.829935101953;5700.543956483471;5707.6575405475805;4633.976830115862;4740.691855029412;4783.521647835189;4796.544328288807;4852.514748525155;5477.424870388591;5553.778168802816;5792.391798861101;5840.591158618899;5920.585559010871;4534.795934182904;4543.1822271990695;4596.632269418438;4887.682300650446;4910.950890491121;4247.723897946624;4366.8034938427845;4518.825105472601;5045.268436076748;5133.332666753298;4539.592726254871;4970.030843985461;4975.278584605285;5210.6613070150315;5220.556252718486;5537.197106419627;5542.949108829678;5577.330720313588;5599.552035837123;5689.630174038674;1426.586289975916;1496.5510346895887;1684.8146703862565;1746.7292569651725;1766.611345503987;1247.9517205547384;1290.0647030902521;1319.6898728798917;1380.7169530246276;1414.886809055273;4365.214261432972;4660.184467718136;4723.551807180777;5118.360204974379;5121.436641969381;4811.615070794328;5424.80654256063;5446.863828404322;5740.942590574125;5754.223179870748;4186.388240527419;4402.295632698753;4456.955430445719;5128.487151284841;5153.1497302945345;2516.6476693262957;2746.986265068702;2827.9536571468275;2875.8849646013923;2934.4424559333656;4972.563443912457;5300.515855560449;5888.558358123072;5889.823305300848;5914.378990206053;4892.936009726337;5115.74421278942;5226.555742761831;5519.917201241985;5922.318933322636;4939.839137802614;5674.177244299553;5869.8239052828485;5879.089850524018;6066.332703402622;4794.352762377034;5054.494550544916;5243.292155558951;5542.168674698827;5790;5151.5363617274625;5272.971770504715;5340.872762148381;5646.237757902631;5650.84157747669;5393.784248630168;5908.61593996406;5930.90767370513;5970.432808883149;5973.611715238496;4017.6384125428854;4053.6959728021106;4529.8641040768825;4535.727856328631;4555.180067587866;5016.698998060128;5348.384935732285;5411.891762164656;5524;5765.971170144123;5487.826195530029;5536.54308281837;5549.5837812163445;5551.528120109836;5558;4602.815887364468;4691.695039822401;5363.892722145613;5439.207244284824;5504.80733174353;4767.974885399656;4827.42070951474;4900.436449808318;4951.702897826142;5046.492687582096;5566.777328906798;5591.664500130005;5596.356419011866;5606.411326810626;5620.4660557247;4540.659450541157;4993.27597498368;5216.608754343515;5381.515663590296;5389.299391079135 04:55:56 INFO - PROCESS | 1673 | |5;yui.html;694.3542505469911;701.6737217194001;771.9922800771991;817.7015389382875;818.8034871630808;14448.566543003713;15736.977096488734;15781.605459863495;17180.570485737862;18134.727979080326;17267.481975540722;17419.73870391945;17460;17533.211005504752;17534.561635959108;951.8477043672997;985.3447457440793;989.3371441134457;989.6981420666693;991.1278075293732;925.2459245714755;967.6371360739722;968.6754937096046;972.3290929258824;974.7368210583138;999.440313424481;1013.7769690668041;1014.4826138669258;1015.973866394939;1018.2414101494397;992.4789485520088;1008.8284991551454;1009.6314845081566;1010.8736407949007;1015.0914931136591;740.3521918321469;745.9216782237842;751.1511991449627;752.2778132992333;754.0687251244708;15397.23013849303;15654.217289135499;15924.601884952854;16203.02781833082;16446.83553164477;13475.191488510623;13617.319134043259;13676.384562694602;13856.168629882239;14046.92976535121;11079.113670906308;11529.884701152965;11586.246893951866;11705.297682139098;12297.938510307391;3577.4454959481322;3584.7849129052343;3652.652997965189;3660.2862441823854;3744.4383342498572;80917.78623320656;96064.51967740187;96215;99560;100853;9508.334416590773;10250.538725757358;10503.264771466076;10527;10799.514021869034;21268.787312126682;21344.77053121995;21389.893050534647;21414.03636836346;21443.249486267905;7438.218987006287;7525.871119332034;7689.077310722637;7755.069391673035;7767.961160194162;4065.3901914712437;4073.7555746655294;4167.249895018926;4188.748675079505;4311.202427550913;3274.7707660464016;3362.4620060790157;3362.7814192077926;3363.9663603364143;3364.6803553662853;574.6494638270651;592.5644651181378;599.1611743558965;599.5892813422819;599.6821684507219;636.2333388267127;659.4131223211346;661.2825084783065;667.2393471442559;672.9024291477708;7723.613819309012;8663.003754568179;8902.688405905892;10739.570417183382;10893.857538022155;514.4547919134488;533.3174134105456;550.5733056880949;596.7549593503916;672.2034389248756;3852.5569559500454;4579.473360563577;4932.7286999215385;4948.307236986825;5026.874328141826;89732.55133724421;91501;92953.53523232476;93950.53024734833;95465;71143.79852906632;80122.59938700269;81657;83890.16109838945;85004.57497712596;69901;71823.64088179526;72373.638131809;72644;72686.63656681789;9458.527073646428;9468.053194680477;9491.145796878314;9502.952485237529;9576.521173941414;47221;47811.76094119507;48316.5168348312;48375.2644021401;48449.27326090041;59754.92083172979;60344.7586289648;60389.79220415479;61169.69415152896;61307;11082.335059896432;11106.666799996014;11267.619644473416;11573.479193436147;11704.94147529291;12445.315507647167;12525.37373131358;12577.371131443208;12630.115891887479;12654.810177847523;11792.23350482216;11856.466459009192;11926.940365298118;11958.103142264192;12088.939555302168;10411.739706507398;11318.773624527299;11548.364839933884;11881;12112;11381.43092845371;11565.653030409101;12118.818217726564;12189.08581856382;12258.325792081521;9412.341136120405;9512.38169518979;9655.733960896674;9658.661946831828;10328.018838210359;8898.42160259581;8899.332550058642;9172.541372931193;9790.216782657513;9934.801303974025 04:55:56 INFO - PROCESS | 1673 | __end_tp_report 04:55:56 INFO - PROCESS | 1673 | __start_cc_report 04:55:56 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,429 04:55:56 INFO - PROCESS | 1673 | __end_cc_report 04:55:56 INFO - PROCESS | 1673 | __startTimestamp1488718556622__endTimestamp 04:55:56 INFO - PROCESS | 1673 | 04:55:56 INFO - PROCESS | 1673 | ------- Summary: start ------- 04:55:56 INFO - PROCESS | 1673 | Number of tests: 6 04:55:56 INFO - PROCESS | 1673 | 04:55:56 INFO - PROCESS | 1673 | [#0] dojo.html Cycles:165 Average:5751.79 Median:6051.76 stddev:685.33 (11.3%) stddev-sans-first:649.77 04:55:56 INFO - PROCESS | 1673 | Values: 2895.5 3236.7 3299.7 3375.1 3440.3 5045.8 5643.6 5767.4 5786.7 5904.9 4751.5 5707.5 5791.4 5886.0 5941.2 5176.9 5304.9 5328.4 5412.8 5416.7 4937.2 5286.3 5367.7 5407.6 5411.3 4400.8 5150.7 5192.4 5333.8 5386.0 3998.6 4432.5 5238.2 5384.7 5387.5 5249.6 5252.6 5280.8 5313.7 5342.9 4641.5 5511.9 5679.0 5909.1 5994.6 6123.9 6181.5 6209.0 6256.2 6301.2 6271.1 6294.5 6304.1 6314.7 6316.4 5150.3 6010.0 6013.3 6054.8 6070.4 6145.4 6189.0 6261.9 6315.8 6421.0 5756.8 6217.9 6229.5 6264.9 6321.0 5055.6 6136.1 6295.9 6302.7 6315.3 5167.7 6171.0 6180.7 6201.8 6260.3 6146.1 6156.4 6255.2 6261.9 6300.6 5057.4 5093.1 5094.0 5105.7 5141.3 4532.5 4546.2 4553.3 4563.3 4563.9 5788.0 5847.5 5930.8 6063.4 6098.7 6143.8 6161.0 6206.8 6261.8 6264.9 6046.5 6059.8 6062.2 6066.2 6106.7 5586.2 5591.3 5591.6 5595.4 5610.6 5518.6 6103.2 6241.8 6344.3 6573.6 5446.7 6234.9 6298.6 6298.8 6346.5 6404.1 6408.5 6475.2 6477.8 6489.4 6101.8 6140.1 6144.7 6255.9 6281.9 6163.7 6183.5 6196.9 6233.1 6240.8 5220.2 5985.7 6029.3 6253.5 6257.9 6032.2 6041.2 6104.7 6145.0 6200.3 6051.8 6075.3 6157.4 6161.0 6184.2 5982.8 6063.0 6074.5 6079.8 6209.1 5945.6 5977.9 6006.1 6008.8 6054.4 04:55:56 INFO - PROCESS | 1673 | 04:55:56 INFO - PROCESS | 1673 | [#1] ext.html Cycles:180 Average:53134.77 Median:30791.50 stddev:111180.62 (361.1%) stddev-sans-first:111422.77 04:55:56 INFO - PROCESS | 1673 | Values: 685.6 711.2 801.1 932.5 933.4 36647.9 38958.6 38962.8 39002.4 39185.6 37711.0 37911.8 37995.2 38014.0 38087.8 7569.8 7724.1 10134.1 10439.5 10586.2 10356.2 10449.5 10450.7 10468.4 10472.0 10466.0 10486.4 10491.6 10491.8 10497.4 10437.5 10439.4 10454.0 10464.7 10481.3 9297.7 9784.2 10153.6 10244.1 10248.1 32245.5 32339.4 32443.4 32503.0 32524.5 3634.9 3655.5 3681.8 3698.6 3758.7 22303.3 24374.1 25193.5 25207.1 25260.5 3052.4 3060.0 3155.0 3189.7 3191.6 256036.0 302993.4 314474.0 315756.0 316162.0 41826.6 41896.9 41899.8 41990.4 42085.6 43540.9 43713.6 43753.3 43807.6 43859.0 12684.4 12764.2 12787.4 12806.2 12830.7 9129.8 10886.7 10929.9 10934.6 10941.4 9198.3 11199.5 11294.8 11311.8 11340.3 2764.6 2844.4 2887.6 5474.6 5526.6 921.6 941.8 975.7 1028.9 1075.9 27496.0 27530.9 27697.9 27781.0 28233.6 901.4 1036.4 1043.1 1054.7 1056.0 13193.7 13584.7 13928.5 13958.6 13978.9 469510.0 472438.0 472886.0 473060.0 473841.6 53774.0 54180.0 54202.5 54211.7 54231.7 1382.1 1417.2 1420.3 1422.7 1423.7 24997.0 25179.7 25418.4 26144.3 26424.7 37802.2 40430.0 42096.4 44752.3 44770.6 400846.0 468530.0 468825.0 469418.0 470419.0 22786.0 23173.4 23173.9 23279.5 23358.8 32781.7 35365.1 36511.6 40509.8 41818.4 26861.5 29636.7 30804.0 31726.4 32489.8 25844.2 31048.4 31880.7 32038.5 32059.7 30779.0 31207.5 31408.0 31792.0 31830.0 22321.0 26008.7 29361.0 29552.7 30235.1 17079.5 22485.9 22520.4 22572.3 22648.8 04:55:56 INFO - PROCESS | 1673 | 04:55:56 INFO - PROCESS | 1673 | [#2] jquery.html Cycles:180 Average:38812.04 Median:13884.81 stddev:105871.25 (762.5%) stddev-sans-first:106128.95 04:55:56 INFO - PROCESS | 1673 | Values: 398.6 401.2 412.2 415.2 446.0 19688.7 20181.2 20625.3 20690.3 20979.3 17695.8 20594.3 20750.8 21119.9 21296.8 6407.8 6692.7 6706.5 6707.6 6708.9 6224.3 6467.4 6472.6 6564.2 6583.9 6550.3 6552.4 6562.6 6565.8 6571.5 6381.9 6450.0 6473.0 6580.7 6600.1 6041.9 6377.5 6400.5 6402.0 6412.9 20302.5 24222.0 24721.0 24817.0 25110.0 2659.6 2691.7 2770.3 2776.7 2782.4 14082.9 14739.5 14941.4 15659.1 15715.1 1823.9 1865.0 1874.1 1879.6 1927.7 100740.0 148083.3 160991.0 172417.1 173417.0 16737.8 18068.7 18283.3 19114.0 19220.6 29533.4 29704.9 29752.9 29797.9 29803.9 9657.4 9669.4 9840.3 9876.2 10013.7 8162.4 8189.7 8190.3 8317.3 8323.5 7280.6 7919.9 8932.5 8978.8 9016.8 3425.8 3529.8 3847.8 3872.7 3942.3 805.2 813.3 820.3 838.7 854.6 19317.9 20699.9 21357.0 21418.3 21580.0 829.7 844.9 864.9 867.1 872.5 11003.9 11137.5 11167.7 11247.6 11275.7 486627.0 627096.0 660269.0 667842.0 677130.6 141551.0 142655.0 143527.0 146395.0 147772.3 1174.2 1233.9 1274.3 1283.4 1286.2 16795.7 19261.8 19502.6 19738.5 19743.5 49809.0 61827.7 62128.7 64445.7 66697.0 89258.0 90010.0 90264.0 90511.5 90609.0 9676.7 11254.5 11311.8 11357.4 11360.3 12252.6 12260.8 12585.8 12599.0 12614.9 9720.4 10644.3 10889.6 10939.0 10977.7 9723.9 9735.9 10606.2 10771.9 10820.6 9718.6 11195.2 11254.8 11468.7 11519.9 10982.4 11311.8 11342.1 11434.8 11474.9 10582.8 10606.6 10730.7 10950.8 10984.3 04:55:56 INFO - PROCESS | 1673 | 04:55:56 INFO - PROCESS | 1673 | [#3] mootools.html Cycles:180 Average:6599.37 Median:3359.77 stddev:4166.46 (124.0%) stddev-sans-first:4160.02 04:55:56 INFO - PROCESS | 1673 | Values: 1426.8 1496.1 1545.2 1561.0 1561.9 9193.8 9450.8 10355.8 11022.9 11099.6 10332.2 10629.4 10666.2 10681.8 10683.7 2243.5 2271.9 2286.3 2293.1 2294.1 2243.4 2277.0 2283.7 2289.6 2293.1 2251.0 2265.2 2268.3 2273.4 2280.2 2211.8 2217.8 2218.4 2230.1 2234.1 2197.3 2263.1 2264.8 2265.4 2268.0 10815.3 10897.5 10948.4 10963.7 10978.9 5486.5 5594.0 5632.8 5651.3 5655.1 3278.6 3331.6 3542.6 3576.4 3579.5 1182.3 1214.9 1220.3 1234.3 1245.9 14820.9 14875.7 14934.6 14967.9 14973.6 4447.7 4653.5 4739.1 4795.6 4798.9 10721.8 12731.2 12754.5 12792.3 12801.9 5616.7 5621.4 5623.8 5624.4 5629.2 4404.3 4885.1 5007.0 5032.2 5172.8 3934.7 3981.1 4019.3 4042.5 4070.3 1131.0 1137.2 1138.3 1149.6 1149.8 783.6 786.7 807.3 811.3 813.0 6380.7 6430.8 6577.1 6782.1 6797.3 871.8 873.7 1000.1 1025.7 1034.8 3387.9 3929.6 4208.0 4285.4 4421.2 12921.4 13332.6 13597.9 13790.7 13797.3 12775.3 13325.4 13362.5 13365.9 13534.1 9756.6 9997.0 10008.0 10021.5 10037.4 5416.5 5849.7 6427.7 6786.2 6790.7 11760.5 11917.3 12135.3 12331.3 12362.8 12258.3 12477.9 12501.7 12525.8 12541.7 8810.6 8818.8 8833.2 8883.6 9017.2 9691.0 9776.8 9850.0 9857.3 9946.3 7491.8 8786.0 8834.6 8902.2 8930.1 7088.8 8573.0 8627.7 8646.7 8713.7 7603.0 7651.8 7754.4 7755.7 7770.5 5734.6 5852.0 5896.1 5920.0 5967.6 5804.9 5845.4 5941.5 6063.9 6130.1 04:55:56 INFO - PROCESS | 1673 | 04:55:56 INFO - PROCESS | 1673 | [#4] prototype.html Cycles:180 Average:4607.81 Median:4962.22 stddev:1273.74 (25.7%) stddev-sans-first:1236.06 04:55:56 INFO - PROCESS | 1673 | Values: 323.5 343.9 348.4 355.7 355.8 4501.4 4902.7 5182.7 5291.6 5346.7 4457.4 4954.4 5115.7 5123.8 5280.7 3596.8 3798.4 4102.7 4260.4 4264.4 3331.0 3976.8 4260.4 4291.0 4330.9 3654.6 4201.9 4275.8 4307.6 4343.6 3475.9 4041.8 4279.3 4297.7 4462.5 3498.0 3626.5 3747.3 4171.3 4262.6 4862.2 5050.8 5055.9 5058.8 5059.3 4430.5 4554.9 4820.7 5093.6 5163.5 4520.4 4925.4 5668.8 5700.5 5707.7 4634.0 4740.7 4783.5 4796.5 4852.5 5477.4 5553.8 5792.4 5840.6 5920.6 4534.8 4543.2 4596.6 4887.7 4911.0 4247.7 4366.8 4518.8 5045.3 5133.3 4539.6 4970.0 4975.3 5210.7 5220.6 5537.2 5542.9 5577.3 5599.6 5689.6 1426.6 1496.6 1684.8 1746.7 1766.6 1248.0 1290.1 1319.7 1380.7 1414.9 4365.2 4660.2 4723.6 5118.4 5121.4 4811.6 5424.8 5446.9 5740.9 5754.2 4186.4 4402.3 4457.0 5128.5 5153.1 2516.6 2747.0 2828.0 2875.9 2934.4 4972.6 5300.5 5888.6 5889.8 5914.4 4892.9 5115.7 5226.6 5519.9 5922.3 4939.8 5674.2 5869.8 5879.1 6066.3 4794.4 5054.5 5243.3 5542.2 5790.0 5151.5 5273.0 5340.9 5646.2 5650.8 5393.8 5908.6 5930.9 5970.4 5973.6 4017.6 4053.7 4529.9 4535.7 4555.2 5016.7 5348.4 5411.9 5524.0 5766.0 5487.8 5536.5 5549.6 5551.5 5558.0 4602.8 4691.7 5363.9 5439.2 5504.8 4768.0 4827.4 4900.4 4951.7 5046.5 5566.8 5591.7 5596.4 5606.4 5620.5 4540.7 4993.3 5216.6 5381.5 5389.3 04:55:56 INFO - PROCESS | 1673 | 04:55:56 INFO - PROCESS | 1673 | [#5] yui.html Cycles:180 Average:18969.25 Median:48345.89 stddev:26533.88 (54.9%) stddev-sans-first:26572.83 04:55:56 INFO - PROCESS | 1673 | Values: 694.4 701.7 772.0 817.7 818.8 14448.6 15737.0 15781.6 17180.6 18134.7 17267.5 17419.7 17460.0 17533.2 17534.6 951.8 985.3 989.3 989.7 991.1 925.2 967.6 968.7 972.3 974.7 999.4 1013.8 1014.5 1016.0 1018.2 992.5 1008.8 1009.6 1010.9 1015.1 740.4 745.9 751.2 752.3 754.1 15397.2 15654.2 15924.6 16203.0 16446.8 13475.2 13617.3 13676.4 13856.2 14046.9 11079.1 11529.9 11586.2 11705.3 12297.9 3577.4 3584.8 3652.7 3660.3 3744.4 80917.8 96064.5 96215.0 99560.0 100853.0 9508.3 10250.5 10503.3 10527.0 10799.5 21268.8 21344.8 21389.9 21414.0 21443.2 7438.2 7525.9 7689.1 7755.1 7768.0 4065.4 4073.8 4167.2 4188.7 4311.2 3274.8 3362.5 3362.8 3364.0 3364.7 574.6 592.6 599.2 599.6 599.7 636.2 659.4 661.3 667.2 672.9 7723.6 8663.0 8902.7 10739.6 10893.9 514.5 533.3 550.6 596.8 672.2 3852.6 4579.5 4932.7 4948.3 5026.9 89732.6 91501.0 92953.5 93950.5 95465.0 71143.8 80122.6 81657.0 83890.2 85004.6 69901.0 71823.6 72373.6 72644.0 72686.6 9458.5 9468.1 9491.1 9503.0 9576.5 47221.0 47811.8 48316.5 48375.3 48449.3 59754.9 60344.8 60389.8 61169.7 61307.0 11082.3 11106.7 11267.6 11573.5 11704.9 12445.3 12525.4 12577.4 12630.1 12654.8 11792.2 11856.5 11926.9 11958.1 12088.9 10411.7 11318.8 11548.4 11881.0 12112.0 11381.4 11565.7 12118.8 12189.1 12258.3 9412.3 9512.4 9655.7 9658.7 10328.0 8898.4 8899.3 9172.5 9790.2 9934.8 04:55:56 INFO - PROCESS | 1673 | -------- Summary: end -------- 04:55:56 INFO - PROCESS | 1673 | 04:55:57 INFO - TEST-INFO | 1673: exit 0 04:55:57 INFO - TEST-OK | dromaeo_css | took 1117644ms 04:55:57 INFO - TEST-START | kraken 04:55:57 INFO - operating with platform_type : mac_ 04:55:57 INFO - Initialising browser for kraken test... 04:55:57 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpMOBjko/profile http://localhost:49242/getInfo.html) 04:56:00 INFO - PROCESS | 1680 | 2017-03-05 04:56:00.350 plugin-container[1682:12048] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 04:56:00 INFO - PROCESS | 1680 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:56:00 INFO - PROCESS | 1680 | 2017-03-05 04:56:00.351 plugin-container[1682:12048] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4323, name = 'com.apple.CFPasteboardClient' 04:56:00 INFO - PROCESS | 1680 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:56:00 INFO - PROCESS | 1680 | 2017-03-05 04:56:00.351 plugin-container[1682:12048] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:56:00 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 04:56:00 INFO - PROCESS | 1680 | colorDepth:24 04:56:00 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 04:56:00 INFO - PROCESS | 1680 | __metrics 04:56:00 ERROR - PROCESS | 1680 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3354: TypeError: this.tabs is undefined 04:56:01 INFO - TEST-INFO | 1680: exit 0 04:56:01 INFO - Browser initialized. 04:56:01 INFO - Running cycle 1/1 for kraken test... 04:56:01 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpMOBjko/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:56:03 INFO - PROCESS | 1683 | 2017-03-05 04:56:03.693 plugin-container[1684:12170] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 04:56:03 INFO - PROCESS | 1683 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:56:03 INFO - PROCESS | 1683 | 2017-03-05 04:56:03.694 plugin-container[1684:12170] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a1f, name = 'com.apple.CFPasteboardClient' 04:56:03 INFO - PROCESS | 1683 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:56:03 INFO - PROCESS | 1683 | 2017-03-05 04:56:03.694 plugin-container[1684:12170] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:56:13 INFO - PROCESS | 1683 | RSS: Main: 226574336 04:56:13 INFO - PROCESS | 1683 | 04:56:16 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 04:56:17 INFO - PROCESS | 1683 | RSS: Main: 241172480 04:56:17 INFO - PROCESS | 1683 | 04:56:20 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 04:56:20 INFO - PROCESS | 1683 | RSS: Main: 249454592 04:56:20 INFO - PROCESS | 1683 | 04:56:24 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 04:56:25 INFO - PROCESS | 1683 | RSS: Main: 252104704 04:56:25 INFO - PROCESS | 1683 | 04:56:27 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 04:56:27 INFO - PROCESS | 1683 | RSS: Main: 253300736 04:56:27 INFO - PROCESS | 1683 | 04:56:29 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:56:30 INFO - PROCESS | 1683 | RSS: Main: 254980096 04:56:30 INFO - PROCESS | 1683 | 04:56:33 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 04:56:34 INFO - PROCESS | 1683 | RSS: Main: 260837376 04:56:34 INFO - PROCESS | 1683 | 04:56:37 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 04:56:38 INFO - PROCESS | 1683 | RSS: Main: 259952640 04:56:38 INFO - PROCESS | 1683 | 04:56:41 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 04:56:42 INFO - PROCESS | 1683 | RSS: Main: 259825664 04:56:42 INFO - PROCESS | 1683 | 04:56:43 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:56:44 INFO - PROCESS | 1683 | RSS: Main: 259788800 04:56:44 INFO - PROCESS | 1683 | 04:56:46 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:56:47 INFO - PROCESS | 1683 | RSS: Main: 259694592 04:56:47 INFO - PROCESS | 1683 | 04:56:49 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:56:49 INFO - PROCESS | 1683 | RSS: Main: 260030464 04:56:49 INFO - PROCESS | 1683 | 04:56:52 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:56:53 INFO - PROCESS | 1683 | RSS: Main: 260292608 04:56:53 INFO - PROCESS | 1683 | 04:56:56 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:56:57 INFO - PROCESS | 1683 | RSS: Main: 259956736 04:56:57 INFO - PROCESS | 1683 | 04:56:59 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 04:56:59 INFO - PROCESS | 1683 | RSS: Main: 263208960 04:56:59 INFO - PROCESS | 1683 | 04:56:59 INFO - PROCESS | 1683 | __start_tp_report 04:56:59 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 04:56:59 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 04:56:59 INFO - PROCESS | 1683 | |i|pagename|runs| 04:56:59 INFO - PROCESS | 1683 | |0;ai-astar;108;120;122;120;128;172;124;120;122;120 04:56:59 INFO - PROCESS | 1683 | |1;audio-beat-detection;177;126;148;191;141;113;115;115;136;112 04:56:59 INFO - PROCESS | 1683 | |2;audio-dft;204;229;269;266;268;201;192;196;198;201 04:56:59 INFO - PROCESS | 1683 | |3;audio-fft;86;52;83;78;62;83;82;86;83;62 04:56:59 INFO - PROCESS | 1683 | |4;audio-oscillator;83;71;84;76;72;71;81;56;70;92 04:56:59 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;87;96;102;90;90;90;91;88;89;89 04:56:59 INFO - PROCESS | 1683 | |6;imaging-darkroom;97;122;151;129;97;97;98;98;95;96 04:56:59 INFO - PROCESS | 1683 | |7;imaging-desaturate;91;86;94;73;121;96;136;140;137;91 04:56:59 INFO - PROCESS | 1683 | |8;json-parse-financial;65;66;66;68;71;62;90;98;96;97 04:56:59 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;50;64;69;68;60;59;60;60;60;62 04:56:59 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;86;90;96;86;88;93;107;94;91;88 04:56:59 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;132;147;167;155;172;149;150;151;203;159 04:56:59 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;177;187;198;176;177;175;176;175;178;180 04:56:59 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;70;74;69;72;67;72;68;68;68;70 04:56:59 INFO - PROCESS | 1683 | __end_tp_report 04:56:59 INFO - PROCESS | 1683 | __start_cc_report 04:56:59 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,1013 04:56:59 INFO - PROCESS | 1683 | __end_cc_report 04:56:59 INFO - PROCESS | 1683 | __startTimestamp1488718619437__endTimestamp 04:56:59 INFO - PROCESS | 1683 | 04:56:59 INFO - PROCESS | 1683 | ------- Summary: start ------- 04:56:59 INFO - PROCESS | 1683 | Number of tests: 14 04:56:59 INFO - PROCESS | 1683 | 04:56:59 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:125.60 Median:122.00 stddev:17.07 (14.0%) stddev-sans-first:16.88 04:56:59 INFO - PROCESS | 1683 | Values: 108.0 120.0 122.0 120.0 128.0 172.0 124.0 120.0 122.0 120.0 04:56:59 INFO - PROCESS | 1683 | 04:56:59 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:138.50 stddev:27.77 (20.1%) stddev-sans-first:25.50 04:56:59 INFO - PROCESS | 1683 | Values: 177.0 126.0 148.0 191.0 141.0 113.0 115.0 115.0 136.0 112.0 04:56:59 INFO - PROCESS | 1683 | 04:56:59 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:222.40 Median:216.50 stddev:32.77 (15.1%) stddev-sans-first:34.08 04:56:59 INFO - PROCESS | 1683 | Values: 204.0 229.0 269.0 266.0 268.0 201.0 192.0 196.0 198.0 201.0 04:56:59 INFO - PROCESS | 1683 | 04:56:59 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:75.70 Median:83.00 stddev:12.27 (14.8%) stddev-sans-first:12.43 04:56:59 INFO - PROCESS | 1683 | Values: 86.0 52.0 83.0 78.0 62.0 83.0 82.0 86.0 83.0 62.0 04:56:59 INFO - PROCESS | 1683 | 04:56:59 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:75.60 Median:78.50 stddev:9.97 (12.7%) stddev-sans-first:10.21 04:56:59 INFO - PROCESS | 1683 | Values: 83.0 71.0 84.0 76.0 72.0 71.0 81.0 56.0 70.0 92.0 04:56:59 INFO - PROCESS | 1683 | 04:56:59 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:91.20 Median:90.00 stddev:4.49 (5.0%) stddev-sans-first:4.50 04:56:59 INFO - PROCESS | 1683 | Values: 87.0 96.0 102.0 90.0 90.0 90.0 91.0 88.0 89.0 89.0 04:56:59 INFO - PROCESS | 1683 | 04:56:59 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:108.00 Median:97.00 stddev:19.33 (19.9%) stddev-sans-first:20.09 04:56:59 INFO - PROCESS | 1683 | Values: 97.0 122.0 151.0 129.0 97.0 97.0 98.0 98.0 95.0 96.0 04:56:59 INFO - PROCESS | 1683 | 04:56:59 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:106.50 Median:88.50 stddev:24.55 (27.7%) stddev-sans-first:25.39 04:56:59 INFO - PROCESS | 1683 | Values: 91.0 86.0 94.0 73.0 121.0 96.0 136.0 140.0 137.0 91.0 04:56:59 INFO - PROCESS | 1683 | 04:56:59 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:77.90 Median:80.50 stddev:15.24 (18.9%) stddev-sans-first:15.44 04:56:59 INFO - PROCESS | 1683 | Values: 65.0 66.0 66.0 68.0 71.0 62.0 90.0 98.0 96.0 97.0 04:56:59 INFO - PROCESS | 1683 | 04:56:59 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:5.29 (8.7%) stddev-sans-first:3.75 04:56:59 INFO - PROCESS | 1683 | Values: 50.0 64.0 69.0 68.0 60.0 59.0 60.0 60.0 60.0 62.0 04:56:59 INFO - PROCESS | 1683 | 04:56:59 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:91.90 Median:90.50 stddev:6.28 (6.9%) stddev-sans-first:6.29 04:56:59 INFO - PROCESS | 1683 | Values: 86.0 90.0 96.0 86.0 88.0 93.0 107.0 94.0 91.0 88.0 04:56:59 INFO - PROCESS | 1683 | 04:56:59 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:158.50 Median:157.00 stddev:19.15 (12.2%) stddev-sans-first:17.75 04:56:59 INFO - PROCESS | 1683 | Values: 132.0 147.0 167.0 155.0 172.0 149.0 150.0 151.0 203.0 159.0 04:56:59 INFO - PROCESS | 1683 | 04:56:59 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.90 Median:177.50 stddev:7.28 (4.1%) stddev-sans-first:7.64 04:56:59 INFO - PROCESS | 1683 | Values: 177.0 187.0 198.0 176.0 177.0 175.0 176.0 175.0 178.0 180.0 04:56:59 INFO - PROCESS | 1683 | 04:56:59 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:2.25 (3.2%) stddev-sans-first:2.39 04:56:59 INFO - PROCESS | 1683 | Values: 70.0 74.0 69.0 72.0 67.0 72.0 68.0 68.0 68.0 70.0 04:56:59 INFO - PROCESS | 1683 | -------- Summary: end -------- 04:56:59 INFO - PROCESS | 1683 | 04:57:00 INFO - TEST-INFO | 1683: exit 0 04:57:00 INFO - TEST-OK | kraken | took 63053ms 04:57:00 INFO - SUITE-END | took 1180s 04:57:00 INFO - Completed test suite (00:19:40) 04:57:00 INFO - javascript benchmark 04:57:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7424.095564866477, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2895.5367141257398, 3236.7053178728506, 3299.736021118311, 3375.0718552398102, 3440.3119376124782, 5045.77294021769, 5643.633163844347, 5767.365589785126, 5786.652800831947, 5904.940950590493, 4751.524847515247, 5707.4577915098, 5791.362950075489, 5886.028805247129, 5941.168236446901, 5176.922346164792, 5304.939012197557, 5328.440513746059, 5412.756425960822, 5416.729163541827, 4937.185364414885, 5286.259923610698, 5367.677939323634, 5407.648502847303, 5411.312657501442, 4400.823967041314, 5150.665206761549, 5192.350956130484, 5333.813316533941, 5385.973070134643, 3998.5601583825755, 4432.53458386868, 5238.1618940969265, 5384.730763461811, 5387.488188622075, 5249.606279529051, 5252.6323157379, 5280.841574752763, 5313.734313284359, 5342.946570534284, 4641.535846415365, 5511.889762204733, 5679.0, 5909.054551271776, 5994.6403215807195, 6123.923256659767, 6181.505479561669, 6209.0, 6256.15541901842, 6301.212348456443, 6271.059341098826, 6294.464970477515, 6304.054391841215, 6314.747410103636, 6316.431521163117, 5150.330457040635, 6009.969950150265, 6013.308469525973, 6054.8183554493435, 6070.423309785563, 6145.371476558716, 6189.04069869171, 6261.935470969946, 6315.810525684236, 6421.0, 5756.769729210869, 6217.937820621736, 6229.470495007885, 6264.906026409608, 6320.968395158086, 5055.620828437882, 6136.090214303957, 6295.937040629627, 6302.716377763011, 6315.305316415191, 5167.689938603696, 6171.0, 6180.690965451709, 6201.751929922752, 6260.311365749764, 6146.108814221912, 6156.415140561639, 6255.249370075529, 6261.937380626136, 6300.59046161998, 5057.367829021372, 5093.1087059764395, 5094.006668699568, 5105.744712764347, 5141.331626888481, 4532.524084971096, 4546.1589605922345, 4553.317002449593, 4563.338315944236, 4563.931541026821, 5788.016037273674, 5847.502962248172, 5930.762769489172, 6063.393660633901, 6098.71926895348, 6143.849652621547, 6160.983437732813, 6206.813795586139, 6261.843453913689, 6264.906026409608, 6046.455818976226, 6059.818205453844, 6062.211912451353, 6066.181065556182, 6106.72519736613, 5586.24585680936, 5591.27313449249, 5591.608587398924, 5595.356533998643, 5610.579206559524, 5518.613697041169, 6103.246756470893, 6241.781537646342, 6344.333844946214, 6573.638449885302, 5446.673199608036, 6234.906476402948, 6298.559100862895, 6298.842528936813, 6346.524010699124, 6404.135441715495, 6408.455281301141, 6475.158229430144, 6477.77327793525, 6489.383508566679, 6101.755929762938, 6140.105498721277, 6144.740328232612, 6255.874882502416, 6281.874362512633, 6163.660998645118, 6183.505319574333, 6196.876062478635, 6233.096201050732, 6240.843978900564, 5220.190870415092, 5985.713071689607, 6029.276486821434, 6253.468455181361, 6257.874842503215, 6032.245969253843, 6041.24484439445, 6104.694765261808, 6144.969275153596, 6200.255969283715, 6051.7579296827635, 6075.301340345917, 6157.384261573807, 6161.045038019114, 6184.165137706352, 5982.7735314261345, 6063.029915213545, 6074.544409169418, 6079.817605471843, 6209.067446405416, 5945.583809133319, 5977.850553736192, 6006.129111278928, 6008.759649613967, 6054.424829641177], "value": 5708.93054426002, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.6366125953244, 711.1785887300167, 801.1027649033084, 932.5150921520809, 933.383966582056, 36647.900562983086, 38958.610413895854, 38962.8051859741, 39002.41496377553, 39185.60814391859, 37711.0, 37911.81044094776, 37995.24009519808, 38014.0, 38087.809560952155, 7569.848603027936, 7724.111727151365, 10134.087932086148, 10439.478026098703, 10586.1531077514, 10356.17150627948, 10449.477526123663, 10450.68647940563, 10468.42423666698, 10471.952804719544, 10466.005729455728, 10486.37081775096, 10491.632792852251, 10491.790164196711, 10497.4226417547, 10437.530311135979, 10439.37363758177, 10454.006869347475, 10464.686059418229, 10481.266311358208, 9297.721068367891, 9784.168345690625, 10153.644622438253, 10244.129249013842, 10248.128909042665, 32245.51631725526, 32339.353212935846, 32443.351132977445, 32503.0, 32524.512132318036, 3634.8913581357674, 3655.5065066215984, 3681.7975011374365, 3698.6301369863068, 3758.7180961428003, 22303.330900073022, 24374.146904858422, 25193.496130077478, 25207.117750878813, 25260.494790104094, 3052.3742632760454, 3060.0, 3154.9842250788597, 3189.740052679202, 3191.6010498687665, 256036.0, 302993.42516437045, 314474.0, 315756.0, 316162.0, 41826.58173418288, 41896.924945883286, 41899.7905010473, 41990.37014444786, 42085.57914420817, 43540.91147721269, 43713.56286437158, 43753.343699844525, 43807.561924380345, 43859.0, 12684.42920068599, 12764.234145951272, 12787.424565894557, 12806.231626102464, 12830.743385132246, 9129.77175570616, 10886.67339979802, 10929.890701093047, 10934.617288395028, 10941.398223097805, 9198.310126740522, 11199.496022678999, 11294.830577541343, 11311.83032254517, 11340.319580825177, 2764.585312203186, 2844.445333160014, 2887.581300711385, 5474.589405794582, 5526.557875370041, 921.6221349246777, 941.7880976780169, 975.7267964969819, 1028.8631062675636, 1075.870895492546, 27496.03763868255, 27530.862345688143, 27697.861510692317, 27781.0, 28233.576496352573, 901.364538000708, 1036.4196050211906, 1043.1289872956015, 1054.6572363981736, 1055.963041293551, 13193.73612527744, 13584.660383490493, 13928.51250206238, 13958.58124256274, 13978.930105349407, 469510.0, 472438.0, 472886.0, 473060.0, 473841.63079185074, 53774.0, 54180.0, 54202.45797541974, 54211.72894135583, 54231.72884135633, 1382.0740104130257, 1417.2134465371612, 1420.3182472413093, 1422.679897023182, 1423.7294913966314, 24997.0, 25179.74820251774, 25418.364540885887, 26144.34639134037, 26424.735752642995, 37802.2439551202, 40429.989250268976, 42096.36855447232, 44752.328715069954, 44770.552294477944, 400846.0, 468530.0, 468825.0, 469418.0, 470419.0, 22785.974631141307, 23173.42066448352, 23173.884130579238, 23279.53440931206, 23358.76641233634, 32781.672183277864, 35365.1158721034, 36511.63488365189, 40509.797451013736, 41818.37272440977, 26861.462770744085, 29636.666350014733, 30804.0, 31726.365472689955, 32489.83755081304, 25844.224673259832, 31048.379032418772, 31880.7247710089, 32038.51942220822, 32059.679403205668, 30779.0, 31207.531887021258, 31408.0, 31792.0, 31830.0, 22321.0, 26008.73991260063, 29361.0, 29552.704472954996, 30235.09294721162, 17079.48761537156, 22485.88757056204, 22520.436989074748, 22572.322830315115, 22648.773512264666], "value": 17296.330576631233, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.6113539299184, 401.20361083249765, 412.2044454203388, 415.19245068342076, 446.00540794029314, 19688.70466942997, 20181.192752289928, 20625.27811526597, 20690.275840345592, 20979.265725699603, 17695.82304176961, 20594.279200227957, 20750.792492075074, 21119.894400528014, 21296.787032129672, 6407.807765767035, 6692.698828552702, 6706.530542862001, 6707.631080290582, 6708.932910670904, 6224.3153253142345, 6467.353264673518, 6472.611643301393, 6564.179477565304, 6583.93416065838, 6550.344965503459, 6552.443042341383, 6562.573432726857, 6565.80302590923, 6571.474282057447, 6381.872362552746, 6449.967750161242, 6472.967635161817, 6580.670966451707, 6600.108985287021, 6041.939580604182, 6377.5216858735785, 6400.487960963112, 6402.007688808196, 6412.93587064128, 20302.492437689176, 24222.031118755403, 24721.0, 24817.00731970719, 25110.0, 2659.614355918381, 2691.7308269173122, 2770.3074231442138, 2776.6806817216075, 2782.3600571868583, 14082.859171408258, 14739.48800303231, 14941.402343906231, 15659.13874736889, 15715.135667538281, 1823.8996855172961, 1864.9720254196197, 1874.08169996702, 1879.5958868843127, 1927.6915693488975, 100740.0, 148083.25958370246, 160991.0, 172417.13791431213, 173417.0, 16737.82408286915, 18068.728969065476, 18283.268669253346, 19114.044297785334, 19220.615587688168, 29533.409331813244, 29704.851475742482, 29752.85123574368, 29797.851010745242, 29803.85098074496, 9657.372270802376, 9669.371490853073, 9840.261980351503, 9876.160526355197, 10013.749656258651, 8162.428629995843, 8189.7133600323705, 8190.262876341158, 8317.251447369767, 8323.5005899645, 7280.635968201569, 7919.891215229873, 8932.508712020901, 8978.820423591622, 9016.774580635536, 3425.760196786251, 3529.835154399042, 3847.8460861565222, 3872.7095467840027, 3942.290387730236, 805.2390490986079, 813.341193633159, 820.274057459141, 838.6813011055759, 854.5812551849673, 19317.903410483137, 20699.8965005174, 21357.0, 21418.250361237595, 21580.0, 829.722043115551, 844.9016278837487, 864.8540683594263, 867.1112110087086, 872.4634349874781, 11003.944980275208, 11137.498812553455, 11167.664970050912, 11247.606333778278, 11275.718107047225, 486627.0, 627096.0, 660269.0, 667842.0, 677130.614346935, 141551.0, 142655.0, 143527.0, 146395.0, 147772.26113869576, 1174.236746115015, 1233.8827811357908, 1274.254561081759, 1283.371148137406, 1286.1704200790625, 16795.748063779298, 19261.807381926003, 19502.609947801247, 19738.50653733668, 19743.506412339808, 49809.0, 61827.6908615454, 62128.689356552924, 64445.67777161084, 66697.0, 89258.0, 90010.0, 90264.0, 90511.54744226237, 90609.0, 9676.70969870905, 11254.493547790205, 11311.830322545004, 11357.432128393713, 11360.318380897173, 12252.571160009356, 12260.754784904073, 12585.811212831632, 12599.0, 12614.873851261736, 9720.368176068532, 10644.254902156774, 10889.618863339745, 10939.0, 10977.737560180682, 9723.9027609723, 9735.929047804877, 10606.151507879506, 10771.946140269249, 10820.621278255223, 9718.562664679965, 11195.160362972647, 11254.831177532507, 11468.655940321803, 11519.884801152217, 10982.395968221825, 11311.830322545004, 11342.092632589538, 11434.82847757301, 11474.94262528682, 10582.841257380991, 10606.575736970435, 10730.731731706457, 10950.835737463785, 10984.340939543654], "value": 10991.259705618575, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.7645838436658, 1496.147196098223, 1545.1501674079261, 1560.9609759756004, 1561.882858785591, 9193.77015574611, 9450.81098378032, 10355.844662330062, 11022.889771102296, 11099.611513597025, 10332.17342612591, 10629.362238265709, 10666.200034997386, 10681.78636427273, 10683.679489615304, 2243.5064285857165, 2271.9432014199697, 2286.27982185611, 2293.1286111277773, 2294.1167650454613, 2243.371855880348, 2276.9772302277015, 2283.748787633359, 2289.645105008718, 2293.128611127769, 2250.966235506469, 2265.184533567914, 2268.3308424014954, 2273.3520946530243, 2280.2247235939776, 2211.756706762255, 2217.81148602369, 2218.4121207879843, 2230.096810791632, 2234.0728597632046, 2197.2968650031994, 2263.106073101132, 2264.79616834484, 2265.444965983328, 2268.036084664011, 10815.297005694605, 10897.455127243606, 10948.3978381189, 10963.671089867237, 10978.890211097867, 5486.478784515464, 5593.972030139864, 5632.7746890124345, 5651.2935883014625, 5655.123455864347, 3278.5573947517255, 3331.600207975034, 3542.5926018507685, 3576.409892367756, 3579.480975258599, 1182.266994463438, 1214.878512148787, 1220.2861326124228, 1234.2594443334017, 1245.912786104973, 14820.925895370561, 14875.702485950329, 14934.551963441114, 14967.925160374238, 14973.550793476214, 4447.73313601185, 4653.53464653532, 4739.123262196505, 4795.592374648194, 4798.880027999258, 10721.78556428867, 12731.172473789175, 12754.489820407265, 12792.2964236966, 12801.871981280254, 5616.66300022, 5621.381648018714, 5623.775048998076, 5624.409437009137, 5629.211910332557, 4404.317330813729, 4885.145099607555, 5007.0, 5032.169692000779, 5172.844814655567, 3934.6655534279907, 3981.1042515433796, 4019.3167161582014, 4042.4946881639794, 4070.2673518766906, 1130.971725706864, 1137.1869113583662, 1138.299945533491, 1149.5574203931546, 1149.816029435303, 783.5572901310741, 786.6971216081736, 807.3057170833079, 811.2638952641234, 812.9674813007414, 6380.723855228973, 6430.839229019312, 6577.144971153815, 6782.118324617768, 6797.2523022467485, 871.7776966873407, 873.6985739919718, 1000.0849222960909, 1025.738436698637, 1034.7671773850973, 3387.932241355159, 3929.626685464876, 4207.957920420818, 4285.442892423965, 4421.226285400042, 12921.418536165895, 13332.600021999355, 13597.932010340082, 13790.65523361904, 13797.310134493235, 12775.297358645177, 13325.400356983959, 13362.465501379836, 13365.866341336656, 13534.120282181626, 9756.609735610497, 9996.950015249877, 10007.99920008008, 10021.549030293654, 10037.44794036335, 5416.539594134542, 5849.707514624167, 6427.6786160690845, 6786.150509759033, 6790.728370865308, 11760.529578816751, 11917.284962902253, 12135.271883687006, 12331.260124392566, 12362.847473894099, 12258.325792081521, 12477.875221247672, 12501.687457813263, 12525.812112818132, 12541.686457838627, 8810.559472026245, 8818.823623527622, 8833.249173820297, 8883.555822208993, 9017.188453039258, 9691.030896910253, 9776.755581110529, 9850.014998500093, 9857.30998830075, 9946.254030947563, 7491.838764991435, 8785.956070219609, 8834.558272086242, 8902.243309318781, 8930.062343453843, 7088.751893683696, 8573.014103378191, 8627.6980305689, 8646.740597782076, 8713.695020674246, 7603.0, 7651.846963060596, 7754.418418618513, 7755.650995705094, 7770.53376797394, 5734.569907257056, 5851.970740146272, 5896.115582662635, 5919.970400147971, 5967.552433567413, 5804.883902322014, 5845.386234445492, 5941.465268125889, 6063.878722425615, 6130.111133885651], "value": 5012.170430663874, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.5082674335011, 343.8607364017572, 348.39031694534566, 355.7349774418059, 355.8078637535731, 4501.437320334958, 4902.730349830758, 5182.714950677711, 5291.550218231455, 5346.732663366831, 4457.375967364572, 4954.405471343435, 5115.667481613693, 5123.820666276681, 5280.735963201843, 3596.8021758803256, 3798.3667023180024, 4102.671786257107, 4260.446142001535, 4264.42430271914, 3330.9840498648023, 3976.8467144528195, 4260.3810551990355, 4290.957090429102, 4330.870073897788, 3654.579723331811, 4201.894952626193, 4275.8075886585175, 4307.6123148916595, 4343.630791382736, 3475.8783442579643, 4041.7574945503366, 4279.277028984788, 4297.720648157875, 4462.486814016397, 3497.965020349815, 3626.5131296168443, 3747.3254814133447, 4171.270027745132, 4262.573742625744, 4862.17343051682, 5050.797968081272, 5055.898882022376, 5058.822941197041, 5059.316992206079, 4430.468343798732, 4554.8861278467975, 4820.662553621248, 5093.617978651616, 5163.457836927144, 4520.389747384094, 4925.350007747409, 5668.829935101953, 5700.543956483471, 5707.6575405475805, 4633.976830115862, 4740.691855029412, 4783.521647835189, 4796.544328288807, 4852.514748525155, 5477.424870388591, 5553.778168802816, 5792.391798861101, 5840.591158618899, 5920.585559010871, 4534.795934182904, 4543.1822271990695, 4596.632269418438, 4887.682300650446, 4910.950890491121, 4247.723897946624, 4366.8034938427845, 4518.825105472601, 5045.268436076748, 5133.332666753298, 4539.592726254871, 4970.030843985461, 4975.278584605285, 5210.6613070150315, 5220.556252718486, 5537.197106419627, 5542.949108829678, 5577.330720313588, 5599.552035837123, 5689.630174038674, 1426.586289975916, 1496.5510346895887, 1684.8146703862565, 1746.7292569651725, 1766.611345503987, 1247.9517205547384, 1290.0647030902521, 1319.6898728798917, 1380.7169530246276, 1414.886809055273, 4365.214261432972, 4660.184467718136, 4723.551807180777, 5118.360204974379, 5121.436641969381, 4811.615070794328, 5424.80654256063, 5446.863828404322, 5740.942590574125, 5754.223179870748, 4186.388240527419, 4402.295632698753, 4456.955430445719, 5128.487151284841, 5153.1497302945345, 2516.6476693262957, 2746.986265068702, 2827.9536571468275, 2875.8849646013923, 2934.4424559333656, 4972.563443912457, 5300.515855560449, 5888.558358123072, 5889.823305300848, 5914.378990206053, 4892.936009726337, 5115.74421278942, 5226.555742761831, 5519.917201241985, 5922.318933322636, 4939.839137802614, 5674.177244299553, 5869.8239052828485, 5879.089850524018, 6066.332703402622, 4794.352762377034, 5054.494550544916, 5243.292155558951, 5542.168674698827, 5790.0, 5151.5363617274625, 5272.971770504715, 5340.872762148381, 5646.237757902631, 5650.84157747669, 5393.784248630168, 5908.61593996406, 5930.90767370513, 5970.432808883149, 5973.611715238496, 4017.6384125428854, 4053.6959728021106, 4529.8641040768825, 4535.727856328631, 4555.180067587866, 5016.698998060128, 5348.384935732285, 5411.891762164656, 5524.0, 5765.971170144123, 5487.826195530029, 5536.54308281837, 5549.5837812163445, 5551.528120109836, 5558.0, 4602.815887364468, 4691.695039822401, 5363.892722145613, 5439.207244284824, 5504.80733174353, 4767.974885399656, 4827.42070951474, 4900.436449808318, 4951.702897826142, 5046.492687582096, 5566.777328906798, 5591.664500130005, 5596.356419011866, 5606.411326810626, 5620.4660557247, 4540.659450541157, 4993.27597498368, 5216.608754343515, 5381.515663590296, 5389.299391079135], "value": 4238.949157050808, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.3542505469911, 701.6737217194001, 771.9922800771991, 817.7015389382875, 818.8034871630808, 14448.566543003713, 15736.977096488734, 15781.605459863495, 17180.570485737862, 18134.727979080326, 17267.481975540722, 17419.73870391945, 17460.0, 17533.211005504752, 17534.561635959108, 951.8477043672997, 985.3447457440793, 989.3371441134457, 989.6981420666693, 991.1278075293732, 925.2459245714755, 967.6371360739722, 968.6754937096046, 972.3290929258824, 974.7368210583138, 999.440313424481, 1013.7769690668041, 1014.4826138669258, 1015.973866394939, 1018.2414101494397, 992.4789485520088, 1008.8284991551454, 1009.6314845081566, 1010.8736407949007, 1015.0914931136591, 740.3521918321469, 745.9216782237842, 751.1511991449627, 752.2778132992333, 754.0687251244708, 15397.23013849303, 15654.217289135499, 15924.601884952854, 16203.02781833082, 16446.83553164477, 13475.191488510623, 13617.319134043259, 13676.384562694602, 13856.168629882239, 14046.92976535121, 11079.113670906308, 11529.884701152965, 11586.246893951866, 11705.297682139098, 12297.938510307391, 3577.4454959481322, 3584.7849129052343, 3652.652997965189, 3660.2862441823854, 3744.4383342498572, 80917.78623320656, 96064.51967740187, 96215.0, 99560.0, 100853.0, 9508.334416590773, 10250.538725757358, 10503.264771466076, 10527.0, 10799.514021869034, 21268.787312126682, 21344.77053121995, 21389.893050534647, 21414.03636836346, 21443.249486267905, 7438.218987006287, 7525.871119332034, 7689.077310722637, 7755.069391673035, 7767.961160194162, 4065.3901914712437, 4073.7555746655294, 4167.249895018926, 4188.748675079505, 4311.202427550913, 3274.7707660464016, 3362.4620060790157, 3362.7814192077926, 3363.9663603364143, 3364.6803553662853, 574.6494638270651, 592.5644651181378, 599.1611743558965, 599.5892813422819, 599.6821684507219, 636.2333388267127, 659.4131223211346, 661.2825084783065, 667.2393471442559, 672.9024291477708, 7723.613819309012, 8663.003754568179, 8902.688405905892, 10739.570417183382, 10893.857538022155, 514.4547919134488, 533.3174134105456, 550.5733056880949, 596.7549593503916, 672.2034389248756, 3852.5569559500454, 4579.473360563577, 4932.7286999215385, 4948.307236986825, 5026.874328141826, 89732.55133724421, 91501.0, 92953.53523232476, 93950.53024734833, 95465.0, 71143.79852906632, 80122.59938700269, 81657.0, 83890.16109838945, 85004.57497712596, 69901.0, 71823.64088179526, 72373.638131809, 72644.0, 72686.63656681789, 9458.527073646428, 9468.053194680477, 9491.145796878314, 9502.952485237529, 9576.521173941414, 47221.0, 47811.76094119507, 48316.5168348312, 48375.2644021401, 48449.27326090041, 59754.92083172979, 60344.7586289648, 60389.79220415479, 61169.69415152896, 61307.0, 11082.335059896432, 11106.666799996014, 11267.619644473416, 11573.479193436147, 11704.94147529291, 12445.315507647167, 12525.37373131358, 12577.371131443208, 12630.115891887479, 12654.810177847523, 11792.23350482216, 11856.466459009192, 11926.940365298118, 11958.103142264192, 12088.939555302168, 10411.739706507398, 11318.773624527299, 11548.364839933884, 11881.0, 12112.0, 11381.43092845371, 11565.653030409101, 12118.818217726564, 12189.08581856382, 12258.325792081521, 9412.341136120405, 9512.38169518979, 9655.733960896674, 9658.661946831828, 10328.018838210359, 8898.42160259581, 8899.332550058642, 9172.541372931193, 9790.216782657513, 9934.801303974025], "value": 7260.7664291816, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1581.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 120.0, 122.0, 120.0, 128.0, 172.0, 124.0, 120.0, 122.0, 120.0], "value": 125.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 126.0, 148.0, 191.0, 141.0, 113.0, 115.0, 115.0, 136.0, 112.0], "value": 137.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 229.0, 269.0, 266.0, 268.0, 201.0, 192.0, 196.0, 198.0, 201.0], "value": 222.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 52.0, 83.0, 78.0, 62.0, 83.0, 82.0, 86.0, 83.0, 62.0], "value": 75.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 71.0, 84.0, 76.0, 72.0, 71.0, 81.0, 56.0, 70.0, 92.0], "value": 75.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 96.0, 102.0, 90.0, 90.0, 90.0, 91.0, 88.0, 89.0, 89.0], "value": 91.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 122.0, 151.0, 129.0, 97.0, 97.0, 98.0, 98.0, 95.0, 96.0], "value": 108.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 86.0, 94.0, 73.0, 121.0, 96.0, 136.0, 140.0, 137.0, 91.0], "value": 106.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 68.0, 71.0, 62.0, 90.0, 98.0, 96.0, 97.0], "value": 77.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 64.0, 69.0, 68.0, 60.0, 59.0, 60.0, 60.0, 60.0, 62.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 90.0, 96.0, 86.0, 88.0, 93.0, 107.0, 94.0, 91.0, 88.0], "value": 91.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 147.0, 167.0, 155.0, 172.0, 149.0, 150.0, 151.0, 203.0, 159.0], "value": 158.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 187.0, 198.0, 176.0, 177.0, 175.0, 176.0, 175.0, 178.0, 180.0], "value": 179.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 74.0, 69.0, 72.0, 67.0, 72.0, 68.0, 68.0, 68.0, 70.0], "value": 69.8, "unit": "score"}]}]} 04:57:00 INFO - Return code: 0 04:57:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:57:00 ERROR - # TBPL SUCCESS # 04:57:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:57:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:57:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:57:00 INFO - 2017-03-05 04:57:00.756 screenresolution[1688:12568] starting screenresolution argv=screenresolution get 04:57:00 INFO - 2017-03-05 04:57:00.758 screenresolution[1688:12568] Display 0: 1600x1200x32@60 04:57:00 INFO - 2017-03-05 04:57:00.765 screenresolution[1689:12571] starting screenresolution argv=screenresolution list 04:57:00 INFO - Available Modes on Display 0 04:57:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:57:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:57:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:57:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:57:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:57:00 INFO - Intel Iris: 04:57:00 INFO - Chipset Model: Intel Iris 04:57:00 INFO - Type: GPU 04:57:00 INFO - Bus: Built-In 04:57:00 INFO - VRAM (Dynamic, Max): 1536 MB 04:57:00 INFO - Vendor: Intel (0x8086) 04:57:00 INFO - Device ID: 0x0a2e 04:57:00 INFO - Revision ID: 0x0009 04:57:00 INFO - Displays: 04:57:00 INFO - Display: 04:57:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:57:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:57:00 INFO - Display Serial Number: 1600x1200 60 04:57:00 INFO - Main Display: Yes 04:57:00 INFO - Mirror: Off 04:57:00 INFO - Online: Yes 04:57:00 INFO - Rotation: Supported 04:57:01 INFO - Return code: 0 04:57:01 INFO - Running post-action listener: _resource_record_post_action 04:57:01 INFO - [mozharness: 2017-03-05 12:57:01.002724Z] Finished run-tests step (success) 04:57:01 INFO - Running post-run listener: _resource_record_post_run 04:57:01 INFO - Total resource usage - Wall time: 1202s; CPU: 55.0%; Read bytes: 34705408; Write bytes: 514603520; Read time: 321; Write time: 1665 04:57:01 INFO - TinderboxPrint: CPU usage
55.0% 04:57:01 INFO - TinderboxPrint: I/O read bytes / time
34,705,408 / 321 04:57:01 INFO - TinderboxPrint: I/O write bytes / time
514,603,520 / 1,665 04:57:01 INFO - TinderboxPrint: CPU idle
2,164.1 (45.0%) 04:57:01 INFO - TinderboxPrint: CPU system
971.0 (20.2%) 04:57:01 INFO - TinderboxPrint: CPU user
1,670.7 (34.8%) 04:57:01 INFO - TinderboxPrint: Swap in / out
240,783,360 / 0 04:57:01 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205750784; Write bytes: 203888128; Read time: 15543; Write time: 509 04:57:01 INFO - run-tests - Wall time: 1182s; CPU: 55.0%; Read bytes: 32624640; Write bytes: 299803648; Read time: 292; Write time: 1121 04:57:01 INFO - Running post-run listener: _upload_blobber_files 04:57:01 INFO - Blob upload gear active. 04:57:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:57:01 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 04:57:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:57:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:57:01 INFO - (blobuploader) - INFO - Open directory for files ... 04:57:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:57:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:57:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:03 INFO - (blobuploader) - INFO - Done attempting. 04:57:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:57:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:57:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:04 INFO - (blobuploader) - INFO - Done attempting. 04:57:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:57:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:57:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:05 INFO - (blobuploader) - INFO - Done attempting. 04:57:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:57:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:57:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:06 INFO - (blobuploader) - INFO - Done attempting. 04:57:06 INFO - (blobuploader) - INFO - Iteration through files over. 04:57:07 INFO - Return code: 0 04:57:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:57:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:57:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/363b267dc441816de609bae87117c0425be4bfce1420b93a87cd00fa4816c6d8d2be3ec4ef12dc343c61396da29f977e7495e73ab8e2a7e39557502750c0b4de", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24bbd74a817e0d3dde91b0b3d167df33e72431517a8b91174e5d65ecea5fc0d7731a7d85e43eb04daeabfad5475a4ef56b08ca620a4ac2abd02c2cc3a763778f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cc3a17db038b4d648ff0a97edffbd08af4add4c4d906011d9194027f90516b1501f0eabfd85d79421f8b4e081ea66c86c7624701130b2f8087d12ec094822b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ddf06d9ecf2fc6cdad4faeb2a894fae37dae5d041ffe002d8f09a2c5cb7fddb44e1c6ef4a66b59cc6733ae580605234c9415eddae62454b0f8b4dcb06230636"} 04:57:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:57:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:57:07 INFO - Contents: 04:57:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/363b267dc441816de609bae87117c0425be4bfce1420b93a87cd00fa4816c6d8d2be3ec4ef12dc343c61396da29f977e7495e73ab8e2a7e39557502750c0b4de", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24bbd74a817e0d3dde91b0b3d167df33e72431517a8b91174e5d65ecea5fc0d7731a7d85e43eb04daeabfad5475a4ef56b08ca620a4ac2abd02c2cc3a763778f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cc3a17db038b4d648ff0a97edffbd08af4add4c4d906011d9194027f90516b1501f0eabfd85d79421f8b4e081ea66c86c7624701130b2f8087d12ec094822b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ddf06d9ecf2fc6cdad4faeb2a894fae37dae5d041ffe002d8f09a2c5cb7fddb44e1c6ef4a66b59cc6733ae580605234c9415eddae62454b0f8b4dcb06230636"} 04:57:07 INFO - Running post-run listener: copy_logs_to_upload_dir 04:57:07 INFO - Copying logs to upload dir... 04:57:07 INFO - mkdir: /builds/slave/test/build/upload/logs 04:57:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.516675 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-05 04:57:07.059136) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-05 04:57:07.062525) ========= 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.d82oAMkrKP/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.jTEg8fJHfo/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/363b267dc441816de609bae87117c0425be4bfce1420b93a87cd00fa4816c6d8d2be3ec4ef12dc343c61396da29f977e7495e73ab8e2a7e39557502750c0b4de", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24bbd74a817e0d3dde91b0b3d167df33e72431517a8b91174e5d65ecea5fc0d7731a7d85e43eb04daeabfad5475a4ef56b08ca620a4ac2abd02c2cc3a763778f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cc3a17db038b4d648ff0a97edffbd08af4add4c4d906011d9194027f90516b1501f0eabfd85d79421f8b4e081ea66c86c7624701130b2f8087d12ec094822b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ddf06d9ecf2fc6cdad4faeb2a894fae37dae5d041ffe002d8f09a2c5cb7fddb44e1c6ef4a66b59cc6733ae580605234c9415eddae62454b0f8b4dcb06230636"} build_url:https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011354 build_url: 'https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/363b267dc441816de609bae87117c0425be4bfce1420b93a87cd00fa4816c6d8d2be3ec4ef12dc343c61396da29f977e7495e73ab8e2a7e39557502750c0b4de", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24bbd74a817e0d3dde91b0b3d167df33e72431517a8b91174e5d65ecea5fc0d7731a7d85e43eb04daeabfad5475a4ef56b08ca620a4ac2abd02c2cc3a763778f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cc3a17db038b4d648ff0a97edffbd08af4add4c4d906011d9194027f90516b1501f0eabfd85d79421f8b4e081ea66c86c7624701130b2f8087d12ec094822b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ddf06d9ecf2fc6cdad4faeb2a894fae37dae5d041ffe002d8f09a2c5cb7fddb44e1c6ef4a66b59cc6733ae580605234c9415eddae62454b0f8b4dcb06230636"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-05 04:57:07.096979) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 04:57:07.097309) ========= 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.d82oAMkrKP/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.jTEg8fJHfo/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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.005082 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 04:57:07.145854) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-05 04:57:07.146178) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-05 04:57:07.146484) ========= ========= Total master_lag: 0.20 =========