builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0175 starttime: 1493459817.29 results: success (0) buildid: 20170429015247 builduid: 641fb14fb61846238522b7eb3b8a3263 revision: dac608a22277b6f24d54546118b36939abc63179 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-29 02:56:57.292540) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-29 02:56:57.292987) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-29 02:56:57.293261) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-29 02:56:57.320755) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-29 02:56:57.321154) ========= 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.caOLWSuFnS/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.K5Vz6rdz9M/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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-29 02:56:57-- 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% 13.5M=0.001s 2017-04-29 02:56:57 (13.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.206208 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-29 02:56:57.555517) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-29 02:56:57.556164) ========= 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.caOLWSuFnS/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.K5Vz6rdz9M/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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.029549 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-29 02:56:57.611885) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-29 02:56:57.612649) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dac608a22277b6f24d54546118b36939abc63179 --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 dac608a22277b6f24d54546118b36939abc63179 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.caOLWSuFnS/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.K5Vz6rdz9M/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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-29 02:56:57,860 truncating revision to first 12 chars 2017-04-29 02:56:57,860 Setting DEBUG logging. 2017-04-29 02:56:57,860 attempt 1/10 2017-04-29 02:56:57,860 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dac608a22277?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-29 02:56:59,233 unpacking tar archive at: mozilla-central-dac608a22277/testing/mozharness/ program finished with exit code 0 elapsedTime=1.647923 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-29 02:56:59.288333) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-29 02:56:59.288894) ========= script_repo_revision: dac608a22277b6f24d54546118b36939abc63179 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-29 02:56:59.289588) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-29 02:56:59.290082) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-29 02:56:59.312070) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-04-29 02:56:59.312730) ========= /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.caOLWSuFnS/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.K5Vz6rdz9M/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 02:56:59 INFO - MultiFileLogger online at 20170429 02:56:59 in /builds/slave/test 02:56:59 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 02:56:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:56:59 INFO - {'append_to_log': False, 02:56:59 INFO - 'base_work_dir': '/builds/slave/test', 02:56:59 INFO - 'blob_upload_branch': 'Firefox', 02:56:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:56:59 INFO - 'branch': 'Firefox', 02:56:59 INFO - 'buildbot_json_path': 'buildprops.json', 02:56:59 INFO - 'config_files': ('talos/mac_config.py',), 02:56:59 INFO - 'default_actions': ('clobber', 02:56:59 INFO - 'read-buildbot-config', 02:56:59 INFO - 'download-and-extract', 02:56:59 INFO - 'populate-webroot', 02:56:59 INFO - 'create-virtualenv', 02:56:59 INFO - 'install', 02:56:59 INFO - 'run-tests'), 02:56:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:56:59 INFO - 'download_minidump_stackwalk': True, 02:56:59 INFO - 'download_symbols': 'ondemand', 02:56:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:56:59 INFO - 'tooltool.py': '/tools/tooltool.py', 02:56:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:56:59 INFO - '/tools/misc-python/virtualenv.py')}, 02:56:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:56:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:56:59 INFO - 'gecko_profile': False, 02:56:59 INFO - 'gecko_profile_interval': 0, 02:56:59 INFO - 'installer_path': 'installer.exe', 02:56:59 INFO - 'log_level': 'info', 02:56:59 INFO - 'log_name': 'talos', 02:56:59 INFO - 'log_to_console': True, 02:56:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:56:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:56:59 INFO - 'opt_config_files': (), 02:56:59 INFO - 'pip_index': False, 02:56:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:56:59 INFO - 'cmd': ('bash', 02:56:59 INFO - '-c', 02:56:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:56:59 INFO - 'enabled': True, 02:56:59 INFO - 'halt_on_failure': False, 02:56:59 INFO - 'name': 'check_screen_resolution'},), 02:56:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:56:59 INFO - 'cmd': ('bash', 02:56:59 INFO - '-c', 02:56:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:56:59 INFO - 'enabled': True, 02:56:59 INFO - 'halt_on_failure': False, 02:56:59 INFO - 'name': 'check_screen_resolution'},), 02:56:59 INFO - 'run_cmd_checks_enabled': True, 02:56:59 INFO - 'suite': 'dromaeojs-e10s', 02:56:59 INFO - 'system_bits': '32', 02:56:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:56:59 INFO - 'title': 't-yosemite-r7-0175', 02:56:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:56:59 INFO - 'use_talos_json': True, 02:56:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:56:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:56:59 INFO - 'work_dir': 'build'} 02:56:59 INFO - [mozharness: 2017-04-29 09:56:59.675137Z] Running clobber step. 02:56:59 INFO - Running pre-action listener: _resource_record_pre_action 02:56:59 INFO - Running main action method: clobber 02:56:59 INFO - rmtree: /builds/slave/test/build 02:56:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:57:02 INFO - Running post-action listener: _resource_record_post_action 02:57:02 INFO - [mozharness: 2017-04-29 09:57:02.166735Z] Finished clobber step (success) 02:57:02 INFO - [mozharness: 2017-04-29 09:57:02.166811Z] Running read-buildbot-config step. 02:57:02 INFO - Running pre-action listener: _resource_record_pre_action 02:57:02 INFO - Running main action method: read_buildbot_config 02:57:02 INFO - Using buildbot properties: 02:57:02 INFO - { 02:57:02 INFO - "project": "", 02:57:02 INFO - "product": "firefox", 02:57:02 INFO - "script_repo_revision": "production", 02:57:02 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 02:57:02 INFO - "repository": "", 02:57:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 02:57:02 INFO - "buildid": "20170429015247", 02:57:02 INFO - "pgo_build": "False", 02:57:02 INFO - "basedir": "/builds/slave/test", 02:57:02 INFO - "buildnumber": 55, 02:57:02 INFO - "slavename": "t-yosemite-r7-0175", 02:57:02 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 02:57:02 INFO - "platform": "yosemite_r7", 02:57:02 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 02:57:02 INFO - "branch": "mozilla-central", 02:57:02 INFO - "repo_path": "mozilla-central", 02:57:02 INFO - "revision": "dac608a22277b6f24d54546118b36939abc63179", 02:57:02 INFO - "stage_platform": "macosx64", 02:57:02 INFO - "builduid": "641fb14fb61846238522b7eb3b8a3263", 02:57:02 INFO - "slavebuilddir": "test" 02:57:02 INFO - } 02:57:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/YwnQTodfSAGSEOF3OI-8mw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 02:57:02 INFO - Running post-action listener: _resource_record_post_action 02:57:02 INFO - [mozharness: 2017-04-29 09:57:02.170192Z] Finished read-buildbot-config step (success) 02:57:02 INFO - [mozharness: 2017-04-29 09:57:02.170313Z] Running download-and-extract step. 02:57:02 INFO - Running pre-action listener: _resource_record_pre_action 02:57:02 INFO - Running main action method: download_and_extract 02:57:02 INFO - mkdir: /builds/slave/test/build/tests 02:57:02 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')]} 02:57:02 INFO - trying https://queue.taskcluster.net/v1/task/YwnQTodfSAGSEOF3OI-8mw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 02:57:02 INFO - Downloading https://queue.taskcluster.net/v1/task/YwnQTodfSAGSEOF3OI-8mw/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 02:57:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YwnQTodfSAGSEOF3OI-8mw/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 02:57:03 INFO - Downloaded 1325 bytes. 02:57:03 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 02:57:03 INFO - Using the following test package requirements: 02:57:03 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:57:03 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 02:57:03 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 02:57:03 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:57:03 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 02:57:03 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:57:03 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 02:57:03 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:57:03 INFO - u'jsshell-mac.zip'], 02:57:03 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:57:03 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 02:57:03 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 02:57:03 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:57:03 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 02:57:03 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:57:03 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 02:57:03 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:57:03 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 02:57:03 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:57:03 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 02:57:03 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:57:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YwnQTodfSAGSEOF3OI-8mw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 02:57:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YwnQTodfSAGSEOF3OI-8mw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:57:03 INFO - Fetch https://queue.taskcluster.net/v1/task/YwnQTodfSAGSEOF3OI-8mw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 02:57:05 INFO - Content-Length response header: 52696534 02:57:05 INFO - Bytes received: 52696534 02:57:21 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 02:57:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YwnQTodfSAGSEOF3OI-8mw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 02:57:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YwnQTodfSAGSEOF3OI-8mw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:57:21 INFO - Fetch https://queue.taskcluster.net/v1/task/YwnQTodfSAGSEOF3OI-8mw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 02:57:23 INFO - Content-Length response header: 52696534 02:57:23 INFO - Bytes received: 52696534 02:57:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YwnQTodfSAGSEOF3OI-8mw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 02:57:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YwnQTodfSAGSEOF3OI-8mw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:57:39 INFO - Fetch https://queue.taskcluster.net/v1/task/YwnQTodfSAGSEOF3OI-8mw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 02:57:40 INFO - Content-Length response header: 14408809 02:57:40 INFO - Bytes received: 14408809 02:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:40 INFO - trying https://queue.taskcluster.net/v1/task/YwnQTodfSAGSEOF3OI-8mw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 02:57:40 INFO - Downloading https://queue.taskcluster.net/v1/task/YwnQTodfSAGSEOF3OI-8mw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 02:57:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YwnQTodfSAGSEOF3OI-8mw/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 02:57:42 INFO - Downloaded 71202461 bytes. 02:57:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YwnQTodfSAGSEOF3OI-8mw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 02:57:42 INFO - mkdir: /builds/slave/test/properties 02:57:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:57:42 INFO - Writing to file /builds/slave/test/properties/build_url 02:57:42 INFO - Contents: 02:57:42 INFO - build_url:https://queue.taskcluster.net/v1/task/YwnQTodfSAGSEOF3OI-8mw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 02:57:42 INFO - Running post-action listener: _resource_record_post_action 02:57:42 INFO - Running post-action listener: set_extra_try_arguments 02:57:42 INFO - [mozharness: 2017-04-29 09:57:42.997581Z] Finished download-and-extract step (success) 02:57:42 INFO - [mozharness: 2017-04-29 09:57:42.997700Z] Running populate-webroot step. 02:57:42 INFO - Running pre-action listener: _resource_record_pre_action 02:57:42 INFO - Running main action method: populate_webroot 02:57:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:57:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:57:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:57:43 INFO - '--tppagecycles', 02:57:43 INFO - '7'], 02:57:43 INFO - 'tests': ['tsvgm']}}, 02:57:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:57:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:57:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:57:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:57:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:57:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:57:43 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:57:43 INFO - 'talos_options': ['--disable-e10s'], 02:57:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:57:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:57:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:57:43 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:57:43 INFO - 'talos_options': ['--disable-e10s'], 02:57:43 INFO - 'tests': ['damp', 'tps']}, 02:57:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:57:43 INFO - 'tests': ['damp', 'tps']}, 02:57:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:57:43 INFO - 'tests': ['dromaeo_dom']}, 02:57:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:57:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:57:43 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:57:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:57:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:57:43 INFO - 'tests': ['a11yr', 02:57:43 INFO - 'ts_paint', 02:57:43 INFO - 'tpaint', 02:57:43 INFO - 'sessionrestore', 02:57:43 INFO - 'sessionrestore_no_auto_restore', 02:57:43 INFO - 'tabpaint']}, 02:57:43 INFO - 'other-e10s': {'tests': ['a11yr', 02:57:43 INFO - 'ts_paint', 02:57:43 INFO - 'tpaint', 02:57:43 INFO - 'sessionrestore', 02:57:43 INFO - 'sessionrestore_no_auto_restore', 02:57:43 INFO - 'tabpaint']}, 02:57:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:57:43 INFO - 'ts_paint', 02:57:43 INFO - 'tpaint', 02:57:43 INFO - 'sessionrestore', 02:57:43 INFO - 'sessionrestore_no_auto_restore', 02:57:43 INFO - 'tabpaint']}, 02:57:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:57:43 INFO - 'ts_paint', 02:57:43 INFO - 'tpaint', 02:57:43 INFO - 'sessionrestore', 02:57:43 INFO - 'sessionrestore_no_auto_restore', 02:57:43 INFO - 'tabpaint']}, 02:57:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:57:43 INFO - 'tests': ['a11yr', 02:57:43 INFO - 'ts_paint', 02:57:43 INFO - 'tpaint', 02:57:43 INFO - 'sessionrestore', 02:57:43 INFO - 'sessionrestore_no_auto_restore', 02:57:43 INFO - 'tabpaint']}, 02:57:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:57:43 INFO - 'tests': ['a11yr', 02:57:43 INFO - 'ts_paint', 02:57:43 INFO - 'tpaint', 02:57:43 INFO - 'sessionrestore', 02:57:43 INFO - 'sessionrestore_no_auto_restore', 02:57:43 INFO - 'tabpaint']}, 02:57:43 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:57:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:57:43 INFO - 'bloom_basic_ref']}, 02:57:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:57:43 INFO - 'tests': ['tsvgx', 02:57:43 INFO - 'tsvgr_opacity', 02:57:43 INFO - 'tart', 02:57:43 INFO - 'tscrollx', 02:57:43 INFO - 'cart', 02:57:43 INFO - 'tsvg_static']}, 02:57:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:57:43 INFO - 'tsvgr_opacity', 02:57:43 INFO - 'tart', 02:57:43 INFO - 'tscrollx', 02:57:43 INFO - 'cart', 02:57:43 INFO - 'tsvg_static']}, 02:57:43 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:57:43 INFO - 'talos_options': ['--disable-e10s'], 02:57:43 INFO - 'tests': ['tp5o']}, 02:57:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:57:43 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:57:43 INFO - 'talos_options': ['--disable-e10s', 02:57:43 INFO - '--xperf_path', 02:57:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:57:43 INFO - 'tests': ['tp5n']}, 02:57:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:57:43 INFO - 'talos_options': ['--xperf_path', 02:57:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:57:43 INFO - 'tests': ['tp5n']}}, 02:57:43 INFO - 'talos.zip': {'path': '', 02:57:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:57:43 INFO - Running post-action listener: _resource_record_post_action 02:57:43 INFO - [mozharness: 2017-04-29 09:57:43.016951Z] Finished populate-webroot step (success) 02:57:43 INFO - [mozharness: 2017-04-29 09:57:43.017051Z] Running create-virtualenv step. 02:57:43 INFO - Running pre-action listener: _resource_record_pre_action 02:57:43 INFO - Running main action method: create_virtualenv 02:57:43 INFO - Creating virtualenv /builds/slave/test/build/venv 02:57:43 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 02:57:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:57:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:57:43 INFO - Using real prefix '/tools/python27' 02:57:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:57:43 INFO - Installing distribute.............................................................................................................................................................................................done. 02:57:46 INFO - Installing pip.................done. 02:57:46 INFO - Return code: 0 02:57:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:57:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:57:47 INFO - Reading from file tmpfile_stdout 02:57:47 INFO - Output received: 02:57:47 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) 02:57:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:57: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')]} 02:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57: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')]} 02:57:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:47 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 0x1070a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fd04721b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e80d30>, '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 0x106da6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e75be8>, '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.caOLWSuFnS/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.K5Vz6rdz9M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 02:57:47 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 02:57:47 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 02:57:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.caOLWSuFnS/Render', 02:57:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:57:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:57:47 INFO - 'HOME': '/Users/cltbld', 02:57:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:57:47 INFO - 'LOGNAME': 'cltbld', 02:57:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:47 INFO - 'MOZ_NO_REMOTE': '1', 02:57:47 INFO - 'NO_EM_RESTART': '1', 02:57:47 INFO - 'PAGER': '/bin/cat', 02:57:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:57:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:47 INFO - 'PWD': '/builds/slave/test', 02:57:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:57:47 INFO - 'SHELL': '/bin/bash', 02:57:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K5Vz6rdz9M/Listeners', 02:57:47 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 02:57:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:57:47 INFO - 'USER': 'cltbld', 02:57:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:57:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:57:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:47 INFO - 'XPC_FLAGS': '0x0', 02:57:47 INFO - 'XPC_SERVICE_NAME': '0', 02:57:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:57:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:47 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 02:57:47 INFO - Cleaning up... 02:57:47 INFO - Return code: 0 02:57:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:57: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')]} 02:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57: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')]} 02:57:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:47 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 0x1070a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fd04721b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e80d30>, '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 0x106da6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e75be8>, '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.caOLWSuFnS/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.K5Vz6rdz9M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 02:57:47 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 02:57:47 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 02:57:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.caOLWSuFnS/Render', 02:57:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:57:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:57:47 INFO - 'HOME': '/Users/cltbld', 02:57:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:57:47 INFO - 'LOGNAME': 'cltbld', 02:57:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:47 INFO - 'MOZ_NO_REMOTE': '1', 02:57:47 INFO - 'NO_EM_RESTART': '1', 02:57:47 INFO - 'PAGER': '/bin/cat', 02:57:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:57:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:47 INFO - 'PWD': '/builds/slave/test', 02:57:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:57:47 INFO - 'SHELL': '/bin/bash', 02:57:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K5Vz6rdz9M/Listeners', 02:57:47 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 02:57:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:57:47 INFO - 'USER': 'cltbld', 02:57:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:57:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:57:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:47 INFO - 'XPC_FLAGS': '0x0', 02:57:47 INFO - 'XPC_SERVICE_NAME': '0', 02:57:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:57:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:47 INFO - Downloading/unpacking psutil>=3.1.1 02:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:57:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:57:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:57:50 INFO - Installing collected packages: psutil 02:57:50 INFO - Running setup.py install for psutil 02:57:51 INFO - building 'psutil._psutil_osx' extension 02:57:51 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 02:57:51 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 02:57:51 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 02:57:51 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 02:57:51 INFO - building 'psutil._psutil_posix' extension 02:57:51 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 02:57:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:57:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:57:51 INFO - ^ 02:57:51 INFO - 1 warning generated. 02:57:51 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 02:57:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:57:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:57:52 INFO - Successfully installed psutil 02:57:52 INFO - Cleaning up... 02:57:52 INFO - Return code: 0 02:57:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:52 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 0x1070a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fd04721b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e80d30>, '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 0x106da6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e75be8>, '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.caOLWSuFnS/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.K5Vz6rdz9M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 02:57:52 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 02:57:52 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 02:57:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.caOLWSuFnS/Render', 02:57:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:57:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:57:52 INFO - 'HOME': '/Users/cltbld', 02:57:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:57:52 INFO - 'LOGNAME': 'cltbld', 02:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:52 INFO - 'MOZ_NO_REMOTE': '1', 02:57:52 INFO - 'NO_EM_RESTART': '1', 02:57:52 INFO - 'PAGER': '/bin/cat', 02:57:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:52 INFO - 'PWD': '/builds/slave/test', 02:57:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:57:52 INFO - 'SHELL': '/bin/bash', 02:57:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K5Vz6rdz9M/Listeners', 02:57:52 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 02:57:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:57:52 INFO - 'USER': 'cltbld', 02:57:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:57:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:52 INFO - 'XPC_FLAGS': '0x0', 02:57:52 INFO - 'XPC_SERVICE_NAME': '0', 02:57:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:57:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:57:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:57:55 INFO - Installing collected packages: mozsystemmonitor 02:57:55 INFO - Running setup.py install for mozsystemmonitor 02:57:55 INFO - Successfully installed mozsystemmonitor 02:57:55 INFO - Cleaning up... 02:57:55 INFO - Return code: 0 02:57:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:57: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')]} 02:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57: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')]} 02:57:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1070a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fd04721b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e80d30>, '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 0x106da6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e75be8>, '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.caOLWSuFnS/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.K5Vz6rdz9M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 02:57:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:57:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:57:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.caOLWSuFnS/Render', 02:57:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:57:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:57:56 INFO - 'HOME': '/Users/cltbld', 02:57:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:57:56 INFO - 'LOGNAME': 'cltbld', 02:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:56 INFO - 'MOZ_NO_REMOTE': '1', 02:57:56 INFO - 'NO_EM_RESTART': '1', 02:57:56 INFO - 'PAGER': '/bin/cat', 02:57:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:56 INFO - 'PWD': '/builds/slave/test', 02:57:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:57:56 INFO - 'SHELL': '/bin/bash', 02:57:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K5Vz6rdz9M/Listeners', 02:57:56 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 02:57:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:57:56 INFO - 'USER': 'cltbld', 02:57:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:57:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:56 INFO - 'XPC_FLAGS': '0x0', 02:57:56 INFO - 'XPC_SERVICE_NAME': '0', 02:57:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:56 INFO - Downloading/unpacking jsonschema==2.5.1 02:57:56 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 02:57:56 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 02:57:56 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 02:57:56 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 02:57:56 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 02:57:56 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 02:57:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:57:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:57: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 02:57: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 02:57: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 02:57: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 02:57: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 02:57: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 02:57:59 INFO - Downloading functools32-3.2.3-2.tar.gz 02:57:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:57:59 INFO - warning: no files found matching '*.txt' 02:57:59 INFO - no previously-included directories found matching 'build' 02:57:59 INFO - no previously-included directories found matching 'dist' 02:57:59 INFO - no previously-included directories found matching '.git*' 02:57:59 INFO - Installing collected packages: jsonschema, functools32 02:57:59 INFO - Running setup.py install for functools32 02:57:59 INFO - warning: no files found matching '*.txt' 02:57:59 INFO - no previously-included directories found matching 'build' 02:57:59 INFO - no previously-included directories found matching 'dist' 02:57:59 INFO - no previously-included directories found matching '.git*' 02:57:59 INFO - Successfully installed jsonschema functools32 02:57:59 INFO - Cleaning up... 02:57:59 INFO - Return code: 0 02:57:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:57:59 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')]} 02:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:59 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')]} 02:57:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:59 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 0x1070a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fd04721b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e80d30>, '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 0x106da6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e75be8>, '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.caOLWSuFnS/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.K5Vz6rdz9M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 02:57:59 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 02:57:59 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 02:57:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.caOLWSuFnS/Render', 02:57:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:57:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:57:59 INFO - 'HOME': '/Users/cltbld', 02:57:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:57:59 INFO - 'LOGNAME': 'cltbld', 02:57:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:59 INFO - 'MOZ_NO_REMOTE': '1', 02:57:59 INFO - 'NO_EM_RESTART': '1', 02:57:59 INFO - 'PAGER': '/bin/cat', 02:57:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:57:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:59 INFO - 'PWD': '/builds/slave/test', 02:57:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:57:59 INFO - 'SHELL': '/bin/bash', 02:57:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K5Vz6rdz9M/Listeners', 02:57:59 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 02:57:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:57:59 INFO - 'USER': 'cltbld', 02:57:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:57:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:57:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:59 INFO - 'XPC_FLAGS': '0x0', 02:57:59 INFO - 'XPC_SERVICE_NAME': '0', 02:57:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:58:00 INFO - Cleaning up... 02:58:00 INFO - Return code: 0 02:58:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:58: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')]} 02:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58: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')]} 02:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1070a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fd04721b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e80d30>, '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 0x106da6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e75be8>, '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.caOLWSuFnS/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.K5Vz6rdz9M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 02:58:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:58:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:58:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.caOLWSuFnS/Render', 02:58:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:00 INFO - 'HOME': '/Users/cltbld', 02:58:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:00 INFO - 'LOGNAME': 'cltbld', 02:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:00 INFO - 'MOZ_NO_REMOTE': '1', 02:58:00 INFO - 'NO_EM_RESTART': '1', 02:58:00 INFO - 'PAGER': '/bin/cat', 02:58:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:00 INFO - 'PWD': '/builds/slave/test', 02:58:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:00 INFO - 'SHELL': '/bin/bash', 02:58:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K5Vz6rdz9M/Listeners', 02:58:00 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 02:58:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:00 INFO - 'USER': 'cltbld', 02:58:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:00 INFO - 'XPC_FLAGS': '0x0', 02:58:00 INFO - 'XPC_SERVICE_NAME': '0', 02:58:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:00 INFO - Downloading/unpacking blobuploader==1.2.4 02:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:03 INFO - Downloading blobuploader-1.2.4.tar.gz 02:58:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:58:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:58:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:04 INFO - Downloading docopt-0.6.1.tar.gz 02:58:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:58:04 INFO - Installing collected packages: blobuploader, requests, docopt 02:58:04 INFO - Running setup.py install for blobuploader 02:58:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:58:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:58:04 INFO - Running setup.py install for requests 02:58:04 INFO - Running setup.py install for docopt 02:58:05 INFO - Successfully installed blobuploader requests docopt 02:58:05 INFO - Cleaning up... 02:58:05 INFO - Return code: 0 02:58:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:58: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')]} 02:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58: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')]} 02:58:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1070a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fd04721b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e80d30>, '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 0x106da6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e75be8>, '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.caOLWSuFnS/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.K5Vz6rdz9M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 02:58:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:58:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.caOLWSuFnS/Render', 02:58:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:05 INFO - 'HOME': '/Users/cltbld', 02:58:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:05 INFO - 'LOGNAME': 'cltbld', 02:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:05 INFO - 'MOZ_NO_REMOTE': '1', 02:58:05 INFO - 'NO_EM_RESTART': '1', 02:58:05 INFO - 'PAGER': '/bin/cat', 02:58:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:05 INFO - 'PWD': '/builds/slave/test', 02:58:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:05 INFO - 'SHELL': '/bin/bash', 02:58:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K5Vz6rdz9M/Listeners', 02:58:05 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 02:58:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:05 INFO - 'USER': 'cltbld', 02:58:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:05 INFO - 'XPC_FLAGS': '0x0', 02:58:05 INFO - 'XPC_SERVICE_NAME': '0', 02:58:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:58:05 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-2d9vPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:58:05 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-bGei2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:58:05 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-FFZlMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:58:05 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-9RS7SS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:58:05 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-0iPc7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:58:05 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-l_O6_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:58:06 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-l_y_v3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:58:06 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-1ODAum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:58:06 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-i06tDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:58:06 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-UXoshK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:58:06 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-3UfutD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:58:06 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-LHkOpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:58:06 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-si19sI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:58:06 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-JDPHfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:06 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-Bf_fTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:58:06 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-GGqfel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:58:07 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-OuYedF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:58:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:58:07 INFO - Running setup.py install for manifestparser 02:58:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:58:07 INFO - Running setup.py install for mozcrash 02:58:07 INFO - Running setup.py install for mozdebug 02:58:07 INFO - Running setup.py install for mozdevice 02:58:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:58:07 INFO - Running setup.py install for mozfile 02:58:07 INFO - Running setup.py install for mozhttpd 02:58:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:58:08 INFO - Running setup.py install for mozinfo 02:58:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:58:08 INFO - Running setup.py install for mozInstall 02:58:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:58:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:58:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:58:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:58:08 INFO - Running setup.py install for mozleak 02:58:08 INFO - Running setup.py install for mozlog 02:58:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:58:08 INFO - Running setup.py install for moznetwork 02:58:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:58:08 INFO - Running setup.py install for mozprocess 02:58:08 INFO - Running setup.py install for mozprofile 02:58:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:58:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:58:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:58:09 INFO - Running setup.py install for mozrunner 02:58:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:58:09 INFO - Running setup.py install for mozscreenshot 02:58:09 INFO - Running setup.py install for moztest 02:58:09 INFO - Running setup.py install for mozversion 02:58:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:58:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:58:09 INFO - Cleaning up... 02:58:09 INFO - Return code: 0 02:58:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:58:09 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')]} 02:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:09 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')]} 02:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:09 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 0x1070a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fd04721b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e80d30>, '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 0x106da6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e75be8>, '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.caOLWSuFnS/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.K5Vz6rdz9M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 02:58:09 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 02:58:09 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 02:58:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.caOLWSuFnS/Render', 02:58:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:09 INFO - 'HOME': '/Users/cltbld', 02:58:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:09 INFO - 'LOGNAME': 'cltbld', 02:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:09 INFO - 'MOZ_NO_REMOTE': '1', 02:58:09 INFO - 'NO_EM_RESTART': '1', 02:58:09 INFO - 'PAGER': '/bin/cat', 02:58:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:09 INFO - 'PWD': '/builds/slave/test', 02:58:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:09 INFO - 'SHELL': '/bin/bash', 02:58:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K5Vz6rdz9M/Listeners', 02:58:09 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 02:58:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:09 INFO - 'USER': 'cltbld', 02:58:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:09 INFO - 'XPC_FLAGS': '0x0', 02:58:09 INFO - 'XPC_SERVICE_NAME': '0', 02:58:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:58:10 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-fmP9Si-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:58:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:58:10 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-ElYfbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:58:10 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)) 02:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:58:10 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-mqQDJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:58:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:58:10 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-tkznH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:58:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 02:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:58:10 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-OWXbtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:58:10 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)) 02:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:58:10 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-pEfCAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:58:10 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)) 02:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:58:10 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-cM6tg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:58:10 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)) 02:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:58:10 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-bNUF7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:58:10 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)) 02:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:58:10 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-eR6mXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:58:10 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)) 02:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:58:10 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-IuJPyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:58:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:58:11 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-M6waUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:58:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:58:11 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-cVqtbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:58:11 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)) 02:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:58:11 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-kMyz8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:58:11 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)) 02:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:58:11 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-E4ijws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:58:11 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)) 02:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:11 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-vtZBbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:11 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)) 02:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:58:11 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-sxSwjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:58:11 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)) 02:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:58:11 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-KcOXvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:58:11 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)) 02:58:11 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)) 02:58:11 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)) 02:58:11 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)) 02:58:11 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:58:11 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:58:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:58:11 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 02:58:11 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 02:58:11 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 02:58:11 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 02:58:11 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 02:58:11 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 02:58:14 INFO - Downloading blessings-1.6.tar.gz 02:58:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:58:14 INFO - Installing collected packages: blessings 02:58:14 INFO - Running setup.py install for blessings 02:58:14 INFO - Successfully installed blessings 02:58:14 INFO - Cleaning up... 02:58:14 INFO - Return code: 0 02:58:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:58:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:58:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:58:14 INFO - Reading from file tmpfile_stdout 02:58:14 INFO - Current package versions: 02:58:14 INFO - blessings == 1.6 02:58:14 INFO - blobuploader == 1.2.4 02:58:14 INFO - docopt == 0.6.1 02:58:14 INFO - functools32 == 3.2.3-2 02:58:14 INFO - jsonschema == 2.5.1 02:58:14 INFO - manifestparser == 1.1 02:58:14 INFO - mozInstall == 1.12 02:58:14 INFO - mozcrash == 1.0 02:58:14 INFO - mozdebug == 0.1 02:58:14 INFO - mozdevice == 0.50 02:58:14 INFO - mozfile == 1.2 02:58:14 INFO - mozhttpd == 0.7 02:58:14 INFO - mozinfo == 0.9 02:58:14 INFO - mozleak == 0.1 02:58:14 INFO - mozlog == 3.4 02:58:14 INFO - moznetwork == 0.27 02:58:14 INFO - mozprocess == 0.25 02:58:14 INFO - mozprofile == 0.28 02:58:14 INFO - mozrunner == 6.13 02:58:14 INFO - mozscreenshot == 0.1 02:58:14 INFO - mozsystemmonitor == 0.3 02:58:14 INFO - moztest == 0.8 02:58:14 INFO - mozversion == 1.4 02:58:14 INFO - psutil == 3.1.1 02:58:14 INFO - requests == 1.2.3 02:58:14 INFO - wsgiref == 0.1.2 02:58:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1070a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fd04721b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e80d30>, '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 0x106da6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e75be8>, '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.caOLWSuFnS/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.K5Vz6rdz9M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 02:58:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:58:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:58:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.caOLWSuFnS/Render', 02:58:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:14 INFO - 'HOME': '/Users/cltbld', 02:58:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:14 INFO - 'LOGNAME': 'cltbld', 02:58:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:14 INFO - 'MOZ_NO_REMOTE': '1', 02:58:14 INFO - 'NO_EM_RESTART': '1', 02:58:14 INFO - 'PAGER': '/bin/cat', 02:58:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:14 INFO - 'PWD': '/builds/slave/test', 02:58:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:14 INFO - 'SHELL': '/bin/bash', 02:58:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K5Vz6rdz9M/Listeners', 02:58:14 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 02:58:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:14 INFO - 'USER': 'cltbld', 02:58:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:14 INFO - 'XPC_FLAGS': '0x0', 02:58:14 INFO - 'XPC_SERVICE_NAME': '0', 02:58:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:58:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:58:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:58:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:58:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:58:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:58:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:58:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:58:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:58:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:58:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:58:15 INFO - Cleaning up... 02:58:15 INFO - Return code: 0 02:58:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:58:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:15 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 0x1070a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fd04721b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e80d30>, '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 0x106da6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e75be8>, '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.caOLWSuFnS/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.K5Vz6rdz9M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 02:58:15 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 02:58:15 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 02:58:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.caOLWSuFnS/Render', 02:58:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:15 INFO - 'HOME': '/Users/cltbld', 02:58:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:15 INFO - 'LOGNAME': 'cltbld', 02:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:15 INFO - 'MOZ_NO_REMOTE': '1', 02:58:15 INFO - 'NO_EM_RESTART': '1', 02:58:15 INFO - 'PAGER': '/bin/cat', 02:58:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:15 INFO - 'PWD': '/builds/slave/test', 02:58:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:15 INFO - 'SHELL': '/bin/bash', 02:58:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K5Vz6rdz9M/Listeners', 02:58:15 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 02:58:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:15 INFO - 'USER': 'cltbld', 02:58:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:15 INFO - 'XPC_FLAGS': '0x0', 02:58:15 INFO - 'XPC_SERVICE_NAME': '0', 02:58:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:58:15 INFO - Cleaning up... 02:58:15 INFO - Return code: 0 02:58:15 INFO - Running post-action listener: _resource_record_post_action 02:58:15 INFO - Running post-action listener: _start_resource_monitoring 02:58:15 INFO - Starting resource monitoring. 02:58:15 INFO - [mozharness: 2017-04-29 09:58:15.505266Z] Finished create-virtualenv step (success) 02:58:15 INFO - [mozharness: 2017-04-29 09:58:15.506225Z] Running install step. 02:58:15 INFO - Running pre-action listener: _resource_record_pre_action 02:58:15 INFO - Running main action method: install 02:58:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:58:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:58:15 INFO - Reading from file tmpfile_stdout 02:58:15 INFO - Detecting whether we're running mozinstall >=1.0... 02:58:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:58:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:58:15 INFO - Reading from file tmpfile_stdout 02:58:15 INFO - Output received: 02:58:15 INFO - Usage: mozinstall [options] installer 02:58:15 INFO - Options: 02:58:15 INFO - -h, --help show this help message and exit 02:58:15 INFO - -d DEST, --destination=DEST 02:58:15 INFO - Directory to install application into. [default: 02:58:15 INFO - "/builds/slave/test"] 02:58:15 INFO - --app=APP Application being installed. [default: firefox] 02:58:15 INFO - mkdir: /builds/slave/test/build/application 02:58:15 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'] 02:58:15 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 02:58:35 INFO - Reading from file tmpfile_stdout 02:58:35 INFO - Output received: 02:58:35 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:58:35 INFO - Running post-action listener: _resource_record_post_action 02:58:35 INFO - [mozharness: 2017-04-29 09:58:35.527781Z] Finished install step (success) 02:58:35 INFO - [mozharness: 2017-04-29 09:58:35.527911Z] Running run-tests step. 02:58:35 INFO - Running pre-action listener: _resource_record_pre_action 02:58:35 INFO - Running main action method: run_tests 02:58:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:58:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:58:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:58:35 INFO - 2017-04-29 02:58:35.542 screenresolution[1631:7373] starting screenresolution argv=screenresolution get 02:58:35 INFO - 2017-04-29 02:58:35.545 screenresolution[1631:7373] Display 0: 1600x1200x32@60 02:58:35 INFO - 2017-04-29 02:58:35.550 screenresolution[1632:7376] starting screenresolution argv=screenresolution list 02:58:35 INFO - Available Modes on Display 0 02:58:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:58:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:58:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:58:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:58:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:58:35 INFO - Intel Iris: 02:58:35 INFO - Chipset Model: Intel Iris 02:58:35 INFO - Type: GPU 02:58:35 INFO - Bus: Built-In 02:58:35 INFO - VRAM (Dynamic, Max): 1536 MB 02:58:35 INFO - Vendor: Intel (0x8086) 02:58:35 INFO - Device ID: 0x0a2e 02:58:35 INFO - Revision ID: 0x0009 02:58:35 INFO - Displays: 02:58:35 INFO - Display: 02:58:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:58:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:58:35 INFO - Display Serial Number: 1600x1200 60 02:58:35 INFO - Main Display: Yes 02:58:35 INFO - Mirror: Off 02:58:35 INFO - Online: Yes 02:58:35 INFO - Rotation: Supported 02:58:35 INFO - Return code: 0 02:58:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:58:35 INFO - Python 2.7.3 02:58:35 INFO - Return code: 0 02:58:35 INFO - grabbing minidump binary from tooltool 02:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:35 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e80d30>, '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 0x106da6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e75be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:58:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:58:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:58:35 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:58:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:58:35 INFO - Return code: 0 02:58:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:58:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:58:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:58:35 INFO - ENV: RUST_BACKTRACE is now 1 02:58:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:58:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:58:35 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/YwnQTodfSAGSEOF3OI-8mw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0175', '--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 02:58:35 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/YwnQTodfSAGSEOF3OI-8mw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0175 --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 02:58:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.caOLWSuFnS/Render', 02:58:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:35 INFO - 'HOME': '/Users/cltbld', 02:58:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:35 INFO - 'LOGNAME': 'cltbld', 02:58:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:58:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:35 INFO - 'MOZ_NO_REMOTE': '1', 02:58:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:58:35 INFO - 'NO_EM_RESTART': '1', 02:58:35 INFO - 'PAGER': '/bin/cat', 02:58:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:35 INFO - 'PWD': '/builds/slave/test', 02:58:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:58:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:35 INFO - 'RUST_BACKTRACE': '1', 02:58:35 INFO - 'SHELL': '/bin/bash', 02:58:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K5Vz6rdz9M/Listeners', 02:58:35 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 02:58:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:35 INFO - 'USER': 'cltbld', 02:58:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:35 INFO - 'XPC_FLAGS': '0x0', 02:58:35 INFO - 'XPC_SERVICE_NAME': '0', 02:58:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:35 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/YwnQTodfSAGSEOF3OI-8mw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0175', '--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 02:58:36 INFO - mozversion application_buildid: 20170429015247 02:58:36 INFO - mozversion application_changeset: dac608a22277b6f24d54546118b36939abc63179 02:58:36 INFO - mozversion application_display_name: Nightly 02:58:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:58:36 INFO - mozversion application_name: Firefox 02:58:36 INFO - mozversion application_remotingname: firefox 02:58:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:58:36 INFO - mozversion application_vendor: Mozilla 02:58:36 INFO - mozversion application_version: 55.0a1 02:58:36 INFO - mozversion platform_buildid: 20170429015247 02:58:36 INFO - mozversion platform_changeset: dac608a22277b6f24d54546118b36939abc63179 02:58:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:58:36 INFO - mozversion platform_version: 55.0a1 02:58:36 INFO - using testdate: 1493459916 02:58:36 INFO - actual date: 1493459916 02:58:36 INFO - starting webserver on 'localhost:49236' 02:58:36 INFO - SUITE-START | Running 2 tests 02:58:36 INFO - TEST-START | dromaeo_css 02:58:36 INFO - operating with platform_type : mac_ 02:58:36 INFO - Initialising browser for dromaeo_css test... 02:58:36 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/tmpMlR04K/profile http://localhost:49236/getInfo.html) 02:58:39 INFO - PID 1642 | 2017-04-29 02:58:39.362 plugin-container[1645:7557] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b47, name = 'com.apple.tsm.portname' 02:58:39 INFO - PID 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:58:39 INFO - PID 1642 | 2017-04-29 02:58:39.365 plugin-container[1645:7557] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9f0b, name = 'com.apple.CFPasteboardClient' 02:58:39 INFO - PID 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:58:39 INFO - PID 1642 | 2017-04-29 02:58:39.365 plugin-container[1645:7557] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:58:39 INFO - PID 1642 | __metrics Screen width/height:1600/1200 02:58:39 INFO - PID 1642 | colorDepth:24 02:58:39 INFO - PID 1642 | Browser inner width/height: 1024/689 02:58:39 INFO - PID 1642 | __metrics 02:58:40 INFO - TEST-INFO | 1642: exit 0 02:58:40 INFO - Browser initialized. 02:58:40 INFO - Running cycle 1/1 for dromaeo_css test... 02:58:40 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/tmpMlR04K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:58:42 INFO - PID 1646 | 2017-04-29 02:58:42.918 plugin-container[1647:7690] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x974b, name = 'com.apple.tsm.portname' 02:58:42 INFO - PID 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:58:42 INFO - PID 1646 | 2017-04-29 02:58:42.918 plugin-container[1647:7690] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x922f, name = 'com.apple.CFPasteboardClient' 02:58:42 INFO - PID 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:58:42 INFO - PID 1646 | 2017-04-29 02:58:42.918 plugin-container[1647:7690] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:58:52 INFO - PID 1646 | RSS: Main: 234917888 02:58:52 INFO - PID 1646 | 03:01:55 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 03:01:57 INFO - PID 1646 | RSS: Main: 250298368 03:01:57 INFO - PID 1646 | 03:03:41 INFO - PID 1646 | ************************* 03:03:41 INFO - PID 1646 | A coding exception was thrown and uncaught in a Task. 03:03:41 INFO - PID 1646 | 03:03:41 ERROR - PID 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:03:41 INFO - PID 1646 | Full stack: 03:03:41 INFO - PID 1646 | ************************* 03:03:41 INFO - PID 1646 | ************************* 03:03:41 INFO - PID 1646 | A coding exception was thrown and uncaught in a Task. 03:03:41 INFO - PID 1646 | 03:03:41 ERROR - PID 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:03:41 INFO - PID 1646 | Full stack: 03:03:41 INFO - PID 1646 | ************************* 03:03:41 INFO - PID 1646 | ************************* 03:03:41 INFO - PID 1646 | A coding exception was thrown and uncaught in a Task. 03:03:41 INFO - PID 1646 | 03:03:41 ERROR - PID 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:03:41 INFO - PID 1646 | Full stack: 03:03:41 INFO - PID 1646 | ************************* 03:03:41 INFO - PID 1646 | ************************* 03:03:41 INFO - PID 1646 | A coding exception was thrown and uncaught in a Task. 03:03:41 INFO - PID 1646 | 03:03:41 ERROR - PID 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:03:41 INFO - PID 1646 | Full stack: 03:03:41 INFO - PID 1646 | ************************* 03:04:59 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 03:04:59 INFO - PID 1646 | RSS: Main: 254734336 03:04:59 INFO - PID 1646 | 03:08:01 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 03:08:02 INFO - PID 1646 | RSS: Main: 266510336 03:08:02 INFO - PID 1646 | 03:11:04 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 03:11:04 INFO - PID 1646 | RSS: Main: 259698688 03:11:04 INFO - PID 1646 | 03:14:07 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 03:14:08 INFO - PID 1646 | RSS: Main: 268288000 03:14:08 INFO - PID 1646 | 03:17:09 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 03:17:10 INFO - PID 1646 | RSS: Main: 263450624 03:17:10 INFO - PID 1646 | 03:17:10 INFO - PID 1646 | __start_tp_report 03:17:10 INFO - PID 1646 | _x_x_mozilla_page_load 03:17:10 INFO - PID 1646 | _x_x_mozilla_page_load_details 03:17:10 INFO - PID 1646 | |i|pagename|runs| 03:17:10 INFO - PID 1646 | |0;dojo.html;2769.736874996875;3223.9999999999995;3590.8743193988216;3621.2938476996997;3634.727395445341;6196.752129914804;6283.717232724527;6287.497000239981;6292.276388215357;6298.874022519547;6109.35851735568;6163.537734669895;6213.068039794033;6214.596051256665;6215.658138802364;5341.65279256849;5460.590455715817;5491.505764481196;5513.007658621446;5539.390667026624;5371.865703357408;5543.556515478752;5559.9444005559835;5563.415841336662;5566.053770858964;4826.517348265163;5530.446955304457;5535.916961245584;5567.832965011056;5571.331440227178;5339.6262261641705;5416.702081385522;5421.213923981;5426.2674538937135;5478.479544443271;5401.513863752242;5407.675539467645;5460.235567020621;5461.672299662033;5489.313835770528;6094.146819445281;6166.7533298667995;6206.596571222856;6272.3100458949475;6279.497640188774;6638.601683898982;6713.4964877634375;6723.159605049369;6734.292899245557;6734.797956061326;6463.967680161616;6543.640099794509;6697.665116744143;6798.184217893884;6812.489063320221;6309.842253943642;6313.242410910674;6323;6333.11336412898;6338.461230795342;6739.730410783612;6876.415504682158;6888.345607167411;6897.034415181878;6906.482013848981;6331.461825744863;6386.8722625547225;6492.188476440445;6536.575122617015;6555.639439830855;6740.9325906740305;6762.492813039042;6776.830579235559;6785.762498312634;6786.660666966632;5238.371395432572;6603.306652801482;6630.270670226271;6653.600783952881;6656.467482601381;5575.470330318613;6380.7128679209545;6442.516811239082;6529.967350163219;6665.7666981656375;5110.565601923804;5295.814646487354;5317.335333083364;5324.760385782649;5375.19372094189;4677.7193368398;4722.976385118052;4724.692894961817;4735.431748190239;4767.785449654774;6045.093236014545;6257.405546473078;6309.400606942425;6340.365963403715;6354.269259035178;6673.599584024974;6740.662966851638;6748.257691653914;6751.864962700718;6769.289224631441;6318.052292156121;6334.208223972004;6360.52296077796;6380.361963803675;6385.712642931079;5214.348206474191;5751;5939.346671866091;5962.25471816023;6021.066734656135;5665.348484924121;6605.966970165118;6781.321867813278;6920.342567456084;6965.094537710065;6751.966240168964;6783.491238157059;6795.116634837637;6800.897986530107;6814.863702725818;5904.911426328695;6678.198616166092;6706.926891697305;6919.065926099912;7001.439884809305;6644.069830223869;6654.367835055662;6657.400833924777;6658.1344425224415;6668.933310667026;6355.491560675043;6586.637734924625;6624.635645039376;6690.13028306317;6763.729450821912;6398.584092034003;6474.158359413246;6516.055172000129;6521.184851893513;6536.934630653633;5213.348331458567;6452.22573291208;6509.544331896722;6527.477801775752;6529.118568993125;6235.812925612239;6297.338779428277;6351.142595749515;6355;6366.649834258975;6344.302126766144;6422.229332479946;6489.513286503437;6508.674566271573;6532;6282.811515654537;6360.968195158995;6380.585261958144;6392.648404337806;6413 03:17:10 INFO - PID 1646 | |1;ext.html;764.4495962906707;836.9455985360951;1093.6882988348323;1139.2480962564705;1219.9024078073755;35622.46566301504;38260.617393826054;38328.42507362392;38405.807970960144;38422.615773842255;37973.05067373317;38363.42454863172;38392.80803595985;38433.231335373275;38549.421758673576;7858.253465920743;8046.235607617267;8239.835203295961;8472.915270847305;8493.617787199591;8507.787305317355;8568.828623427527;8637.39538232324;8647.437916535406;8656.523891185981;8595.312375010015;8598.785030374229;8617.741467755977;8629.611667474946;8644.222020018196;8542.658293668246;8579.184977427134;8591.441556298883;8605.698800541952;8607.18231767981;8297.502149870967;8355.373346998938;8413;8413.242808147235;8422.073571907085;37360.252794943946;37488;37499.81250093732;37539.62460375416;37569.812150939346;3713.9442908356395;3748.850045998157;3755.887323380303;3756.3614185588244;3761;31170.376592468023;31219.37561248785;31294.687053129404;31357.52963705546;31380.21549461259;3152.952705709416;3167.667394923523;3187.585613870205;3195.5206718992104;3196.4566023776015;286989;287408.9999999979;287847;288809;289240;40201.39697904534;40712.98217544585;48899.755501222266;49369.753151234014;50353.489395318196;51397.715057123874;51699.224511632354;51850.74074629678;51868.481315186364;51958;14624.341904614104;14748.18884961316;14750.704985900436;14768.778468322984;14790.11259324444;11844.703882402837;11872.525098996117;11881.88118118825;11898.22661526998;11980.221285616408;11766.117541184445;13718.314084295745;13760.587182384545;13792.448302067805;13891.305434728223;5960.731767070492;6001.7599296027665;6016.729247183887;6034.48706859913;6050;955.5986485676033;962.5572236771163;965.3676841668719;1032.1742605915238;1064.7178497698117;24176.516469670507;24755.04879220107;24766.133185338425;24892.875535622567;25020.374490637514;970.6554173268529;1138.9772204555863;1166.2128063557066;1177.4230626992712;1185.6739396665987;11226.607068752555;12188.268703877795;12272.822123076063;12502.249865008129;12755.362231888368;278855;280599;302376;303777;339173;57215.71392143013;57319;57351.71324143436;57393.56516087048;57660.423395766345;1378.63466181462;1528.663693987321;1556.4552406657579;1565.1626379886934;1567.968640627204;24189.63715544233;24255;24287;24355.14756983497;24446.63330050015;39691.80154099326;39750;39829.60170398259;39914.80042599768;39954.200915982095;291586;291929;292124;292744;292856;30765.846170769004;33156.83421582876;35279.823600881835;35556.64443355533;35615;43837.78081109574;44083.77958110189;45437.31844022276;45481.31778023266;45482.27106373628;22874.885625571766;29686.55470167906;30328.569500471644;31015.844920775253;31940.201494961882;24600.6309905348;30302.696973029986;31417.8429107853;31510.054698359087;31665;38233.23533529369;38298.23403531858;38300.80849595734;38308.85073447801;38362;30094.548581770854;30913;31284.687153128176;31796.205094872814;32138;22292.665610015538;23937.640935385636;24280.271591852274;24354;24395 03:17:10 INFO - PID 1646 | |2;jquery.html;434.98042588083575;443.0474479868283;443.0982949697366;454.13487306680776;462.2350010732237;19334.51663708408;20528.486787830312;21179.94100294987;21377.893110534445;21407.357779266607;18036.909815450905;21960.35297352697;22129.778702212974;22384.440388990282;22453.887730561364;5908.379620139888;6121.908171377433;6191.845203869894;6216.222972128484;6219.315875253718;5796.159556864252;6025.457708806207;6096.146539484475;6100.938990610103;6106.2977757558;5935.792247271346;6006;6009.819705408823;6034.728437220314;6047.274327080757;5821.3887541808135;6086.330503644595;6092.725827337758;6113.755449782004;6160.907586386208;5233.842984710427;5338.386085600167;5352.678839269656;5365.03429382711;5404.756785944603;25766.84049217771;25769;25803;25813.870930645415;25878.22365329043;2281.258590957945;2301.528186721718;2321.338418550722;2324.9651255231183;2328.348062542491;13188.670283242996;16761.078140702255;16971.3211471541;17018.978861268362;17545.298188072462;2056.9177232910665;2133.8933053347428;2170.7720689327552;2177.8366622503377;2178.4662757624324;129915.40169196657;153435.23282383516;155075;156545.2172739129;159443.20278398533;11802.11484138693;12253.571125010581;12286.508539658493;12334.75330493385;12385.62843114708;15804;15976.840231597535;16062;16084.874058816005;16089.51731448035;8721.91278087211;8895.28837692983;8911.866322005175;8924.152205540464;8961.283097352196;6920.446364290845;7247.891281630779;8209.753707388787;8594.925634295712;8602.612882420306;6428.871422571522;6731.899021514681;6909.896351554731;7449.255074492507;7788.922110778933;2151.1395441823397;2156.4501052231894;2164.7835216478225;2165.8267338612873;2365.1367250953276;911.0388540090269;956.2397893674546;974.6734843827397;976.1068622210739;1003.6938733686296;17986;20140.496487587927;20523.973801309876;20584.794152058286;20871.58256834885;856.6958729651009;883.6995421556702;913.6071489259682;934.5420743835472;1028.717102796737;8790.340724445692;10495.737606559744;10538.31500952451;10563.63027294041;10576.41829699374;529032;540339;546447;548489;552126;122738.38630806789;126348.73651263553;132553.33723331513;137565;137840;1192.9045676345872;1226.055936928578;1242.975140497203;1245.1097465312346;1250.5935570939298;18348.81651183471;20045.198192072738;20855.734655611872;21195.046222920315;21207.15171393127;55529;57740;58139.70930145322;58474.4152558486;58816.70591647014;81191.78212326701;81406.18593813985;81783.18216817756;82405.17594823975;83902;8717.433366831136;8812.295016398544;8883.244924181517;8921.06328835489;8940.552972351486;11755.765644607192;12117;13915.304234788018;14090.929545352208;14110.36503357331;11616.88383116158;11730.413479326171;11818.172727909308;11917.880821192024;12223.572174973833;9983.900160998588;9989.401695728939;11161.553537858395;11306;11488.597899073493;11649.534018639499;11783.410829458322;12120.151589388659;12171.721969193108;12295.077869160028;8631.784205394915;8782.341324400568;8814;8857.424267422597;8860.86708699357;10427.94786026065;10688.877667844765;10984.560617575207;11588.710282243012;12018.459169337226 03:17:10 INFO - PID 1646 | |3;mootools.html;1298.2535042350644;1361.754884120858;1408.9225092619906;1411.9223442710647;1480.792689023537;11289.943550282247;11313.094952403808;11581.247218930774;11742.471588778515;12003.3398163101;11510.424478776049;11686.474108665108;11691.590794322201;11707.648770536876;11771.646850594496;2499.1502889017684;2540.5300019496453;2552.731963143871;2556.2970183199677;2556.5398228318895;2083.2812679625504;2227.454273702945;2460.8065088432095;2472.11004038546;2511.510255500178;2486.4032632168332;2512.660790793238;2517.471331020488;2530.4812513434704;2535.125381743305;2430.1008626808107;2451.240115564172;2477.1082410332265;2479.82641215115;2486.204414587333;2425.211806163004;2442.426029882976;2458.8770561472033;2464.0759715106833;2526.886290116949;11691.473883675255;11704.063674905987;11709.238899471507;11737.295762254207;11781.234219775773;6549.770758023494;6731.057651928734;6797.320267973212;6804.149481314836;6821.590704557742;3936.645701886844;4303.33298338758;4307.440032795716;4379.868603941887;4380.78096095194;1085.6688709943464;1250.8936740376987;1257.7484503099417;1286.2218357893528;1310.1287643716917;15035;15608.687826243411;16259.756103658454;16415.097169655663;16443.260053297632;5447.101228297366;5496.890062198733;5678.943210567924;5707.4577915098;5726.255586773693;11729.061675066145;11802.822957655642;11939.820902686466;11952;11952.163348565517;6521.706523206467;6525.673716314165;6528.575642583217;6536.281009088996;6538.084668146464;6042.4561789438285;6060.666663333559;6122.54080943931;6182.629042257479;6214.098955651405;4258;4386.144701783185;4392.121575684876;4428.867133985986;4443.37792709021;1256.723520825417;1273.1088238233274;1273.9490420383265;1284.0433876761685;1291.322055920649;681.5672048249397;785.6503855784122;820.6758330459435;824.4146655874276;828.6809578312273;6219.751209951552;6370.872582548416;6665.766698165541;6942.507360917427;7029.261927497641;790.9124953189364;955.2262667239559;963.325672029582;964.628617982082;997.6508222122344;4312.921769557611;4521.977390113028;4587.472440669299;4615.838445654386;4777.474477807438;14679.266036698122;14736.042157259744;14978;14985.475508357154;14996.625084372978;14289.928550357181;14821;14838.258087095603;14858.851411485963;14892;7201.315874991763;8232.958835205905;8319.251267385964;8428.45215061019;8479.788005299793;5971.58198926071;6839.760608378683;7086.397656199075;7136.179339376038;7148.749793757402;12805.871941280468;13291.867081329063;13383.598492044865;13407.32963351848;13672.589822305346;13523.797143042666;13780.448782049007;13856;13960.022798404421;14068.296585170496;9328.53357332117;9346.579403926704;9369.390989585656;9451.196648284973;9479.004704505927;9033.81932361336;10450.372977621368;10663.680089597325;10689.198310126927;10775.892241077489;7327.37717294036;7611.923880761343;9232.261419086322;9246.583903724215;9271.490068046322;8900.198982091642;8973.698813672112;9071.682491112779;9081.727548173565;9092.408993415407;6915.550489218184;6999.930000700131;8181.263686268265;8221.17788221173;8309.210624990616;4680.531946805429;6042.848928776816;6172.98145805937;6185.84535386619;6345.809625711236;6118.326984031664;6148.415900489446;6150.200473938359;6219.0982307566055;6285.497160227263 03:17:10 INFO - PID 1646 | |4;prototype.html;340.9880654177104;371.42985517231057;409.51063479142425;413.5864135864136;419.1805021183586;6355.11028456016;6379.712912918924;6381.680915954195;6393.232812062559;6424.839379015521;6093.969530152354;6192.690365481731;6221.315655277927;6267.905981410283;6305.148804911336;3880.980595097035;4029.741187749985;4729.78715957781;4755.334253204554;4760.357351757511;4688.2264426369775;4704.741239231841;4770.833020844271;4774.848599924051;4775.880602984936;4257.510386305568;4370.792749661417;4695.812167513295;4715.929261061086;4757.762111894409;4667.249781332001;4692.788824502889;4718.551737584924;4721.315409265671;4729.31424943383;3548.27260411615;3705.2959937612036;3992.820323085439;4006.9198616027807;4240.681948853849;5283.969625922947;5342.996376358866;5945.881082378328;6015.819525414201;6059.515238780887;4674.555917187861;5102.953894451629;5335.306410166653;5366.517013468768;5409.0534156522845;5697.202391665171;6430.485561155097;6507.7071531781185;6572.6807961979375;6654.500912431538;3368.3768502827056;3540.8937731868086;4307.8492252771;4356.455443069616;4424.84513042042;5477.589180811455;5801.955647983404;5888.440598143169;6934;7088.468364872655;3648.4709717091405;4322.157179349996;4359.215341238608;4411.874971882149;4417.712848664826;3935.940960885589;3993.8233662653342;4198.908283846161;4440.511543730187;4479.70881892676;3760.6051364606324;4625.606823419979;4934.235193545006;5163.993021360874;5342.813001544927;6292.748290068346;6624.735010599618;6649.634270115093;6656.567323123982;6693.397594216543;1461.415433826478;1504.3456096598015;1523.6059006009598;1528.6407694191855;1536.3240174323262;991.2912267728609;992.8560358747941;994.7662299359645;995.5669283861544;1003.5784970312486;6323.1779868617705;6377.649229292433;6379.393957574023;6383.585066970725;6412.839679008062;5342.358916929993;6754.76358327466;6933.341332573397;6942.062821519131;6944.826379340557;6317.4946004319545;6326.240851097898;6354.046892965999;6362.9045564316575;6515.771947981798;2886.639170103737;3480.9477857832153;3608.675219230282;3628.528291322164;3630.854765809338;6974.232834388214;7160.641967901584;7165.534240274365;7179.569225846466;7187.712491500386;6788.59268443895;7088.468364872552;7102.14774227096;7128.465365097639;7140.178879428829;5432.511074003359;6595.735111120026;6652.7671531497135;6737.898931515933;6986.825329366705;6565.934340656532;6696.48881669374;6978.232394436506;6997;6997.895031574632;6086.939130608637;6763.410598509248;6769.864602708017;6770.5104876927;6802.591844489347;6284.497240220863;7148.535345202546;7166.355028047501;7196.496245262991;7209.206987231296;3675.9081022974638;4373.584509471595;4401.25178719612;4403;4428.933565996448;6051.485623722033;6772.98405239218;6789.422899053636;7028.367446929801;7073.575585464889;5806.76772929095;5844.561657875762;6128.927437698296;6687.331266873273;6716.865662686621;6433.195850518685;6604.306547812603;6683.732650693918;6700.966495167493;6802.435439848764;6497.480201583768;6503.479721622353;6523.282438931618;6536.281009088902;6537;6378.394052564999;6418.871622567429;6482.57863238888;6686.665666716547;6688.966555167193;6505.804825855232;6559.409653131241;6564.8358791030605;6587.242467116152;6591.077249185022 03:17:10 INFO - PID 1646 | |5;yui.html;829.8174401631646;843.2789964580284;843.5697794124997;862.4782006885833;867.0375882770126;16191.919040404797;16645.084520351375;16703.415380461687;18399.26402943884;19188.616227675473;17320.653586928252;17533.561660958483;17763.733543996852;18383.724244136316;18448.169832357544;1001.7746007148406;1016.8983101689846;1028.984565231522;1033.966033966034;1034.2811745836646;1033.7467320506487;1038.5118994072773;1041.5625437316307;1041.572955088414;1042.7393151712072;1067.5783065689047;1070.8286674132141;1077.6120596585224;1077.9759228732696;1078.067471637036;1048.7587854793364;1057.0697785948394;1071.9035286824185;1073.7047311989227;1075.833245846895;751.6918063593955;766.9194734552904;777.5023984649829;777.6267391652038;778.0896351269029;16407.343706251737;16565.08892010939;16571.83428165715;16573.585660358465;16596.004239745653;15263.85521085923;16219.189040547926;16546.58633534171;16684.165791710486;16700.248488818033;10262.794744105151;13868.58394248164;13911.930440347733;13948.953828462805;13980.300984950814;3342.1644588852787;3375.038114137459;3393.5079413485155;3433.536472576195;3456.1359660084977;134428.32785836008;135520.32239838835;137703;137899;139740;13122.671933201746;13248;13339.26634035118;13486.730265394834;13490.055696101179;20696.79303206979;25068.87465562697;25312.873435632704;25605;25787;7693.269139431745;7717.8456430871065;7794.337481314038;7855.096663883726;7886.487378320391;3978.840846366171;4028.798560071985;4040.878773636796;4051.6556092731857;4054.6350828425584;4156.960759810047;4252.213340532012;4263.957360426418;4278.657707383401;4301.720388174758;878.6441491196076;889.035396594702;896.2068569316071;902.3953950852813;905.6830109461768;643.4852118305337;651.8924377477758;658.3252166529346;661.381608196338;681.4990981628499;11071.612493562687;11717.824232636518;11943.462544185533;11976.700582485333;12115.818262726067;538.8383484954576;637.5505268785495;649.95775274607;652.1749986267375;682.7507959594712;5303.893922121536;5427.538659214011;5862.765489380462;6103.206583144163;6183.227096612924;85649;109548;110166.89833101566;110855.33716994252;112550;96087.03912960921;96398.51800740951;96915.51542242385;96950;97460.05079898362;62263;78260;79532.60233698794;80997;81076.18923810804;11559.208322709994;12482.188657737219;12511;12531.812022819482;12740.171888827197;40578;40644.39033414442;40714;41816.790916045225;41930.37104443375;54940;72418;74537.62731186309;74587;76293.61853190699;16815;17063.744043839102;17075.31698732037;17109.23008464647;17135.314587416364;17422.912885435493;17771.73342399891;18496.630067398844;18747.25010999599;18908.621827563646;16640.417585384454;16951.66096678035;16977.915110424863;17384.652306953536;17531;16290.67418651644;16619.002859828448;17326.9603823771;17520.211590478204;17588.38440654571;16124.193790310672;16681.74977375316;16736.916315418344;16743.33026678919;16883.40908068212;11819.881801182222;12097;12148.514059437524;12327.198732082386;12373.566925157576;12092.637220883387;13052.34738263064;13114.803277950648;13167.53913613019;13442.193468391928 03:17:10 INFO - PID 1646 | __end_tp_report 03:17:10 INFO - PID 1646 | __start_cc_report 03:17:10 INFO - PID 1646 | _x_x_mozilla_cycle_collect,428 03:17:10 INFO - PID 1646 | __end_cc_report 03:17:10 INFO - PID 1646 | __startTimestamp1493461030060__endTimestamp 03:17:10 INFO - PID 1646 | 03:17:10 INFO - PID 1646 | ------- Summary: start ------- 03:17:10 INFO - PID 1646 | Number of tests: 6 03:17:10 INFO - PID 1646 | 03:17:10 INFO - PID 1646 | [#0] dojo.html Cycles:165 Average:6122.78 Median:6354.27 stddev:746.19 (11.7%) stddev-sans-first:700.58 03:17:10 INFO - PID 1646 | Values: 2769.7 3224.0 3590.9 3621.3 3634.7 6196.8 6283.7 6287.5 6292.3 6298.9 6109.4 6163.5 6213.1 6214.6 6215.7 5341.7 5460.6 5491.5 5513.0 5539.4 5371.9 5543.6 5559.9 5563.4 5566.1 4826.5 5530.4 5535.9 5567.8 5571.3 5339.6 5416.7 5421.2 5426.3 5478.5 5401.5 5407.7 5460.2 5461.7 5489.3 6094.1 6166.8 6206.6 6272.3 6279.5 6638.6 6713.5 6723.2 6734.3 6734.8 6464.0 6543.6 6697.7 6798.2 6812.5 6309.8 6313.2 6323.0 6333.1 6338.5 6739.7 6876.4 6888.3 6897.0 6906.5 6331.5 6386.9 6492.2 6536.6 6555.6 6740.9 6762.5 6776.8 6785.8 6786.7 5238.4 6603.3 6630.3 6653.6 6656.5 5575.5 6380.7 6442.5 6530.0 6665.8 5110.6 5295.8 5317.3 5324.8 5375.2 4677.7 4723.0 4724.7 4735.4 4767.8 6045.1 6257.4 6309.4 6340.4 6354.3 6673.6 6740.7 6748.3 6751.9 6769.3 6318.1 6334.2 6360.5 6380.4 6385.7 5214.3 5751.0 5939.3 5962.3 6021.1 5665.3 6606.0 6781.3 6920.3 6965.1 6752.0 6783.5 6795.1 6800.9 6814.9 5904.9 6678.2 6706.9 6919.1 7001.4 6644.1 6654.4 6657.4 6658.1 6668.9 6355.5 6586.6 6624.6 6690.1 6763.7 6398.6 6474.2 6516.1 6521.2 6536.9 5213.3 6452.2 6509.5 6527.5 6529.1 6235.8 6297.3 6351.1 6355.0 6366.6 6344.3 6422.2 6489.5 6508.7 6532.0 6282.8 6361.0 6380.6 6392.6 6413.0 03:17:10 INFO - PID 1646 | 03:17:10 INFO - PID 1646 | [#1] ext.html Cycles:180 Average:44825.31 Median:187226.41 stddev:77015.16 (41.1%) stddev-sans-first:77160.15 03:17:10 INFO - PID 1646 | Values: 764.4 836.9 1093.7 1139.2 1219.9 35622.5 38260.6 38328.4 38405.8 38422.6 37973.1 38363.4 38392.8 38433.2 38549.4 7858.3 8046.2 8239.8 8472.9 8493.6 8507.8 8568.8 8637.4 8647.4 8656.5 8595.3 8598.8 8617.7 8629.6 8644.2 8542.7 8579.2 8591.4 8605.7 8607.2 8297.5 8355.4 8413.0 8413.2 8422.1 37360.3 37488.0 37499.8 37539.6 37569.8 3713.9 3748.9 3755.9 3756.4 3761.0 31170.4 31219.4 31294.7 31357.5 31380.2 3153.0 3167.7 3187.6 3195.5 3196.5 286989.0 287409.0 287847.0 288809.0 289240.0 40201.4 40713.0 48899.8 49369.8 50353.5 51397.7 51699.2 51850.7 51868.5 51958.0 14624.3 14748.2 14750.7 14768.8 14790.1 11844.7 11872.5 11881.9 11898.2 11980.2 11766.1 13718.3 13760.6 13792.4 13891.3 5960.7 6001.8 6016.7 6034.5 6050.0 955.6 962.6 965.4 1032.2 1064.7 24176.5 24755.0 24766.1 24892.9 25020.4 970.7 1139.0 1166.2 1177.4 1185.7 11226.6 12188.3 12272.8 12502.2 12755.4 278855.0 280599.0 302376.0 303777.0 339173.0 57215.7 57319.0 57351.7 57393.6 57660.4 1378.6 1528.7 1556.5 1565.2 1568.0 24189.6 24255.0 24287.0 24355.1 24446.6 39691.8 39750.0 39829.6 39914.8 39954.2 291586.0 291929.0 292124.0 292744.0 292856.0 30765.8 33156.8 35279.8 35556.6 35615.0 43837.8 44083.8 45437.3 45481.3 45482.3 22874.9 29686.6 30328.6 31015.8 31940.2 24600.6 30302.7 31417.8 31510.1 31665.0 38233.2 38298.2 38300.8 38308.9 38362.0 30094.5 30913.0 31284.7 31796.2 32138.0 22292.7 23937.6 24280.3 24354.0 24395.0 03:17:10 INFO - PID 1646 | 03:17:10 INFO - PID 1646 | [#2] jquery.html Cycles:180 Average:35243.15 Median:2323.15 stddev:92327.59 (3974.2%) stddev-sans-first:92549.61 03:17:10 INFO - PID 1646 | Values: 435.0 443.0 443.1 454.1 462.2 19334.5 20528.5 21179.9 21377.9 21407.4 18036.9 21960.4 22129.8 22384.4 22453.9 5908.4 6121.9 6191.8 6216.2 6219.3 5796.2 6025.5 6096.1 6100.9 6106.3 5935.8 6006.0 6009.8 6034.7 6047.3 5821.4 6086.3 6092.7 6113.8 6160.9 5233.8 5338.4 5352.7 5365.0 5404.8 25766.8 25769.0 25803.0 25813.9 25878.2 2281.3 2301.5 2321.3 2325.0 2328.3 13188.7 16761.1 16971.3 17019.0 17545.3 2056.9 2133.9 2170.8 2177.8 2178.5 129915.4 153435.2 155075.0 156545.2 159443.2 11802.1 12253.6 12286.5 12334.8 12385.6 15804.0 15976.8 16062.0 16084.9 16089.5 8721.9 8895.3 8911.9 8924.2 8961.3 6920.4 7247.9 8209.8 8594.9 8602.6 6428.9 6731.9 6909.9 7449.3 7788.9 2151.1 2156.5 2164.8 2165.8 2365.1 911.0 956.2 974.7 976.1 1003.7 17986.0 20140.5 20524.0 20584.8 20871.6 856.7 883.7 913.6 934.5 1028.7 8790.3 10495.7 10538.3 10563.6 10576.4 529032.0 540339.0 546447.0 548489.0 552126.0 122738.4 126348.7 132553.3 137565.0 137840.0 1192.9 1226.1 1243.0 1245.1 1250.6 18348.8 20045.2 20855.7 21195.0 21207.2 55529.0 57740.0 58139.7 58474.4 58816.7 81191.8 81406.2 81783.2 82405.2 83902.0 8717.4 8812.3 8883.2 8921.1 8940.6 11755.8 12117.0 13915.3 14090.9 14110.4 11616.9 11730.4 11818.2 11917.9 12223.6 9983.9 9989.4 11161.6 11306.0 11488.6 11649.5 11783.4 12120.2 12171.7 12295.1 8631.8 8782.3 8814.0 8857.4 8860.9 10427.9 10688.9 10984.6 11588.7 12018.5 03:17:10 INFO - PID 1646 | 03:17:10 INFO - PID 1646 | [#3] mootools.html Cycles:180 Average:7067.91 Median:4280.67 stddev:4442.64 (103.8%) stddev-sans-first:4433.94 03:17:10 INFO - PID 1646 | Values: 1298.3 1361.8 1408.9 1411.9 1480.8 11289.9 11313.1 11581.2 11742.5 12003.3 11510.4 11686.5 11691.6 11707.6 11771.6 2499.2 2540.5 2552.7 2556.3 2556.5 2083.3 2227.5 2460.8 2472.1 2511.5 2486.4 2512.7 2517.5 2530.5 2535.1 2430.1 2451.2 2477.1 2479.8 2486.2 2425.2 2442.4 2458.9 2464.1 2526.9 11691.5 11704.1 11709.2 11737.3 11781.2 6549.8 6731.1 6797.3 6804.1 6821.6 3936.6 4303.3 4307.4 4379.9 4380.8 1085.7 1250.9 1257.7 1286.2 1310.1 15035.0 15608.7 16259.8 16415.1 16443.3 5447.1 5496.9 5678.9 5707.5 5726.3 11729.1 11802.8 11939.8 11952.0 11952.2 6521.7 6525.7 6528.6 6536.3 6538.1 6042.5 6060.7 6122.5 6182.6 6214.1 4258.0 4386.1 4392.1 4428.9 4443.4 1256.7 1273.1 1273.9 1284.0 1291.3 681.6 785.7 820.7 824.4 828.7 6219.8 6370.9 6665.8 6942.5 7029.3 790.9 955.2 963.3 964.6 997.7 4312.9 4522.0 4587.5 4615.8 4777.5 14679.3 14736.0 14978.0 14985.5 14996.6 14289.9 14821.0 14838.3 14858.9 14892.0 7201.3 8233.0 8319.3 8428.5 8479.8 5971.6 6839.8 7086.4 7136.2 7148.7 12805.9 13291.9 13383.6 13407.3 13672.6 13523.8 13780.4 13856.0 13960.0 14068.3 9328.5 9346.6 9369.4 9451.2 9479.0 9033.8 10450.4 10663.7 10689.2 10775.9 7327.4 7611.9 9232.3 9246.6 9271.5 8900.2 8973.7 9071.7 9081.7 9092.4 6915.6 6999.9 8181.3 8221.2 8309.2 4680.5 6042.8 6173.0 6185.8 6345.8 6118.3 6148.4 6150.2 6219.1 6285.5 03:17:10 INFO - PID 1646 | 03:17:10 INFO - PID 1646 | [#4] prototype.html Cycles:180 Average:5349.25 Median:6276.20 stddev:1727.85 (27.5%) stddev-sans-first:1691.31 03:17:10 INFO - PID 1646 | Values: 341.0 371.4 409.5 413.6 419.2 6355.1 6379.7 6381.7 6393.2 6424.8 6094.0 6192.7 6221.3 6267.9 6305.1 3881.0 4029.7 4729.8 4755.3 4760.4 4688.2 4704.7 4770.8 4774.8 4775.9 4257.5 4370.8 4695.8 4715.9 4757.8 4667.2 4692.8 4718.6 4721.3 4729.3 3548.3 3705.3 3992.8 4006.9 4240.7 5284.0 5343.0 5945.9 6015.8 6059.5 4674.6 5103.0 5335.3 5366.5 5409.1 5697.2 6430.5 6507.7 6572.7 6654.5 3368.4 3540.9 4307.8 4356.5 4424.8 5477.6 5802.0 5888.4 6934.0 7088.5 3648.5 4322.2 4359.2 4411.9 4417.7 3935.9 3993.8 4198.9 4440.5 4479.7 3760.6 4625.6 4934.2 5164.0 5342.8 6292.7 6624.7 6649.6 6656.6 6693.4 1461.4 1504.3 1523.6 1528.6 1536.3 991.3 992.9 994.8 995.6 1003.6 6323.2 6377.6 6379.4 6383.6 6412.8 5342.4 6754.8 6933.3 6942.1 6944.8 6317.5 6326.2 6354.0 6362.9 6515.8 2886.6 3480.9 3608.7 3628.5 3630.9 6974.2 7160.6 7165.5 7179.6 7187.7 6788.6 7088.5 7102.1 7128.5 7140.2 5432.5 6595.7 6652.8 6737.9 6986.8 6565.9 6696.5 6978.2 6997.0 6997.9 6086.9 6763.4 6769.9 6770.5 6802.6 6284.5 7148.5 7166.4 7196.5 7209.2 3675.9 4373.6 4401.3 4403.0 4428.9 6051.5 6773.0 6789.4 7028.4 7073.6 5806.8 5844.6 6128.9 6687.3 6716.9 6433.2 6604.3 6683.7 6701.0 6802.4 6497.5 6503.5 6523.3 6536.3 6537.0 6378.4 6418.9 6482.6 6686.7 6689.0 6505.8 6559.4 6564.8 6587.2 6591.1 03:17:10 INFO - PID 1646 | 03:17:10 INFO - PID 1646 | [#5] yui.html Cycles:180 Average:22652.25 Median:17471.56 stddev:32559.78 (186.4%) stddev-sans-first:32609.88 03:17:10 INFO - PID 1646 | Values: 829.8 843.3 843.6 862.5 867.0 16191.9 16645.1 16703.4 18399.3 19188.6 17320.7 17533.6 17763.7 18383.7 18448.2 1001.8 1016.9 1029.0 1034.0 1034.3 1033.7 1038.5 1041.6 1041.6 1042.7 1067.6 1070.8 1077.6 1078.0 1078.1 1048.8 1057.1 1071.9 1073.7 1075.8 751.7 766.9 777.5 777.6 778.1 16407.3 16565.1 16571.8 16573.6 16596.0 15263.9 16219.2 16546.6 16684.2 16700.2 10262.8 13868.6 13911.9 13949.0 13980.3 3342.2 3375.0 3393.5 3433.5 3456.1 134428.3 135520.3 137703.0 137899.0 139740.0 13122.7 13248.0 13339.3 13486.7 13490.1 20696.8 25068.9 25312.9 25605.0 25787.0 7693.3 7717.8 7794.3 7855.1 7886.5 3978.8 4028.8 4040.9 4051.7 4054.6 4157.0 4252.2 4264.0 4278.7 4301.7 878.6 889.0 896.2 902.4 905.7 643.5 651.9 658.3 661.4 681.5 11071.6 11717.8 11943.5 11976.7 12115.8 538.8 637.6 650.0 652.2 682.8 5303.9 5427.5 5862.8 6103.2 6183.2 85649.0 109548.0 110166.9 110855.3 112550.0 96087.0 96398.5 96915.5 96950.0 97460.1 62263.0 78260.0 79532.6 80997.0 81076.2 11559.2 12482.2 12511.0 12531.8 12740.2 40578.0 40644.4 40714.0 41816.8 41930.4 54940.0 72418.0 74537.6 74587.0 76293.6 16815.0 17063.7 17075.3 17109.2 17135.3 17422.9 17771.7 18496.6 18747.3 18908.6 16640.4 16951.7 16977.9 17384.7 17531.0 16290.7 16619.0 17327.0 17520.2 17588.4 16124.2 16681.7 16736.9 16743.3 16883.4 11819.9 12097.0 12148.5 12327.2 12373.6 12092.6 13052.3 13114.8 13167.5 13442.2 03:17:10 INFO - PID 1646 | -------- Summary: end -------- 03:17:10 INFO - PID 1646 | 03:17:10 INFO - TEST-INFO | 1646: exit 0 03:17:10 INFO - TEST-OK | dromaeo_css | took 1114518ms 03:17:10 INFO - TEST-START | kraken 03:17:10 INFO - operating with platform_type : mac_ 03:17:10 INFO - Initialising browser for kraken test... 03:17:10 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/tmpR5YSYz/profile http://localhost:49236/getInfo.html) 03:17:13 INFO - PID 1659 | 2017-04-29 03:17:13.637 plugin-container[1660:10147] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x454b, name = 'com.apple.tsm.portname' 03:17:13 INFO - PID 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:17:13 INFO - PID 1659 | 2017-04-29 03:17:13.639 plugin-container[1660:10147] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x990b, name = 'com.apple.CFPasteboardClient' 03:17:13 INFO - PID 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:17:13 INFO - PID 1659 | 2017-04-29 03:17:13.639 plugin-container[1660:10147] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:17:13 INFO - PID 1659 | __metrics Screen width/height:1600/1200 03:17:13 INFO - PID 1659 | colorDepth:24 03:17:13 INFO - PID 1659 | Browser inner width/height: 1024/689 03:17:13 INFO - PID 1659 | __metrics 03:17:14 INFO - TEST-INFO | 1659: exit 0 03:17:14 INFO - Browser initialized. 03:17:14 INFO - Running cycle 1/1 for kraken test... 03:17:14 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/tmpR5YSYz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:17:17 INFO - PID 1661 | 2017-04-29 03:17:17.219 plugin-container[1662:10272] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9747, name = 'com.apple.tsm.portname' 03:17:17 INFO - PID 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:17:17 INFO - PID 1661 | 2017-04-29 03:17:17.219 plugin-container[1662:10272] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x974b, name = 'com.apple.CFPasteboardClient' 03:17:17 INFO - PID 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:17:17 INFO - PID 1661 | 2017-04-29 03:17:17.219 plugin-container[1662:10272] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:17:27 INFO - PID 1661 | RSS: Main: 234733568 03:17:27 INFO - PID 1661 | 03:17:29 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 03:17:30 INFO - PID 1661 | RSS: Main: 248270848 03:17:30 INFO - PID 1661 | 03:17:33 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 03:17:33 INFO - PID 1661 | RSS: Main: 256434176 03:17:33 INFO - PID 1661 | 03:17:37 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 03:17:37 INFO - PID 1661 | RSS: Main: 258805760 03:17:37 INFO - PID 1661 | 03:17:39 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 03:17:40 INFO - PID 1661 | RSS: Main: 260775936 03:17:40 INFO - PID 1661 | 03:17:42 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:17:43 INFO - PID 1661 | RSS: Main: 261505024 03:17:43 INFO - PID 1661 | 03:17:46 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 03:17:46 INFO - PID 1661 | RSS: Main: 267366400 03:17:46 INFO - PID 1661 | 03:17:49 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 03:17:50 INFO - PID 1661 | RSS: Main: 269090816 03:17:50 INFO - PID 1661 | 03:17:53 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 03:17:54 INFO - PID 1661 | RSS: Main: 268570624 03:17:54 INFO - PID 1661 | 03:17:55 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:17:56 INFO - PID 1661 | RSS: Main: 267431936 03:17:56 INFO - PID 1661 | 03:17:58 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:17:58 INFO - PID 1661 | RSS: Main: 267550720 03:17:58 INFO - PID 1661 | 03:18:00 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:18:01 INFO - PID 1661 | RSS: Main: 267100160 03:18:01 INFO - PID 1661 | 03:18:04 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:18:05 INFO - PID 1661 | RSS: Main: 267456512 03:18:05 INFO - PID 1661 | 03:18:08 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:18:08 INFO - PID 1661 | RSS: Main: 267534336 03:18:08 INFO - PID 1661 | 03:18:10 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 03:18:10 INFO - PID 1661 | RSS: Main: 269156352 03:18:10 INFO - PID 1661 | 03:18:10 INFO - PID 1661 | __start_tp_report 03:18:10 INFO - PID 1661 | _x_x_mozilla_page_load 03:18:10 INFO - PID 1661 | _x_x_mozilla_page_load_details 03:18:10 INFO - PID 1661 | |i|pagename|runs| 03:18:10 INFO - PID 1661 | |0;ai-astar;103;116;115;115;114;114;116;114;115;114 03:18:10 INFO - PID 1661 | |1;audio-beat-detection;136;112;108;148;117;111;113;108;135;110 03:18:10 INFO - PID 1661 | |2;audio-dft;196;220;233;259;234;199;193;199;200;193 03:18:10 INFO - PID 1661 | |3;audio-fft;81;57;62;106;49;57;68;89;93;89 03:18:10 INFO - PID 1661 | |4;audio-oscillator;88;54;112;106;102;103;79;74;113;113 03:18:10 INFO - PID 1661 | |5;imaging-gaussian-blur;89;88;88;87;89;88;98;95;136;89 03:18:10 INFO - PID 1661 | |6;imaging-darkroom;95;96;95;96;96;96;96;96;96;96 03:18:10 INFO - PID 1661 | |7;imaging-desaturate;93;91;76;141;143;111;141;91;118;79 03:18:10 INFO - PID 1661 | |8;json-parse-financial;45;63;62;51;52;51;42;43;71;74 03:18:10 INFO - PID 1661 | |9;json-stringify-tinderbox;55;56;65;72;62;62;57;57;59;56 03:18:10 INFO - PID 1661 | |10;stanford-crypto-aes;85;84;85;83;84;87;82;83;84;86 03:18:10 INFO - PID 1661 | |11;stanford-crypto-ccm;137;140;137;135;136;136;136;138;197;146 03:18:10 INFO - PID 1661 | |12;stanford-crypto-pbkdf2;194;241;199;186;192;183;186;186;191;211 03:18:10 INFO - PID 1661 | |13;stanford-crypto-sha256-iterative;69;67;70;66;63;66;70;69;69;69 03:18:10 INFO - PID 1661 | __end_tp_report 03:18:10 INFO - PID 1661 | __start_cc_report 03:18:10 INFO - PID 1661 | _x_x_mozilla_cycle_collect,986 03:18:10 INFO - PID 1661 | __end_cc_report 03:18:10 INFO - PID 1661 | __startTimestamp1493461090786__endTimestamp 03:18:10 INFO - PID 1661 | 03:18:10 INFO - PID 1661 | ------- Summary: start ------- 03:18:10 INFO - PID 1661 | Number of tests: 14 03:18:10 INFO - PID 1661 | 03:18:10 INFO - PID 1661 | [#0] ai-astar Cycles:10 Average:113.60 Median:115.00 stddev:3.81 (3.3%) stddev-sans-first:0.83 03:18:10 INFO - PID 1661 | Values: 103.0 116.0 115.0 115.0 114.0 114.0 116.0 114.0 115.0 114.0 03:18:10 INFO - PID 1661 | 03:18:10 INFO - PID 1661 | [#1] audio-beat-detection Cycles:10 Average:119.80 Median:115.00 stddev:14.36 (12.5%) stddev-sans-first:13.98 03:18:10 INFO - PID 1661 | Values: 136.0 112.0 108.0 148.0 117.0 111.0 113.0 108.0 135.0 110.0 03:18:10 INFO - PID 1661 | 03:18:10 INFO - PID 1661 | [#2] audio-dft Cycles:10 Average:212.60 Median:210.00 stddev:22.74 (10.8%) stddev-sans-first:23.31 03:18:10 INFO - PID 1661 | Values: 196.0 220.0 233.0 259.0 234.0 199.0 193.0 199.0 200.0 193.0 03:18:10 INFO - PID 1661 | 03:18:10 INFO - PID 1661 | [#3] audio-fft Cycles:10 Average:75.10 Median:74.50 stddev:19.02 (25.5%) stddev-sans-first:20.05 03:18:10 INFO - PID 1661 | Values: 81.0 57.0 62.0 106.0 49.0 57.0 68.0 89.0 93.0 89.0 03:18:10 INFO - PID 1661 | 03:18:10 INFO - PID 1661 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:83.50 stddev:19.98 (23.9%) stddev-sans-first:21.06 03:18:10 INFO - PID 1661 | Values: 88.0 54.0 112.0 106.0 102.0 103.0 79.0 74.0 113.0 113.0 03:18:10 INFO - PID 1661 | 03:18:10 INFO - PID 1661 | [#5] imaging-gaussian-blur Cycles:10 Average:94.70 Median:89.00 stddev:14.94 (16.8%) stddev-sans-first:15.70 03:18:10 INFO - PID 1661 | Values: 89.0 88.0 88.0 87.0 89.0 88.0 98.0 95.0 136.0 89.0 03:18:10 INFO - PID 1661 | 03:18:10 INFO - PID 1661 | [#6] imaging-darkroom Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 03:18:10 INFO - PID 1661 | Values: 95.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 03:18:10 INFO - PID 1661 | 03:18:10 INFO - PID 1661 | [#7] imaging-desaturate Cycles:10 Average:108.40 Median:77.50 stddev:26.20 (33.8%) stddev-sans-first:27.19 03:18:10 INFO - PID 1661 | Values: 93.0 91.0 76.0 141.0 143.0 111.0 141.0 91.0 118.0 79.0 03:18:10 INFO - PID 1661 | 03:18:10 INFO - PID 1661 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:57.00 stddev:11.46 (20.1%) stddev-sans-first:11.52 03:18:10 INFO - PID 1661 | Values: 45.0 63.0 62.0 51.0 52.0 51.0 42.0 43.0 71.0 74.0 03:18:10 INFO - PID 1661 | 03:18:10 INFO - PID 1661 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.50 stddev:5.30 (8.8%) stddev-sans-first:5.29 03:18:10 INFO - PID 1661 | Values: 55.0 56.0 65.0 72.0 62.0 62.0 57.0 57.0 59.0 56.0 03:18:10 INFO - PID 1661 | 03:18:10 INFO - PID 1661 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.50 stddev:1.49 (1.8%) stddev-sans-first:1.56 03:18:10 INFO - PID 1661 | Values: 85.0 84.0 85.0 83.0 84.0 87.0 82.0 83.0 84.0 86.0 03:18:10 INFO - PID 1661 | 03:18:10 INFO - PID 1661 | [#11] stanford-crypto-ccm Cycles:10 Average:143.80 Median:137.50 stddev:18.96 (13.8%) stddev-sans-first:19.95 03:18:10 INFO - PID 1661 | Values: 137.0 140.0 137.0 135.0 136.0 136.0 136.0 138.0 197.0 146.0 03:18:10 INFO - PID 1661 | 03:18:10 INFO - PID 1661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.90 Median:193.00 stddev:17.53 (9.1%) stddev-sans-first:18.56 03:18:10 INFO - PID 1661 | Values: 194.0 241.0 199.0 186.0 192.0 183.0 186.0 186.0 191.0 211.0 03:18:10 INFO - PID 1661 | 03:18:10 INFO - PID 1661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:69.00 stddev:2.25 (3.3%) stddev-sans-first:2.35 03:18:10 INFO - PID 1661 | Values: 69.0 67.0 70.0 66.0 63.0 66.0 70.0 69.0 69.0 69.0 03:18:10 INFO - PID 1661 | -------- Summary: end -------- 03:18:10 INFO - PID 1661 | 03:18:11 INFO - TEST-INFO | 1661: exit 0 03:18:11 INFO - TEST-OK | kraken | took 61191ms 03:18:11 INFO - SUITE-END | took 1175s 03:18:11 INFO - Completed test suite (00:19:35) 03:18:11 INFO - javascript benchmark 03:18:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7894.086304387385, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2769.736874996875, 3223.9999999999995, 3590.8743193988216, 3621.2938476996997, 3634.727395445341, 6196.752129914804, 6283.717232724527, 6287.497000239981, 6292.276388215357, 6298.874022519547, 6109.35851735568, 6163.537734669895, 6213.068039794033, 6214.596051256665, 6215.658138802364, 5341.65279256849, 5460.590455715817, 5491.505764481196, 5513.007658621446, 5539.390667026624, 5371.865703357408, 5543.556515478752, 5559.9444005559835, 5563.415841336662, 5566.053770858964, 4826.517348265163, 5530.446955304457, 5535.916961245584, 5567.832965011056, 5571.331440227178, 5339.6262261641705, 5416.702081385522, 5421.213923981, 5426.2674538937135, 5478.479544443271, 5401.513863752242, 5407.675539467645, 5460.235567020621, 5461.672299662033, 5489.313835770528, 6094.146819445281, 6166.7533298667995, 6206.596571222856, 6272.3100458949475, 6279.497640188774, 6638.601683898982, 6713.4964877634375, 6723.159605049369, 6734.292899245557, 6734.797956061326, 6463.967680161616, 6543.640099794509, 6697.665116744143, 6798.184217893884, 6812.489063320221, 6309.842253943642, 6313.242410910674, 6323.0, 6333.11336412898, 6338.461230795342, 6739.730410783612, 6876.415504682158, 6888.345607167411, 6897.034415181878, 6906.482013848981, 6331.461825744863, 6386.8722625547225, 6492.188476440445, 6536.575122617015, 6555.639439830855, 6740.9325906740305, 6762.492813039042, 6776.830579235559, 6785.762498312634, 6786.660666966632, 5238.371395432572, 6603.306652801482, 6630.270670226271, 6653.600783952881, 6656.467482601381, 5575.470330318613, 6380.7128679209545, 6442.516811239082, 6529.967350163219, 6665.7666981656375, 5110.565601923804, 5295.814646487354, 5317.335333083364, 5324.760385782649, 5375.19372094189, 4677.7193368398, 4722.976385118052, 4724.692894961817, 4735.431748190239, 4767.785449654774, 6045.093236014545, 6257.405546473078, 6309.400606942425, 6340.365963403715, 6354.269259035178, 6673.599584024974, 6740.662966851638, 6748.257691653914, 6751.864962700718, 6769.289224631441, 6318.052292156121, 6334.208223972004, 6360.52296077796, 6380.361963803675, 6385.712642931079, 5214.348206474191, 5751.0, 5939.346671866091, 5962.25471816023, 6021.066734656135, 5665.348484924121, 6605.966970165118, 6781.321867813278, 6920.342567456084, 6965.094537710065, 6751.966240168964, 6783.491238157059, 6795.116634837637, 6800.897986530107, 6814.863702725818, 5904.911426328695, 6678.198616166092, 6706.926891697305, 6919.065926099912, 7001.439884809305, 6644.069830223869, 6654.367835055662, 6657.400833924777, 6658.1344425224415, 6668.933310667026, 6355.491560675043, 6586.637734924625, 6624.635645039376, 6690.13028306317, 6763.729450821912, 6398.584092034003, 6474.158359413246, 6516.055172000129, 6521.184851893513, 6536.934630653633, 5213.348331458567, 6452.22573291208, 6509.544331896722, 6527.477801775752, 6529.118568993125, 6235.812925612239, 6297.338779428277, 6351.142595749515, 6355.0, 6366.649834258975, 6344.302126766144, 6422.229332479946, 6489.513286503437, 6508.674566271573, 6532.0, 6282.811515654537, 6360.968195158995, 6380.585261958144, 6392.648404337806, 6413.0], "value": 6071.92262667769, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [764.4495962906707, 836.9455985360951, 1093.6882988348323, 1139.2480962564705, 1219.9024078073755, 35622.46566301504, 38260.617393826054, 38328.42507362392, 38405.807970960144, 38422.615773842255, 37973.05067373317, 38363.42454863172, 38392.80803595985, 38433.231335373275, 38549.421758673576, 7858.253465920743, 8046.235607617267, 8239.835203295961, 8472.915270847305, 8493.617787199591, 8507.787305317355, 8568.828623427527, 8637.39538232324, 8647.437916535406, 8656.523891185981, 8595.312375010015, 8598.785030374229, 8617.741467755977, 8629.611667474946, 8644.222020018196, 8542.658293668246, 8579.184977427134, 8591.441556298883, 8605.698800541952, 8607.18231767981, 8297.502149870967, 8355.373346998938, 8413.0, 8413.242808147235, 8422.073571907085, 37360.252794943946, 37488.0, 37499.81250093732, 37539.62460375416, 37569.812150939346, 3713.9442908356395, 3748.850045998157, 3755.887323380303, 3756.3614185588244, 3761.0, 31170.376592468023, 31219.37561248785, 31294.687053129404, 31357.52963705546, 31380.21549461259, 3152.952705709416, 3167.667394923523, 3187.585613870205, 3195.5206718992104, 3196.4566023776015, 286989.0, 287408.9999999979, 287847.0, 288809.0, 289240.0, 40201.39697904534, 40712.98217544585, 48899.755501222266, 49369.753151234014, 50353.489395318196, 51397.715057123874, 51699.224511632354, 51850.74074629678, 51868.481315186364, 51958.0, 14624.341904614104, 14748.18884961316, 14750.704985900436, 14768.778468322984, 14790.11259324444, 11844.703882402837, 11872.525098996117, 11881.88118118825, 11898.22661526998, 11980.221285616408, 11766.117541184445, 13718.314084295745, 13760.587182384545, 13792.448302067805, 13891.305434728223, 5960.731767070492, 6001.7599296027665, 6016.729247183887, 6034.48706859913, 6050.0, 955.5986485676033, 962.5572236771163, 965.3676841668719, 1032.1742605915238, 1064.7178497698117, 24176.516469670507, 24755.04879220107, 24766.133185338425, 24892.875535622567, 25020.374490637514, 970.6554173268529, 1138.9772204555863, 1166.2128063557066, 1177.4230626992712, 1185.6739396665987, 11226.607068752555, 12188.268703877795, 12272.822123076063, 12502.249865008129, 12755.362231888368, 278855.0, 280599.0, 302376.0, 303777.0, 339173.0, 57215.71392143013, 57319.0, 57351.71324143436, 57393.56516087048, 57660.423395766345, 1378.63466181462, 1528.663693987321, 1556.4552406657579, 1565.1626379886934, 1567.968640627204, 24189.63715544233, 24255.0, 24287.0, 24355.14756983497, 24446.63330050015, 39691.80154099326, 39750.0, 39829.60170398259, 39914.80042599768, 39954.200915982095, 291586.0, 291929.0, 292124.0, 292744.0, 292856.0, 30765.846170769004, 33156.83421582876, 35279.823600881835, 35556.64443355533, 35615.0, 43837.78081109574, 44083.77958110189, 45437.31844022276, 45481.31778023266, 45482.27106373628, 22874.885625571766, 29686.55470167906, 30328.569500471644, 31015.844920775253, 31940.201494961882, 24600.6309905348, 30302.696973029986, 31417.8429107853, 31510.054698359087, 31665.0, 38233.23533529369, 38298.23403531858, 38300.80849595734, 38308.85073447801, 38362.0, 30094.548581770854, 30913.0, 31284.687153128176, 31796.205094872814, 32138.0, 22292.665610015538, 23937.640935385636, 24280.271591852274, 24354.0, 24395.0], "value": 17692.545996286306, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.98042588083575, 443.0474479868283, 443.0982949697366, 454.13487306680776, 462.2350010732237, 19334.51663708408, 20528.486787830312, 21179.94100294987, 21377.893110534445, 21407.357779266607, 18036.909815450905, 21960.35297352697, 22129.778702212974, 22384.440388990282, 22453.887730561364, 5908.379620139888, 6121.908171377433, 6191.845203869894, 6216.222972128484, 6219.315875253718, 5796.159556864252, 6025.457708806207, 6096.146539484475, 6100.938990610103, 6106.2977757558, 5935.792247271346, 6006.0, 6009.819705408823, 6034.728437220314, 6047.274327080757, 5821.3887541808135, 6086.330503644595, 6092.725827337758, 6113.755449782004, 6160.907586386208, 5233.842984710427, 5338.386085600167, 5352.678839269656, 5365.03429382711, 5404.756785944603, 25766.84049217771, 25769.0, 25803.0, 25813.870930645415, 25878.22365329043, 2281.258590957945, 2301.528186721718, 2321.338418550722, 2324.9651255231183, 2328.348062542491, 13188.670283242996, 16761.078140702255, 16971.3211471541, 17018.978861268362, 17545.298188072462, 2056.9177232910665, 2133.8933053347428, 2170.7720689327552, 2177.8366622503377, 2178.4662757624324, 129915.40169196657, 153435.23282383516, 155075.0, 156545.2172739129, 159443.20278398533, 11802.11484138693, 12253.571125010581, 12286.508539658493, 12334.75330493385, 12385.62843114708, 15804.0, 15976.840231597535, 16062.0, 16084.874058816005, 16089.51731448035, 8721.91278087211, 8895.28837692983, 8911.866322005175, 8924.152205540464, 8961.283097352196, 6920.446364290845, 7247.891281630779, 8209.753707388787, 8594.925634295712, 8602.612882420306, 6428.871422571522, 6731.899021514681, 6909.896351554731, 7449.255074492507, 7788.922110778933, 2151.1395441823397, 2156.4501052231894, 2164.7835216478225, 2165.8267338612873, 2365.1367250953276, 911.0388540090269, 956.2397893674546, 974.6734843827397, 976.1068622210739, 1003.6938733686296, 17986.0, 20140.496487587927, 20523.973801309876, 20584.794152058286, 20871.58256834885, 856.6958729651009, 883.6995421556702, 913.6071489259682, 934.5420743835472, 1028.717102796737, 8790.340724445692, 10495.737606559744, 10538.31500952451, 10563.63027294041, 10576.41829699374, 529032.0, 540339.0, 546447.0, 548489.0, 552126.0, 122738.38630806789, 126348.73651263553, 132553.33723331513, 137565.0, 137840.0, 1192.9045676345872, 1226.055936928578, 1242.975140497203, 1245.1097465312346, 1250.5935570939298, 18348.81651183471, 20045.198192072738, 20855.734655611872, 21195.046222920315, 21207.15171393127, 55529.0, 57740.0, 58139.70930145322, 58474.4152558486, 58816.70591647014, 81191.78212326701, 81406.18593813985, 81783.18216817756, 82405.17594823975, 83902.0, 8717.433366831136, 8812.295016398544, 8883.244924181517, 8921.06328835489, 8940.552972351486, 11755.765644607192, 12117.0, 13915.304234788018, 14090.929545352208, 14110.36503357331, 11616.88383116158, 11730.413479326171, 11818.172727909308, 11917.880821192024, 12223.572174973833, 9983.900160998588, 9989.401695728939, 11161.553537858395, 11306.0, 11488.597899073493, 11649.534018639499, 11783.410829458322, 12120.151589388659, 12171.721969193108, 12295.077869160028, 8631.784205394915, 8782.341324400568, 8814.0, 8857.424267422597, 8860.86708699357, 10427.94786026065, 10688.877667844765, 10984.560617575207, 11588.710282243012, 12018.459169337226], "value": 10269.739663027387, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1298.2535042350644, 1361.754884120858, 1408.9225092619906, 1411.9223442710647, 1480.792689023537, 11289.943550282247, 11313.094952403808, 11581.247218930774, 11742.471588778515, 12003.3398163101, 11510.424478776049, 11686.474108665108, 11691.590794322201, 11707.648770536876, 11771.646850594496, 2499.1502889017684, 2540.5300019496453, 2552.731963143871, 2556.2970183199677, 2556.5398228318895, 2083.2812679625504, 2227.454273702945, 2460.8065088432095, 2472.11004038546, 2511.510255500178, 2486.4032632168332, 2512.660790793238, 2517.471331020488, 2530.4812513434704, 2535.125381743305, 2430.1008626808107, 2451.240115564172, 2477.1082410332265, 2479.82641215115, 2486.204414587333, 2425.211806163004, 2442.426029882976, 2458.8770561472033, 2464.0759715106833, 2526.886290116949, 11691.473883675255, 11704.063674905987, 11709.238899471507, 11737.295762254207, 11781.234219775773, 6549.770758023494, 6731.057651928734, 6797.320267973212, 6804.149481314836, 6821.590704557742, 3936.645701886844, 4303.33298338758, 4307.440032795716, 4379.868603941887, 4380.78096095194, 1085.6688709943464, 1250.8936740376987, 1257.7484503099417, 1286.2218357893528, 1310.1287643716917, 15035.0, 15608.687826243411, 16259.756103658454, 16415.097169655663, 16443.260053297632, 5447.101228297366, 5496.890062198733, 5678.943210567924, 5707.4577915098, 5726.255586773693, 11729.061675066145, 11802.822957655642, 11939.820902686466, 11952.0, 11952.163348565517, 6521.706523206467, 6525.673716314165, 6528.575642583217, 6536.281009088996, 6538.084668146464, 6042.4561789438285, 6060.666663333559, 6122.54080943931, 6182.629042257479, 6214.098955651405, 4258.0, 4386.144701783185, 4392.121575684876, 4428.867133985986, 4443.37792709021, 1256.723520825417, 1273.1088238233274, 1273.9490420383265, 1284.0433876761685, 1291.322055920649, 681.5672048249397, 785.6503855784122, 820.6758330459435, 824.4146655874276, 828.6809578312273, 6219.751209951552, 6370.872582548416, 6665.766698165541, 6942.507360917427, 7029.261927497641, 790.9124953189364, 955.2262667239559, 963.325672029582, 964.628617982082, 997.6508222122344, 4312.921769557611, 4521.977390113028, 4587.472440669299, 4615.838445654386, 4777.474477807438, 14679.266036698122, 14736.042157259744, 14978.0, 14985.475508357154, 14996.625084372978, 14289.928550357181, 14821.0, 14838.258087095603, 14858.851411485963, 14892.0, 7201.315874991763, 8232.958835205905, 8319.251267385964, 8428.45215061019, 8479.788005299793, 5971.58198926071, 6839.760608378683, 7086.397656199075, 7136.179339376038, 7148.749793757402, 12805.871941280468, 13291.867081329063, 13383.598492044865, 13407.32963351848, 13672.589822305346, 13523.797143042666, 13780.448782049007, 13856.0, 13960.022798404421, 14068.296585170496, 9328.53357332117, 9346.579403926704, 9369.390989585656, 9451.196648284973, 9479.004704505927, 9033.81932361336, 10450.372977621368, 10663.680089597325, 10689.198310126927, 10775.892241077489, 7327.37717294036, 7611.923880761343, 9232.261419086322, 9246.583903724215, 9271.490068046322, 8900.198982091642, 8973.698813672112, 9071.682491112779, 9081.727548173565, 9092.408993415407, 6915.550489218184, 6999.930000700131, 8181.263686268265, 8221.17788221173, 8309.210624990616, 4680.531946805429, 6042.848928776816, 6172.98145805937, 6185.84535386619, 6345.809625711236, 6118.326984031664, 6148.415900489446, 6150.200473938359, 6219.0982307566055, 6285.497160227263], "value": 5361.916553717927, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.9880654177104, 371.42985517231057, 409.51063479142425, 413.5864135864136, 419.1805021183586, 6355.11028456016, 6379.712912918924, 6381.680915954195, 6393.232812062559, 6424.839379015521, 6093.969530152354, 6192.690365481731, 6221.315655277927, 6267.905981410283, 6305.148804911336, 3880.980595097035, 4029.741187749985, 4729.78715957781, 4755.334253204554, 4760.357351757511, 4688.2264426369775, 4704.741239231841, 4770.833020844271, 4774.848599924051, 4775.880602984936, 4257.510386305568, 4370.792749661417, 4695.812167513295, 4715.929261061086, 4757.762111894409, 4667.249781332001, 4692.788824502889, 4718.551737584924, 4721.315409265671, 4729.31424943383, 3548.27260411615, 3705.2959937612036, 3992.820323085439, 4006.9198616027807, 4240.681948853849, 5283.969625922947, 5342.996376358866, 5945.881082378328, 6015.819525414201, 6059.515238780887, 4674.555917187861, 5102.953894451629, 5335.306410166653, 5366.517013468768, 5409.0534156522845, 5697.202391665171, 6430.485561155097, 6507.7071531781185, 6572.6807961979375, 6654.500912431538, 3368.3768502827056, 3540.8937731868086, 4307.8492252771, 4356.455443069616, 4424.84513042042, 5477.589180811455, 5801.955647983404, 5888.440598143169, 6934.0, 7088.468364872655, 3648.4709717091405, 4322.157179349996, 4359.215341238608, 4411.874971882149, 4417.712848664826, 3935.940960885589, 3993.8233662653342, 4198.908283846161, 4440.511543730187, 4479.70881892676, 3760.6051364606324, 4625.606823419979, 4934.235193545006, 5163.993021360874, 5342.813001544927, 6292.748290068346, 6624.735010599618, 6649.634270115093, 6656.567323123982, 6693.397594216543, 1461.415433826478, 1504.3456096598015, 1523.6059006009598, 1528.6407694191855, 1536.3240174323262, 991.2912267728609, 992.8560358747941, 994.7662299359645, 995.5669283861544, 1003.5784970312486, 6323.1779868617705, 6377.649229292433, 6379.393957574023, 6383.585066970725, 6412.839679008062, 5342.358916929993, 6754.76358327466, 6933.341332573397, 6942.062821519131, 6944.826379340557, 6317.4946004319545, 6326.240851097898, 6354.046892965999, 6362.9045564316575, 6515.771947981798, 2886.639170103737, 3480.9477857832153, 3608.675219230282, 3628.528291322164, 3630.854765809338, 6974.232834388214, 7160.641967901584, 7165.534240274365, 7179.569225846466, 7187.712491500386, 6788.59268443895, 7088.468364872552, 7102.14774227096, 7128.465365097639, 7140.178879428829, 5432.511074003359, 6595.735111120026, 6652.7671531497135, 6737.898931515933, 6986.825329366705, 6565.934340656532, 6696.48881669374, 6978.232394436506, 6997.0, 6997.895031574632, 6086.939130608637, 6763.410598509248, 6769.864602708017, 6770.5104876927, 6802.591844489347, 6284.497240220863, 7148.535345202546, 7166.355028047501, 7196.496245262991, 7209.206987231296, 3675.9081022974638, 4373.584509471595, 4401.25178719612, 4403.0, 4428.933565996448, 6051.485623722033, 6772.98405239218, 6789.422899053636, 7028.367446929801, 7073.575585464889, 5806.76772929095, 5844.561657875762, 6128.927437698296, 6687.331266873273, 6716.865662686621, 6433.195850518685, 6604.306547812603, 6683.732650693918, 6700.966495167493, 6802.435439848764, 6497.480201583768, 6503.479721622353, 6523.282438931618, 6536.281009088902, 6537.0, 6378.394052564999, 6418.871622567429, 6482.57863238888, 6686.665666716547, 6688.966555167193, 6505.804825855232, 6559.409653131241, 6564.8358791030605, 6587.242467116152, 6591.077249185022], "value": 4804.047472216724, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [829.8174401631646, 843.2789964580284, 843.5697794124997, 862.4782006885833, 867.0375882770126, 16191.919040404797, 16645.084520351375, 16703.415380461687, 18399.26402943884, 19188.616227675473, 17320.653586928252, 17533.561660958483, 17763.733543996852, 18383.724244136316, 18448.169832357544, 1001.7746007148406, 1016.8983101689846, 1028.984565231522, 1033.966033966034, 1034.2811745836646, 1033.7467320506487, 1038.5118994072773, 1041.5625437316307, 1041.572955088414, 1042.7393151712072, 1067.5783065689047, 1070.8286674132141, 1077.6120596585224, 1077.9759228732696, 1078.067471637036, 1048.7587854793364, 1057.0697785948394, 1071.9035286824185, 1073.7047311989227, 1075.833245846895, 751.6918063593955, 766.9194734552904, 777.5023984649829, 777.6267391652038, 778.0896351269029, 16407.343706251737, 16565.08892010939, 16571.83428165715, 16573.585660358465, 16596.004239745653, 15263.85521085923, 16219.189040547926, 16546.58633534171, 16684.165791710486, 16700.248488818033, 10262.794744105151, 13868.58394248164, 13911.930440347733, 13948.953828462805, 13980.300984950814, 3342.1644588852787, 3375.038114137459, 3393.5079413485155, 3433.536472576195, 3456.1359660084977, 134428.32785836008, 135520.32239838835, 137703.0, 137899.0, 139740.0, 13122.671933201746, 13248.0, 13339.26634035118, 13486.730265394834, 13490.055696101179, 20696.79303206979, 25068.87465562697, 25312.873435632704, 25605.0, 25787.0, 7693.269139431745, 7717.8456430871065, 7794.337481314038, 7855.096663883726, 7886.487378320391, 3978.840846366171, 4028.798560071985, 4040.878773636796, 4051.6556092731857, 4054.6350828425584, 4156.960759810047, 4252.213340532012, 4263.957360426418, 4278.657707383401, 4301.720388174758, 878.6441491196076, 889.035396594702, 896.2068569316071, 902.3953950852813, 905.6830109461768, 643.4852118305337, 651.8924377477758, 658.3252166529346, 661.381608196338, 681.4990981628499, 11071.612493562687, 11717.824232636518, 11943.462544185533, 11976.700582485333, 12115.818262726067, 538.8383484954576, 637.5505268785495, 649.95775274607, 652.1749986267375, 682.7507959594712, 5303.893922121536, 5427.538659214011, 5862.765489380462, 6103.206583144163, 6183.227096612924, 85649.0, 109548.0, 110166.89833101566, 110855.33716994252, 112550.0, 96087.03912960921, 96398.51800740951, 96915.51542242385, 96950.0, 97460.05079898362, 62263.0, 78260.0, 79532.60233698794, 80997.0, 81076.18923810804, 11559.208322709994, 12482.188657737219, 12511.0, 12531.812022819482, 12740.171888827197, 40578.0, 40644.39033414442, 40714.0, 41816.790916045225, 41930.37104443375, 54940.0, 72418.0, 74537.62731186309, 74587.0, 76293.61853190699, 16815.0, 17063.744043839102, 17075.31698732037, 17109.23008464647, 17135.314587416364, 17422.912885435493, 17771.73342399891, 18496.630067398844, 18747.25010999599, 18908.621827563646, 16640.417585384454, 16951.66096678035, 16977.915110424863, 17384.652306953536, 17531.0, 16290.67418651644, 16619.002859828448, 17326.9603823771, 17520.211590478204, 17588.38440654571, 16124.193790310672, 16681.74977375316, 16736.916315418344, 16743.33026678919, 16883.40908068212, 11819.881801182222, 12097.0, 12148.514059437524, 12327.198732082386, 12373.566925157576, 12092.637220883387, 13052.34738263064, 13114.803277950648, 13167.53913613019, 13442.193468391928], "value": 8514.854259817832, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1522.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 116.0, 115.0, 115.0, 114.0, 114.0, 116.0, 114.0, 115.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 112.0, 108.0, 148.0, 117.0, 111.0, 113.0, 108.0, 135.0, 110.0], "value": 119.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 220.0, 233.0, 259.0, 234.0, 199.0, 193.0, 199.0, 200.0, 193.0], "value": 212.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 57.0, 62.0, 106.0, 49.0, 57.0, 68.0, 89.0, 93.0, 89.0], "value": 75.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 54.0, 112.0, 106.0, 102.0, 103.0, 79.0, 74.0, 113.0, 113.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 88.0, 87.0, 89.0, 88.0, 98.0, 95.0, 136.0, 89.0], "value": 94.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 76.0, 141.0, 143.0, 111.0, 141.0, 91.0, 118.0, 79.0], "value": 108.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 63.0, 62.0, 51.0, 52.0, 51.0, 42.0, 43.0, 71.0, 74.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 65.0, 72.0, 62.0, 62.0, 57.0, 57.0, 59.0, 56.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 83.0, 84.0, 87.0, 82.0, 83.0, 84.0, 86.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 140.0, 137.0, 135.0, 136.0, 136.0, 136.0, 138.0, 197.0, 146.0], "value": 143.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 241.0, 199.0, 186.0, 192.0, 183.0, 186.0, 186.0, 191.0, 211.0], "value": 196.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 70.0, 66.0, 63.0, 66.0, 70.0, 69.0, 69.0, 69.0], "value": 67.8, "unit": "score"}]}]} 03:18:12 INFO - Return code: 0 03:18:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:18:12 ERROR - # TBPL SUCCESS # 03:18:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:18:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:18:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:18:12 INFO - 2017-04-29 03:18:12.156 screenresolution[1667:10668] starting screenresolution argv=screenresolution get 03:18:12 INFO - 2017-04-29 03:18:12.159 screenresolution[1667:10668] Display 0: 1600x1200x32@60 03:18:12 INFO - 2017-04-29 03:18:12.165 screenresolution[1668:10671] starting screenresolution argv=screenresolution list 03:18:12 INFO - Available Modes on Display 0 03:18:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:18:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:18:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:18:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:18:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:18:12 INFO - Intel Iris: 03:18:12 INFO - Chipset Model: Intel Iris 03:18:12 INFO - Type: GPU 03:18:12 INFO - Bus: Built-In 03:18:12 INFO - VRAM (Dynamic, Max): 1536 MB 03:18:12 INFO - Vendor: Intel (0x8086) 03:18:12 INFO - Device ID: 0x0a2e 03:18:12 INFO - Revision ID: 0x0009 03:18:12 INFO - Displays: 03:18:12 INFO - Display: 03:18:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:18:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:18:12 INFO - Display Serial Number: 1600x1200 60 03:18:12 INFO - Main Display: Yes 03:18:12 INFO - Mirror: Off 03:18:12 INFO - Online: Yes 03:18:12 INFO - Rotation: Supported 03:18:12 INFO - Return code: 0 03:18:12 INFO - Running post-action listener: _resource_record_post_action 03:18:12 INFO - [mozharness: 2017-04-29 10:18:12.405919Z] Finished run-tests step (success) 03:18:12 INFO - Running post-run listener: _resource_record_post_run 03:18:12 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 41229312; Write bytes: 514887680; Read time: 407; Write time: 1709 03:18:12 INFO - TinderboxPrint: CPU usage
54.1% 03:18:12 INFO - TinderboxPrint: I/O read bytes / time
41,229,312 / 407 03:18:12 INFO - TinderboxPrint: I/O write bytes / time
514,887,680 / 1,709 03:18:12 INFO - TinderboxPrint: CPU idle
2,198.4 (45.9%) 03:18:12 INFO - TinderboxPrint: CPU system
958.2 (20.0%) 03:18:12 INFO - TinderboxPrint: CPU user
1,629.1 (34.0%) 03:18:12 INFO - TinderboxPrint: Swap in / out
263,188,480 / 0 03:18:12 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 528384; Write bytes: 210994688; Read time: 13; Write time: 540 03:18:12 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 36056064; Write bytes: 302557696; Read time: 366; Write time: 1164 03:18:12 INFO - Running post-run listener: _upload_blobber_files 03:18:12 INFO - Blob upload gear active. 03:18:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:18:12 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 03:18:12 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'] 03:18:12 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 03:18:13 INFO - (blobuploader) - INFO - Open directory for files ... 03:18:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:18:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:18:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:13 INFO - (blobuploader) - INFO - Done attempting. 03:18:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:18:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:18:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:15 INFO - (blobuploader) - INFO - Done attempting. 03:18:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:18:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:18:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:15 INFO - (blobuploader) - INFO - Done attempting. 03:18:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:18:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:18:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:18 INFO - (blobuploader) - INFO - Done attempting. 03:18:18 INFO - (blobuploader) - INFO - Iteration through files over. 03:18:18 INFO - Return code: 0 03:18:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:18:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:18:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e6e0791386e84ea2f5cb10d5497e3f29d96b58734d85276c5998e9396995c5b8e3c462ad4d90c82ea0d51b38e3a5a862f6bd5b505b5608c6a2feb598cff9846", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c92461a8943b123c6c441354c833441d8cc3237fb66b0edcfa1803d3bd63c4d92192765461b3789d188ff8d419879b6324ec1e0ae2d7c93b3ef43658a59bf10b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8bec4a523cf36f9d22b392af43ab446ea20bea8b5d84284019416a2c13bb114e926b206e8b5b11f7be6de0f99161596c7e691434d55471648f8100829009d60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0577a155f3299a6fbc4be5cbe6e8e021ce421d1e0c0fd93be4c11736febd86cd99b73cd547f9f7d7e6e03f859e057f4e354d3df473f8ed902f2233abff56ac3c"} 03:18:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:18:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:18:18 INFO - Contents: 03:18:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e6e0791386e84ea2f5cb10d5497e3f29d96b58734d85276c5998e9396995c5b8e3c462ad4d90c82ea0d51b38e3a5a862f6bd5b505b5608c6a2feb598cff9846", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c92461a8943b123c6c441354c833441d8cc3237fb66b0edcfa1803d3bd63c4d92192765461b3789d188ff8d419879b6324ec1e0ae2d7c93b3ef43658a59bf10b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8bec4a523cf36f9d22b392af43ab446ea20bea8b5d84284019416a2c13bb114e926b206e8b5b11f7be6de0f99161596c7e691434d55471648f8100829009d60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0577a155f3299a6fbc4be5cbe6e8e021ce421d1e0c0fd93be4c11736febd86cd99b73cd547f9f7d7e6e03f859e057f4e354d3df473f8ed902f2233abff56ac3c"} 03:18:18 INFO - Running post-run listener: copy_logs_to_upload_dir 03:18:18 INFO - Copying logs to upload dir... 03:18:18 INFO - mkdir: /builds/slave/test/build/upload/logs 03:18:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.860452 ========= master_lag: 0.20 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-04-29 03:18:18.368469) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-29 03:18:18.374110) ========= 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.caOLWSuFnS/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.K5Vz6rdz9M/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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/8e6e0791386e84ea2f5cb10d5497e3f29d96b58734d85276c5998e9396995c5b8e3c462ad4d90c82ea0d51b38e3a5a862f6bd5b505b5608c6a2feb598cff9846", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c92461a8943b123c6c441354c833441d8cc3237fb66b0edcfa1803d3bd63c4d92192765461b3789d188ff8d419879b6324ec1e0ae2d7c93b3ef43658a59bf10b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8bec4a523cf36f9d22b392af43ab446ea20bea8b5d84284019416a2c13bb114e926b206e8b5b11f7be6de0f99161596c7e691434d55471648f8100829009d60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0577a155f3299a6fbc4be5cbe6e8e021ce421d1e0c0fd93be4c11736febd86cd99b73cd547f9f7d7e6e03f859e057f4e354d3df473f8ed902f2233abff56ac3c"} build_url:https://queue.taskcluster.net/v1/task/YwnQTodfSAGSEOF3OI-8mw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010916 build_url: 'https://queue.taskcluster.net/v1/task/YwnQTodfSAGSEOF3OI-8mw/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/8e6e0791386e84ea2f5cb10d5497e3f29d96b58734d85276c5998e9396995c5b8e3c462ad4d90c82ea0d51b38e3a5a862f6bd5b505b5608c6a2feb598cff9846", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c92461a8943b123c6c441354c833441d8cc3237fb66b0edcfa1803d3bd63c4d92192765461b3789d188ff8d419879b6324ec1e0ae2d7c93b3ef43658a59bf10b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8bec4a523cf36f9d22b392af43ab446ea20bea8b5d84284019416a2c13bb114e926b206e8b5b11f7be6de0f99161596c7e691434d55471648f8100829009d60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0577a155f3299a6fbc4be5cbe6e8e021ce421d1e0c0fd93be4c11736febd86cd99b73cd547f9f7d7e6e03f859e057f4e354d3df473f8ed902f2233abff56ac3c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-29 03:18:18.412432) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-29 03:18:18.412785) ========= 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.caOLWSuFnS/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.K5Vz6rdz9M/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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.005168 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-29 03:18:18.462822) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-29 03:18:18.463141) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-29 03:18:18.463511) ========= ========= Total master_lag: 0.35 =========