builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0188 starttime: 1491219829.49 results: success (0) buildid: 20170403031423 builduid: af923ef774b54073bed7e085d6e2c657 revision: aaa0cd3bd620daf6be29c72625f6e63fd0bc1d46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 04:43:49.491571) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 04:43:49.492119) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 04:43:49.492451) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 04:43:49.520206) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 04:43:49.520662) ========= 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.qbh5eP0TZk/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.WNjCrAbet1/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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-04-03 04:43:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.5M=0.001s 2017-04-03 04:43:49 (15.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.246274 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 04:43:49.791972) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 04:43:49.792349) ========= 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.qbh5eP0TZk/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.WNjCrAbet1/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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.029179 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 04:43:49.845389) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-03 04:43:49.845823) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev aaa0cd3bd620daf6be29c72625f6e63fd0bc1d46 --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 aaa0cd3bd620daf6be29c72625f6e63fd0bc1d46 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qbh5eP0TZk/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.WNjCrAbet1/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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-04-03 04:43:49,978 truncating revision to first 12 chars 2017-04-03 04:43:49,978 Setting DEBUG logging. 2017-04-03 04:43:49,978 attempt 1/10 2017-04-03 04:43:49,978 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/aaa0cd3bd620?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-03 04:43:51,290 unpacking tar archive at: mozilla-central-aaa0cd3bd620/testing/mozharness/ program finished with exit code 0 elapsedTime=1.585285 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-03 04:43:51.460008) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 04:43:51.460823) ========= script_repo_revision: aaa0cd3bd620daf6be29c72625f6e63fd0bc1d46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 04:43:51.461796) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 04:43:51.462512) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 04:43:51.483756) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2017-04-03 04:43:51.484075) ========= /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.qbh5eP0TZk/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.WNjCrAbet1/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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:43:51 INFO - MultiFileLogger online at 20170403 04:43:51 in /builds/slave/test 04:43:51 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:43:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:43:51 INFO - {'append_to_log': False, 04:43:51 INFO - 'base_work_dir': '/builds/slave/test', 04:43:51 INFO - 'blob_upload_branch': 'Firefox', 04:43:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:43:51 INFO - 'branch': 'Firefox', 04:43:51 INFO - 'buildbot_json_path': 'buildprops.json', 04:43:51 INFO - 'config_files': ('talos/mac_config.py',), 04:43:51 INFO - 'default_actions': ('clobber', 04:43:51 INFO - 'read-buildbot-config', 04:43:51 INFO - 'download-and-extract', 04:43:51 INFO - 'populate-webroot', 04:43:51 INFO - 'create-virtualenv', 04:43:51 INFO - 'install', 04:43:51 INFO - 'run-tests'), 04:43:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:43:51 INFO - 'download_minidump_stackwalk': True, 04:43:51 INFO - 'download_symbols': 'ondemand', 04:43:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:43:51 INFO - 'tooltool.py': '/tools/tooltool.py', 04:43:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:43:51 INFO - '/tools/misc-python/virtualenv.py')}, 04:43:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:43:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:43:51 INFO - 'gecko_profile': False, 04:43:51 INFO - 'gecko_profile_interval': 0, 04:43:51 INFO - 'installer_path': 'installer.exe', 04:43:51 INFO - 'log_level': 'info', 04:43:51 INFO - 'log_name': 'talos', 04:43:51 INFO - 'log_to_console': True, 04:43:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:43:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:43:51 INFO - 'opt_config_files': (), 04:43:51 INFO - 'pip_index': False, 04:43:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:43:51 INFO - 'cmd': ('bash', 04:43:51 INFO - '-c', 04:43:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:43:51 INFO - 'enabled': True, 04:43:51 INFO - 'halt_on_failure': False, 04:43:51 INFO - 'name': 'check_screen_resolution'},), 04:43:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:43:51 INFO - 'cmd': ('bash', 04:43:51 INFO - '-c', 04:43:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:43:51 INFO - 'enabled': True, 04:43:51 INFO - 'halt_on_failure': False, 04:43:51 INFO - 'name': 'check_screen_resolution'},), 04:43:51 INFO - 'run_cmd_checks_enabled': True, 04:43:51 INFO - 'suite': 'dromaeojs-e10s', 04:43:51 INFO - 'system_bits': '32', 04:43:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:43:51 INFO - 'title': 't-yosemite-r7-0188', 04:43:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:43:51 INFO - 'use_talos_json': True, 04:43:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:43:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:43:51 INFO - 'work_dir': 'build'} 04:43:51 INFO - [mozharness: 2017-04-03 11:43:51.733513Z] Running clobber step. 04:43:51 INFO - Running pre-action listener: _resource_record_pre_action 04:43:51 INFO - Running main action method: clobber 04:43:51 INFO - rmtree: /builds/slave/test/build 04:43:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:43:56 INFO - Running post-action listener: _resource_record_post_action 04:43:56 INFO - [mozharness: 2017-04-03 11:43:56.246841Z] Finished clobber step (success) 04:43:56 INFO - [mozharness: 2017-04-03 11:43:56.246989Z] Running read-buildbot-config step. 04:43:56 INFO - Running pre-action listener: _resource_record_pre_action 04:43:56 INFO - Running main action method: read_buildbot_config 04:43:56 INFO - Using buildbot properties: 04:43:56 INFO - { 04:43:56 INFO - "project": "", 04:43:56 INFO - "product": "firefox", 04:43:56 INFO - "script_repo_revision": "production", 04:43:56 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:43:56 INFO - "repository": "", 04:43:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:43:56 INFO - "buildid": "20170403031423", 04:43:56 INFO - "pgo_build": "False", 04:43:56 INFO - "basedir": "/builds/slave/test", 04:43:56 INFO - "buildnumber": 14, 04:43:56 INFO - "slavename": "t-yosemite-r7-0188", 04:43:56 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 04:43:56 INFO - "platform": "yosemite_r7", 04:43:56 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:43:56 INFO - "branch": "mozilla-central", 04:43:56 INFO - "repo_path": "mozilla-central", 04:43:56 INFO - "revision": "aaa0cd3bd620daf6be29c72625f6e63fd0bc1d46", 04:43:56 INFO - "stage_platform": "macosx64", 04:43:56 INFO - "builduid": "af923ef774b54073bed7e085d6e2c657", 04:43:56 INFO - "slavebuilddir": "test" 04:43:56 INFO - } 04:43:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:43:56 INFO - Running post-action listener: _resource_record_post_action 04:43:56 INFO - [mozharness: 2017-04-03 11:43:56.250201Z] Finished read-buildbot-config step (success) 04:43:56 INFO - [mozharness: 2017-04-03 11:43:56.250310Z] Running download-and-extract step. 04:43:56 INFO - Running pre-action listener: _resource_record_pre_action 04:43:56 INFO - Running main action method: download_and_extract 04:43:56 INFO - mkdir: /builds/slave/test/build/tests 04:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:56 INFO - trying https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:43:56 INFO - Downloading https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:43:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:43:57 INFO - Downloaded 1325 bytes. 04:43:57 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:43:57 INFO - Using the following test package requirements: 04:43:57 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:43:57 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:43:57 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:43:57 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:43:57 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:43:57 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:43:57 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:43:57 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:43:57 INFO - u'jsshell-mac.zip'], 04:43:57 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:43:57 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:43:57 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:43:57 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:43:57 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:43:57 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:43:57 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:43:57 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:43:57 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:43:57 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:43:57 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:43:57 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:43:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:43:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:43:57 INFO - Fetch https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:43:59 INFO - Expected file size: 52519377 04:43:59 INFO - Obtained file size: 52519377 04:44:15 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:44:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:44:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:44:15 INFO - Fetch https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:44:17 INFO - Expected file size: 52519377 04:44:17 INFO - Obtained file size: 52519377 04:44:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:44:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:44:32 INFO - Fetch https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:44:34 INFO - Expected file size: 14404152 04:44:34 INFO - Obtained file size: 14404152 04:44:34 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:44:34 INFO - trying https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:44:34 INFO - Downloading https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:44:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:44:37 INFO - Downloaded 75570606 bytes. 04:44:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:44:37 INFO - mkdir: /builds/slave/test/properties 04:44:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:44:37 INFO - Writing to file /builds/slave/test/properties/build_url 04:44:37 INFO - Contents: 04:44:37 INFO - build_url:https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:44:38 INFO - Running post-action listener: _resource_record_post_action 04:44:38 INFO - Running post-action listener: set_extra_try_arguments 04:44:38 INFO - [mozharness: 2017-04-03 11:44:38.001828Z] Finished download-and-extract step (success) 04:44:38 INFO - [mozharness: 2017-04-03 11:44:38.001974Z] Running populate-webroot step. 04:44:38 INFO - Running pre-action listener: _resource_record_pre_action 04:44:38 INFO - Running main action method: populate_webroot 04:44:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:44:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:44:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:44:38 INFO - '--tppagecycles', 04:44:38 INFO - '7'], 04:44:38 INFO - 'tests': ['tsvgm']}}, 04:44:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:44:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:44:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:44:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:44:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:44:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:44:38 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:44:38 INFO - 'talos_options': ['--disable-e10s'], 04:44:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:44:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:44:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:44:38 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:44:38 INFO - 'talos_options': ['--disable-e10s'], 04:44:38 INFO - 'tests': ['damp', 'tps']}, 04:44:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:44:38 INFO - 'tests': ['damp', 'tps']}, 04:44:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:44:38 INFO - 'tests': ['dromaeo_dom']}, 04:44:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:44:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:44:38 INFO - 'tests': ['basic_compositor_video']}, 04:44:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:44:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:44:38 INFO - 'tests': ['a11yr', 04:44:38 INFO - 'ts_paint', 04:44:38 INFO - 'tpaint', 04:44:38 INFO - 'sessionrestore', 04:44:38 INFO - 'sessionrestore_no_auto_restore', 04:44:38 INFO - 'tabpaint']}, 04:44:38 INFO - 'other-e10s': {'tests': ['a11yr', 04:44:38 INFO - 'ts_paint', 04:44:38 INFO - 'tpaint', 04:44:38 INFO - 'sessionrestore', 04:44:38 INFO - 'sessionrestore_no_auto_restore', 04:44:38 INFO - 'tabpaint']}, 04:44:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:44:38 INFO - 'ts_paint', 04:44:38 INFO - 'tpaint', 04:44:38 INFO - 'sessionrestore', 04:44:38 INFO - 'sessionrestore_no_auto_restore', 04:44:38 INFO - 'tabpaint']}, 04:44:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:44:38 INFO - 'ts_paint', 04:44:38 INFO - 'tpaint', 04:44:38 INFO - 'sessionrestore', 04:44:38 INFO - 'sessionrestore_no_auto_restore', 04:44:38 INFO - 'tabpaint']}, 04:44:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:44:38 INFO - 'tests': ['a11yr', 04:44:38 INFO - 'ts_paint', 04:44:38 INFO - 'tpaint', 04:44:38 INFO - 'sessionrestore', 04:44:38 INFO - 'sessionrestore_no_auto_restore', 04:44:38 INFO - 'tabpaint']}, 04:44:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:44:38 INFO - 'tests': ['a11yr', 04:44:38 INFO - 'ts_paint', 04:44:38 INFO - 'tpaint', 04:44:38 INFO - 'sessionrestore', 04:44:38 INFO - 'sessionrestore_no_auto_restore', 04:44:38 INFO - 'tabpaint']}, 04:44:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:44:38 INFO - 'tests': ['tsvgx', 04:44:38 INFO - 'tsvgr_opacity', 04:44:38 INFO - 'tart', 04:44:38 INFO - 'tscrollx', 04:44:38 INFO - 'cart', 04:44:38 INFO - 'tsvg_static']}, 04:44:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:44:38 INFO - 'tsvgr_opacity', 04:44:38 INFO - 'tart', 04:44:38 INFO - 'tscrollx', 04:44:38 INFO - 'cart', 04:44:38 INFO - 'tsvg_static']}, 04:44:38 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:44:38 INFO - 'talos_options': ['--disable-e10s'], 04:44:38 INFO - 'tests': ['tp5o']}, 04:44:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:44:38 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:44:38 INFO - 'talos_options': ['--disable-e10s', 04:44:38 INFO - '--xperf_path', 04:44:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:44:38 INFO - 'tests': ['tp5n']}, 04:44:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:44:38 INFO - 'talos_options': ['--xperf_path', 04:44:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:44:38 INFO - 'tests': ['tp5n']}}, 04:44:38 INFO - 'talos.zip': {'path': '', 04:44:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:44:38 INFO - Running post-action listener: _resource_record_post_action 04:44:38 INFO - [mozharness: 2017-04-03 11:44:38.020120Z] Finished populate-webroot step (success) 04:44:38 INFO - [mozharness: 2017-04-03 11:44:38.020251Z] Running create-virtualenv step. 04:44:38 INFO - Running pre-action listener: _resource_record_pre_action 04:44:38 INFO - Running main action method: create_virtualenv 04:44:38 INFO - Creating virtualenv /builds/slave/test/build/venv 04:44:38 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:44:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:44:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:44:38 INFO - Using real prefix '/tools/python27' 04:44:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:44:38 INFO - Installing distribute.............................................................................................................................................................................................done. 04:44:41 INFO - Installing pip.................done. 04:44:41 INFO - Return code: 0 04:44:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:44:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:44:42 INFO - Reading from file tmpfile_stdout 04:44:42 INFO - Output received: 04:44:42 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:44:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:44: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:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106ccfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefc9deb0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aadd30>, '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 0x1069d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106aa2be8>, '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.qbh5eP0TZk/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.WNjCrAbet1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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:44: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', 'pip>=1.5'] in /builds/slave/test/build 04:44: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 pip>=1.5 04:44:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qbh5eP0TZk/Render', 04:44:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:42 INFO - 'HOME': '/Users/cltbld', 04:44:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:42 INFO - 'LOGNAME': 'cltbld', 04:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:42 INFO - 'MOZ_NO_REMOTE': '1', 04:44:42 INFO - 'NO_EM_RESTART': '1', 04:44:42 INFO - 'PAGER': '/bin/cat', 04:44:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:42 INFO - 'PWD': '/builds/slave/test', 04:44:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:42 INFO - 'SHELL': '/bin/bash', 04:44:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WNjCrAbet1/Listeners', 04:44:42 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 04:44:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:42 INFO - 'USER': 'cltbld', 04:44:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:42 INFO - 'XPC_FLAGS': '0x0', 04:44:42 INFO - 'XPC_SERVICE_NAME': '0', 04:44:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:42 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:44:42 INFO - Cleaning up... 04:44:42 INFO - Return code: 0 04:44:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:44: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:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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', '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 0x106ccfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefc9deb0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aadd30>, '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 0x1069d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106aa2be8>, '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.qbh5eP0TZk/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.WNjCrAbet1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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:44: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:44: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 psutil>=3.1.1 04:44:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qbh5eP0TZk/Render', 04:44:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:42 INFO - 'HOME': '/Users/cltbld', 04:44:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:42 INFO - 'LOGNAME': 'cltbld', 04:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:42 INFO - 'MOZ_NO_REMOTE': '1', 04:44:42 INFO - 'NO_EM_RESTART': '1', 04:44:42 INFO - 'PAGER': '/bin/cat', 04:44:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:42 INFO - 'PWD': '/builds/slave/test', 04:44:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:42 INFO - 'SHELL': '/bin/bash', 04:44:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WNjCrAbet1/Listeners', 04:44:42 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 04:44:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:42 INFO - 'USER': 'cltbld', 04:44:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:42 INFO - 'XPC_FLAGS': '0x0', 04:44:42 INFO - 'XPC_SERVICE_NAME': '0', 04:44:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:42 INFO - Downloading/unpacking psutil>=3.1.1 04:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:44:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:44:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:44:45 INFO - Installing collected packages: psutil 04:44:45 INFO - Running setup.py install for psutil 04:44:46 INFO - building 'psutil._psutil_osx' extension 04:44:46 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:44:46 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:44:46 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:44:46 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:44:46 INFO - building 'psutil._psutil_posix' extension 04:44:46 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:44:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:44:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:44:46 INFO - ^ 04:44:46 INFO - 1 warning generated. 04:44:46 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:44:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:44:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:44:47 INFO - Successfully installed psutil 04:44:47 INFO - Cleaning up... 04:44:47 INFO - Return code: 0 04:44:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:44:47 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:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:47 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:44:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106ccfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefc9deb0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aadd30>, '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 0x1069d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106aa2be8>, '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.qbh5eP0TZk/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.WNjCrAbet1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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:44:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:44:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qbh5eP0TZk/Render', 04:44:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:48 INFO - 'HOME': '/Users/cltbld', 04:44:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:48 INFO - 'LOGNAME': 'cltbld', 04:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:48 INFO - 'MOZ_NO_REMOTE': '1', 04:44:48 INFO - 'NO_EM_RESTART': '1', 04:44:48 INFO - 'PAGER': '/bin/cat', 04:44:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:48 INFO - 'PWD': '/builds/slave/test', 04:44:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:48 INFO - 'SHELL': '/bin/bash', 04:44:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WNjCrAbet1/Listeners', 04:44:48 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 04:44:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:48 INFO - 'USER': 'cltbld', 04:44:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:48 INFO - 'XPC_FLAGS': '0x0', 04:44:48 INFO - 'XPC_SERVICE_NAME': '0', 04:44:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:44:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:44:51 INFO - Installing collected packages: mozsystemmonitor 04:44:51 INFO - Running setup.py install for mozsystemmonitor 04:44:51 INFO - Successfully installed mozsystemmonitor 04:44:51 INFO - Cleaning up... 04:44:51 INFO - Return code: 0 04:44:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:44:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106ccfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefc9deb0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aadd30>, '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 0x1069d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106aa2be8>, '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.qbh5eP0TZk/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.WNjCrAbet1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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:44:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:44:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:44:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qbh5eP0TZk/Render', 04:44:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:51 INFO - 'HOME': '/Users/cltbld', 04:44:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:51 INFO - 'LOGNAME': 'cltbld', 04:44:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:51 INFO - 'MOZ_NO_REMOTE': '1', 04:44:51 INFO - 'NO_EM_RESTART': '1', 04:44:51 INFO - 'PAGER': '/bin/cat', 04:44:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:51 INFO - 'PWD': '/builds/slave/test', 04:44:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:51 INFO - 'SHELL': '/bin/bash', 04:44:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WNjCrAbet1/Listeners', 04:44:51 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 04:44:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:51 INFO - 'USER': 'cltbld', 04:44:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:51 INFO - 'XPC_FLAGS': '0x0', 04:44:51 INFO - 'XPC_SERVICE_NAME': '0', 04:44:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:51 INFO - Downloading/unpacking jsonschema==2.5.1 04:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:44:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:44: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:44: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:44: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:44: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:44: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:44: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:44:54 INFO - Downloading functools32-3.2.3-2.tar.gz 04:44:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:44:54 INFO - warning: no files found matching '*.txt' 04:44:54 INFO - no previously-included directories found matching 'build' 04:44:54 INFO - no previously-included directories found matching 'dist' 04:44:54 INFO - no previously-included directories found matching '.git*' 04:44:54 INFO - Installing collected packages: jsonschema, functools32 04:44:55 INFO - Running setup.py install for functools32 04:44:55 INFO - warning: no files found matching '*.txt' 04:44:55 INFO - no previously-included directories found matching 'build' 04:44:55 INFO - no previously-included directories found matching 'dist' 04:44:55 INFO - no previously-included directories found matching '.git*' 04:44:55 INFO - Successfully installed jsonschema functools32 04:44:55 INFO - Cleaning up... 04:44:55 INFO - Return code: 0 04:44:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:55 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 0x106ccfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefc9deb0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aadd30>, '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 0x1069d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106aa2be8>, '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.qbh5eP0TZk/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.WNjCrAbet1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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:44:55 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:44:55 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:44:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qbh5eP0TZk/Render', 04:44:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:55 INFO - 'HOME': '/Users/cltbld', 04:44:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:55 INFO - 'LOGNAME': 'cltbld', 04:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:55 INFO - 'MOZ_NO_REMOTE': '1', 04:44:55 INFO - 'NO_EM_RESTART': '1', 04:44:55 INFO - 'PAGER': '/bin/cat', 04:44:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:55 INFO - 'PWD': '/builds/slave/test', 04:44:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:55 INFO - 'SHELL': '/bin/bash', 04:44:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WNjCrAbet1/Listeners', 04:44:55 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 04:44:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:55 INFO - 'USER': 'cltbld', 04:44:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:55 INFO - 'XPC_FLAGS': '0x0', 04:44:55 INFO - 'XPC_SERVICE_NAME': '0', 04:44:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:44:55 INFO - Cleaning up... 04:44:55 INFO - Return code: 0 04:44:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:55 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 0x106ccfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefc9deb0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aadd30>, '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 0x1069d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106aa2be8>, '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.qbh5eP0TZk/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.WNjCrAbet1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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:44:55 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:44:55 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:44:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qbh5eP0TZk/Render', 04:44:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:55 INFO - 'HOME': '/Users/cltbld', 04:44:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:55 INFO - 'LOGNAME': 'cltbld', 04:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:55 INFO - 'MOZ_NO_REMOTE': '1', 04:44:55 INFO - 'NO_EM_RESTART': '1', 04:44:55 INFO - 'PAGER': '/bin/cat', 04:44:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:55 INFO - 'PWD': '/builds/slave/test', 04:44:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:55 INFO - 'SHELL': '/bin/bash', 04:44:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WNjCrAbet1/Listeners', 04:44:55 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 04:44:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:55 INFO - 'USER': 'cltbld', 04:44:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:55 INFO - 'XPC_FLAGS': '0x0', 04:44:55 INFO - 'XPC_SERVICE_NAME': '0', 04:44:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:55 INFO - Downloading/unpacking blobuploader==1.2.4 04:44:55 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:44:55 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:44:55 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:44:55 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:44:55 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:44:55 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:44:58 INFO - Downloading blobuploader-1.2.4.tar.gz 04:44:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:44:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:44:58 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:44:58 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:44:58 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:44:58 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:44:58 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:44:58 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:44:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:44:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:59 INFO - Downloading docopt-0.6.1.tar.gz 04:44:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:44:59 INFO - Installing collected packages: blobuploader, requests, docopt 04:44:59 INFO - Running setup.py install for blobuploader 04:44:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:44:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:44:59 INFO - Running setup.py install for requests 04:45:00 INFO - Running setup.py install for docopt 04:45:00 INFO - Successfully installed blobuploader requests docopt 04:45:00 INFO - Cleaning up... 04:45:00 INFO - Return code: 0 04:45:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:00 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 0x106ccfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefc9deb0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aadd30>, '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 0x1069d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106aa2be8>, '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.qbh5eP0TZk/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.WNjCrAbet1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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:45:00 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:45:00 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:45:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qbh5eP0TZk/Render', 04:45:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:00 INFO - 'HOME': '/Users/cltbld', 04:45:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:00 INFO - 'LOGNAME': 'cltbld', 04:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:00 INFO - 'MOZ_NO_REMOTE': '1', 04:45:00 INFO - 'NO_EM_RESTART': '1', 04:45:00 INFO - 'PAGER': '/bin/cat', 04:45:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:00 INFO - 'PWD': '/builds/slave/test', 04:45:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:00 INFO - 'SHELL': '/bin/bash', 04:45:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WNjCrAbet1/Listeners', 04:45:00 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 04:45:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:00 INFO - 'USER': 'cltbld', 04:45:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:00 INFO - 'XPC_FLAGS': '0x0', 04:45:00 INFO - 'XPC_SERVICE_NAME': '0', 04:45:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:45:00 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-QGFZHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:45:01 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-ODXLuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:45:01 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-3KNZDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:45:01 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-QVLi7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:45:01 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-KWx6ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:45:01 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-AI__Fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:45:01 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-VyADzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:45:01 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-Q2N0i9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:45:01 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-9te2rt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:45:01 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-qaOFQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:45:01 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-ffyKsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:45:02 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-ZDlneC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:45:02 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-hapZF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:45:02 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-Eg5oB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:02 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-tVZk1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:45:02 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-SXmgbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:45:02 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-mFdITV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:45:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:45:02 INFO - Running setup.py install for manifestparser 04:45:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:45:02 INFO - Running setup.py install for mozcrash 04:45:02 INFO - Running setup.py install for mozdebug 04:45:03 INFO - Running setup.py install for mozdevice 04:45:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:45:03 INFO - Running setup.py install for mozfile 04:45:03 INFO - Running setup.py install for mozhttpd 04:45:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:45:03 INFO - Running setup.py install for mozinfo 04:45:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:45:03 INFO - Running setup.py install for mozInstall 04:45:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:45:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:45:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:45:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:45:03 INFO - Running setup.py install for mozleak 04:45:03 INFO - Running setup.py install for mozlog 04:45:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:45:04 INFO - Running setup.py install for moznetwork 04:45:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:45:04 INFO - Running setup.py install for mozprocess 04:45:04 INFO - Running setup.py install for mozprofile 04:45:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:45:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:45:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:45:04 INFO - Running setup.py install for mozrunner 04:45:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:45:04 INFO - Running setup.py install for mozscreenshot 04:45:04 INFO - Running setup.py install for moztest 04:45:05 INFO - Running setup.py install for mozversion 04:45:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:45:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:45:05 INFO - Cleaning up... 04:45:05 INFO - Return code: 0 04:45:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:05 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 0x106ccfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefc9deb0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aadd30>, '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 0x1069d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106aa2be8>, '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.qbh5eP0TZk/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.WNjCrAbet1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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:45:05 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:45:05 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:45:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qbh5eP0TZk/Render', 04:45:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:05 INFO - 'HOME': '/Users/cltbld', 04:45:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:05 INFO - 'LOGNAME': 'cltbld', 04:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:05 INFO - 'MOZ_NO_REMOTE': '1', 04:45:05 INFO - 'NO_EM_RESTART': '1', 04:45:05 INFO - 'PAGER': '/bin/cat', 04:45:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:05 INFO - 'PWD': '/builds/slave/test', 04:45:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:05 INFO - 'SHELL': '/bin/bash', 04:45:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WNjCrAbet1/Listeners', 04:45:05 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 04:45:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:05 INFO - 'USER': 'cltbld', 04:45:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:05 INFO - 'XPC_FLAGS': '0x0', 04:45:05 INFO - 'XPC_SERVICE_NAME': '0', 04:45:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:45:05 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-g4dPd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:45:05 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:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:45:05 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-rOew_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:45:05 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:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:45:05 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-M3giI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:45:05 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:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:45:05 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-zn8dKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:45:05 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:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:45:05 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-uJkBnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:45:06 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:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:45:06 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-Izz2ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:45:06 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:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:45:06 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-Ub_EQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:45:06 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:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:45:06 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-rUYdtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:45:06 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:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:45:06 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-TkRbi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:45:06 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:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:45:06 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-keaTxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:45:06 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:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:45:06 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-B4VbcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:45:06 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:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:45:06 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-XXRo58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:45:06 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:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:45:06 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-5J1eLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:45:06 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:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:45:06 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-MinPyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:45:06 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:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:07 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-7Bzmtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:07 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:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:45:07 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-5lYpBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:45:07 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:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:45:07 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-vjuu20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:45:07 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:45:07 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:45:07 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:45:07 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:45:07 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:45:07 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:45:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:45:07 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:45:07 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:45:07 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:45:07 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:45:07 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:45:07 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:45:10 INFO - Downloading blessings-1.6.tar.gz 04:45:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:45:10 INFO - Installing collected packages: blessings 04:45:10 INFO - Running setup.py install for blessings 04:45:10 INFO - Successfully installed blessings 04:45:10 INFO - Cleaning up... 04:45:10 INFO - Return code: 0 04:45:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:45:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:45:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:45:10 INFO - Reading from file tmpfile_stdout 04:45:10 INFO - Current package versions: 04:45:10 INFO - blessings == 1.6 04:45:10 INFO - blobuploader == 1.2.4 04:45:10 INFO - docopt == 0.6.1 04:45:10 INFO - functools32 == 3.2.3-2 04:45:10 INFO - jsonschema == 2.5.1 04:45:10 INFO - manifestparser == 1.1 04:45:10 INFO - mozInstall == 1.12 04:45:10 INFO - mozcrash == 1.0 04:45:10 INFO - mozdebug == 0.1 04:45:10 INFO - mozdevice == 0.49 04:45:10 INFO - mozfile == 1.2 04:45:10 INFO - mozhttpd == 0.7 04:45:10 INFO - mozinfo == 0.9 04:45:10 INFO - mozleak == 0.1 04:45:10 INFO - mozlog == 3.4 04:45:10 INFO - moznetwork == 0.27 04:45:10 INFO - mozprocess == 0.25 04:45:10 INFO - mozprofile == 0.28 04:45:10 INFO - mozrunner == 6.13 04:45:10 INFO - mozscreenshot == 0.1 04:45:10 INFO - mozsystemmonitor == 0.3 04:45:10 INFO - moztest == 0.8 04:45:10 INFO - mozversion == 1.4 04:45:10 INFO - psutil == 3.1.1 04:45:10 INFO - requests == 1.2.3 04:45:10 INFO - wsgiref == 0.1.2 04:45:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:10 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 0x106ccfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefc9deb0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aadd30>, '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 0x1069d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106aa2be8>, '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.qbh5eP0TZk/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.WNjCrAbet1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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:45:10 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:45:10 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:45:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qbh5eP0TZk/Render', 04:45:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:10 INFO - 'HOME': '/Users/cltbld', 04:45:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:10 INFO - 'LOGNAME': 'cltbld', 04:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:10 INFO - 'MOZ_NO_REMOTE': '1', 04:45:10 INFO - 'NO_EM_RESTART': '1', 04:45:10 INFO - 'PAGER': '/bin/cat', 04:45:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:10 INFO - 'PWD': '/builds/slave/test', 04:45:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:10 INFO - 'SHELL': '/bin/bash', 04:45:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WNjCrAbet1/Listeners', 04:45:10 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 04:45:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:10 INFO - 'USER': 'cltbld', 04:45:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:10 INFO - 'XPC_FLAGS': '0x0', 04:45:10 INFO - 'XPC_SERVICE_NAME': '0', 04:45:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:10 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:45:10 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:45:10 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:45:10 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:45:10 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:45:10 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:45:10 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:45:10 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:45:10 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:45:10 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:45:10 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:45:10 INFO - Cleaning up... 04:45:10 INFO - Return code: 0 04:45:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:10 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 0x106ccfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefc9deb0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aadd30>, '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 0x1069d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106aa2be8>, '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.qbh5eP0TZk/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.WNjCrAbet1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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:45:10 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:45:10 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:45:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qbh5eP0TZk/Render', 04:45:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:10 INFO - 'HOME': '/Users/cltbld', 04:45:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:10 INFO - 'LOGNAME': 'cltbld', 04:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:10 INFO - 'MOZ_NO_REMOTE': '1', 04:45:10 INFO - 'NO_EM_RESTART': '1', 04:45:10 INFO - 'PAGER': '/bin/cat', 04:45:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:10 INFO - 'PWD': '/builds/slave/test', 04:45:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:10 INFO - 'SHELL': '/bin/bash', 04:45:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WNjCrAbet1/Listeners', 04:45:10 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 04:45:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:10 INFO - 'USER': 'cltbld', 04:45:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:10 INFO - 'XPC_FLAGS': '0x0', 04:45:10 INFO - 'XPC_SERVICE_NAME': '0', 04:45:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:45:11 INFO - Cleaning up... 04:45:11 INFO - Return code: 0 04:45:11 INFO - Running post-action listener: _resource_record_post_action 04:45:11 INFO - Running post-action listener: _start_resource_monitoring 04:45:11 INFO - Starting resource monitoring. 04:45:11 INFO - [mozharness: 2017-04-03 11:45:11.265516Z] Finished create-virtualenv step (success) 04:45:11 INFO - [mozharness: 2017-04-03 11:45:11.266472Z] Running install step. 04:45:11 INFO - Running pre-action listener: _resource_record_pre_action 04:45:11 INFO - Running main action method: install 04:45:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:45:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:45:11 INFO - Reading from file tmpfile_stdout 04:45:11 INFO - Detecting whether we're running mozinstall >=1.0... 04:45:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:45:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:45:11 INFO - Reading from file tmpfile_stdout 04:45:11 INFO - Output received: 04:45:11 INFO - Usage: mozinstall [options] installer 04:45:11 INFO - Options: 04:45:11 INFO - -h, --help show this help message and exit 04:45:11 INFO - -d DEST, --destination=DEST 04:45:11 INFO - Directory to install application into. [default: 04:45:11 INFO - "/builds/slave/test"] 04:45:11 INFO - --app=APP Application being installed. [default: firefox] 04:45:11 INFO - mkdir: /builds/slave/test/build/application 04:45:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:45:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:45:32 INFO - Reading from file tmpfile_stdout 04:45:32 INFO - Output received: 04:45:32 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:45:32 INFO - Running post-action listener: _resource_record_post_action 04:45:32 INFO - [mozharness: 2017-04-03 11:45:32.012098Z] Finished install step (success) 04:45:32 INFO - [mozharness: 2017-04-03 11:45:32.012255Z] Running run-tests step. 04:45:32 INFO - Running pre-action listener: _resource_record_pre_action 04:45:32 INFO - Running main action method: run_tests 04:45:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:45:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:45:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:45:32 INFO - 2017-04-03 04:45:32.027 screenresolution[1629:7858] starting screenresolution argv=screenresolution get 04:45:32 INFO - 2017-04-03 04:45:32.029 screenresolution[1629:7858] Display 0: 1600x1200x32@60 04:45:32 INFO - 2017-04-03 04:45:32.035 screenresolution[1630:7860] starting screenresolution argv=screenresolution list 04:45:32 INFO - Available Modes on Display 0 04:45:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:45:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:45:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:45:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:45:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:45:32 INFO - Intel Iris: 04:45:32 INFO - Chipset Model: Intel Iris 04:45:32 INFO - Type: GPU 04:45:32 INFO - Bus: Built-In 04:45:32 INFO - VRAM (Dynamic, Max): 1536 MB 04:45:32 INFO - Vendor: Intel (0x8086) 04:45:32 INFO - Device ID: 0x0a2e 04:45:32 INFO - Revision ID: 0x0009 04:45:32 INFO - Displays: 04:45:32 INFO - Display: 04:45:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:45:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:45:32 INFO - Display Serial Number: 1600x1200 60 04:45:32 INFO - Main Display: Yes 04:45:32 INFO - Mirror: Off 04:45:32 INFO - Online: Yes 04:45:32 INFO - Rotation: Supported 04:45:32 INFO - Return code: 0 04:45:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:45:32 INFO - Python 2.7.3 04:45:32 INFO - Return code: 0 04:45:32 INFO - grabbing minidump binary from tooltool 04:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:32 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 0x106aadd30>, '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 0x1069d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106aa2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:45:32 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:45:32 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:45:32 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:45:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:45:32 INFO - Return code: 0 04:45:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:45:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:45:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:45:32 INFO - ENV: RUST_BACKTRACE is now 1 04:45:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:45:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:45:32 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0188', '--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:45:32 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0188 --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:45:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qbh5eP0TZk/Render', 04:45:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:32 INFO - 'HOME': '/Users/cltbld', 04:45:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:32 INFO - 'LOGNAME': 'cltbld', 04:45:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:45:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:32 INFO - 'MOZ_NO_REMOTE': '1', 04:45:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:45:32 INFO - 'NO_EM_RESTART': '1', 04:45:32 INFO - 'PAGER': '/bin/cat', 04:45:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:32 INFO - 'PWD': '/builds/slave/test', 04:45:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:45:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:32 INFO - 'RUST_BACKTRACE': '1', 04:45:32 INFO - 'SHELL': '/bin/bash', 04:45:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WNjCrAbet1/Listeners', 04:45:32 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 04:45:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:32 INFO - 'USER': 'cltbld', 04:45:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:32 INFO - 'XPC_FLAGS': '0x0', 04:45:32 INFO - 'XPC_SERVICE_NAME': '0', 04:45:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:32 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0188', '--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:45:32 INFO - mozversion application_buildid: 20170403031423 04:45:32 INFO - mozversion application_changeset: aaa0cd3bd620daf6be29c72625f6e63fd0bc1d46 04:45:32 INFO - mozversion application_display_name: Nightly 04:45:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:45:32 INFO - mozversion application_name: Firefox 04:45:32 INFO - mozversion application_remotingname: firefox 04:45:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:45:32 INFO - mozversion application_vendor: Mozilla 04:45:32 INFO - mozversion application_version: 55.0a1 04:45:32 INFO - mozversion platform_buildid: 20170403031423 04:45:32 INFO - mozversion platform_changeset: aaa0cd3bd620daf6be29c72625f6e63fd0bc1d46 04:45:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:45:32 INFO - mozversion platform_version: 55.0a1 04:45:32 INFO - using testdate: 1491219932 04:45:32 INFO - actual date: 1491219932 04:45:32 INFO - starting webserver on 'localhost:49243' 04:45:32 INFO - SUITE-START | Running 2 tests 04:45:32 INFO - TEST-START | dromaeo_css 04:45:32 INFO - operating with platform_type : mac_ 04:45:32 INFO - Initialising browser for dromaeo_css test... 04:45:32 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmpxWg8FO/profile http://localhost:49243/getInfo.html) 04:45:35 INFO - PID 1640 | 2017-04-03 04:45:35.345 plugin-container[1642:8039] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4947, name = 'com.apple.tsm.portname' 04:45:35 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:45:35 INFO - PID 1640 | 2017-04-03 04:45:35.348 plugin-container[1642:8039] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f4b, name = 'com.apple.CFPasteboardClient' 04:45:35 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:45:35 INFO - PID 1640 | 2017-04-03 04:45:35.348 plugin-container[1642:8039] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:45:35 INFO - PID 1640 | __metrics Screen width/height:1600/1200 04:45:35 INFO - PID 1640 | colorDepth:24 04:45:35 INFO - PID 1640 | Browser inner width/height: 1024/689 04:45:35 INFO - PID 1640 | __metrics 04:45:35 ERROR - PID 1640 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 04:45:36 INFO - TEST-INFO | 1640: exit 0 04:45:36 INFO - Browser initialized. 04:45:36 INFO - Running cycle 1/1 for dromaeo_css test... 04:45:36 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmpxWg8FO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:45:38 INFO - PID 1643 | 2017-04-03 04:45:38.976 plugin-container[1644:8169] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 04:45:38 INFO - PID 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:45:38 INFO - PID 1643 | 2017-04-03 04:45:38.977 plugin-container[1644:8169] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 04:45:38 INFO - PID 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:45:38 INFO - PID 1643 | 2017-04-03 04:45:38.977 plugin-container[1644:8169] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:45:48 INFO - PID 1643 | RSS: Main: 228724736 04:45:48 INFO - PID 1643 | 04:48:52 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 04:48:54 INFO - PID 1643 | RSS: Main: 253198336 04:48:54 INFO - PID 1643 | 04:50:36 INFO - PID 1643 | ************************* 04:50:36 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 04:50:36 INFO - PID 1643 | 04:50:36 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:50:36 INFO - PID 1643 | Full stack: 04:50:36 INFO - PID 1643 | ************************* 04:50:36 INFO - PID 1643 | ************************* 04:50:36 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 04:50:36 INFO - PID 1643 | 04:50:36 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:50:36 INFO - PID 1643 | Full stack: 04:50:36 INFO - PID 1643 | ************************* 04:50:36 INFO - PID 1643 | ************************* 04:50:36 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 04:50:36 INFO - PID 1643 | 04:50:36 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:50:36 INFO - PID 1643 | Full stack: 04:50:36 INFO - PID 1643 | ************************* 04:50:36 INFO - PID 1643 | ************************* 04:50:36 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 04:50:36 INFO - PID 1643 | 04:50:36 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:50:36 INFO - PID 1643 | Full stack: 04:50:36 INFO - PID 1643 | ************************* 04:51:56 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 04:51:57 INFO - PID 1643 | RSS: Main: 261378048 04:51:57 INFO - PID 1643 | 04:54:59 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 04:54:59 INFO - PID 1643 | RSS: Main: 273100800 04:54:59 INFO - PID 1643 | 04:58:01 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 04:58:02 INFO - PID 1643 | RSS: Main: 265404416 04:58:02 INFO - PID 1643 | 05:01:05 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 05:01:05 INFO - PID 1643 | RSS: Main: 278822912 05:01:05 INFO - PID 1643 | 05:04:08 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 05:04:08 INFO - PID 1643 | RSS: Main: 272572416 05:04:08 INFO - PID 1643 | 05:04:08 INFO - PID 1643 | __start_tp_report 05:04:08 INFO - PID 1643 | _x_x_mozilla_page_load 05:04:08 INFO - PID 1643 | _x_x_mozilla_page_load_details 05:04:08 INFO - PID 1643 | |i|pagename|runs| 05:04:08 INFO - PID 1643 | |0;dojo.html;2940.514815055515;3557.6264492228333;3588.1388466767985;3609.9097522561933;3613.6386361363852;6093.573449858512;6194.81415557534;6198.56610037297;6199.8140055798285;6200;5042.747862606873;6134.2529056856065;6134.559047376644;6140.841692977898;6196.473299769514;5418;5438.966596346701;5474.452554744534;5510.173473978895;5559.277293951781;5371.113766228567;5451.672899626015;5478.863028424282;5516.972415137939;5539.947409992089;5352.116900711378;5384.515393614554;5457.126859702468;5481.150421684645;5505.394406615289;5416.458354164592;5425.945740542623;5438.428964958662;5446.400895901447;5483.958047970913;4008.318585840385;5372.328458942632;5380.946190538123;5392.622516423852;5443.455654434564;4536.616332018733;5264.394594621591;5603.439656034405;6077;6128.19758601264;5735.627184233053;6651.700673469705;6665.633390163539;6666.133402657672;6693.832654183636;5939.67331796751;6495.902561461582;6735.730570777163;6755.864882702367;6757.493188010919;6164.044573091178;6189.442950134509;6250.781222657185;6270.153529273535;6275.843103922392;6836.726530938707;6876.587404755631;6901.1718593769065;6915.308469153045;6944.826379340456;6303.968480157661;6326.652034138075;6399.392057754506;6481.967590162113;6500.609963402211;6645.634490102994;6708.161479815023;6715.7985260442265;6732.2931092235585;6765.221999470025;6402.9359706403275;6464.288928217892;6633.9668301658185;6651.900221496681;6667.433268172163;5609.607327487037;6570.704318305688;6613.834654133589;6720.22717387497;6734.124563806674;5333.626646134733;5338.599605029638;5355.946440535623;5358.517733404013;5378.1663842104535;4655.720656760605;4737.052589482118;4745.762711864393;4764.166270902579;4807.759612019455;6303.653299068504;6317.4946004319545;6355.3009168991375;6382;6406.903896441557;6797.116374871235;6816.931830681629;6818.863622727517;6818.93181068183;6827.317268273133;6309.589876658002;6341.524385671093;6386.616802991835;6393.1688880445245;6404.871902561923;4435.733855968652;5739.311282646026;5795.623284486495;5803.65178089316;5883.7058147092475;6942.826429339307;6980.511364204457;7014.123234595676;7018.122734658168;7023.648817559204;6716.29478904708;6767.695453704693;6782.932170678428;6787.966060169668;6788.355106264897;6720.932790672031;6806.285340039422;6966.5471744336455;6994.545354552141;7039.401650859734;6540.051692504655;6613.206415230203;6668.366505182;6668.999650052531;6692.297308782702;6418.518611104092;6705.4635629150525;6731.46148308144;6734.966325168343;6741.393274605309;6415.230172379344;6444.871102577828;6533.248676402274;6541.738330466728;6546.24718157418;6271.96864015677;6532.5427220096035;6558.475321974326;6571.310012448624;6576.2766095730385;4641.698289611165;6161.907571386522;6294.433500984934;6303.49572034227;6357.364263573791;6555.147830781968;6563.573367731082;6567.080608714879;6578.177727784027;6586.967065164644;6391.616503009835;6396.58422202574;6401.391867772554;6408.263049749152;6412.61524308543 05:04:08 INFO - PID 1643 | |1;ext.html;726.1540305544038;792.932600728938;840.4033136473106;1294.5533790842155;1299.2074834351038;39850.60149398505;40599;40600.59399406005;40640.593594064085;40706;33190.33619327618;39910.800445997804;40345.59654403455;40347.59652403475;40510.59489405105;7035.401990830773;7381.892716092602;8084.878726819103;8791.384603077788;8792.780180495474;7538.924610753905;8808.295336373107;8835.514046727427;8902.643894244255;8947.865782013276;8826.470411775283;8849.469031858109;8927.866082008775;8935.687250946217;8939.418937769024;8805.25155361795;8846.955765221197;8849.69026084084;8885.955570222108;8956.462612243286;8653.004904436008;8711.259542938858;8715.259202967756;8716.869246961302;8750.824983500357;39668.801655991534;39756.40365394521;39928.600713993066;39948.20103597912;39952.60047399518;2625.566781481053;3056.3428862794385;3110.004798464492;3126.5622812806228;3133.7336326412283;28769.56845647317;28846.42307153845;28923.56614650761;28977.275568110756;28999.85500072507;2367.562001029815;2800.2999250187454;2813.817101888371;2837;2839.574063890412;245161;260364;304629.9999999978;338875;339421;50180;50671;50888.49111508911;50899.74550127226;50995.725106872625;52250.73874630602;52590.47409525932;52594.47405525972;52893.6197871089;52917.7354113227;14617.415303387745;14719.337629806685;14725.779113313309;14744.189069601274;14749.705005900036;11888;12188.756224875453;12191.573294934635;12206.877931220573;12239;13826.930865345608;13921.095128816594;13964.51124210668;14048.859511404755;14139.85860141406;5045.41977672565;5945.16767652529;5971.164037034819;5977.970110149508;5985.670788106696;972.9416235025922;987.8765154355706;998.2463240253562;1001.2140469731372;1055.831067029287;24710;24785.87607061953;24902;24904.750952490605;24919.875400623245;1100.6422912553453;1126.718320419895;1126.9575642530626;1148.305275308443;1148.322489731046;12183.695407614703;12716.872831271568;12837.293948832717;12839.165454245443;12887.291198983958;463161;465389;466028;466542;467386;56737.44681489343;56918.71540642353;56966;57079;57583.712081440164;1456.4392708807186;1493.6788590453104;1527.732646786808;1529.9541013769606;1547.4119834463056;24222.67901333112;24473.51052978895;24500;24638.384040399134;24664.753352466247;39563.604363955994;39753;39768.403473947335;39837.80081099576;39980;343104.2671799675;404891;407302.9634851807;407579;408073;27939.58090628683;28499;34160;34464.655353447146;34986.300273994886;36177.60039910202;43740.56259437365;43977.56022439735;45222.773886131676;45401.77299113615;29961.850190748908;30617.08148755452;30621.387572247986;30674.386512269182;31609.73561057532;27490.862545687945;28256.717432825408;28553.857230713715;28646.854125834732;29205.41589168247;29457;35369.29261414706;36250.8187459061;36636.81681591575;36673.63326366702;30572;30936.071917842502;31098.067057988297;31119.53320700146;31500.527492088095;22977.19579814765;23072.76927230706;23322.300330990096;24568.877155614107;24762.50474990454 05:04:08 INFO - PID 1643 | |2;jquery.html;392.3800395375307;414.7221361687669;423.73940026883474;431.8229525894382;451.44246855133906;21897.905104744757;22166.335009949726;22900.88549557254;23101.768982310172;23315.650265246033;18705.906470467664;22465.326040218777;22584.43538911528;22728.31815045547;22779.31662050137;6054.909176362358;6227.221597300338;6266.874662506747;6296.118543403904;6301.52738544611;5839.591228613998;6143.784967526138;6146.0473626587955;6206.255249370082;6209.441150296495;6040.75836966523;6155.907661385083;6166.075088736703;6172.382761723837;6172.47533959614;5988;6153.446189842935;6183.412575805291;6193.659348735818;6198.597091189058;5447.073997420448;5461.563074954034;5484.945150548483;5508.504234618864;5515.510812080715;27202.863985680142;27369.04208352718;27514.587281190798;27678;27858;2041.3365656161807;2042.234162189179;2060.8660437071544;2068.5449201175716;2098.244631932503;16373.91813040939;17072.317107315692;17107.657846843118;17111.40110096153;17802.931824090465;1884.3781552087778;1893.5550145715745;1930.8744931579402;1931.6233334499777;1975.249405226005;137363;137538;155598;157791;177366.11316943463;10424.635137770141;12535.31055791922;12744;12895.290759008158;12952;13592.11651242666;15923.920380398024;16284.022958622283;16326;16338.509844704678;8973.775655608662;9273.629054837866;9312.301577381724;9411.011843756443;9419.858702119474;7551.924480755232;8744;8946.463212207289;8979.272119736865;9239.76900577491;6890.586564806128;7769.494982826098;8036.598170091472;8086.191380861985;8143.429959902868;2204.5370472201016;2214.7342318921833;2219.4451387153213;2219.655953327237;2398.4843258699116;954.1269738189618;954.1984732824461;954.8233576788316;980.7597138700921;983.1348413396165;19679.901600491907;21055.578888422147;21232.832194229155;21456.678149827454;24417.023319067393;985.1872205430549;991.9355241909253;999.8650182225307;1017.7760892603616;1019.9286049976579;9749.927507974116;10774.353538787698;10972.725681858017;11063.557457701601;11089.889101109047;676027;696096;709834;713971;718151;159614.40385596227;163088;164118;166698;167885;1210.3706072842074;1229.1211783574786;1258.7230809221955;1260.5588044184462;1264.3425418782365;18459.723104153716;18617.813821861608;18624.813751862308;18911.338103166872;21553.676694849903;62699;63059;63558.72882542231;64225.67887160534;64420;87286.56356718176;87789;88289;89183;89386;8682.565871706263;8773.473591584525;9056.864147037932;9058.094190581152;9137.269018478373;13619.31903404806;14197.148171109766;14337.06809057408;14715.92642036783;14872.182029988455;11622.593209237637;11626.825597615873;11873.168878178445;12040.518379264731;12151;9294.93108292555;9404.76488087776;11184.776304473702;11278.379689117177;11621.941890290494;9394.718158455258;9635.22918166559;11820.527178912747;11836.46735896904;12372;7590.354819840375;7734.381249500139;8295.917040829514;8691.348148888985;8720;11651.88348116542;11754.941225293818;11962.820557691468;11999.220050696676;12111 05:04:08 INFO - PID 1643 | |3;mootools.html;1200.6698158006548;1431.9498817541382;1439.3810661415587;1444.9638759031022;1459.1536908593016;10762.35425874448;11024.889751102486;11249.325040497575;11273.32360058396;11310.151738619616;10678.679639610804;10902.236843420964;10904.34573925565;10909.672709818698;10909.727256818584;2433.2578563538113;2464.0636558107894;2467.8766061696933;2473.863937483438;2480.7147178074574;2395.700537432821;2415.685960825099;2442.3894026493376;2448.571499987504;2460.2619214235747;1887.2451019592136;1959.5786905815246;2457.606782914734;2460.0897667862914;2480.8960012794314;2184.224600266898;2224.0547767199037;2407.8555286682767;2418.7702168293986;2423.9515209695883;1956.6086782643529;2032;2408.9156879509133;2424.527217192648;2438.4879175373194;10106.73665791776;10172.796544069151;10825.945870270598;10918.290311129751;11006.889931100666;6139.140520327158;6303.653299068549;6384.074309225182;6392.041193820917;6396.872062558769;4033.3546632538655;4043.757374557536;4062.3906414037833;4078.3270760324513;4101.99501122224;1155.8786327435666;1184.1533303687904;1184.4729095552482;1200.5977997370892;1218.5795900414344;13634.386452609657;14085.71828563423;15088.924555377153;15416.691666166726;15421.768673469907;5574.972125139429;5756.704741433227;5789.305283366023;5817.621854579524;5853.560982926298;12581.245125292511;12617.684557886127;12642.2414655121;12672;12681.746365072648;5786.826395208151;6004.699765011732;6202.81391558254;6317.684115794192;6390.137331460193;5940.762369505172;5972.313183983811;6061.302950160788;6069.089636554464;6078.845019446291;4257.169851878916;4303.741775493418;4310.116426132635;4342.565743425632;4363.912721745611;1232.550119206501;1250.2498500899387;1263.1347526944073;1263.5009171377255;1267.1383459247616;775.1279810213509;783.475071701961;794.7774623105539;800.5596921693162;805.9113497515268;5923.318818335861;5973.850653733604;6105.9694701526205;6142.78500252489;6241.063840423973;560.4227645525116;566.5722379603374;576.4408523731973;576.6684156609882;596.704631207555;3993.7603743774885;4032.6370626643156;4067.8169482373364;4118.897027574275;4275.764832934156;13315.600531984055;13852.376643051088;13873.653158671113;13888.583342499742;13890.513832015831;11965.880341196651;13512.459501620022;13633.182009079486;13709.108907920952;13728.588142355746;9898.60405583783;10141.594336226468;10147.594096236215;10163.28856980019;10180.083792458567;5492.368377636463;5758.568107392046;6848.452123829982;6896.792956296756;6908.240093589801;12377.814332784836;12565.120441569003;12590.433430495466;12590.992720582515;12747.681307967376;11830.940845295718;12197.817032744339;12421.006319494238;12628.810567841674;12931.288779116863;9881.555330010024;10062.245331600305;10218.897811022092;10226.539805708611;10247;8270.545120018456;10190.796184076426;10263.332883362558;10294.073533382032;10318.845217321596;8496.532690701824;8622.78443038929;8764.956175219084;8844.159804818531;8958.148975847284;8445.324374050184;8545.61544730501;8559.57202139878;8672.566371681516;8762.299016078827;7886.447948643769;7921.247481489249;8005.519668819889;8008.039035315566;8008.7597372078935;5029.899402011866;5791.305043394819;5965.821025369246;6022.126791615104;6038.698065096815;5987.730552125252;6042.577019608585;6122.785702500391;6135.049067394561;6250.687465626609 05:04:08 INFO - PID 1643 | |4;prototype.html;402.20965802198674;406.3562888117565;406.82506522195456;413.68448334296926;417.724301960706;5600.971995140024;6385.840353991141;6392.264889537704;6548.901766473501;6572.73709051638;5199.870003249921;5706.543476521879;6099.390060993898;6401.967990160054;6409.775657851976;4555.929356601196;4667.906641867169;4689.085628302482;4697.342372067913;4700.8952896069395;4291.326382710746;4298.914021719564;4669;4676.883077923045;4720.929186062212;3623.420252759559;4645.6980296280635;4646.4191976003;4663.134746101553;4663.930041049387;4530.524294949032;4587.632989360844;4635.745034023127;4649.163150632885;4668.743219122947;3323.1556486150175;3959.673509374363;3976.5029371328583;3980.20395920817;3989.1822176453757;5476.069068258405;5726.484616384504;6225.159603453521;6325.810225693236;6350.460210882081;4582.33556134362;5312.76092575835;5398.541124004464;5558.499735023867;5559.8888022239735;6819.431530747956;6824.931750682479;6838.213250724512;6848.691808868563;6871.278515755874;3922.607739226083;4362.978185109086;4533.070720502289;4533.977330113328;4540.682152249344;6485.319041500669;6541.574797638138;6667.633280169589;6923.238443771181;7073.752418665374;3921.5294164700417;4087.9386809197886;4358.585934336233;4431.914181025605;4563.452385713736;4051.534073581517;4316.935245971313;4479.888002799956;4690.742009189527;4714.4106986626675;4657.976710116428;5253.870417860178;5456.945430545644;5522.779088836482;5536.916946245809;6789.388954994074;6850.4862135340045;6883.242843287235;6912.688928998106;6920.5847649141215;1357.2738584857054;1555.813302403696;1594.1710310638402;1608.565687264432;1609.2275707660388;1032.3083534032216;1049.3127001813825;1049.821530339844;1051.353417648141;1068.871735391758;5816.941830581724;6328.557001009977;6490.740370385131;6543.607383557001;6557.5899882596095;5948.334466349429;6454.612723236621;6887.311268873073;7143.8571228576175;7160.641967901584;6332.9234030214975;6378.712957916905;6547.9672601636685;6569.80290591283;6590.9681546489155;3254.723348515403;3658.9937767113724;3681.3617940016434;3724.5530536335273;3731.6828069613844;6123.203983482119;7043.401310888632;7436.553806771611;7452.174217316792;7478.401727861758;5795.710214489259;5995.52035837132;6358.586691865014;7016.649167541603;7399.85200295991;6632.568883022588;7329.303716146957;7341.302576255247;7398.630068496554;7416.814579635552;6634.938409854401;7152.247699313702;7175.892361614684;7181.784546463615;7202.315780001101;6652.83367915806;6695.163104611924;6713.468408824122;6978.267281935324;6996.335348141918;6059.848503787441;7059.470539709439;7131.503973609195;7167.426605871622;7185.347370104801;3815.618438156162;4469.128519938711;4600.05698831732;4609.907801844011;4616.607588354893;5205.401378841481;7065.682044307916;7134.393576546052;7144.785386484414;7151.856962860609;6432.716385683015;6555.6066636002;6886.827829304107;6898.379145876896;6901.792946211622;5249.527542521191;5340.786368545215;6705.446113559821;6900.3444672756;6933.37065789529;6364.695237476399;6566.6388348641285;6724.4620430364475;6730.360615741497;6744.763933262312;5318.441563635763;6856.657167141722;6882.139732533434;6923.065386172802;6933.791986240421;6117.113018612187;6129.570930034854;6631.834204144935;6673.632950187786;6680.331966803281 05:04:08 INFO - PID 1643 | |5;yui.html;632.2570979099556;675.9831004224894;682.4574463301675;720.4956530428698;749.5615065186865;15803.446879359224;16027.358905643774;16575.25411356489;16845.831541684594;16873.578160545992;12933.741325173514;14934.253287335618;15336.923315383436;15482.303296351663;15533.37866485342;976.1263669016244;995.1044060345674;1001.9899801001969;1002.293383164867;1003.6888564544978;967.6129548180749;1002.9197664186884;1013.4324778124237;1014.5637375928347;1020.9489525523732;1066.1470823341335;1089.1014912697017;1096;1096.0519150934424;1097.780443911217;1079.13129930406;1087.8205096159124;1092.3609688332335;1096.983545246814;1097.9624255078993;799.2526987266866;805.1867613710136;808.0545761459048;809.2716555100397;809.995950020252;16358.918205409016;16808.57978550546;16866.325346986105;17101.230444630022;17334;12858.614241572674;13205.603831885059;15151.090934543963;15275.409999501477;15276.236188190656;9901.257405694601;11836.763264734656;11888.405579721066;12158.392080396034;12275.508979640803;2742.287005378596;2753.3942532642986;3007.65411977621;3032.090372888125;3063.2188791857934;94655;109488;110166.89833101726;115358.42320788342;117039;10055.497225138713;11667.708307292385;11760.235584686969;11868.287902725864;12217.877821221851;24083.397915052265;24348;24545.931758530183;24546.913512351293;24552.386190345384;8109.918900811034;8123.675052997932;8207.466514676527;8340.582970851434;8446.070932197454;4095.140020595649;4225.514065882463;4240.1307731914885;4273.1240095780295;4282.807273672693;3696.8539752676757;3872.3223435898603;4208.452901122896;4241.957580424218;4260.91478170441;795.8647030004913;799.2473011785702;807.4872455990371;807.9798005049921;811.6996711216888;524.53915844374;530.3026520126022;549.2859282932252;582.2285471749864;586.0710773424171;10433.113185379176;10469.162467002621;10522;10545.894541054644;10696.946515267375;522.639378828607;563.4309347558994;575.6459777236969;585.4528343941124;590.1325052173298;4723.7401942893475;4839.443464001685;4847.345608342899;4856.174450343379;4863.8540843774035;92744;100456.49771751094;100827;101719.47420788695;102049.48975255075;97747.02252977522;98110;98839;99128.50435747919;99620;82870.58564707138;83169.16830831736;84174.57912710398;84796.57601711951;84971.57514212513;8046.275835174863;9869.950650246703;9891.653792117242;9896.554655040396;9899.604015839286;40843;41116.94339584975;41736.79131604323;42238.944026399586;42696;52786.208206877694;52938.47061529335;53228.66928326823;53656.73171634117;54625.1806222899;11701.590444334408;11726.41367931617;11915.82126268124;12297.692557685772;12363.75272494563;12639;12811.80782288285;12853.742925141632;13311.068225224528;13689;11896.405179740805;11922.52309907594;12301.692457688629;12452.564160254347;12658.493660253855;11832.82250766222;11860.517435320586;11948.462319195483;11954.10344224204;12671.113022088733;11695.941520292345;11717.88282117168;11846.466908988943;12147.271163730204;12187.878121218675;8708.390412671051;8820.162084601952;8957.462552246887;9225.58484868196;9687.757806054624;8028.668102737299;8981.955090224506;9042.819143617222;9607;9631 05:04:08 INFO - PID 1643 | __end_tp_report 05:04:08 INFO - PID 1643 | __start_cc_report 05:04:08 INFO - PID 1643 | _x_x_mozilla_cycle_collect,432 05:04:08 INFO - PID 1643 | __end_cc_report 05:04:08 INFO - PID 1643 | __startTimestamp1491221048859__endTimestamp 05:04:08 INFO - PID 1643 | 05:04:08 INFO - PID 1643 | ------- Summary: start ------- 05:04:08 INFO - PID 1643 | Number of tests: 6 05:04:08 INFO - PID 1643 | 05:04:08 INFO - PID 1643 | [#0] dojo.html Cycles:165 Average:6102.22 Median:6386.62 stddev:789.25 (12.4%) stddev-sans-first:751.69 05:04:08 INFO - PID 1643 | Values: 2940.5 3557.6 3588.1 3609.9 3613.6 6093.6 6194.8 6198.6 6199.8 6200.0 5042.7 6134.3 6134.6 6140.8 6196.5 5418.0 5439.0 5474.5 5510.2 5559.3 5371.1 5451.7 5478.9 5517.0 5539.9 5352.1 5384.5 5457.1 5481.2 5505.4 5416.5 5425.9 5438.4 5446.4 5484.0 4008.3 5372.3 5380.9 5392.6 5443.5 4536.6 5264.4 5603.4 6077.0 6128.2 5735.6 6651.7 6665.6 6666.1 6693.8 5939.7 6495.9 6735.7 6755.9 6757.5 6164.0 6189.4 6250.8 6270.2 6275.8 6836.7 6876.6 6901.2 6915.3 6944.8 6304.0 6326.7 6399.4 6482.0 6500.6 6645.6 6708.2 6715.8 6732.3 6765.2 6402.9 6464.3 6634.0 6651.9 6667.4 5609.6 6570.7 6613.8 6720.2 6734.1 5333.6 5338.6 5355.9 5358.5 5378.2 4655.7 4737.1 4745.8 4764.2 4807.8 6303.7 6317.5 6355.3 6382.0 6406.9 6797.1 6816.9 6818.9 6818.9 6827.3 6309.6 6341.5 6386.6 6393.2 6404.9 4435.7 5739.3 5795.6 5803.7 5883.7 6942.8 6980.5 7014.1 7018.1 7023.6 6716.3 6767.7 6782.9 6788.0 6788.4 6720.9 6806.3 6966.5 6994.5 7039.4 6540.1 6613.2 6668.4 6669.0 6692.3 6418.5 6705.5 6731.5 6735.0 6741.4 6415.2 6444.9 6533.2 6541.7 6546.2 6272.0 6532.5 6558.5 6571.3 6576.3 4641.7 6161.9 6294.4 6303.5 6357.4 6555.1 6563.6 6567.1 6578.2 6587.0 6391.6 6396.6 6401.4 6408.3 6412.6 05:04:08 INFO - PID 1643 | 05:04:08 INFO - PID 1643 | [#1] ext.html Cycles:180 Average:52547.97 Median:34725.48 stddev:104263.91 (300.3%) stddev-sans-first:104483.80 05:04:08 INFO - PID 1643 | Values: 726.2 792.9 840.4 1294.6 1299.2 39850.6 40599.0 40600.6 40640.6 40706.0 33190.3 39910.8 40345.6 40347.6 40510.6 7035.4 7381.9 8084.9 8791.4 8792.8 7538.9 8808.3 8835.5 8902.6 8947.9 8826.5 8849.5 8927.9 8935.7 8939.4 8805.3 8847.0 8849.7 8886.0 8956.5 8653.0 8711.3 8715.3 8716.9 8750.8 39668.8 39756.4 39928.6 39948.2 39952.6 2625.6 3056.3 3110.0 3126.6 3133.7 28769.6 28846.4 28923.6 28977.3 28999.9 2367.6 2800.3 2813.8 2837.0 2839.6 245161.0 260364.0 304630.0 338875.0 339421.0 50180.0 50671.0 50888.5 50899.7 50995.7 52250.7 52590.5 52594.5 52893.6 52917.7 14617.4 14719.3 14725.8 14744.2 14749.7 11888.0 12188.8 12191.6 12206.9 12239.0 13826.9 13921.1 13964.5 14048.9 14139.9 5045.4 5945.2 5971.2 5978.0 5985.7 972.9 987.9 998.2 1001.2 1055.8 24710.0 24785.9 24902.0 24904.8 24919.9 1100.6 1126.7 1127.0 1148.3 1148.3 12183.7 12716.9 12837.3 12839.2 12887.3 463161.0 465389.0 466028.0 466542.0 467386.0 56737.4 56918.7 56966.0 57079.0 57583.7 1456.4 1493.7 1527.7 1530.0 1547.4 24222.7 24473.5 24500.0 24638.4 24664.8 39563.6 39753.0 39768.4 39837.8 39980.0 343104.3 404891.0 407303.0 407579.0 408073.0 27939.6 28499.0 34160.0 34464.7 34986.3 36177.6 43740.6 43977.6 45222.8 45401.8 29961.9 30617.1 30621.4 30674.4 31609.7 27490.9 28256.7 28553.9 28646.9 29205.4 29457.0 35369.3 36250.8 36636.8 36673.6 30572.0 30936.1 31098.1 31119.5 31500.5 22977.2 23072.8 23322.3 24568.9 24762.5 05:04:08 INFO - PID 1643 | 05:04:08 INFO - PID 1643 | [#2] jquery.html Cycles:180 Average:41206.90 Median:13407.75 stddev:118211.96 (881.7%) stddev-sans-first:118503.85 05:04:08 INFO - PID 1643 | Values: 392.4 414.7 423.7 431.8 451.4 21897.9 22166.3 22900.9 23101.8 23315.7 18705.9 22465.3 22584.4 22728.3 22779.3 6054.9 6227.2 6266.9 6296.1 6301.5 5839.6 6143.8 6146.0 6206.3 6209.4 6040.8 6155.9 6166.1 6172.4 6172.5 5988.0 6153.4 6183.4 6193.7 6198.6 5447.1 5461.6 5484.9 5508.5 5515.5 27202.9 27369.0 27514.6 27678.0 27858.0 2041.3 2042.2 2060.9 2068.5 2098.2 16373.9 17072.3 17107.7 17111.4 17802.9 1884.4 1893.6 1930.9 1931.6 1975.2 137363.0 137538.0 155598.0 157791.0 177366.1 10424.6 12535.3 12744.0 12895.3 12952.0 13592.1 15923.9 16284.0 16326.0 16338.5 8973.8 9273.6 9312.3 9411.0 9419.9 7551.9 8744.0 8946.5 8979.3 9239.8 6890.6 7769.5 8036.6 8086.2 8143.4 2204.5 2214.7 2219.4 2219.7 2398.5 954.1 954.2 954.8 980.8 983.1 19679.9 21055.6 21232.8 21456.7 24417.0 985.2 991.9 999.9 1017.8 1019.9 9749.9 10774.4 10972.7 11063.6 11089.9 676027.0 696096.0 709834.0 713971.0 718151.0 159614.4 163088.0 164118.0 166698.0 167885.0 1210.4 1229.1 1258.7 1260.6 1264.3 18459.7 18617.8 18624.8 18911.3 21553.7 62699.0 63059.0 63558.7 64225.7 64420.0 87286.6 87789.0 88289.0 89183.0 89386.0 8682.6 8773.5 9056.9 9058.1 9137.3 13619.3 14197.1 14337.1 14715.9 14872.2 11622.6 11626.8 11873.2 12040.5 12151.0 9294.9 9404.8 11184.8 11278.4 11621.9 9394.7 9635.2 11820.5 11836.5 12372.0 7590.4 7734.4 8295.9 8691.3 8720.0 11651.9 11754.9 11962.8 11999.2 12111.0 05:04:08 INFO - PID 1643 | 05:04:08 INFO - PID 1643 | [#3] mootools.html Cycles:180 Average:6816.85 Median:2460.18 stddev:4214.72 (171.3%) stddev-sans-first:4205.41 05:04:08 INFO - PID 1643 | Values: 1200.7 1431.9 1439.4 1445.0 1459.2 10762.4 11024.9 11249.3 11273.3 11310.2 10678.7 10902.2 10904.3 10909.7 10909.7 2433.3 2464.1 2467.9 2473.9 2480.7 2395.7 2415.7 2442.4 2448.6 2460.3 1887.2 1959.6 2457.6 2460.1 2480.9 2184.2 2224.1 2407.9 2418.8 2424.0 1956.6 2032.0 2408.9 2424.5 2438.5 10106.7 10172.8 10825.9 10918.3 11006.9 6139.1 6303.7 6384.1 6392.0 6396.9 4033.4 4043.8 4062.4 4078.3 4102.0 1155.9 1184.2 1184.5 1200.6 1218.6 13634.4 14085.7 15088.9 15416.7 15421.8 5575.0 5756.7 5789.3 5817.6 5853.6 12581.2 12617.7 12642.2 12672.0 12681.7 5786.8 6004.7 6202.8 6317.7 6390.1 5940.8 5972.3 6061.3 6069.1 6078.8 4257.2 4303.7 4310.1 4342.6 4363.9 1232.6 1250.2 1263.1 1263.5 1267.1 775.1 783.5 794.8 800.6 805.9 5923.3 5973.9 6106.0 6142.8 6241.1 560.4 566.6 576.4 576.7 596.7 3993.8 4032.6 4067.8 4118.9 4275.8 13315.6 13852.4 13873.7 13888.6 13890.5 11965.9 13512.5 13633.2 13709.1 13728.6 9898.6 10141.6 10147.6 10163.3 10180.1 5492.4 5758.6 6848.5 6896.8 6908.2 12377.8 12565.1 12590.4 12591.0 12747.7 11830.9 12197.8 12421.0 12628.8 12931.3 9881.6 10062.2 10218.9 10226.5 10247.0 8270.5 10190.8 10263.3 10294.1 10318.8 8496.5 8622.8 8765.0 8844.2 8958.1 8445.3 8545.6 8559.6 8672.6 8762.3 7886.4 7921.2 8005.5 8008.0 8008.8 5029.9 5791.3 5965.8 6022.1 6038.7 5987.7 6042.6 6122.8 6135.0 6250.7 05:04:08 INFO - PID 1643 | 05:04:08 INFO - PID 1643 | [#4] prototype.html Cycles:180 Average:5447.02 Median:6120.16 stddev:1750.97 (28.6%) stddev-sans-first:1714.45 05:04:08 INFO - PID 1643 | Values: 402.2 406.4 406.8 413.7 417.7 5601.0 6385.8 6392.3 6548.9 6572.7 5199.9 5706.5 6099.4 6402.0 6409.8 4555.9 4667.9 4689.1 4697.3 4700.9 4291.3 4298.9 4669.0 4676.9 4720.9 3623.4 4645.7 4646.4 4663.1 4663.9 4530.5 4587.6 4635.7 4649.2 4668.7 3323.2 3959.7 3976.5 3980.2 3989.2 5476.1 5726.5 6225.2 6325.8 6350.5 4582.3 5312.8 5398.5 5558.5 5559.9 6819.4 6824.9 6838.2 6848.7 6871.3 3922.6 4363.0 4533.1 4534.0 4540.7 6485.3 6541.6 6667.6 6923.2 7073.8 3921.5 4087.9 4358.6 4431.9 4563.5 4051.5 4316.9 4479.9 4690.7 4714.4 4658.0 5253.9 5456.9 5522.8 5536.9 6789.4 6850.5 6883.2 6912.7 6920.6 1357.3 1555.8 1594.2 1608.6 1609.2 1032.3 1049.3 1049.8 1051.4 1068.9 5816.9 6328.6 6490.7 6543.6 6557.6 5948.3 6454.6 6887.3 7143.9 7160.6 6332.9 6378.7 6548.0 6569.8 6591.0 3254.7 3659.0 3681.4 3724.6 3731.7 6123.2 7043.4 7436.6 7452.2 7478.4 5795.7 5995.5 6358.6 7016.6 7399.9 6632.6 7329.3 7341.3 7398.6 7416.8 6634.9 7152.2 7175.9 7181.8 7202.3 6652.8 6695.2 6713.5 6978.3 6996.3 6059.8 7059.5 7131.5 7167.4 7185.3 3815.6 4469.1 4600.1 4609.9 4616.6 5205.4 7065.7 7134.4 7144.8 7151.9 6432.7 6555.6 6886.8 6898.4 6901.8 5249.5 5340.8 6705.4 6900.3 6933.4 6364.7 6566.6 6724.5 6730.4 6744.8 5318.4 6856.7 6882.1 6923.1 6933.8 6117.1 6129.6 6631.8 6673.6 6680.3 05:04:08 INFO - PID 1643 | 05:04:08 INFO - PID 1643 | [#5] yui.html Cycles:180 Average:20226.83 Median:2880.52 stddev:29765.12 (1033.3%) stddev-sans-first:29812.25 05:04:08 INFO - PID 1643 | Values: 632.3 676.0 682.5 720.5 749.6 15803.4 16027.4 16575.3 16845.8 16873.6 12933.7 14934.3 15336.9 15482.3 15533.4 976.1 995.1 1002.0 1002.3 1003.7 967.6 1002.9 1013.4 1014.6 1020.9 1066.1 1089.1 1096.0 1096.1 1097.8 1079.1 1087.8 1092.4 1097.0 1098.0 799.3 805.2 808.1 809.3 810.0 16358.9 16808.6 16866.3 17101.2 17334.0 12858.6 13205.6 15151.1 15275.4 15276.2 9901.3 11836.8 11888.4 12158.4 12275.5 2742.3 2753.4 3007.7 3032.1 3063.2 94655.0 109488.0 110166.9 115358.4 117039.0 10055.5 11667.7 11760.2 11868.3 12217.9 24083.4 24348.0 24545.9 24546.9 24552.4 8109.9 8123.7 8207.5 8340.6 8446.1 4095.1 4225.5 4240.1 4273.1 4282.8 3696.9 3872.3 4208.5 4242.0 4260.9 795.9 799.2 807.5 808.0 811.7 524.5 530.3 549.3 582.2 586.1 10433.1 10469.2 10522.0 10545.9 10696.9 522.6 563.4 575.6 585.5 590.1 4723.7 4839.4 4847.3 4856.2 4863.9 92744.0 100456.5 100827.0 101719.5 102049.5 97747.0 98110.0 98839.0 99128.5 99620.0 82870.6 83169.2 84174.6 84796.6 84971.6 8046.3 9870.0 9891.7 9896.6 9899.6 40843.0 41116.9 41736.8 42238.9 42696.0 52786.2 52938.5 53228.7 53656.7 54625.2 11701.6 11726.4 11915.8 12297.7 12363.8 12639.0 12811.8 12853.7 13311.1 13689.0 11896.4 11922.5 12301.7 12452.6 12658.5 11832.8 11860.5 11948.5 11954.1 12671.1 11695.9 11717.9 11846.5 12147.3 12187.9 8708.4 8820.2 8957.5 9225.6 9687.8 8028.7 8982.0 9042.8 9607.0 9631.0 05:04:08 INFO - PID 1643 | -------- Summary: end -------- 05:04:08 INFO - PID 1643 | 05:04:09 INFO - TEST-INFO | 1643: exit 0 05:04:09 INFO - TEST-OK | dromaeo_css | took 1116860ms 05:04:09 INFO - TEST-START | kraken 05:04:09 INFO - operating with platform_type : mac_ 05:04:09 INFO - Initialising browser for kraken test... 05:04:09 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmp6Qc_eP/profile http://localhost:49243/getInfo.html) 05:04:12 INFO - PID 1651 | 2017-04-03 05:04:12.239 plugin-container[1652:10497] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 05:04:12 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:04:12 INFO - PID 1651 | 2017-04-03 05:04:12.242 plugin-container[1652:10497] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e23, name = 'com.apple.CFPasteboardClient' 05:04:12 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:04:12 INFO - PID 1651 | 2017-04-03 05:04:12.242 plugin-container[1652:10497] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:04:12 INFO - PID 1651 | __metrics Screen width/height:1600/1200 05:04:12 INFO - PID 1651 | colorDepth:24 05:04:12 INFO - PID 1651 | Browser inner width/height: 1024/689 05:04:12 INFO - PID 1651 | __metrics 05:04:12 ERROR - PID 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 05:04:13 INFO - TEST-INFO | 1651: exit 0 05:04:13 INFO - Browser initialized. 05:04:13 INFO - Running cycle 1/1 for kraken test... 05:04:13 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmp6Qc_eP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:04:15 INFO - PID 1653 | 2017-04-03 05:04:15.731 plugin-container[1654:10617] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a47, name = 'com.apple.tsm.portname' 05:04:15 INFO - PID 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:04:15 INFO - PID 1653 | 2017-04-03 05:04:15.731 plugin-container[1654:10617] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a4b, name = 'com.apple.CFPasteboardClient' 05:04:15 INFO - PID 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:04:15 INFO - PID 1653 | 2017-04-03 05:04:15.732 plugin-container[1654:10617] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:04:25 INFO - PID 1653 | RSS: Main: 228507648 05:04:25 INFO - PID 1653 | 05:04:28 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 05:04:29 INFO - PID 1653 | RSS: Main: 243376128 05:04:29 INFO - PID 1653 | 05:04:32 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 05:04:32 INFO - PID 1653 | RSS: Main: 252092416 05:04:32 INFO - PID 1653 | 05:04:36 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 05:04:37 INFO - PID 1653 | RSS: Main: 254246912 05:04:37 INFO - PID 1653 | 05:04:38 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 05:04:39 INFO - PID 1653 | RSS: Main: 255336448 05:04:39 INFO - PID 1653 | 05:04:41 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:04:42 INFO - PID 1653 | RSS: Main: 256909312 05:04:42 INFO - PID 1653 | 05:04:45 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 05:04:46 INFO - PID 1653 | RSS: Main: 262598656 05:04:46 INFO - PID 1653 | 05:04:49 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 05:04:50 INFO - PID 1653 | RSS: Main: 263081984 05:04:50 INFO - PID 1653 | 05:04:53 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 05:04:54 INFO - PID 1653 | RSS: Main: 262868992 05:04:54 INFO - PID 1653 | 05:04:55 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:04:56 INFO - PID 1653 | RSS: Main: 262324224 05:04:56 INFO - PID 1653 | 05:04:58 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:04:58 INFO - PID 1653 | RSS: Main: 262193152 05:04:58 INFO - PID 1653 | 05:05:01 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:05:01 INFO - PID 1653 | RSS: Main: 262311936 05:05:01 INFO - PID 1653 | 05:05:04 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:05:05 INFO - PID 1653 | RSS: Main: 262889472 05:05:05 INFO - PID 1653 | 05:05:09 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:05:09 INFO - PID 1653 | RSS: Main: 262406144 05:05:09 INFO - PID 1653 | 05:05:11 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 05:05:11 INFO - PID 1653 | RSS: Main: 265502720 05:05:11 INFO - PID 1653 | 05:05:11 INFO - PID 1653 | __start_tp_report 05:05:11 INFO - PID 1653 | _x_x_mozilla_page_load 05:05:11 INFO - PID 1653 | _x_x_mozilla_page_load_details 05:05:11 INFO - PID 1653 | |i|pagename|runs| 05:05:11 INFO - PID 1653 | |0;ai-astar;159;180;121;123;120;122;120;122;120;115 05:05:11 INFO - PID 1653 | |1;audio-beat-detection;150;115;126;201;132;156;154;131;143;119 05:05:11 INFO - PID 1653 | |2;audio-dft;222;229;236;274;227;219;223;214;214;221 05:05:11 INFO - PID 1653 | |3;audio-fft;93;62;68;88;55;63;62;62;76;57 05:05:11 INFO - PID 1653 | |4;audio-oscillator;85;71;87;73;71;72;85;71;72;88 05:05:11 INFO - PID 1653 | |5;imaging-gaussian-blur;89;140;141;110;140;119;90;140;90;90 05:05:11 INFO - PID 1653 | |6;imaging-darkroom;100;108;162;100;106;100;101;152;131;100 05:05:11 INFO - PID 1653 | |7;imaging-desaturate;166;147;108;158;101;101;100;106;103;103 05:05:11 INFO - PID 1653 | |8;json-parse-financial;52;51;52;57;52;53;53;52;54;53 05:05:11 INFO - PID 1653 | |9;json-stringify-tinderbox;70;63;62;68;75;57;58;60;60;60 05:05:11 INFO - PID 1653 | |10;stanford-crypto-aes;105;114;107;77;81;100;88;114;116;93 05:05:11 INFO - PID 1653 | |11;stanford-crypto-ccm;164;163;161;168;161;170;164;150;222;181 05:05:11 INFO - PID 1653 | |12;stanford-crypto-pbkdf2;197;188;251;200;195;195;196;197;189;177 05:05:11 INFO - PID 1653 | |13;stanford-crypto-sha256-iterative;68;69;68;118;101;62;91;99;104;98 05:05:11 INFO - PID 1653 | __end_tp_report 05:05:11 INFO - PID 1653 | __start_cc_report 05:05:11 INFO - PID 1653 | _x_x_mozilla_cycle_collect,1010 05:05:11 INFO - PID 1653 | __end_cc_report 05:05:11 INFO - PID 1653 | __startTimestamp1491221111877__endTimestamp 05:05:11 INFO - PID 1653 | 05:05:11 INFO - PID 1653 | ------- Summary: start ------- 05:05:11 INFO - PID 1653 | Number of tests: 14 05:05:11 INFO - PID 1653 | 05:05:11 INFO - PID 1653 | [#0] ai-astar Cycles:10 Average:130.20 Median:122.00 stddev:21.41 (17.5%) stddev-sans-first:20.01 05:05:11 INFO - PID 1653 | Values: 159.0 180.0 121.0 123.0 120.0 122.0 120.0 122.0 120.0 115.0 05:05:11 INFO - PID 1653 | 05:05:11 INFO - PID 1653 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:146.50 stddev:24.98 (17.1%) stddev-sans-first:26.36 05:05:11 INFO - PID 1653 | Values: 150.0 115.0 126.0 201.0 132.0 156.0 154.0 131.0 143.0 119.0 05:05:11 INFO - PID 1653 | 05:05:11 INFO - PID 1653 | [#2] audio-dft Cycles:10 Average:227.90 Median:225.00 stddev:17.53 (7.8%) stddev-sans-first:18.46 05:05:11 INFO - PID 1653 | Values: 222.0 229.0 236.0 274.0 227.0 219.0 223.0 214.0 214.0 221.0 05:05:11 INFO - PID 1653 | 05:05:11 INFO - PID 1653 | [#3] audio-fft Cycles:10 Average:68.60 Median:65.50 stddev:12.95 (19.8%) stddev-sans-first:10.29 05:05:11 INFO - PID 1653 | Values: 93.0 62.0 68.0 88.0 55.0 63.0 62.0 62.0 76.0 57.0 05:05:11 INFO - PID 1653 | 05:05:11 INFO - PID 1653 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:79.00 stddev:7.60 (9.6%) stddev-sans-first:7.57 05:05:11 INFO - PID 1653 | Values: 85.0 71.0 87.0 73.0 71.0 72.0 85.0 71.0 72.0 88.0 05:05:11 INFO - PID 1653 | 05:05:11 INFO - PID 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:114.90 Median:115.00 stddev:23.90 (20.8%) stddev-sans-first:23.45 05:05:11 INFO - PID 1653 | Values: 89.0 140.0 141.0 110.0 140.0 119.0 90.0 140.0 90.0 90.0 05:05:11 INFO - PID 1653 | 05:05:11 INFO - PID 1653 | [#6] imaging-darkroom Cycles:10 Average:116.00 Median:107.00 stddev:23.69 (22.1%) stddev-sans-first:24.41 05:05:11 INFO - PID 1653 | Values: 100.0 108.0 162.0 100.0 106.0 100.0 101.0 152.0 131.0 100.0 05:05:11 INFO - PID 1653 | 05:05:11 INFO - PID 1653 | [#7] imaging-desaturate Cycles:10 Average:119.30 Median:107.00 stddev:26.51 (24.8%) stddev-sans-first:22.08 05:05:11 INFO - PID 1653 | Values: 166.0 147.0 108.0 158.0 101.0 101.0 100.0 106.0 103.0 103.0 05:05:11 INFO - PID 1653 | 05:05:11 INFO - PID 1653 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:1.66 (3.1%) stddev-sans-first:1.73 05:05:11 INFO - PID 1653 | Values: 52.0 51.0 52.0 57.0 52.0 53.0 53.0 52.0 54.0 53.0 05:05:11 INFO - PID 1653 | 05:05:11 INFO - PID 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:62.50 stddev:5.83 (9.3%) stddev-sans-first:5.66 05:05:11 INFO - PID 1653 | Values: 70.0 63.0 62.0 68.0 75.0 57.0 58.0 60.0 60.0 60.0 05:05:11 INFO - PID 1653 | 05:05:11 INFO - PID 1653 | [#10] stanford-crypto-aes Cycles:10 Average:99.50 Median:96.50 stddev:14.15 (14.7%) stddev-sans-first:14.87 05:05:11 INFO - PID 1653 | Values: 105.0 114.0 107.0 77.0 81.0 100.0 88.0 114.0 116.0 93.0 05:05:11 INFO - PID 1653 | 05:05:11 INFO - PID 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:170.40 Median:166.00 stddev:19.75 (11.9%) stddev-sans-first:20.81 05:05:11 INFO - PID 1653 | Values: 164.0 163.0 161.0 168.0 161.0 170.0 164.0 150.0 222.0 181.0 05:05:11 INFO - PID 1653 | 05:05:11 INFO - PID 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:198.50 Median:196.50 stddev:19.60 (10.0%) stddev-sans-first:20.78 05:05:11 INFO - PID 1653 | Values: 197.0 188.0 251.0 200.0 195.0 195.0 196.0 197.0 189.0 177.0 05:05:11 INFO - PID 1653 | 05:05:11 INFO - PID 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:87.80 Median:68.50 stddev:19.41 (28.3%) stddev-sans-first:19.22 05:05:11 INFO - PID 1653 | Values: 68.0 69.0 68.0 118.0 101.0 62.0 91.0 99.0 104.0 98.0 05:05:11 INFO - PID 1653 | -------- Summary: end -------- 05:05:11 INFO - PID 1653 | 05:05:12 INFO - TEST-INFO | 1653: exit 0 05:05:12 INFO - TEST-OK | kraken | took 63296ms 05:05:12 INFO - SUITE-END | took 1180s 05:05:13 INFO - Completed test suite (00:19:40) 05:05:13 INFO - javascript benchmark 05:05:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7748.21431985119, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2940.514815055515, 3557.6264492228333, 3588.1388466767985, 3609.9097522561933, 3613.6386361363852, 6093.573449858512, 6194.81415557534, 6198.56610037297, 6199.8140055798285, 6200.0, 5042.747862606873, 6134.2529056856065, 6134.559047376644, 6140.841692977898, 6196.473299769514, 5418.0, 5438.966596346701, 5474.452554744534, 5510.173473978895, 5559.277293951781, 5371.113766228567, 5451.672899626015, 5478.863028424282, 5516.972415137939, 5539.947409992089, 5352.116900711378, 5384.515393614554, 5457.126859702468, 5481.150421684645, 5505.394406615289, 5416.458354164592, 5425.945740542623, 5438.428964958662, 5446.400895901447, 5483.958047970913, 4008.318585840385, 5372.328458942632, 5380.946190538123, 5392.622516423852, 5443.455654434564, 4536.616332018733, 5264.394594621591, 5603.439656034405, 6077.0, 6128.19758601264, 5735.627184233053, 6651.700673469705, 6665.633390163539, 6666.133402657672, 6693.832654183636, 5939.67331796751, 6495.902561461582, 6735.730570777163, 6755.864882702367, 6757.493188010919, 6164.044573091178, 6189.442950134509, 6250.781222657185, 6270.153529273535, 6275.843103922392, 6836.726530938707, 6876.587404755631, 6901.1718593769065, 6915.308469153045, 6944.826379340456, 6303.968480157661, 6326.652034138075, 6399.392057754506, 6481.967590162113, 6500.609963402211, 6645.634490102994, 6708.161479815023, 6715.7985260442265, 6732.2931092235585, 6765.221999470025, 6402.9359706403275, 6464.288928217892, 6633.9668301658185, 6651.900221496681, 6667.433268172163, 5609.607327487037, 6570.704318305688, 6613.834654133589, 6720.22717387497, 6734.124563806674, 5333.626646134733, 5338.599605029638, 5355.946440535623, 5358.517733404013, 5378.1663842104535, 4655.720656760605, 4737.052589482118, 4745.762711864393, 4764.166270902579, 4807.759612019455, 6303.653299068504, 6317.4946004319545, 6355.3009168991375, 6382.0, 6406.903896441557, 6797.116374871235, 6816.931830681629, 6818.863622727517, 6818.93181068183, 6827.317268273133, 6309.589876658002, 6341.524385671093, 6386.616802991835, 6393.1688880445245, 6404.871902561923, 4435.733855968652, 5739.311282646026, 5795.623284486495, 5803.65178089316, 5883.7058147092475, 6942.826429339307, 6980.511364204457, 7014.123234595676, 7018.122734658168, 7023.648817559204, 6716.29478904708, 6767.695453704693, 6782.932170678428, 6787.966060169668, 6788.355106264897, 6720.932790672031, 6806.285340039422, 6966.5471744336455, 6994.545354552141, 7039.401650859734, 6540.051692504655, 6613.206415230203, 6668.366505182, 6668.999650052531, 6692.297308782702, 6418.518611104092, 6705.4635629150525, 6731.46148308144, 6734.966325168343, 6741.393274605309, 6415.230172379344, 6444.871102577828, 6533.248676402274, 6541.738330466728, 6546.24718157418, 6271.96864015677, 6532.5427220096035, 6558.475321974326, 6571.310012448624, 6576.2766095730385, 4641.698289611165, 6161.907571386522, 6294.433500984934, 6303.49572034227, 6357.364263573791, 6555.147830781968, 6563.573367731082, 6567.080608714879, 6578.177727784027, 6586.967065164644, 6391.616503009835, 6396.58422202574, 6401.391867772554, 6408.263049749152, 6412.61524308543], "value": 6048.82590895358, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.1540305544038, 792.932600728938, 840.4033136473106, 1294.5533790842155, 1299.2074834351038, 39850.60149398505, 40599.0, 40600.59399406005, 40640.593594064085, 40706.0, 33190.33619327618, 39910.800445997804, 40345.59654403455, 40347.59652403475, 40510.59489405105, 7035.401990830773, 7381.892716092602, 8084.878726819103, 8791.384603077788, 8792.780180495474, 7538.924610753905, 8808.295336373107, 8835.514046727427, 8902.643894244255, 8947.865782013276, 8826.470411775283, 8849.469031858109, 8927.866082008775, 8935.687250946217, 8939.418937769024, 8805.25155361795, 8846.955765221197, 8849.69026084084, 8885.955570222108, 8956.462612243286, 8653.004904436008, 8711.259542938858, 8715.259202967756, 8716.869246961302, 8750.824983500357, 39668.801655991534, 39756.40365394521, 39928.600713993066, 39948.20103597912, 39952.60047399518, 2625.566781481053, 3056.3428862794385, 3110.004798464492, 3126.5622812806228, 3133.7336326412283, 28769.56845647317, 28846.42307153845, 28923.56614650761, 28977.275568110756, 28999.85500072507, 2367.562001029815, 2800.2999250187454, 2813.817101888371, 2837.0, 2839.574063890412, 245161.0, 260364.0, 304629.9999999978, 338875.0, 339421.0, 50180.0, 50671.0, 50888.49111508911, 50899.74550127226, 50995.725106872625, 52250.73874630602, 52590.47409525932, 52594.47405525972, 52893.6197871089, 52917.7354113227, 14617.415303387745, 14719.337629806685, 14725.779113313309, 14744.189069601274, 14749.705005900036, 11888.0, 12188.756224875453, 12191.573294934635, 12206.877931220573, 12239.0, 13826.930865345608, 13921.095128816594, 13964.51124210668, 14048.859511404755, 14139.85860141406, 5045.41977672565, 5945.16767652529, 5971.164037034819, 5977.970110149508, 5985.670788106696, 972.9416235025922, 987.8765154355706, 998.2463240253562, 1001.2140469731372, 1055.831067029287, 24710.0, 24785.87607061953, 24902.0, 24904.750952490605, 24919.875400623245, 1100.6422912553453, 1126.718320419895, 1126.9575642530626, 1148.305275308443, 1148.322489731046, 12183.695407614703, 12716.872831271568, 12837.293948832717, 12839.165454245443, 12887.291198983958, 463161.0, 465389.0, 466028.0, 466542.0, 467386.0, 56737.44681489343, 56918.71540642353, 56966.0, 57079.0, 57583.712081440164, 1456.4392708807186, 1493.6788590453104, 1527.732646786808, 1529.9541013769606, 1547.4119834463056, 24222.67901333112, 24473.51052978895, 24500.0, 24638.384040399134, 24664.753352466247, 39563.604363955994, 39753.0, 39768.403473947335, 39837.80081099576, 39980.0, 343104.2671799675, 404891.0, 407302.9634851807, 407579.0, 408073.0, 27939.58090628683, 28499.0, 34160.0, 34464.655353447146, 34986.300273994886, 36177.60039910202, 43740.56259437365, 43977.56022439735, 45222.773886131676, 45401.77299113615, 29961.850190748908, 30617.08148755452, 30621.387572247986, 30674.386512269182, 31609.73561057532, 27490.862545687945, 28256.717432825408, 28553.857230713715, 28646.854125834732, 29205.41589168247, 29457.0, 35369.29261414706, 36250.8187459061, 36636.81681591575, 36673.63326366702, 30572.0, 30936.071917842502, 31098.067057988297, 31119.53320700146, 31500.527492088095, 22977.19579814765, 23072.76927230706, 23322.300330990096, 24568.877155614107, 24762.50474990454], "value": 17939.44900349213, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.3800395375307, 414.7221361687669, 423.73940026883474, 431.8229525894382, 451.44246855133906, 21897.905104744757, 22166.335009949726, 22900.88549557254, 23101.768982310172, 23315.650265246033, 18705.906470467664, 22465.326040218777, 22584.43538911528, 22728.31815045547, 22779.31662050137, 6054.909176362358, 6227.221597300338, 6266.874662506747, 6296.118543403904, 6301.52738544611, 5839.591228613998, 6143.784967526138, 6146.0473626587955, 6206.255249370082, 6209.441150296495, 6040.75836966523, 6155.907661385083, 6166.075088736703, 6172.382761723837, 6172.47533959614, 5988.0, 6153.446189842935, 6183.412575805291, 6193.659348735818, 6198.597091189058, 5447.073997420448, 5461.563074954034, 5484.945150548483, 5508.504234618864, 5515.510812080715, 27202.863985680142, 27369.04208352718, 27514.587281190798, 27678.0, 27858.0, 2041.3365656161807, 2042.234162189179, 2060.8660437071544, 2068.5449201175716, 2098.244631932503, 16373.91813040939, 17072.317107315692, 17107.657846843118, 17111.40110096153, 17802.931824090465, 1884.3781552087778, 1893.5550145715745, 1930.8744931579402, 1931.6233334499777, 1975.249405226005, 137363.0, 137538.0, 155598.0, 157791.0, 177366.11316943463, 10424.635137770141, 12535.31055791922, 12744.0, 12895.290759008158, 12952.0, 13592.11651242666, 15923.920380398024, 16284.022958622283, 16326.0, 16338.509844704678, 8973.775655608662, 9273.629054837866, 9312.301577381724, 9411.011843756443, 9419.858702119474, 7551.924480755232, 8744.0, 8946.463212207289, 8979.272119736865, 9239.76900577491, 6890.586564806128, 7769.494982826098, 8036.598170091472, 8086.191380861985, 8143.429959902868, 2204.5370472201016, 2214.7342318921833, 2219.4451387153213, 2219.655953327237, 2398.4843258699116, 954.1269738189618, 954.1984732824461, 954.8233576788316, 980.7597138700921, 983.1348413396165, 19679.901600491907, 21055.578888422147, 21232.832194229155, 21456.678149827454, 24417.023319067393, 985.1872205430549, 991.9355241909253, 999.8650182225307, 1017.7760892603616, 1019.9286049976579, 9749.927507974116, 10774.353538787698, 10972.725681858017, 11063.557457701601, 11089.889101109047, 676027.0, 696096.0, 709834.0, 713971.0, 718151.0, 159614.40385596227, 163088.0, 164118.0, 166698.0, 167885.0, 1210.3706072842074, 1229.1211783574786, 1258.7230809221955, 1260.5588044184462, 1264.3425418782365, 18459.723104153716, 18617.813821861608, 18624.813751862308, 18911.338103166872, 21553.676694849903, 62699.0, 63059.0, 63558.72882542231, 64225.67887160534, 64420.0, 87286.56356718176, 87789.0, 88289.0, 89183.0, 89386.0, 8682.565871706263, 8773.473591584525, 9056.864147037932, 9058.094190581152, 9137.269018478373, 13619.31903404806, 14197.148171109766, 14337.06809057408, 14715.92642036783, 14872.182029988455, 11622.593209237637, 11626.825597615873, 11873.168878178445, 12040.518379264731, 12151.0, 9294.93108292555, 9404.76488087776, 11184.776304473702, 11278.379689117177, 11621.941890290494, 9394.718158455258, 9635.22918166559, 11820.527178912747, 11836.46735896904, 12372.0, 7590.354819840375, 7734.381249500139, 8295.917040829514, 8691.348148888985, 8720.0, 11651.88348116542, 11754.941225293818, 11962.820557691468, 11999.220050696676, 12111.0], "value": 10586.56453186435, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1200.6698158006548, 1431.9498817541382, 1439.3810661415587, 1444.9638759031022, 1459.1536908593016, 10762.35425874448, 11024.889751102486, 11249.325040497575, 11273.32360058396, 11310.151738619616, 10678.679639610804, 10902.236843420964, 10904.34573925565, 10909.672709818698, 10909.727256818584, 2433.2578563538113, 2464.0636558107894, 2467.8766061696933, 2473.863937483438, 2480.7147178074574, 2395.700537432821, 2415.685960825099, 2442.3894026493376, 2448.571499987504, 2460.2619214235747, 1887.2451019592136, 1959.5786905815246, 2457.606782914734, 2460.0897667862914, 2480.8960012794314, 2184.224600266898, 2224.0547767199037, 2407.8555286682767, 2418.7702168293986, 2423.9515209695883, 1956.6086782643529, 2032.0, 2408.9156879509133, 2424.527217192648, 2438.4879175373194, 10106.73665791776, 10172.796544069151, 10825.945870270598, 10918.290311129751, 11006.889931100666, 6139.140520327158, 6303.653299068549, 6384.074309225182, 6392.041193820917, 6396.872062558769, 4033.3546632538655, 4043.757374557536, 4062.3906414037833, 4078.3270760324513, 4101.99501122224, 1155.8786327435666, 1184.1533303687904, 1184.4729095552482, 1200.5977997370892, 1218.5795900414344, 13634.386452609657, 14085.71828563423, 15088.924555377153, 15416.691666166726, 15421.768673469907, 5574.972125139429, 5756.704741433227, 5789.305283366023, 5817.621854579524, 5853.560982926298, 12581.245125292511, 12617.684557886127, 12642.2414655121, 12672.0, 12681.746365072648, 5786.826395208151, 6004.699765011732, 6202.81391558254, 6317.684115794192, 6390.137331460193, 5940.762369505172, 5972.313183983811, 6061.302950160788, 6069.089636554464, 6078.845019446291, 4257.169851878916, 4303.741775493418, 4310.116426132635, 4342.565743425632, 4363.912721745611, 1232.550119206501, 1250.2498500899387, 1263.1347526944073, 1263.5009171377255, 1267.1383459247616, 775.1279810213509, 783.475071701961, 794.7774623105539, 800.5596921693162, 805.9113497515268, 5923.318818335861, 5973.850653733604, 6105.9694701526205, 6142.78500252489, 6241.063840423973, 560.4227645525116, 566.5722379603374, 576.4408523731973, 576.6684156609882, 596.704631207555, 3993.7603743774885, 4032.6370626643156, 4067.8169482373364, 4118.897027574275, 4275.764832934156, 13315.600531984055, 13852.376643051088, 13873.653158671113, 13888.583342499742, 13890.513832015831, 11965.880341196651, 13512.459501620022, 13633.182009079486, 13709.108907920952, 13728.588142355746, 9898.60405583783, 10141.594336226468, 10147.594096236215, 10163.28856980019, 10180.083792458567, 5492.368377636463, 5758.568107392046, 6848.452123829982, 6896.792956296756, 6908.240093589801, 12377.814332784836, 12565.120441569003, 12590.433430495466, 12590.992720582515, 12747.681307967376, 11830.940845295718, 12197.817032744339, 12421.006319494238, 12628.810567841674, 12931.288779116863, 9881.555330010024, 10062.245331600305, 10218.897811022092, 10226.539805708611, 10247.0, 8270.545120018456, 10190.796184076426, 10263.332883362558, 10294.073533382032, 10318.845217321596, 8496.532690701824, 8622.78443038929, 8764.956175219084, 8844.159804818531, 8958.148975847284, 8445.324374050184, 8545.61544730501, 8559.57202139878, 8672.566371681516, 8762.299016078827, 7886.447948643769, 7921.247481489249, 8005.519668819889, 8008.039035315566, 8008.7597372078935, 5029.899402011866, 5791.305043394819, 5965.821025369246, 6022.126791615104, 6038.698065096815, 5987.730552125252, 6042.577019608585, 6122.785702500391, 6135.049067394561, 6250.687465626609], "value": 5130.269927190788, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.20965802198674, 406.3562888117565, 406.82506522195456, 413.68448334296926, 417.724301960706, 5600.971995140024, 6385.840353991141, 6392.264889537704, 6548.901766473501, 6572.73709051638, 5199.870003249921, 5706.543476521879, 6099.390060993898, 6401.967990160054, 6409.775657851976, 4555.929356601196, 4667.906641867169, 4689.085628302482, 4697.342372067913, 4700.8952896069395, 4291.326382710746, 4298.914021719564, 4669.0, 4676.883077923045, 4720.929186062212, 3623.420252759559, 4645.6980296280635, 4646.4191976003, 4663.134746101553, 4663.930041049387, 4530.524294949032, 4587.632989360844, 4635.745034023127, 4649.163150632885, 4668.743219122947, 3323.1556486150175, 3959.673509374363, 3976.5029371328583, 3980.20395920817, 3989.1822176453757, 5476.069068258405, 5726.484616384504, 6225.159603453521, 6325.810225693236, 6350.460210882081, 4582.33556134362, 5312.76092575835, 5398.541124004464, 5558.499735023867, 5559.8888022239735, 6819.431530747956, 6824.931750682479, 6838.213250724512, 6848.691808868563, 6871.278515755874, 3922.607739226083, 4362.978185109086, 4533.070720502289, 4533.977330113328, 4540.682152249344, 6485.319041500669, 6541.574797638138, 6667.633280169589, 6923.238443771181, 7073.752418665374, 3921.5294164700417, 4087.9386809197886, 4358.585934336233, 4431.914181025605, 4563.452385713736, 4051.534073581517, 4316.935245971313, 4479.888002799956, 4690.742009189527, 4714.4106986626675, 4657.976710116428, 5253.870417860178, 5456.945430545644, 5522.779088836482, 5536.916946245809, 6789.388954994074, 6850.4862135340045, 6883.242843287235, 6912.688928998106, 6920.5847649141215, 1357.2738584857054, 1555.813302403696, 1594.1710310638402, 1608.565687264432, 1609.2275707660388, 1032.3083534032216, 1049.3127001813825, 1049.821530339844, 1051.353417648141, 1068.871735391758, 5816.941830581724, 6328.557001009977, 6490.740370385131, 6543.607383557001, 6557.5899882596095, 5948.334466349429, 6454.612723236621, 6887.311268873073, 7143.8571228576175, 7160.641967901584, 6332.9234030214975, 6378.712957916905, 6547.9672601636685, 6569.80290591283, 6590.9681546489155, 3254.723348515403, 3658.9937767113724, 3681.3617940016434, 3724.5530536335273, 3731.6828069613844, 6123.203983482119, 7043.401310888632, 7436.553806771611, 7452.174217316792, 7478.401727861758, 5795.710214489259, 5995.52035837132, 6358.586691865014, 7016.649167541603, 7399.85200295991, 6632.568883022588, 7329.303716146957, 7341.302576255247, 7398.630068496554, 7416.814579635552, 6634.938409854401, 7152.247699313702, 7175.892361614684, 7181.784546463615, 7202.315780001101, 6652.83367915806, 6695.163104611924, 6713.468408824122, 6978.267281935324, 6996.335348141918, 6059.848503787441, 7059.470539709439, 7131.503973609195, 7167.426605871622, 7185.347370104801, 3815.618438156162, 4469.128519938711, 4600.05698831732, 4609.907801844011, 4616.607588354893, 5205.401378841481, 7065.682044307916, 7134.393576546052, 7144.785386484414, 7151.856962860609, 6432.716385683015, 6555.6066636002, 6886.827829304107, 6898.379145876896, 6901.792946211622, 5249.527542521191, 5340.786368545215, 6705.446113559821, 6900.3444672756, 6933.37065789529, 6364.695237476399, 6566.6388348641285, 6724.4620430364475, 6730.360615741497, 6744.763933262312, 5318.441563635763, 6856.657167141722, 6882.139732533434, 6923.065386172802, 6933.791986240421, 6117.113018612187, 6129.570930034854, 6631.834204144935, 6673.632950187786, 6680.331966803281], "value": 4903.7772955101755, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.2570979099556, 675.9831004224894, 682.4574463301675, 720.4956530428698, 749.5615065186865, 15803.446879359224, 16027.358905643774, 16575.25411356489, 16845.831541684594, 16873.578160545992, 12933.741325173514, 14934.253287335618, 15336.923315383436, 15482.303296351663, 15533.37866485342, 976.1263669016244, 995.1044060345674, 1001.9899801001969, 1002.293383164867, 1003.6888564544978, 967.6129548180749, 1002.9197664186884, 1013.4324778124237, 1014.5637375928347, 1020.9489525523732, 1066.1470823341335, 1089.1014912697017, 1096.0, 1096.0519150934424, 1097.780443911217, 1079.13129930406, 1087.8205096159124, 1092.3609688332335, 1096.983545246814, 1097.9624255078993, 799.2526987266866, 805.1867613710136, 808.0545761459048, 809.2716555100397, 809.995950020252, 16358.918205409016, 16808.57978550546, 16866.325346986105, 17101.230444630022, 17334.0, 12858.614241572674, 13205.603831885059, 15151.090934543963, 15275.409999501477, 15276.236188190656, 9901.257405694601, 11836.763264734656, 11888.405579721066, 12158.392080396034, 12275.508979640803, 2742.287005378596, 2753.3942532642986, 3007.65411977621, 3032.090372888125, 3063.2188791857934, 94655.0, 109488.0, 110166.89833101726, 115358.42320788342, 117039.0, 10055.497225138713, 11667.708307292385, 11760.235584686969, 11868.287902725864, 12217.877821221851, 24083.397915052265, 24348.0, 24545.931758530183, 24546.913512351293, 24552.386190345384, 8109.918900811034, 8123.675052997932, 8207.466514676527, 8340.582970851434, 8446.070932197454, 4095.140020595649, 4225.514065882463, 4240.1307731914885, 4273.1240095780295, 4282.807273672693, 3696.8539752676757, 3872.3223435898603, 4208.452901122896, 4241.957580424218, 4260.91478170441, 795.8647030004913, 799.2473011785702, 807.4872455990371, 807.9798005049921, 811.6996711216888, 524.53915844374, 530.3026520126022, 549.2859282932252, 582.2285471749864, 586.0710773424171, 10433.113185379176, 10469.162467002621, 10522.0, 10545.894541054644, 10696.946515267375, 522.639378828607, 563.4309347558994, 575.6459777236969, 585.4528343941124, 590.1325052173298, 4723.7401942893475, 4839.443464001685, 4847.345608342899, 4856.174450343379, 4863.8540843774035, 92744.0, 100456.49771751094, 100827.0, 101719.47420788695, 102049.48975255075, 97747.02252977522, 98110.0, 98839.0, 99128.50435747919, 99620.0, 82870.58564707138, 83169.16830831736, 84174.57912710398, 84796.57601711951, 84971.57514212513, 8046.275835174863, 9869.950650246703, 9891.653792117242, 9896.554655040396, 9899.604015839286, 40843.0, 41116.94339584975, 41736.79131604323, 42238.944026399586, 42696.0, 52786.208206877694, 52938.47061529335, 53228.66928326823, 53656.73171634117, 54625.1806222899, 11701.590444334408, 11726.41367931617, 11915.82126268124, 12297.692557685772, 12363.75272494563, 12639.0, 12811.80782288285, 12853.742925141632, 13311.068225224528, 13689.0, 11896.405179740805, 11922.52309907594, 12301.692457688629, 12452.564160254347, 12658.493660253855, 11832.82250766222, 11860.517435320586, 11948.462319195483, 11954.10344224204, 12671.113022088733, 11695.941520292345, 11717.88282117168, 11846.466908988943, 12147.271163730204, 12187.878121218675, 8708.390412671051, 8820.162084601952, 8957.462552246887, 9225.58484868196, 9687.757806054624, 8028.668102737299, 8981.955090224506, 9042.819143617222, 9607.0, 9631.0], "value": 7486.375675541191, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1669.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 180.0, 121.0, 123.0, 120.0, 122.0, 120.0, 122.0, 120.0, 115.0], "value": 130.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 115.0, 126.0, 201.0, 132.0, 156.0, 154.0, 131.0, 143.0, 119.0], "value": 142.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [222.0, 229.0, 236.0, 274.0, 227.0, 219.0, 223.0, 214.0, 214.0, 221.0], "value": 227.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 62.0, 68.0, 88.0, 55.0, 63.0, 62.0, 62.0, 76.0, 57.0], "value": 68.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 87.0, 73.0, 71.0, 72.0, 85.0, 71.0, 72.0, 88.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 140.0, 141.0, 110.0, 140.0, 119.0, 90.0, 140.0, 90.0, 90.0], "value": 114.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 108.0, 162.0, 100.0, 106.0, 100.0, 101.0, 152.0, 131.0, 100.0], "value": 116.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 147.0, 108.0, 158.0, 101.0, 101.0, 100.0, 106.0, 103.0, 103.0], "value": 119.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 57.0, 52.0, 53.0, 53.0, 52.0, 54.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 63.0, 62.0, 68.0, 75.0, 57.0, 58.0, 60.0, 60.0, 60.0], "value": 63.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 107.0, 77.0, 81.0, 100.0, 88.0, 114.0, 116.0, 93.0], "value": 99.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 161.0, 168.0, 161.0, 170.0, 164.0, 150.0, 222.0, 181.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 188.0, 251.0, 200.0, 195.0, 195.0, 196.0, 197.0, 189.0, 177.0], "value": 198.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 118.0, 101.0, 62.0, 91.0, 99.0, 104.0, 98.0], "value": 87.8, "unit": "score"}]}]} 05:05:13 INFO - Return code: 0 05:05:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:05:13 ERROR - # TBPL SUCCESS # 05:05:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:05:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:05:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:05:13 INFO - 2017-04-03 05:05:13.171 screenresolution[1658:11009] starting screenresolution argv=screenresolution get 05:05:13 INFO - 2017-04-03 05:05:13.174 screenresolution[1658:11009] Display 0: 1600x1200x32@60 05:05:13 INFO - 2017-04-03 05:05:13.181 screenresolution[1659:11012] starting screenresolution argv=screenresolution list 05:05:13 INFO - Available Modes on Display 0 05:05:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:05:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:05:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:05:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:05:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:05:13 INFO - Intel Iris: 05:05:13 INFO - Chipset Model: Intel Iris 05:05:13 INFO - Type: GPU 05:05:13 INFO - Bus: Built-In 05:05:13 INFO - VRAM (Dynamic, Max): 1536 MB 05:05:13 INFO - Vendor: Intel (0x8086) 05:05:13 INFO - Device ID: 0x0a2e 05:05:13 INFO - Revision ID: 0x0009 05:05:13 INFO - Displays: 05:05:13 INFO - Display: 05:05:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:05:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:05:13 INFO - Display Serial Number: 1600x1200 60 05:05:13 INFO - Main Display: Yes 05:05:13 INFO - Mirror: Off 05:05:13 INFO - Online: Yes 05:05:13 INFO - Rotation: Supported 05:05:13 INFO - Return code: 0 05:05:13 INFO - Running post-action listener: _resource_record_post_action 05:05:13 INFO - [mozharness: 2017-04-03 12:05:13.425686Z] Finished run-tests step (success) 05:05:13 INFO - Running post-run listener: _resource_record_post_run 05:05:13 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 41122304; Write bytes: 516993024; Read time: 414; Write time: 1790 05:05:13 INFO - TinderboxPrint: CPU usage
54.2% 05:05:13 INFO - TinderboxPrint: I/O read bytes / time
41,122,304 / 414 05:05:13 INFO - TinderboxPrint: I/O write bytes / time
516,993,024 / 1,790 05:05:13 INFO - TinderboxPrint: CPU idle
2,202.2 (45.8%) 05:05:13 INFO - TinderboxPrint: CPU system
966.1 (20.1%) 05:05:13 INFO - TinderboxPrint: CPU user
1,637.5 (34.1%) 05:05:13 INFO - TinderboxPrint: Swap in / out
251,023,360 / 0 05:05:13 INFO - install - Wall time: 21s; CPU: 55.0%; Read bytes: 209375744; Write bytes: 205166592; Read time: 15672; Write time: 460 05:05:13 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 34886144; Write bytes: 301873152; Read time: 332; Write time: 1297 05:05:13 INFO - Running post-run listener: _upload_blobber_files 05:05:13 INFO - Blob upload gear active. 05:05:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:05:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:05:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:05:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:05:14 INFO - (blobuploader) - INFO - Open directory for files ... 05:05:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:05:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:05:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:15 INFO - (blobuploader) - INFO - Done attempting. 05:05:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:05:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:05:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:16 INFO - (blobuploader) - INFO - Done attempting. 05:05:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:05:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:05:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:18 INFO - (blobuploader) - INFO - Done attempting. 05:05:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:05:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:05:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:22 INFO - (blobuploader) - INFO - Done attempting. 05:05:22 INFO - (blobuploader) - INFO - Iteration through files over. 05:05:22 INFO - Return code: 0 05:05:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:05:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:05:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ec9099c26f7800a224f945e4e93e7194739c99e318eb5c5096bb927623a9adb5c99521ffa6df13b67522b0e5093e54a7fdaee83c9266b29af7bc4202e7d42cf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81f8bd1bb4a7b8fcddcd3f87d923da89364474e7066954d16cb0fa1917a8e88ace1a79c43c41adaaa9ef7a99f875bec284d35e8f5a646bdbc8301fe2d1fa43d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f6f2b9b54c44fd1ced188657fe9b4cf1ee8c089ab0fc55836d03ec403a9e7d5018d67a9e77b253895edcb08f9f012f73d3ce85d7dfd316614e824927c535f52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/028b30461f87ac2f299f613d5752898f1343dd40374c74543ba4739c80c621b038ab8f510957cd7b2a07f6278944f8394586b7eb653d5c9a8e180a649632c5e3"} 05:05:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:05:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:05:22 INFO - Contents: 05:05:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ec9099c26f7800a224f945e4e93e7194739c99e318eb5c5096bb927623a9adb5c99521ffa6df13b67522b0e5093e54a7fdaee83c9266b29af7bc4202e7d42cf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81f8bd1bb4a7b8fcddcd3f87d923da89364474e7066954d16cb0fa1917a8e88ace1a79c43c41adaaa9ef7a99f875bec284d35e8f5a646bdbc8301fe2d1fa43d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f6f2b9b54c44fd1ced188657fe9b4cf1ee8c089ab0fc55836d03ec403a9e7d5018d67a9e77b253895edcb08f9f012f73d3ce85d7dfd316614e824927c535f52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/028b30461f87ac2f299f613d5752898f1343dd40374c74543ba4739c80c621b038ab8f510957cd7b2a07f6278944f8394586b7eb653d5c9a8e180a649632c5e3"} 05:05:22 INFO - Running post-run listener: copy_logs_to_upload_dir 05:05:22 INFO - Copying logs to upload dir... 05:05:22 INFO - mkdir: /builds/slave/test/build/upload/logs 05:05:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1290.600936 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2017-04-03 05:05:22.181075) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 05:05:22.184881) ========= 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.qbh5eP0TZk/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.WNjCrAbet1/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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/8ec9099c26f7800a224f945e4e93e7194739c99e318eb5c5096bb927623a9adb5c99521ffa6df13b67522b0e5093e54a7fdaee83c9266b29af7bc4202e7d42cf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81f8bd1bb4a7b8fcddcd3f87d923da89364474e7066954d16cb0fa1917a8e88ace1a79c43c41adaaa9ef7a99f875bec284d35e8f5a646bdbc8301fe2d1fa43d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f6f2b9b54c44fd1ced188657fe9b4cf1ee8c089ab0fc55836d03ec403a9e7d5018d67a9e77b253895edcb08f9f012f73d3ce85d7dfd316614e824927c535f52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/028b30461f87ac2f299f613d5752898f1343dd40374c74543ba4739c80c621b038ab8f510957cd7b2a07f6278944f8394586b7eb653d5c9a8e180a649632c5e3"} build_url:https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011763 build_url: 'https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ec9099c26f7800a224f945e4e93e7194739c99e318eb5c5096bb927623a9adb5c99521ffa6df13b67522b0e5093e54a7fdaee83c9266b29af7bc4202e7d42cf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81f8bd1bb4a7b8fcddcd3f87d923da89364474e7066954d16cb0fa1917a8e88ace1a79c43c41adaaa9ef7a99f875bec284d35e8f5a646bdbc8301fe2d1fa43d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f6f2b9b54c44fd1ced188657fe9b4cf1ee8c089ab0fc55836d03ec403a9e7d5018d67a9e77b253895edcb08f9f012f73d3ce85d7dfd316614e824927c535f52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/028b30461f87ac2f299f613d5752898f1343dd40374c74543ba4739c80c621b038ab8f510957cd7b2a07f6278944f8394586b7eb653d5c9a8e180a649632c5e3"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 05:05:22.224699) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 05:05:22.225409) ========= 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.qbh5eP0TZk/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.WNjCrAbet1/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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.005128 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 05:05:22.277148) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 05:05:22.277827) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 05:05:22.278542) ========= ========= Total master_lag: 0.25 =========