builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0366 starttime: 1493684495.27 results: success (0) buildid: 20170501155621 builduid: 51d28ecb229f4f5d9d09e2ab26a87af0 revision: 4b134293293043d247f8dcfd076ca9fc853332b4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-01 17:21:35.270488) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-01 17:21:35.270947) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-01 17:21:35.271232) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-01 17:21:35.302061) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 17:21:35.302464) ========= 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.qCh5dsvPAY/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.BDIbPfnKgc/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-05-01 17:21:35-- 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% 228M=0s 2017-05-01 17:21:35 (228 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093724 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 17:21:35.420729) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 17:21:35.421058) ========= 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.qCh5dsvPAY/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.BDIbPfnKgc/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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.022642 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 17:21:35.469519) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-01 17:21:35.469841) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4b134293293043d247f8dcfd076ca9fc853332b4 --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 4b134293293043d247f8dcfd076ca9fc853332b4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qCh5dsvPAY/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.BDIbPfnKgc/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-05-01 17:21:35,561 truncating revision to first 12 chars 2017-05-01 17:21:35,561 Setting DEBUG logging. 2017-05-01 17:21:35,561 attempt 1/10 2017-05-01 17:21:35,562 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4b1342932930?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-01 17:21:37,657 unpacking tar archive at: mozilla-central-4b1342932930/testing/mozharness/ program finished with exit code 0 elapsedTime=2.384237 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-01 17:21:37.878974) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-01 17:21:37.879387) ========= script_repo_revision: 4b134293293043d247f8dcfd076ca9fc853332b4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-01 17:21:37.879820) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-01 17:21:37.880111) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-01 17:21:37.900480) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-05-01 17:21:37.900801) ========= /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.qCh5dsvPAY/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.BDIbPfnKgc/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 17:21:38 INFO - MultiFileLogger online at 20170501 17:21:38 in /builds/slave/test 17:21:38 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 17:21:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:21:38 INFO - {'append_to_log': False, 17:21:38 INFO - 'base_work_dir': '/builds/slave/test', 17:21:38 INFO - 'blob_upload_branch': 'Firefox', 17:21:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:21:38 INFO - 'branch': 'Firefox', 17:21:38 INFO - 'buildbot_json_path': 'buildprops.json', 17:21:38 INFO - 'config_files': ('talos/mac_config.py',), 17:21:38 INFO - 'default_actions': ('clobber', 17:21:38 INFO - 'read-buildbot-config', 17:21:38 INFO - 'download-and-extract', 17:21:38 INFO - 'populate-webroot', 17:21:38 INFO - 'create-virtualenv', 17:21:38 INFO - 'install', 17:21:38 INFO - 'run-tests'), 17:21:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:21:38 INFO - 'download_minidump_stackwalk': True, 17:21:38 INFO - 'download_symbols': 'ondemand', 17:21:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:21:38 INFO - 'tooltool.py': '/tools/tooltool.py', 17:21:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:21:38 INFO - '/tools/misc-python/virtualenv.py')}, 17:21:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:21:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:21:38 INFO - 'gecko_profile': False, 17:21:38 INFO - 'gecko_profile_interval': 0, 17:21:38 INFO - 'installer_path': 'installer.exe', 17:21:38 INFO - 'log_level': 'info', 17:21:38 INFO - 'log_name': 'talos', 17:21:38 INFO - 'log_to_console': True, 17:21:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:21:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:21:38 INFO - 'opt_config_files': (), 17:21:38 INFO - 'pip_index': False, 17:21:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:21:38 INFO - 'cmd': ('bash', 17:21:38 INFO - '-c', 17:21:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:21:38 INFO - 'enabled': True, 17:21:38 INFO - 'halt_on_failure': False, 17:21:38 INFO - 'name': 'check_screen_resolution'},), 17:21:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:21:38 INFO - 'cmd': ('bash', 17:21:38 INFO - '-c', 17:21:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:21:38 INFO - 'enabled': True, 17:21:38 INFO - 'halt_on_failure': False, 17:21:38 INFO - 'name': 'check_screen_resolution'},), 17:21:38 INFO - 'run_cmd_checks_enabled': True, 17:21:38 INFO - 'suite': 'dromaeojs-e10s', 17:21:38 INFO - 'system_bits': '32', 17:21:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:21:38 INFO - 'title': 't-yosemite-r7-0366', 17:21:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:21:38 INFO - 'use_talos_json': True, 17:21:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:21:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:21:38 INFO - 'work_dir': 'build'} 17:21:38 INFO - [mozharness: 2017-05-02 00:21:38.108749Z] Running clobber step. 17:21:38 INFO - Running pre-action listener: _resource_record_pre_action 17:21:38 INFO - Running main action method: clobber 17:21:38 INFO - rmtree: /builds/slave/test/build 17:21:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:21:39 INFO - Running post-action listener: _resource_record_post_action 17:21:39 INFO - [mozharness: 2017-05-02 00:21:39.941550Z] Finished clobber step (success) 17:21:39 INFO - [mozharness: 2017-05-02 00:21:39.941713Z] Running read-buildbot-config step. 17:21:39 INFO - Running pre-action listener: _resource_record_pre_action 17:21:39 INFO - Running main action method: read_buildbot_config 17:21:39 INFO - Using buildbot properties: 17:21:39 INFO - { 17:21:39 INFO - "project": "", 17:21:39 INFO - "product": "firefox", 17:21:39 INFO - "script_repo_revision": "production", 17:21:39 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 17:21:39 INFO - "repository": "", 17:21:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 17:21:39 INFO - "buildid": "20170501155621", 17:21:39 INFO - "pgo_build": "False", 17:21:39 INFO - "basedir": "/builds/slave/test", 17:21:39 INFO - "buildnumber": 55, 17:21:39 INFO - "slavename": "t-yosemite-r7-0366", 17:21:39 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 17:21:39 INFO - "platform": "yosemite_r7", 17:21:39 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:21:39 INFO - "branch": "mozilla-central", 17:21:39 INFO - "repo_path": "mozilla-central", 17:21:39 INFO - "revision": "4b134293293043d247f8dcfd076ca9fc853332b4", 17:21:39 INFO - "stage_platform": "macosx64", 17:21:39 INFO - "builduid": "51d28ecb229f4f5d9d09e2ab26a87af0", 17:21:39 INFO - "slavebuilddir": "test" 17:21:39 INFO - } 17:21:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/GXUTVu_CT2SoWeCAVwNIVg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 17:21:39 INFO - Running post-action listener: _resource_record_post_action 17:21:39 INFO - [mozharness: 2017-05-02 00:21:39.944997Z] Finished read-buildbot-config step (success) 17:21:39 INFO - [mozharness: 2017-05-02 00:21:39.945096Z] Running download-and-extract step. 17:21:39 INFO - Running pre-action listener: _resource_record_pre_action 17:21:39 INFO - Running main action method: download_and_extract 17:21:39 INFO - mkdir: /builds/slave/test/build/tests 17:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:39 INFO - trying https://queue.taskcluster.net/v1/task/GXUTVu_CT2SoWeCAVwNIVg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 17:21:39 INFO - Downloading https://queue.taskcluster.net/v1/task/GXUTVu_CT2SoWeCAVwNIVg/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 17:21:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GXUTVu_CT2SoWeCAVwNIVg/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 17:21:40 INFO - Downloaded 1325 bytes. 17:21:40 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:21:40 INFO - Using the following test package requirements: 17:21:40 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:21:40 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 17:21:40 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:21:40 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:21:40 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 17:21:40 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:21:40 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 17:21:40 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:21:40 INFO - u'jsshell-mac.zip'], 17:21:40 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:21:40 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 17:21:40 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:21:40 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:21:40 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 17:21:40 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:21:40 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 17:21:40 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:21:40 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 17:21:40 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:21:40 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 17:21:40 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:21:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GXUTVu_CT2SoWeCAVwNIVg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:21:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GXUTVu_CT2SoWeCAVwNIVg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:21:40 INFO - Fetch https://queue.taskcluster.net/v1/task/GXUTVu_CT2SoWeCAVwNIVg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:21:42 INFO - Content-Length response header: 52698527 17:21:42 INFO - Bytes received: 52698527 17:21:58 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 17:21:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GXUTVu_CT2SoWeCAVwNIVg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:21:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GXUTVu_CT2SoWeCAVwNIVg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:21:58 INFO - Fetch https://queue.taskcluster.net/v1/task/GXUTVu_CT2SoWeCAVwNIVg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:22:00 INFO - Content-Length response header: 52698527 17:22:00 INFO - Bytes received: 52698527 17:22:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GXUTVu_CT2SoWeCAVwNIVg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 17:22:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GXUTVu_CT2SoWeCAVwNIVg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:22:15 INFO - Fetch https://queue.taskcluster.net/v1/task/GXUTVu_CT2SoWeCAVwNIVg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 17:22:16 INFO - Content-Length response header: 14408811 17:22:16 INFO - Bytes received: 14408811 17:22:17 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')]} 17:22:17 INFO - trying https://queue.taskcluster.net/v1/task/GXUTVu_CT2SoWeCAVwNIVg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:22:17 INFO - Downloading https://queue.taskcluster.net/v1/task/GXUTVu_CT2SoWeCAVwNIVg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 17:22:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GXUTVu_CT2SoWeCAVwNIVg/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 17:22:19 INFO - Downloaded 71241478 bytes. 17:22:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GXUTVu_CT2SoWeCAVwNIVg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:22:19 INFO - mkdir: /builds/slave/test/properties 17:22:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:22:19 INFO - Writing to file /builds/slave/test/properties/build_url 17:22:19 INFO - Contents: 17:22:19 INFO - build_url:https://queue.taskcluster.net/v1/task/GXUTVu_CT2SoWeCAVwNIVg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:22:19 INFO - Running post-action listener: _resource_record_post_action 17:22:19 INFO - Running post-action listener: set_extra_try_arguments 17:22:19 INFO - [mozharness: 2017-05-02 00:22:19.740982Z] Finished download-and-extract step (success) 17:22:19 INFO - [mozharness: 2017-05-02 00:22:19.741118Z] Running populate-webroot step. 17:22:19 INFO - Running pre-action listener: _resource_record_pre_action 17:22:19 INFO - Running main action method: populate_webroot 17:22:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:22:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:22:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:22:19 INFO - '--tppagecycles', 17:22:19 INFO - '7'], 17:22:19 INFO - 'tests': ['tsvgm']}}, 17:22:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:22:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:22:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:22:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:22:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:22:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:22:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:22:19 INFO - 'talos_options': ['--disable-e10s'], 17:22:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:22:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:22:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:22:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:22:19 INFO - 'talos_options': ['--disable-e10s'], 17:22:19 INFO - 'tests': ['damp', 'tps']}, 17:22:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:22:19 INFO - 'tests': ['damp', 'tps']}, 17:22:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:22:19 INFO - 'tests': ['dromaeo_dom']}, 17:22:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:22:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:22:19 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:22:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:22:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:22:19 INFO - 'tests': ['a11yr', 17:22:19 INFO - 'ts_paint', 17:22:19 INFO - 'tpaint', 17:22:19 INFO - 'sessionrestore', 17:22:19 INFO - 'sessionrestore_no_auto_restore', 17:22:19 INFO - 'tabpaint']}, 17:22:19 INFO - 'other-e10s': {'tests': ['a11yr', 17:22:19 INFO - 'ts_paint', 17:22:19 INFO - 'tpaint', 17:22:19 INFO - 'sessionrestore', 17:22:19 INFO - 'sessionrestore_no_auto_restore', 17:22:19 INFO - 'tabpaint']}, 17:22:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:22:19 INFO - 'ts_paint', 17:22:19 INFO - 'tpaint', 17:22:19 INFO - 'sessionrestore', 17:22:19 INFO - 'sessionrestore_no_auto_restore', 17:22:19 INFO - 'tabpaint']}, 17:22:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:22:19 INFO - 'ts_paint', 17:22:19 INFO - 'tpaint', 17:22:19 INFO - 'sessionrestore', 17:22:19 INFO - 'sessionrestore_no_auto_restore', 17:22:19 INFO - 'tabpaint']}, 17:22:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:22:19 INFO - 'tests': ['a11yr', 17:22:19 INFO - 'ts_paint', 17:22:19 INFO - 'tpaint', 17:22:19 INFO - 'sessionrestore', 17:22:19 INFO - 'sessionrestore_no_auto_restore', 17:22:19 INFO - 'tabpaint']}, 17:22:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:22:19 INFO - 'tests': ['a11yr', 17:22:19 INFO - 'ts_paint', 17:22:19 INFO - 'tpaint', 17:22:19 INFO - 'sessionrestore', 17:22:19 INFO - 'sessionrestore_no_auto_restore', 17:22:19 INFO - 'tabpaint']}, 17:22:19 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 17:22:19 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 17:22:19 INFO - 'bloom_basic_ref']}, 17:22:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:22:19 INFO - 'tests': ['tsvgx', 17:22:19 INFO - 'tsvgr_opacity', 17:22:19 INFO - 'tart', 17:22:19 INFO - 'tscrollx', 17:22:19 INFO - 'cart', 17:22:19 INFO - 'tsvg_static']}, 17:22:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:22:19 INFO - 'tsvgr_opacity', 17:22:19 INFO - 'tart', 17:22:19 INFO - 'tscrollx', 17:22:19 INFO - 'cart', 17:22:19 INFO - 'tsvg_static']}, 17:22:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:22:19 INFO - 'talos_options': ['--disable-e10s'], 17:22:19 INFO - 'tests': ['tp5o']}, 17:22:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:22:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:22:19 INFO - 'talos_options': ['--disable-e10s', 17:22:19 INFO - '--xperf_path', 17:22:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:22:19 INFO - 'tests': ['tp5n']}, 17:22:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:22:19 INFO - 'talos_options': ['--xperf_path', 17:22:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:22:19 INFO - 'tests': ['tp5n']}}, 17:22:19 INFO - 'talos.zip': {'path': '', 17:22:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:22:19 INFO - Running post-action listener: _resource_record_post_action 17:22:19 INFO - [mozharness: 2017-05-02 00:22:19.760586Z] Finished populate-webroot step (success) 17:22:19 INFO - [mozharness: 2017-05-02 00:22:19.760699Z] Running create-virtualenv step. 17:22:19 INFO - Running pre-action listener: _resource_record_pre_action 17:22:19 INFO - Running main action method: create_virtualenv 17:22:19 INFO - Creating virtualenv /builds/slave/test/build/venv 17:22:19 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 17:22:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:22:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:22:19 INFO - Using real prefix '/tools/python27' 17:22:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:22:20 INFO - Installing distribute.............................................................................................................................................................................................done. 17:22:23 INFO - Installing pip.................done. 17:22:23 INFO - Return code: 0 17:22:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:22:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:22:23 INFO - Reading from file tmpfile_stdout 17:22:23 INFO - Output received: 17:22:23 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) 17:22:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:22:23 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')]} 17:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:23 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')]} 17:22:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:23 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 0x10d77ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d77d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa348d8c010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d558d30>, '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 0x10d47edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d54dbe8>, '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.qCh5dsvPAY/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.BDIbPfnKgc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 17:22:23 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 17:22:23 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 17:22:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qCh5dsvPAY/Render', 17:22:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:22:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:22:23 INFO - 'HOME': '/Users/cltbld', 17:22:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:22:23 INFO - 'LOGNAME': 'cltbld', 17:22:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:23 INFO - 'MOZ_NO_REMOTE': '1', 17:22:23 INFO - 'NO_EM_RESTART': '1', 17:22:23 INFO - 'PAGER': '/bin/cat', 17:22:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:22:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:23 INFO - 'PWD': '/builds/slave/test', 17:22:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:22:23 INFO - 'SHELL': '/bin/bash', 17:22:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BDIbPfnKgc/Listeners', 17:22:23 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 17:22:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:22:23 INFO - 'USER': 'cltbld', 17:22:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:22:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:22:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:23 INFO - 'XPC_FLAGS': '0x0', 17:22:23 INFO - 'XPC_SERVICE_NAME': '0', 17:22:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:22:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:24 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 17:22:24 INFO - Cleaning up... 17:22:24 INFO - Return code: 0 17:22:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:22:24 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')]} 17:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:24 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')]} 17:22:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:24 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 0x10d77ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d77d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa348d8c010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d558d30>, '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 0x10d47edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d54dbe8>, '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.qCh5dsvPAY/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.BDIbPfnKgc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 17:22:24 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 17:22:24 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 17:22:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qCh5dsvPAY/Render', 17:22:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:22:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:22:24 INFO - 'HOME': '/Users/cltbld', 17:22:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:22:24 INFO - 'LOGNAME': 'cltbld', 17:22:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:24 INFO - 'MOZ_NO_REMOTE': '1', 17:22:24 INFO - 'NO_EM_RESTART': '1', 17:22:24 INFO - 'PAGER': '/bin/cat', 17:22:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:22:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:24 INFO - 'PWD': '/builds/slave/test', 17:22:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:22:24 INFO - 'SHELL': '/bin/bash', 17:22:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BDIbPfnKgc/Listeners', 17:22:24 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 17:22:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:22:24 INFO - 'USER': 'cltbld', 17:22:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:22:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:22:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:24 INFO - 'XPC_FLAGS': '0x0', 17:22:24 INFO - 'XPC_SERVICE_NAME': '0', 17:22:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:22:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:24 INFO - Downloading/unpacking psutil>=3.1.1 17:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:22:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:22:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:22:27 INFO - Installing collected packages: psutil 17:22:27 INFO - Running setup.py install for psutil 17:22:27 INFO - building 'psutil._psutil_osx' extension 17:22:27 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 17:22:28 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 17:22:28 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 17:22:28 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 17:22:28 INFO - building 'psutil._psutil_posix' extension 17:22:28 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 17:22:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:22:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:22:28 INFO - ^ 17:22:28 INFO - 1 warning generated. 17:22:28 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 17:22:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:22:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:22:28 INFO - Successfully installed psutil 17:22:28 INFO - Cleaning up... 17:22:28 INFO - Return code: 0 17:22:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:22:28 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')]} 17:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d77ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d77d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa348d8c010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d558d30>, '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 0x10d47edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d54dbe8>, '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.qCh5dsvPAY/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.BDIbPfnKgc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 17:22:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:22:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qCh5dsvPAY/Render', 17:22:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:22:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:22:29 INFO - 'HOME': '/Users/cltbld', 17:22:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:22:29 INFO - 'LOGNAME': 'cltbld', 17:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:29 INFO - 'MOZ_NO_REMOTE': '1', 17:22:29 INFO - 'NO_EM_RESTART': '1', 17:22:29 INFO - 'PAGER': '/bin/cat', 17:22:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:29 INFO - 'PWD': '/builds/slave/test', 17:22:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:22:29 INFO - 'SHELL': '/bin/bash', 17:22:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BDIbPfnKgc/Listeners', 17:22:29 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 17:22:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:22:29 INFO - 'USER': 'cltbld', 17:22:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:22:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:29 INFO - 'XPC_FLAGS': '0x0', 17:22:29 INFO - 'XPC_SERVICE_NAME': '0', 17:22:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:22:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:22:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:22:33 INFO - Installing collected packages: mozsystemmonitor 17:22:33 INFO - Running setup.py install for mozsystemmonitor 17:22:33 INFO - Successfully installed mozsystemmonitor 17:22:33 INFO - Cleaning up... 17:22:33 INFO - Return code: 0 17:22:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:22:33 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')]} 17:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:33 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')]} 17:22:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:33 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 0x10d77ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d77d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa348d8c010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d558d30>, '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 0x10d47edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d54dbe8>, '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.qCh5dsvPAY/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.BDIbPfnKgc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 17:22:33 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 17:22:33 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 17:22:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qCh5dsvPAY/Render', 17:22:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:22:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:22:33 INFO - 'HOME': '/Users/cltbld', 17:22:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:22:33 INFO - 'LOGNAME': 'cltbld', 17:22:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:33 INFO - 'MOZ_NO_REMOTE': '1', 17:22:33 INFO - 'NO_EM_RESTART': '1', 17:22:33 INFO - 'PAGER': '/bin/cat', 17:22:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:22:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:33 INFO - 'PWD': '/builds/slave/test', 17:22:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:22:33 INFO - 'SHELL': '/bin/bash', 17:22:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BDIbPfnKgc/Listeners', 17:22:33 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 17:22:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:22:33 INFO - 'USER': 'cltbld', 17:22:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:22:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:22:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:33 INFO - 'XPC_FLAGS': '0x0', 17:22:33 INFO - 'XPC_SERVICE_NAME': '0', 17:22:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:22:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:33 INFO - Downloading/unpacking jsonschema==2.5.1 17:22:33 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 17:22:33 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 17:22:33 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 17:22:33 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 17:22:33 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 17:22:33 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 17:22:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:22:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:22:36 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 17:22:36 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 17:22:36 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 17:22:36 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 17:22:36 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 17:22:36 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 17:22:36 INFO - Downloading functools32-3.2.3-2.tar.gz 17:22:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:22:36 INFO - warning: no files found matching '*.txt' 17:22:36 INFO - no previously-included directories found matching 'build' 17:22:36 INFO - no previously-included directories found matching 'dist' 17:22:36 INFO - no previously-included directories found matching '.git*' 17:22:37 INFO - Installing collected packages: jsonschema, functools32 17:22:37 INFO - Running setup.py install for functools32 17:22:37 INFO - warning: no files found matching '*.txt' 17:22:37 INFO - no previously-included directories found matching 'build' 17:22:37 INFO - no previously-included directories found matching 'dist' 17:22:37 INFO - no previously-included directories found matching '.git*' 17:22:37 INFO - Successfully installed jsonschema functools32 17:22:37 INFO - Cleaning up... 17:22:37 INFO - Return code: 0 17:22:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:22:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d77ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d77d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa348d8c010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d558d30>, '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 0x10d47edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d54dbe8>, '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.qCh5dsvPAY/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.BDIbPfnKgc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 17:22:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:22:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:22:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qCh5dsvPAY/Render', 17:22:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:22:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:22:37 INFO - 'HOME': '/Users/cltbld', 17:22:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:22:37 INFO - 'LOGNAME': 'cltbld', 17:22:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:37 INFO - 'MOZ_NO_REMOTE': '1', 17:22:37 INFO - 'NO_EM_RESTART': '1', 17:22:37 INFO - 'PAGER': '/bin/cat', 17:22:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:22:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:37 INFO - 'PWD': '/builds/slave/test', 17:22:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:22:37 INFO - 'SHELL': '/bin/bash', 17:22:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BDIbPfnKgc/Listeners', 17:22:37 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 17:22:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:22:37 INFO - 'USER': 'cltbld', 17:22:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:22:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:22:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:37 INFO - 'XPC_FLAGS': '0x0', 17:22:37 INFO - 'XPC_SERVICE_NAME': '0', 17:22:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:22:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:22:37 INFO - Cleaning up... 17:22:37 INFO - Return code: 0 17:22:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:22:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d77ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d77d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa348d8c010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d558d30>, '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 0x10d47edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d54dbe8>, '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.qCh5dsvPAY/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.BDIbPfnKgc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 17:22:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:22:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:22:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qCh5dsvPAY/Render', 17:22:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:22:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:22:37 INFO - 'HOME': '/Users/cltbld', 17:22:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:22:37 INFO - 'LOGNAME': 'cltbld', 17:22:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:37 INFO - 'MOZ_NO_REMOTE': '1', 17:22:37 INFO - 'NO_EM_RESTART': '1', 17:22:37 INFO - 'PAGER': '/bin/cat', 17:22:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:22:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:37 INFO - 'PWD': '/builds/slave/test', 17:22:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:22:37 INFO - 'SHELL': '/bin/bash', 17:22:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BDIbPfnKgc/Listeners', 17:22:37 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 17:22:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:22:37 INFO - 'USER': 'cltbld', 17:22:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:22:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:22:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:37 INFO - 'XPC_FLAGS': '0x0', 17:22:37 INFO - 'XPC_SERVICE_NAME': '0', 17:22:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:22:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:37 INFO - Downloading/unpacking blobuploader==1.2.4 17:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:40 INFO - Downloading blobuploader-1.2.4.tar.gz 17:22:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:22:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:22:40 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 17:22:40 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 17:22:40 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 17:22:40 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 17:22:40 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 17:22:40 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 17:22:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:22:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:41 INFO - Downloading docopt-0.6.1.tar.gz 17:22:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:22:41 INFO - Installing collected packages: blobuploader, requests, docopt 17:22:41 INFO - Running setup.py install for blobuploader 17:22:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:22:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:22:41 INFO - Running setup.py install for requests 17:22:42 INFO - Running setup.py install for docopt 17:22:42 INFO - Successfully installed blobuploader requests docopt 17:22:42 INFO - Cleaning up... 17:22:42 INFO - Return code: 0 17:22:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:42 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 0x10d77ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d77d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa348d8c010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d558d30>, '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 0x10d47edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d54dbe8>, '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.qCh5dsvPAY/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.BDIbPfnKgc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 17:22:42 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 17:22:42 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 17:22:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qCh5dsvPAY/Render', 17:22:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:22:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:22:42 INFO - 'HOME': '/Users/cltbld', 17:22:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:22:42 INFO - 'LOGNAME': 'cltbld', 17:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:42 INFO - 'MOZ_NO_REMOTE': '1', 17:22:42 INFO - 'NO_EM_RESTART': '1', 17:22:42 INFO - 'PAGER': '/bin/cat', 17:22:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:42 INFO - 'PWD': '/builds/slave/test', 17:22:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:22:42 INFO - 'SHELL': '/bin/bash', 17:22:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BDIbPfnKgc/Listeners', 17:22:42 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 17:22:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:22:42 INFO - 'USER': 'cltbld', 17:22:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:22:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:42 INFO - 'XPC_FLAGS': '0x0', 17:22:42 INFO - 'XPC_SERVICE_NAME': '0', 17:22:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:22:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:22:42 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-__eu1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:22:43 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-04RI97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:22:43 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-Co651K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:22:43 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-0a5jDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:22:43 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-_IMfmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:22:43 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-gfnyZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:22:43 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-uSLAHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:22:43 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-RzQm9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:22:43 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-9FpxLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:22:43 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-jzMidU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:22:43 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-quESxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:22:44 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-bW9IgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:22:44 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-dGgCTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:22:44 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-pwUmv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:22:44 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-6gBC28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:22:44 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-RZO_c0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:22:44 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-5SEHTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:22:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:22:44 INFO - Running setup.py install for manifestparser 17:22:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:22:44 INFO - Running setup.py install for mozcrash 17:22:44 INFO - Running setup.py install for mozdebug 17:22:45 INFO - Running setup.py install for mozdevice 17:22:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:22:45 INFO - Running setup.py install for mozfile 17:22:45 INFO - Running setup.py install for mozhttpd 17:22:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:22:45 INFO - Running setup.py install for mozinfo 17:22:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:22:45 INFO - Running setup.py install for mozInstall 17:22:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:22:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:22:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:22:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:22:45 INFO - Running setup.py install for mozleak 17:22:45 INFO - Running setup.py install for mozlog 17:22:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:22:46 INFO - Running setup.py install for moznetwork 17:22:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:22:46 INFO - Running setup.py install for mozprocess 17:22:46 INFO - Running setup.py install for mozprofile 17:22:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:22:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:22:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:22:46 INFO - Running setup.py install for mozrunner 17:22:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:22:46 INFO - Running setup.py install for mozscreenshot 17:22:46 INFO - Running setup.py install for moztest 17:22:47 INFO - Running setup.py install for mozversion 17:22:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:22:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:22:47 INFO - Cleaning up... 17:22:47 INFO - Return code: 0 17:22:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:22: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')]} 17:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22: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')]} 17:22:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:47 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 0x10d77ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d77d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa348d8c010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d558d30>, '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 0x10d47edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d54dbe8>, '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.qCh5dsvPAY/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.BDIbPfnKgc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 17:22:47 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 17:22:47 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 17:22:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qCh5dsvPAY/Render', 17:22:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:22:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:22:47 INFO - 'HOME': '/Users/cltbld', 17:22:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:22:47 INFO - 'LOGNAME': 'cltbld', 17:22:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:47 INFO - 'MOZ_NO_REMOTE': '1', 17:22:47 INFO - 'NO_EM_RESTART': '1', 17:22:47 INFO - 'PAGER': '/bin/cat', 17:22:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:22:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:47 INFO - 'PWD': '/builds/slave/test', 17:22:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:22:47 INFO - 'SHELL': '/bin/bash', 17:22:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BDIbPfnKgc/Listeners', 17:22:47 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 17:22:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:22:47 INFO - 'USER': 'cltbld', 17:22:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:22:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:22:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:47 INFO - 'XPC_FLAGS': '0x0', 17:22:47 INFO - 'XPC_SERVICE_NAME': '0', 17:22:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:22:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:22:47 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-0oPjec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:22:47 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)) 17:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:22:47 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-Oez3rr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:22:47 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)) 17:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:22:47 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-QvMz8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:22:47 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)) 17:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:22:47 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-WhyL4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:22:47 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)) 17:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:22:47 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-p7pGE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:22:48 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)) 17:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:22:48 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-Ljd2Be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:22:48 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)) 17:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:22:48 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-jGEzT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:22:48 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)) 17:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:22:48 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-bDnJ7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:22:48 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)) 17:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:22:48 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-nbkbWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:22:48 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)) 17:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:22:48 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-5KAHwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:22:48 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)) 17:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:22:48 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-ssM4Bl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:22:48 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)) 17:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:22:48 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-q7VC__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:22:48 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)) 17:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:22:48 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-V3yrjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:22:48 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)) 17:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:22:48 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-wfG70A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:22:49 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)) 17:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:22:49 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-rFxO54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:22:49 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)) 17:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:22:49 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-N0FZOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:22:49 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)) 17:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:22:49 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-I_pbGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:22:49 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)) 17:22:49 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)) 17:22:49 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)) 17:22:49 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)) 17:22:49 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)) 17:22:49 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)) 17:22:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:52 INFO - Downloading blessings-1.6.tar.gz 17:22:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:22:52 INFO - Installing collected packages: blessings 17:22:52 INFO - Running setup.py install for blessings 17:22:52 INFO - Successfully installed blessings 17:22:52 INFO - Cleaning up... 17:22:52 INFO - Return code: 0 17:22:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:22:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:22:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:22:52 INFO - Reading from file tmpfile_stdout 17:22:52 INFO - Current package versions: 17:22:52 INFO - blessings == 1.6 17:22:52 INFO - blobuploader == 1.2.4 17:22:52 INFO - docopt == 0.6.1 17:22:52 INFO - functools32 == 3.2.3-2 17:22:52 INFO - jsonschema == 2.5.1 17:22:52 INFO - manifestparser == 1.1 17:22:52 INFO - mozInstall == 1.12 17:22:52 INFO - mozcrash == 1.0 17:22:52 INFO - mozdebug == 0.1 17:22:52 INFO - mozdevice == 0.50 17:22:52 INFO - mozfile == 1.2 17:22:52 INFO - mozhttpd == 0.7 17:22:52 INFO - mozinfo == 0.9 17:22:52 INFO - mozleak == 0.1 17:22:52 INFO - mozlog == 3.4 17:22:52 INFO - moznetwork == 0.27 17:22:52 INFO - mozprocess == 0.25 17:22:52 INFO - mozprofile == 0.28 17:22:52 INFO - mozrunner == 6.13 17:22:52 INFO - mozscreenshot == 0.1 17:22:52 INFO - mozsystemmonitor == 0.3 17:22:52 INFO - moztest == 0.8 17:22:52 INFO - mozversion == 1.4 17:22:52 INFO - psutil == 3.1.1 17:22:52 INFO - requests == 1.2.3 17:22:52 INFO - wsgiref == 0.1.2 17:22:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:22: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')]} 17:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22: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')]} 17:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:52 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 0x10d77ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d77d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa348d8c010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d558d30>, '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 0x10d47edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d54dbe8>, '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.qCh5dsvPAY/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.BDIbPfnKgc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 17:22:52 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 17:22:52 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 17:22:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qCh5dsvPAY/Render', 17:22:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:22:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:22:52 INFO - 'HOME': '/Users/cltbld', 17:22:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:22:52 INFO - 'LOGNAME': 'cltbld', 17:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:52 INFO - 'MOZ_NO_REMOTE': '1', 17:22:52 INFO - 'NO_EM_RESTART': '1', 17:22:52 INFO - 'PAGER': '/bin/cat', 17:22:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:52 INFO - 'PWD': '/builds/slave/test', 17:22:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:22:52 INFO - 'SHELL': '/bin/bash', 17:22:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BDIbPfnKgc/Listeners', 17:22:52 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 17:22:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:22:52 INFO - 'USER': 'cltbld', 17:22:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:22:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:52 INFO - 'XPC_FLAGS': '0x0', 17:22:52 INFO - 'XPC_SERVICE_NAME': '0', 17:22:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:22:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:52 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)) 17:22:52 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)) 17:22:52 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)) 17:22:52 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)) 17:22:52 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)) 17:22:52 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)) 17:22:52 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)) 17:22:52 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)) 17:22:52 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)) 17:22:52 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)) 17:22:52 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)) 17:22:52 INFO - Cleaning up... 17:22:52 INFO - Return code: 0 17:22:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:22: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')]} 17:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22: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')]} 17:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d77ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d77d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa348d8c010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d558d30>, '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 0x10d47edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d54dbe8>, '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.qCh5dsvPAY/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.BDIbPfnKgc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 17:22: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', 'jsonschema'] in /builds/slave/test/build 17:22: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 jsonschema 17:22:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qCh5dsvPAY/Render', 17:22:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:22:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:22:52 INFO - 'HOME': '/Users/cltbld', 17:22:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:22:52 INFO - 'LOGNAME': 'cltbld', 17:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:52 INFO - 'MOZ_NO_REMOTE': '1', 17:22:52 INFO - 'NO_EM_RESTART': '1', 17:22:52 INFO - 'PAGER': '/bin/cat', 17:22:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:52 INFO - 'PWD': '/builds/slave/test', 17:22:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:22:52 INFO - 'SHELL': '/bin/bash', 17:22:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BDIbPfnKgc/Listeners', 17:22:52 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 17:22:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:22:52 INFO - 'USER': 'cltbld', 17:22:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:22:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:52 INFO - 'XPC_FLAGS': '0x0', 17:22:52 INFO - 'XPC_SERVICE_NAME': '0', 17:22:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:22:53 INFO - Cleaning up... 17:22:53 INFO - Return code: 0 17:22:53 INFO - Running post-action listener: _resource_record_post_action 17:22:53 INFO - Running post-action listener: _start_resource_monitoring 17:22:53 INFO - Starting resource monitoring. 17:22:53 INFO - [mozharness: 2017-05-02 00:22:53.222630Z] Finished create-virtualenv step (success) 17:22:53 INFO - [mozharness: 2017-05-02 00:22:53.223695Z] Running install step. 17:22:53 INFO - Running pre-action listener: _resource_record_pre_action 17:22:53 INFO - Running main action method: install 17:22:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:22:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:22:53 INFO - Reading from file tmpfile_stdout 17:22:53 INFO - Detecting whether we're running mozinstall >=1.0... 17:22:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:22:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:22:53 INFO - Reading from file tmpfile_stdout 17:22:53 INFO - Output received: 17:22:53 INFO - Usage: mozinstall [options] installer 17:22:53 INFO - Options: 17:22:53 INFO - -h, --help show this help message and exit 17:22:53 INFO - -d DEST, --destination=DEST 17:22:53 INFO - Directory to install application into. [default: 17:22:53 INFO - "/builds/slave/test"] 17:22:53 INFO - --app=APP Application being installed. [default: firefox] 17:22:53 INFO - mkdir: /builds/slave/test/build/application 17:22:53 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'] 17:22:53 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 17:23:12 INFO - Reading from file tmpfile_stdout 17:23:12 INFO - Output received: 17:23:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:23:12 INFO - Running post-action listener: _resource_record_post_action 17:23:12 INFO - [mozharness: 2017-05-02 00:23:12.986161Z] Finished install step (success) 17:23:12 INFO - [mozharness: 2017-05-02 00:23:12.986292Z] Running run-tests step. 17:23:12 INFO - Running pre-action listener: _resource_record_pre_action 17:23:12 INFO - Running main action method: run_tests 17:23:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:23:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:23:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:23:13 INFO - 2017-05-01 17:23:13.000 screenresolution[2870:36300] starting screenresolution argv=screenresolution get 17:23:13 INFO - 2017-05-01 17:23:13.003 screenresolution[2870:36300] Display 0: 1600x1200x32@60 17:23:13 INFO - 2017-05-01 17:23:13.009 screenresolution[2871:36303] starting screenresolution argv=screenresolution list 17:23:13 INFO - Available Modes on Display 0 17:23:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:23:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:23:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:23:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:23:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:23:13 INFO - Intel Iris: 17:23:13 INFO - Chipset Model: Intel Iris 17:23:13 INFO - Type: GPU 17:23:13 INFO - Bus: Built-In 17:23:13 INFO - VRAM (Dynamic, Max): 1536 MB 17:23:13 INFO - Vendor: Intel (0x8086) 17:23:13 INFO - Device ID: 0x0a2e 17:23:13 INFO - Revision ID: 0x0009 17:23:13 INFO - Displays: 17:23:13 INFO - Display: 17:23:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:23:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:23:13 INFO - Display Serial Number: 1600x1200 60 17:23:13 INFO - Main Display: Yes 17:23:13 INFO - Mirror: Off 17:23:13 INFO - Online: Yes 17:23:13 INFO - Rotation: Supported 17:23:13 INFO - Return code: 0 17:23:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:23:13 INFO - Python 2.7.3 17:23:13 INFO - Return code: 0 17:23:13 INFO - grabbing minidump binary from tooltool 17:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:23:13 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 0x10d558d30>, '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 0x10d47edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d54dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:23:13 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 17:23:13 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 17:23:13 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 17:23:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:23:13 INFO - Return code: 0 17:23:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:23:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:23:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:23:13 INFO - ENV: RUST_BACKTRACE is now 1 17:23:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:23:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:23:13 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/GXUTVu_CT2SoWeCAVwNIVg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0366', '--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 17:23:13 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/GXUTVu_CT2SoWeCAVwNIVg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0366 --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 17:23:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qCh5dsvPAY/Render', 17:23:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:23:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:23:13 INFO - 'HOME': '/Users/cltbld', 17:23:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:23:13 INFO - 'LOGNAME': 'cltbld', 17:23:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:23:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:13 INFO - 'MOZ_NO_REMOTE': '1', 17:23:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:23:13 INFO - 'NO_EM_RESTART': '1', 17:23:13 INFO - 'PAGER': '/bin/cat', 17:23:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:13 INFO - 'PWD': '/builds/slave/test', 17:23:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:23:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:23:13 INFO - 'RUST_BACKTRACE': '1', 17:23:13 INFO - 'SHELL': '/bin/bash', 17:23:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BDIbPfnKgc/Listeners', 17:23:13 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 17:23:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:23:13 INFO - 'USER': 'cltbld', 17:23:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:23:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:13 INFO - 'XPC_FLAGS': '0x0', 17:23:13 INFO - 'XPC_SERVICE_NAME': '0', 17:23:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:23:13 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/GXUTVu_CT2SoWeCAVwNIVg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0366', '--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 17:23:13 INFO - mozversion application_buildid: 20170501155621 17:23:13 INFO - mozversion application_changeset: 4b134293293043d247f8dcfd076ca9fc853332b4 17:23:13 INFO - mozversion application_display_name: Nightly 17:23:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:23:13 INFO - mozversion application_name: Firefox 17:23:13 INFO - mozversion application_remotingname: firefox 17:23:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:23:13 INFO - mozversion application_vendor: Mozilla 17:23:13 INFO - mozversion application_version: 55.0a1 17:23:13 INFO - mozversion platform_buildid: 20170501155621 17:23:13 INFO - mozversion platform_changeset: 4b134293293043d247f8dcfd076ca9fc853332b4 17:23:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:23:13 INFO - mozversion platform_version: 55.0a1 17:23:13 INFO - using testdate: 1493684593 17:23:13 INFO - actual date: 1493684593 17:23:13 INFO - starting webserver on 'localhost:57675' 17:23:13 INFO - SUITE-START | Running 2 tests 17:23:13 INFO - TEST-START | dromaeo_css 17:23:13 INFO - operating with platform_type : mac_ 17:23:13 INFO - Initialising browser for dromaeo_css test... 17:23:13 INFO - TEST-INFO | started process 2881 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/tmp3tUcxt/profile http://localhost:57675/getInfo.html) 17:23:16 INFO - PID 2881 | 2017-05-01 17:23:16.249 plugin-container[2883:36478] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9b3b, name = 'com.apple.tsm.portname' 17:23:16 INFO - PID 2881 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:23:16 INFO - PID 2881 | 2017-05-01 17:23:16.252 plugin-container[2883:36478] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9e0b, name = 'com.apple.CFPasteboardClient' 17:23:16 INFO - PID 2881 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:23:16 INFO - PID 2881 | 2017-05-01 17:23:16.252 plugin-container[2883:36478] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:23:16 INFO - PID 2881 | __metrics Screen width/height:1600/1200 17:23:16 INFO - PID 2881 | colorDepth:24 17:23:16 INFO - PID 2881 | Browser inner width/height: 1024/689 17:23:16 INFO - PID 2881 | __metrics 17:23:17 INFO - TEST-INFO | 2881: exit 0 17:23:17 INFO - Browser initialized. 17:23:17 INFO - Running cycle 1/1 for dromaeo_css test... 17:23:17 INFO - TEST-INFO | started process 2884 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/tmp3tUcxt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:23:19 INFO - PID 2884 | 2017-05-01 17:23:19.820 plugin-container[2885:36607] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 17:23:19 INFO - PID 2884 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:23:19 INFO - PID 2884 | 2017-05-01 17:23:19.821 plugin-container[2885:36607] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471b, name = 'com.apple.CFPasteboardClient' 17:23:19 INFO - PID 2884 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:23:19 INFO - PID 2884 | 2017-05-01 17:23:19.821 plugin-container[2885:36607] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:23:29 INFO - PID 2884 | RSS: Main: 251449344 17:23:29 INFO - PID 2884 | 17:26:33 INFO - PID 2884 | Cycle 1(1): loaded http://localhost:57675/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57675/tests/dromaeo/cssquery-ext.html) 17:26:35 INFO - PID 2884 | RSS: Main: 257548288 17:26:35 INFO - PID 2884 | 17:28:17 INFO - PID 2884 | ************************* 17:28:17 INFO - PID 2884 | A coding exception was thrown and uncaught in a Task. 17:28:17 INFO - PID 2884 | 17:28:17 ERROR - PID 2884 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:28:17 INFO - PID 2884 | Full stack: 17:28:17 INFO - PID 2884 | ************************* 17:28:17 INFO - PID 2884 | ************************* 17:28:17 INFO - PID 2884 | A coding exception was thrown and uncaught in a Task. 17:28:17 INFO - PID 2884 | 17:28:17 ERROR - PID 2884 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:28:17 INFO - PID 2884 | Full stack: 17:28:17 INFO - PID 2884 | ************************* 17:28:17 INFO - PID 2884 | ************************* 17:28:17 INFO - PID 2884 | A coding exception was thrown and uncaught in a Task. 17:28:17 INFO - PID 2884 | 17:28:17 ERROR - PID 2884 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:28:17 INFO - PID 2884 | Full stack: 17:28:17 INFO - PID 2884 | ************************* 17:28:17 INFO - PID 2884 | ************************* 17:28:17 INFO - PID 2884 | A coding exception was thrown and uncaught in a Task. 17:28:17 INFO - PID 2884 | 17:28:17 ERROR - PID 2884 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:28:17 INFO - PID 2884 | Full stack: 17:28:17 INFO - PID 2884 | ************************* 17:29:36 INFO - PID 2884 | Cycle 1(1): loaded http://localhost:57675/tests/dromaeo/cssquery-ext.html (next: http://localhost:57675/tests/dromaeo/cssquery-jquery.html) 17:29:37 INFO - PID 2884 | RSS: Main: 263561216 17:29:37 INFO - PID 2884 | 17:32:39 INFO - PID 2884 | Cycle 1(1): loaded http://localhost:57675/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57675/tests/dromaeo/cssquery-mootools.html) 17:32:39 INFO - PID 2884 | RSS: Main: 272539648 17:32:39 INFO - PID 2884 | 17:35:41 INFO - PID 2884 | Cycle 1(1): loaded http://localhost:57675/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57675/tests/dromaeo/cssquery-prototype.html) 17:35:42 INFO - PID 2884 | RSS: Main: 265043968 17:35:42 INFO - PID 2884 | 17:38:45 INFO - PID 2884 | Cycle 1(1): loaded http://localhost:57675/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57675/tests/dromaeo/cssquery-yui.html) 17:38:45 INFO - PID 2884 | RSS: Main: 275152896 17:38:45 INFO - PID 2884 | 17:41:47 INFO - PID 2884 | Cycle 1(1): loaded http://localhost:57675/tests/dromaeo/cssquery-yui.html (next: http://localhost:57675/tests/dromaeo/cssquery-dojo.html) 17:41:47 INFO - PID 2884 | RSS: Main: 269885440 17:41:47 INFO - PID 2884 | 17:41:47 INFO - PID 2884 | __start_tp_report 17:41:47 INFO - PID 2884 | _x_x_mozilla_page_load 17:41:47 INFO - PID 2884 | _x_x_mozilla_page_load_details 17:41:47 INFO - PID 2884 | |i|pagename|runs| 17:41:47 INFO - PID 2884 | |0;dojo.html;3009.518477043673;3570.161012162143;3623.9637603623955;3628.872989445368;3634.7455678102533;6022.247219097613;6171.352008039153;6212.130301757752;6221.782237621678;6279.968600157004;4827.951720482794;6149.046897730859;6199.907001394983;6228.314885362618;6257.843553911154;5357.8392648220615;5392.595555333346;5400.837974860741;5402.540784033362;5428.83713488595;5465.508104270615;5486.3690675572225;5502.339719233698;5515.917261241085;5522.447755224465;4482.9551704482865;4885.267209918505;4927.6304277179;5481.177823326493;5516.282883225195;4356.542563030868;5062.898742025176;5434.049041417736;5474.808381706621;5477.178423236506;5370.731463426852;5416.593755468316;5416.674999500043;5426.864328391822;5491.917621235684;5025.271335656309;6137.162486020116;6155.507559395282;6295.213098362705;6295.307516173218;6592.868142637169;6635.834104147387;6687.933120668779;6694.330566943267;6732.764353247613;6819.795406137824;6840.623765692885;6842.247352791189;6843;6860.108185935846;6233.2208473940755;6286.622802631811;6313.589616674947;6319.368063193644;6329.556931014785;6776.42400395962;6829.556078854858;6879.3120687931805;6889.104416425833;6926.341997510229;6385.2656944451055;6472.676366181672;6554.246261679968;6624.6025238485845;6679.398854103154;5988.28140623128;6716.597004179765;6791.524593278522;6808.148981377328;6827.795166144924;6728.091707619506;6744.6627668616375;6749.42629876466;6761.391474767294;6783.050372947791;6440.903386449207;6563.638999855054;6570.277269500351;6598;6719.395254427125;4751.83368582098;4783.736894470768;5318.627696061239;5391.919121213185;5405.8107966221;4496.887577810516;4729.219678753036;4739.620830333634;4776.880577985508;4786;6193.81418557444;6327.082573026885;6340.904886426707;6361.745530178833;6389.233292004989;6656.467482601477;6742.056112144303;6764.0868482754195;6860;6864.965675171692;6304.401081897213;6343.809685709436;6345.96827015862;6353.714082866282;6359.427651511293;5757.021306377926;5834.766609335664;5868.2664666916635;5901.704914754245;5914.733836977346;6597.670116494252;6790.830229244309;6912;6964.895526567207;7042.330978557029;6859.691313890787;6875.656217189221;6879.759208427681;6900.585964842126;6901.62041087745;6988;7078.68145933424;7109.969054486967;7129.322714342129;7140.892886606601;6492.156019717407;6565.967170164118;6603.570767900071;6737.2252190996705;6775.119234499483;6794.422474089758;6836.863262734817;6839.93160068393;6843.692033858588;6890.31096890327;6350.301466838737;6354.205724284465;6581.967090164519;6608.603483790988;6617.6029438231935;6406.903896441464;6439.452646525097;6489.9351006491215;6604.108445359815;6613.735450581923;6255.374462553708;6273.874522509433;6460.418562329225;6485.383888530582;6486.383793539606;4874.5856602189215;6416.871662566629;6488.513361497812;6526.510511711545;6635.867282654223;6420.06908998202;6434.163558737334;6444.9355506444335;6457.289698133108;6467.579607325509 17:41:47 INFO - PID 2884 | |1;ext.html;720.5388551327151;783.0485959559135;843.0010437631405;1153.9884601153985;1232.6548566401405;35827.64172358279;37396;37443.81278093609;37482.25035499292;37562.8121859391;38063;38416.42375364365;38508.80745596275;38561;38728;6748.358905903931;7874.370050395969;8277.213664701843;8502.957485212566;8540.487570745745;7146.249643787405;8563.743087707378;8609.139086091403;8629.266512346458;8640.611172497222;7659.736143536337;8144.877826832602;8558.78603034926;8644;8653.653853845839;8591.742247732578;8592.914070859306;8629.223369896708;8638.654453821871;8672.8699069514;8357.12250213731;8418.03192632849;8445.788855278606;8452.8732069019;8453.873191902127;36979.4453083204;37031;37194.62805371939;37235.627643723485;37320.626793731986;3688.7233457490797;3694.353488139565;3716.479692843004;3734.8506059757847;3742.6070262622306;30240.697593024008;30371.69628303711;30440.391192176256;30537;30570.08289751311;3146.6695996920453;3166.066010526877;3186.283086305586;3189.3302406494663;3197.728193103566;247284.76357618277;251965;282340.5882970572;295514;295962;47292.763536182785;47420;47479;47513.5248647516;47637.28544071842;49566;49886.50113498818;49947.50052499501;50036.499635003915;50096.49903500991;14100.224487653073;14198.787018194735;14231.43074277038;14234.715305694035;14244.287785610679;11580.76838463226;11667.59163429276;11731.88268117308;11752.529898803952;11771.764564708828;13443.86556134426;13467.12463689857;13487.25820079905;13492.392842321922;13569.389377478037;5901.911471327933;5909.990603194934;5956.421548289707;5999.970000149971;6004.969975150097;842.8579275082297;1011.7116621762763;1046.3930920066343;1046.7801761630144;1082.2370228988543;16493.17534123289;20463.590728185354;22758.65862012071;23333.533329333317;24645.507089858103;899.595182168027;1089.1885545268826;1114.395270810031;1134.444122380028;1179.7168679516853;9801;11227.607033753779;11913.689494155637;12451.377431128407;12480.188787728768;317931;319778;321849;322354.38822805736;323004.76995230216;54707;54769;54838.177427338625;54841.72579137079;55016.44983550193;1532.9846701533065;1576.5664442278464;1582.849629285216;1591.1487354265412;1594.06747052973;19631.607367852277;21987.34037978799;23852.403689907893;23985;24376.390590235387;36850.44724329084;37383.25233495369;37392.62607373892;37546.436803447425;38053.4291985626;289479;290276;290354;290543;291573;32335.514967275038;32877.383487815845;32929;34060.659393405746;34079.82960085184;42639.93400165021;44900;45242.77378613217;45342.093158137315;45375.77312113418;29229;29960.25099372533;29999;30370.392592148477;30416.783328666606;30319.545206822357;30766.846165769028;30850.69149308478;31162.844185778926;31424;36012.63987360093;36173.09567260734;37108.072298191684;37466.438003430514;37654.811725941196;31566;31666.208344791565;31704.048878533682;31833.522497163023;31969.68030319667;22963.540729184988;23508.882455587613;24208.51582968366;24225.515489689755;24307.63538546888 17:41:47 INFO - PID 2884 | |2;jquery.html;435.33828580557554;436.90388114614774;439.37827973417615;456.7670488051094;465.07450174153445;19575.902120489394;21179.57640847184;21885.452863678416;22039.889800551016;22080.558388832214;21426.14295428181;22667.546649067008;23225.535489290203;23273.418164545852;23458.413539661517;6045.214122164112;6097.817065488031;6275.278342990546;6306.62160270383;6320.051992201161;6083.270007599072;6285.811425657238;6289.748410063592;6293.339199384068;6298.212723409574;5914.733836977325;6155.384461553854;6202.255729312489;6244.781432649858;6244.906326405085;6137.508999280047;6144.5698801083945;6145.047517634774;6147.047207682816;6184.814455566295;4642.605378542828;5456.0997435423105;5472.50747432733;5484.287042684426;5552.86117847053;26906.86546567274;27697.446051079067;27913.162605121877;28117;28557.57163642547;2258.5934531784274;2306.215886598548;2307.204014614955;2309.1802410144323;2311.8150547956125;15275.770863437057;17932.462026139106;18022.91862488255;18294.542636434195;18481.907590462095;2150.053976250445;2162.794534519234;2208.646616541346;2215.8670479771267;2216.2797090945505;132329.99999999904;139390;144644;146561;147102;12252;12774.23354598727;12785;12799.680007999874;12891.35543222835;16491.5877103071;16515.58711032234;16533.33866645345;16547.255373507982;16699.415520456725;8465.238128568335;8704.695335663222;8707.6516939323;8745.47527148373;8825.249853762374;8060.717874874468;8069.435139540294;8072.878906816402;8222.259996600334;8247.340212782963;8026.317762990211;8147.940767700161;8163.775433684876;8172.713955011665;8219.095899451055;1746.9301227950739;2234.2180236916947;2241.462049108235;2248.4716091718433;2417.5164967006667;754.6868049759398;957.913787759105;964.1322809471532;979.2019504104132;992.3202606214766;21422.664586892657;21609.027593758317;21625.351239462525;21653.458663533223;21982.560348792933;908.2007833106956;980.8087422952456;1009.369144284822;1011.6661501704419;1012.7670635753818;11056.502457389437;11260.43697815106;11286.20996530235;11288.661340159808;11300;564205;565461;567833;571010;577145;125741.37129314295;134559.29042483467;141826;142220.28889855483;151479;1188.8038473651923;1214.1743614342156;1261.5836773864603;1264.3804535777404;1271.936403179856;16599.50201493957;21985;22485.88757056204;22985.310440686808;23217;57120.42879571151;57790.42209577851;59145.81708365895;59966.10050849154;60723;55740.44259557353;77482.22517774976;78051.82922256057;78809;79389;8853.557322133738;8910.509921954095;9140.634374625206;9219.723408297761;9395;14327.426902923766;14486.565403037926;14654.78017829712;14736.042157259744;14785.038972467186;12255.325957072446;12325.260484370967;12354.949829264253;12358.50565977351;12520.686982825502;10138.442385668859;10950.671479855617;11548.364839933884;11569.595064172714;11886.524539018343;12276.140670153003;12334.938325308316;12434.37828108609;12469.812952805534;12558;9052.185303322733;9061.77345566366;9142.908570914471;9170.082991700776;9199.448033117767;12101.394930253628;12257.938710306391;12300.507979680713;12300.954418874497;12466.376681166086 17:41:47 INFO - PID 2884 | |3;mootools.html;1214.4170798016946;1236.4806781151915;1337.9130356526825;1468.1117923656188;1468.5447511271502;11109.388983605899;11478.253913495617;11512.654620361382;11573.421328933562;11829.585964491245;11574.884251157486;11723.413829308522;11729.53081876724;11748.823767643471;11879.643610691694;2512.346789834647;2549.1332946798084;2549.337172335197;2551.8516667499607;2554.0805310088354;2470.4318006858434;2518.937026574341;2521.281434791085;2531.6455696202547;2532.328932832801;2477.5168842075805;2486.080150344366;2515.207709571488;2517.0435234610914;2522.697276326843;2451.3381387025493;2480.776730094291;2513.208339373092;2517;2526.494701059786;2419.987900060506;2501.737317581646;2502.674652295208;2520.798336133105;2528.127795910408;10637.680869573926;11749.177557570973;11864.822027669592;11870;11885.5840045598;6275.309715931244;6838.623875686835;6845.247022827485;6855.965720171417;6856.211535673411;3998.1204135090234;4305.720128191658;4318.719283246579;4335.826566937319;4376.912461750747;1252.2298786246483;1266.9303188324639;1305.725797582509;1319.9340032998407;1321.319520446961;13718.039737218398;15586.922065389714;16251.756223656655;16312;16329;5477.698726569997;5545.419555426684;5689.118186681071;5698.059820129715;5734.053881109654;11685.88314116865;11689.181757276909;11775.23460975034;11784.351860647575;11841.467133978991;6506.41442270198;6579.111819904348;6581.2102547694585;6582.3746744059235;6591.077249185118;6060.666663333471;6064.848378790565;6170.660613666201;6240.5319601030105;6250.1874756281395;4243.511996120424;4380.540043295408;4415.536368681306;4440.267355886307;4453.1093781243235;1253.9122261441612;1265.4811527273773;1268.1630124118037;1280.4238092858252;1288.5361269942814;794.162158922331;796.9760907172794;813.2436833744556;825.8678611422143;849.1466076592984;6093.603915745551;6140.600860944113;6286.779962701284;6345.936540634627;6346.2067241594805;595.8689088400545;600.2586805295457;601.1643815097019;603.9516838652897;623.9719212635442;3438.862445502152;3892.2410130024373;4013.7190396671954;4132.690048246393;4394.033312671208;11120.888791111985;14764.630884227765;14843.109413435228;14902.627434314012;14962.850371496146;14627.544012985392;14836.70326593462;14841.183734894468;14853.777193342108;14865.033772804733;7497.700091996259;8209.630566624517;8614.095519970439;8669.26311263537;8676;6273.215848018997;6912.723491060301;6964.303569643198;7165.3551180394015;7212.134543854771;13125.868741312464;13167.209967401986;13462.798058028942;13499.730005400033;13576.456941722221;13281.335933203109;13648.044636875324;13768.931155344158;13803.792943106062;13993.930030349784;8236.83526329458;8907.910920890708;9242.584083716114;9328.533573321443;9355.953220233856;10962;11046.944765276123;11050.778984420427;11053.336799792038;11100.61147859821;7608.972788673458;8871.733847984313;9155.633774648939;9163.633454661738;9312.301577381859;8905.599248033725;8938.329625278;8958;9016.729498115066;9128.406653567497;6825.931740682529;8034.598270086589;8166.142555031636;8234.835303294021;8257.669693212205;5088.516590923857;5192.636515443883;5870.503021729432;5959.821205363846;6080.118382834553;6086.239220097488;6138.202033735586;6253.562250642593;6293.118963345227;6327.905081423874 17:41:47 INFO - PID 2884 | |4;prototype.html;309.85436844683005;402.86906755304517;416.72079706596577;421.33639517759536;421.87976426718393;5398.460153984604;6156.538259630534;6429.646369449679;6543.7055332510035;6588.769393071243;5035.672681275714;6290.96854515728;6302.716377763;6316.431521163095;6375.617462952227;4079.6129316032543;4779.068081724065;4808.643764555378;4814.7351895645725;4822.228443449048;4818.638602104857;4825.806967721304;4846;4852.684575502581;4857;3919.4708714323488;4277.978610106945;4373.278409062501;4520.801987473305;4563.680542362036;3724.8510059597584;4470.217711900421;4542.523035081302;4559.817607295704;4564.7717614119165;3874.341361968472;3879.12719638082;3885.3977633466857;3891.1439483313625;3896.9867834362985;5267.420583735786;5560.360558535739;5952.851178720523;6178.574282745939;6271.937280627181;4685.554872287127;5229.137192363255;5350.197470379435;5399.487048730364;5417.945820541783;5406.459354064601;6578.539502234846;6729.1252137221845;6772.864542709118;6810.829729256809;4321.416608757809;4357.629601483878;4377.299632058855;4380.978095109536;4392.209402307583;5984.97007514964;6829.078074459934;6949.826254343631;7028.789136325919;7122.252163522808;4423.933640995388;4432.246518091933;4458.286674132188;4460.107978404332;4467.329900514948;4525.185466616041;4536.639008297498;4542.841000564964;4544.227481328182;4545.431821022372;5266.815661451831;5391.32608423947;5432.348118225759;5442.550852116563;5468.91796623051;5713.542916566665;6765.492588055817;6815.556988795713;6830.453563714891;6848.931510684929;1520.5058356034333;1534.6571749718996;1544.3204989804674;1551.6431220819275;1551.9301631426613;1089.2919602258437;1101.8430647819757;1225.3199474291853;1227.3617718786359;1233.907456940733;6511.28375878653;6514.348565143542;6515.306020434627;6554.606723596599;6597.86804263912;6226.501879849601;6694.8284050291;6876.449884009267;6943.270956549591;7152.213256541776;5876.882462350729;5907.911381329283;6502.772402965874;6613.3056029117215;6654.83362915931;2962.4963756161505;3277.557529733503;3544.5923718772156;3667.5965643779164;3799.411091280856;5604.887902242014;7193.568385896863;7355.154157271875;7392.852142957218;7397.741079062314;6044.280073966733;6113.32753397126;6718.966405167943;6957.9304206958295;7361.190269070398;5958.033848829876;7356.926430735624;7373.926260737431;7432.739854105297;7449.664765085476;6827.351401616838;7099.645017748989;7126.857462850818;7131.96891321176;7142.999980002907;5722.484976352148;6866.622335771581;7045.57726536389;7047.365737083482;7056.364927156581;6122.836471199627;7400.037995060823;7446.664900079401;7454.739084132029;7458;3737.551493820759;4462.34893089559;4480.843170489017;4481.126180394792;4486.327050942385;7046.471514636525;7082.893756593552;7100.325469080429;7118.822029449305;7155.284471553011;6529.444997175293;6586.6678651506845;6830.624315662686;6859.7256109757045;6870.27862074495;6041.848953776191;6079.696015199311;6692.862213423632;6770.695318710768;6773.205184501761;5437.972810135924;5950.702464876826;6724.226713927766;6743.426808721314;6861.313868613099;5286.841394758163;5907.616004959664;6692.564983276072;6856.965715171392;6872.656367181521;6188.721507532262;6677.599344039373;6697.01072700841;6736.93263067363;6751.738167713675 17:41:47 INFO - PID 2884 | |5;yui.html;731.6780616528727;754.3625636337297;779.894714213581;808.7343307723417;870.1037930931141;16507.42224022158;17006.404775832834;17029.829701702994;18179.636407271846;19464.318748843794;18090.909545452287;18418.355357562454;18594.442166734985;18765;18879.43361699148;985.8866230383508;1030.8247597908337;1031.9845202321972;1034.0125180452649;1036.383351905615;996.7059717383389;1039.469870366115;1045.7333379988092;1047.005344922323;1047.2302857399804;1088.4448931045144;1097.7310558913077;1099.6041425086962;1101.2126329674281;1101.251149218531;1073.3023534702468;1096.5339730614496;1097.3525619884226;1099.3019432660237;1111.222144498854;811.4401063266328;816.0941355095839;817.4972391978949;818.2267756969666;818.3126174013797;15911.920440397724;16034.278457469441;16202.946808457413;16868.746968795476;16986.235619397157;17306;17360.39238626642;17598.472045838516;17713.822861771347;17716.291348346178;11743.001844843198;12254.754904901853;13976.860231397657;14135.505257316048;14304.427822887072;3492.109512074405;3516.4549494828343;3518.20840310928;3521;3524.859005639771;101567.49216253945;125188.74811251953;129729.35135324263;130668;131956;13365.064445488722;13439.664008399868;13440.529581464602;13562;13589;24318.87840560786;26199.21402357894;26200.737992620212;26255.343616409362;26759.598606020925;7937.880931786028;8090.271875531231;8116.959415202886;8118.3099436548555;8140.104588495261;3796.37359835624;3925.5878132796215;3977.721559490808;4059.0055436417674;4064.5935406459707;4185.937210941838;4274.658027357804;4280.379344994958;4287.506936702257;4288.442502474721;942.9811403771886;945.8439357506072;953.8330792111353;956.6081351633356;960.9903900961041;632.7816903168399;645.3159650770199;659.9769008084694;661.8180000499805;677.9186497620317;10113.848292275621;11160.776784464266;13436.664083397798;13628.250446225553;13734.862651373558;634.6890023888261;640.8718256348749;645.2740666749906;661.7121552124842;680.5406350713348;5131.61512886535;5352.866178345573;5451.591130665216;5567.805126820623;5629.127485239713;98032.50983745178;98060;98118.50940745251;98684.01315986892;99613;90754;91224.07043542148;91388;92039.61940570897;93929.0607093934;80212;80478;81034.59482702667;81569;82074;7624.80937976555;8851.69019084329;9347.597860320735;10426;10812.45937703096;23657;27721.584176237775;30926;31159;39777.60222397739;52116;52489;52767.416977490735;71055;75575.7972673682;16183.271752771388;16591;16678.49964501067;16871.66256674884;16921.83078169252;15369.692606148039;18211.635767284846;18568.81431185671;19010.809891900903;19591.412257632295;17062.829371706124;17590.824091758917;18367.724484133018;18505.259789608805;18653.160607772956;17296.567585810455;17790.110494475484;18345.72481412753;18436.801607895442;18496.537586559905;16493.34026638969;17009.91495042517;17043.65912681764;17052;17190.828091718922;9790.951045244728;10576.576936922436;11091.223614346918;11504.61944566624;11745.765084698087;13388.19670819754;13769.931150344184;13809.585712428241;13947.721045578828;14073.859261407664 17:41:47 INFO - PID 2884 | __end_tp_report 17:41:47 INFO - PID 2884 | __start_cc_report 17:41:47 INFO - PID 2884 | _x_x_mozilla_cycle_collect,420 17:41:47 INFO - PID 2884 | __end_cc_report 17:41:47 INFO - PID 2884 | __startTimestamp1493685707791__endTimestamp 17:41:47 INFO - PID 2884 | 17:41:47 INFO - PID 2884 | ------- Summary: start ------- 17:41:47 INFO - PID 2884 | Number of tests: 6 17:41:47 INFO - PID 2884 | 17:41:47 INFO - PID 2884 | [#0] dojo.html Cycles:165 Average:6144.81 Median:6406.90 stddev:808.42 (12.6%) stddev-sans-first:772.58 17:41:47 INFO - PID 2884 | Values: 3009.5 3570.2 3624.0 3628.9 3634.7 6022.2 6171.4 6212.1 6221.8 6280.0 4828.0 6149.0 6199.9 6228.3 6257.8 5357.8 5392.6 5400.8 5402.5 5428.8 5465.5 5486.4 5502.3 5515.9 5522.4 4483.0 4885.3 4927.6 5481.2 5516.3 4356.5 5062.9 5434.0 5474.8 5477.2 5370.7 5416.6 5416.7 5426.9 5491.9 5025.3 6137.2 6155.5 6295.2 6295.3 6592.9 6635.8 6687.9 6694.3 6732.8 6819.8 6840.6 6842.2 6843.0 6860.1 6233.2 6286.6 6313.6 6319.4 6329.6 6776.4 6829.6 6879.3 6889.1 6926.3 6385.3 6472.7 6554.2 6624.6 6679.4 5988.3 6716.6 6791.5 6808.1 6827.8 6728.1 6744.7 6749.4 6761.4 6783.1 6440.9 6563.6 6570.3 6598.0 6719.4 4751.8 4783.7 5318.6 5391.9 5405.8 4496.9 4729.2 4739.6 4776.9 4786.0 6193.8 6327.1 6340.9 6361.7 6389.2 6656.5 6742.1 6764.1 6860.0 6865.0 6304.4 6343.8 6346.0 6353.7 6359.4 5757.0 5834.8 5868.3 5901.7 5914.7 6597.7 6790.8 6912.0 6964.9 7042.3 6859.7 6875.7 6879.8 6900.6 6901.6 6988.0 7078.7 7110.0 7129.3 7140.9 6492.2 6566.0 6603.6 6737.2 6775.1 6794.4 6836.9 6839.9 6843.7 6890.3 6350.3 6354.2 6582.0 6608.6 6617.6 6406.9 6439.5 6489.9 6604.1 6613.7 6255.4 6273.9 6460.4 6485.4 6486.4 4874.6 6416.9 6488.5 6526.5 6635.9 6420.1 6434.2 6444.9 6457.3 6467.6 17:41:47 INFO - PID 2884 | 17:41:47 INFO - PID 2884 | [#1] ext.html Cycles:180 Average:44573.11 Median:32903.19 stddev:77676.39 (236.1%) stddev-sans-first:77824.51 17:41:47 INFO - PID 2884 | Values: 720.5 783.0 843.0 1154.0 1232.7 35827.6 37396.0 37443.8 37482.3 37562.8 38063.0 38416.4 38508.8 38561.0 38728.0 6748.4 7874.4 8277.2 8503.0 8540.5 7146.2 8563.7 8609.1 8629.3 8640.6 7659.7 8144.9 8558.8 8644.0 8653.7 8591.7 8592.9 8629.2 8638.7 8672.9 8357.1 8418.0 8445.8 8452.9 8453.9 36979.4 37031.0 37194.6 37235.6 37320.6 3688.7 3694.4 3716.5 3734.9 3742.6 30240.7 30371.7 30440.4 30537.0 30570.1 3146.7 3166.1 3186.3 3189.3 3197.7 247284.8 251965.0 282340.6 295514.0 295962.0 47292.8 47420.0 47479.0 47513.5 47637.3 49566.0 49886.5 49947.5 50036.5 50096.5 14100.2 14198.8 14231.4 14234.7 14244.3 11580.8 11667.6 11731.9 11752.5 11771.8 13443.9 13467.1 13487.3 13492.4 13569.4 5901.9 5910.0 5956.4 6000.0 6005.0 842.9 1011.7 1046.4 1046.8 1082.2 16493.2 20463.6 22758.7 23333.5 24645.5 899.6 1089.2 1114.4 1134.4 1179.7 9801.0 11227.6 11913.7 12451.4 12480.2 317931.0 319778.0 321849.0 322354.4 323004.8 54707.0 54769.0 54838.2 54841.7 55016.4 1533.0 1576.6 1582.8 1591.1 1594.1 19631.6 21987.3 23852.4 23985.0 24376.4 36850.4 37383.3 37392.6 37546.4 38053.4 289479.0 290276.0 290354.0 290543.0 291573.0 32335.5 32877.4 32929.0 34060.7 34079.8 42639.9 44900.0 45242.8 45342.1 45375.8 29229.0 29960.3 29999.0 30370.4 30416.8 30319.5 30766.8 30850.7 31162.8 31424.0 36012.6 36173.1 37108.1 37466.4 37654.8 31566.0 31666.2 31704.0 31833.5 31969.7 22963.5 23508.9 24208.5 24225.5 24307.6 17:41:47 INFO - PID 2884 | 17:41:47 INFO - PID 2884 | [#2] jquery.html Cycles:180 Average:36188.58 Median:2308.19 stddev:96064.41 (4161.9%) stddev-sans-first:96296.39 17:41:47 INFO - PID 2884 | Values: 435.3 436.9 439.4 456.8 465.1 19575.9 21179.6 21885.5 22039.9 22080.6 21426.1 22667.5 23225.5 23273.4 23458.4 6045.2 6097.8 6275.3 6306.6 6320.1 6083.3 6285.8 6289.7 6293.3 6298.2 5914.7 6155.4 6202.3 6244.8 6244.9 6137.5 6144.6 6145.0 6147.0 6184.8 4642.6 5456.1 5472.5 5484.3 5552.9 26906.9 27697.4 27913.2 28117.0 28557.6 2258.6 2306.2 2307.2 2309.2 2311.8 15275.8 17932.5 18022.9 18294.5 18481.9 2150.1 2162.8 2208.6 2215.9 2216.3 132330.0 139390.0 144644.0 146561.0 147102.0 12252.0 12774.2 12785.0 12799.7 12891.4 16491.6 16515.6 16533.3 16547.3 16699.4 8465.2 8704.7 8707.7 8745.5 8825.2 8060.7 8069.4 8072.9 8222.3 8247.3 8026.3 8147.9 8163.8 8172.7 8219.1 1746.9 2234.2 2241.5 2248.5 2417.5 754.7 957.9 964.1 979.2 992.3 21422.7 21609.0 21625.4 21653.5 21982.6 908.2 980.8 1009.4 1011.7 1012.8 11056.5 11260.4 11286.2 11288.7 11300.0 564205.0 565461.0 567833.0 571010.0 577145.0 125741.4 134559.3 141826.0 142220.3 151479.0 1188.8 1214.2 1261.6 1264.4 1271.9 16599.5 21985.0 22485.9 22985.3 23217.0 57120.4 57790.4 59145.8 59966.1 60723.0 55740.4 77482.2 78051.8 78809.0 79389.0 8853.6 8910.5 9140.6 9219.7 9395.0 14327.4 14486.6 14654.8 14736.0 14785.0 12255.3 12325.3 12354.9 12358.5 12520.7 10138.4 10950.7 11548.4 11569.6 11886.5 12276.1 12334.9 12434.4 12469.8 12558.0 9052.2 9061.8 9142.9 9170.1 9199.4 12101.4 12257.9 12300.5 12301.0 12466.4 17:41:47 INFO - PID 2884 | 17:41:47 INFO - PID 2884 | [#3] mootools.html Cycles:180 Average:7025.87 Median:3665.55 stddev:4422.43 (120.6%) stddev-sans-first:4413.27 17:41:47 INFO - PID 2884 | Values: 1214.4 1236.5 1337.9 1468.1 1468.5 11109.4 11478.3 11512.7 11573.4 11829.6 11574.9 11723.4 11729.5 11748.8 11879.6 2512.3 2549.1 2549.3 2551.9 2554.1 2470.4 2518.9 2521.3 2531.6 2532.3 2477.5 2486.1 2515.2 2517.0 2522.7 2451.3 2480.8 2513.2 2517.0 2526.5 2420.0 2501.7 2502.7 2520.8 2528.1 10637.7 11749.2 11864.8 11870.0 11885.6 6275.3 6838.6 6845.2 6856.0 6856.2 3998.1 4305.7 4318.7 4335.8 4376.9 1252.2 1266.9 1305.7 1319.9 1321.3 13718.0 15586.9 16251.8 16312.0 16329.0 5477.7 5545.4 5689.1 5698.1 5734.1 11685.9 11689.2 11775.2 11784.4 11841.5 6506.4 6579.1 6581.2 6582.4 6591.1 6060.7 6064.8 6170.7 6240.5 6250.2 4243.5 4380.5 4415.5 4440.3 4453.1 1253.9 1265.5 1268.2 1280.4 1288.5 794.2 797.0 813.2 825.9 849.1 6093.6 6140.6 6286.8 6345.9 6346.2 595.9 600.3 601.2 604.0 624.0 3438.9 3892.2 4013.7 4132.7 4394.0 11120.9 14764.6 14843.1 14902.6 14962.9 14627.5 14836.7 14841.2 14853.8 14865.0 7497.7 8209.6 8614.1 8669.3 8676.0 6273.2 6912.7 6964.3 7165.4 7212.1 13125.9 13167.2 13462.8 13499.7 13576.5 13281.3 13648.0 13768.9 13803.8 13993.9 8236.8 8907.9 9242.6 9328.5 9356.0 10962.0 11046.9 11050.8 11053.3 11100.6 7609.0 8871.7 9155.6 9163.6 9312.3 8905.6 8938.3 8958.0 9016.7 9128.4 6825.9 8034.6 8166.1 8234.8 8257.7 5088.5 5192.6 5870.5 5959.8 6080.1 6086.2 6138.2 6253.6 6293.1 6327.9 17:41:47 INFO - PID 2884 | 17:41:47 INFO - PID 2884 | [#4] prototype.html Cycles:180 Average:5440.76 Median:5971.50 stddev:1743.81 (29.2%) stddev-sans-first:1705.65 17:41:47 INFO - PID 2884 | Values: 309.9 402.9 416.7 421.3 421.9 5398.5 6156.5 6429.6 6543.7 6588.8 5035.7 6291.0 6302.7 6316.4 6375.6 4079.6 4779.1 4808.6 4814.7 4822.2 4818.6 4825.8 4846.0 4852.7 4857.0 3919.5 4278.0 4373.3 4520.8 4563.7 3724.9 4470.2 4542.5 4559.8 4564.8 3874.3 3879.1 3885.4 3891.1 3897.0 5267.4 5560.4 5952.9 6178.6 6271.9 4685.6 5229.1 5350.2 5399.5 5417.9 5406.5 6578.5 6729.1 6772.9 6810.8 4321.4 4357.6 4377.3 4381.0 4392.2 5985.0 6829.1 6949.8 7028.8 7122.3 4423.9 4432.2 4458.3 4460.1 4467.3 4525.2 4536.6 4542.8 4544.2 4545.4 5266.8 5391.3 5432.3 5442.6 5468.9 5713.5 6765.5 6815.6 6830.5 6848.9 1520.5 1534.7 1544.3 1551.6 1551.9 1089.3 1101.8 1225.3 1227.4 1233.9 6511.3 6514.3 6515.3 6554.6 6597.9 6226.5 6694.8 6876.4 6943.3 7152.2 5876.9 5907.9 6502.8 6613.3 6654.8 2962.5 3277.6 3544.6 3667.6 3799.4 5604.9 7193.6 7355.2 7392.9 7397.7 6044.3 6113.3 6719.0 6957.9 7361.2 5958.0 7356.9 7373.9 7432.7 7449.7 6827.4 7099.6 7126.9 7132.0 7143.0 5722.5 6866.6 7045.6 7047.4 7056.4 6122.8 7400.0 7446.7 7454.7 7458.0 3737.6 4462.3 4480.8 4481.1 4486.3 7046.5 7082.9 7100.3 7118.8 7155.3 6529.4 6586.7 6830.6 6859.7 6870.3 6041.8 6079.7 6692.9 6770.7 6773.2 5438.0 5950.7 6724.2 6743.4 6861.3 5286.8 5907.6 6692.6 6857.0 6872.7 6188.7 6677.6 6697.0 6736.9 6751.7 17:41:47 INFO - PID 2884 | 17:41:47 INFO - PID 2884 | [#5] yui.html Cycles:180 Average:21593.06 Median:18945.12 stddev:30215.38 (159.5%) stddev-sans-first:30259.53 17:41:47 INFO - PID 2884 | Values: 731.7 754.4 779.9 808.7 870.1 16507.4 17006.4 17029.8 18179.6 19464.3 18090.9 18418.4 18594.4 18765.0 18879.4 985.9 1030.8 1032.0 1034.0 1036.4 996.7 1039.5 1045.7 1047.0 1047.2 1088.4 1097.7 1099.6 1101.2 1101.3 1073.3 1096.5 1097.4 1099.3 1111.2 811.4 816.1 817.5 818.2 818.3 15911.9 16034.3 16202.9 16868.7 16986.2 17306.0 17360.4 17598.5 17713.8 17716.3 11743.0 12254.8 13976.9 14135.5 14304.4 3492.1 3516.5 3518.2 3521.0 3524.9 101567.5 125188.7 129729.4 130668.0 131956.0 13365.1 13439.7 13440.5 13562.0 13589.0 24318.9 26199.2 26200.7 26255.3 26759.6 7937.9 8090.3 8117.0 8118.3 8140.1 3796.4 3925.6 3977.7 4059.0 4064.6 4185.9 4274.7 4280.4 4287.5 4288.4 943.0 945.8 953.8 956.6 961.0 632.8 645.3 660.0 661.8 677.9 10113.8 11160.8 13436.7 13628.3 13734.9 634.7 640.9 645.3 661.7 680.5 5131.6 5352.9 5451.6 5567.8 5629.1 98032.5 98060.0 98118.5 98684.0 99613.0 90754.0 91224.1 91388.0 92039.6 93929.1 80212.0 80478.0 81034.6 81569.0 82074.0 7624.8 8851.7 9347.6 10426.0 10812.5 23657.0 27721.6 30926.0 31159.0 39777.6 52116.0 52489.0 52767.4 71055.0 75575.8 16183.3 16591.0 16678.5 16871.7 16921.8 15369.7 18211.6 18568.8 19010.8 19591.4 17062.8 17590.8 18367.7 18505.3 18653.2 17296.6 17790.1 18345.7 18436.8 18496.5 16493.3 17009.9 17043.7 17052.0 17190.8 9791.0 10576.6 11091.2 11504.6 11745.8 13388.2 13769.9 13809.6 13947.7 14073.9 17:41:47 INFO - PID 2884 | -------- Summary: end -------- 17:41:47 INFO - PID 2884 | 17:41:48 INFO - TEST-INFO | 2884: exit 0 17:41:48 INFO - TEST-OK | dromaeo_css | took 1114819ms 17:41:48 INFO - TEST-START | kraken 17:41:48 INFO - operating with platform_type : mac_ 17:41:48 INFO - Initialising browser for kraken test... 17:41:48 INFO - TEST-INFO | started process 2890 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/tmpUvtSVp/profile http://localhost:57675/getInfo.html) 17:41:51 INFO - PID 2890 | 2017-05-01 17:41:51.132 plugin-container[2891:38709] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x963b, name = 'com.apple.tsm.portname' 17:41:51 INFO - PID 2890 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:41:51 INFO - PID 2890 | 2017-05-01 17:41:51.136 plugin-container[2891:38709] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9b03, name = 'com.apple.CFPasteboardClient' 17:41:51 INFO - PID 2890 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:41:51 INFO - PID 2890 | 2017-05-01 17:41:51.136 plugin-container[2891:38709] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:41:51 INFO - PID 2890 | __metrics Screen width/height:1600/1200 17:41:51 INFO - PID 2890 | colorDepth:24 17:41:51 INFO - PID 2890 | Browser inner width/height: 1024/689 17:41:51 INFO - PID 2890 | __metrics 17:41:52 INFO - TEST-INFO | 2890: exit 0 17:41:52 INFO - Browser initialized. 17:41:52 INFO - Running cycle 1/1 for kraken test... 17:41:52 INFO - TEST-INFO | started process 2892 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/tmpUvtSVp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:41:54 INFO - PID 2892 | 2017-05-01 17:41:54.715 plugin-container[2893:38838] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4343, name = 'com.apple.tsm.portname' 17:41:54 INFO - PID 2892 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:41:54 INFO - PID 2892 | 2017-05-01 17:41:54.717 plugin-container[2893:38838] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x460b, name = 'com.apple.CFPasteboardClient' 17:41:54 INFO - PID 2892 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:41:54 INFO - PID 2892 | 2017-05-01 17:41:54.717 plugin-container[2893:38838] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:42:04 INFO - PID 2892 | RSS: Main: 234725376 17:42:04 INFO - PID 2892 | 17:42:07 INFO - PID 2892 | Cycle 1(1): loaded http://localhost:57675/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57675/tests/kraken/driver.html?testName=audio-beat-detection) 17:42:08 INFO - PID 2892 | RSS: Main: 247656448 17:42:08 INFO - PID 2892 | 17:42:10 INFO - PID 2892 | Cycle 1(1): loaded http://localhost:57675/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57675/tests/kraken/driver.html?testName=audio-dft) 17:42:11 INFO - PID 2892 | RSS: Main: 256630784 17:42:11 INFO - PID 2892 | 17:42:14 INFO - PID 2892 | Cycle 1(1): loaded http://localhost:57675/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57675/tests/kraken/driver.html?testName=audio-fft) 17:42:15 INFO - PID 2892 | RSS: Main: 258899968 17:42:15 INFO - PID 2892 | 17:42:17 INFO - PID 2892 | Cycle 1(1): loaded http://localhost:57675/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57675/tests/kraken/driver.html?testName=audio-oscillator) 17:42:18 INFO - PID 2892 | RSS: Main: 260038656 17:42:18 INFO - PID 2892 | 17:42:19 INFO - PID 2892 | Cycle 1(1): loaded http://localhost:57675/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57675/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:42:20 INFO - PID 2892 | RSS: Main: 260464640 17:42:20 INFO - PID 2892 | 17:42:23 INFO - PID 2892 | Cycle 1(1): loaded http://localhost:57675/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57675/tests/kraken/driver.html?testName=imaging-darkroom) 17:42:23 INFO - PID 2892 | RSS: Main: 267771904 17:42:23 INFO - PID 2892 | 17:42:27 INFO - PID 2892 | Cycle 1(1): loaded http://localhost:57675/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57675/tests/kraken/driver.html?testName=imaging-desaturate) 17:42:27 INFO - PID 2892 | RSS: Main: 269189120 17:42:27 INFO - PID 2892 | 17:42:30 INFO - PID 2892 | Cycle 1(1): loaded http://localhost:57675/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57675/tests/kraken/driver.html?testName=json-parse-financial) 17:42:31 INFO - PID 2892 | RSS: Main: 268427264 17:42:31 INFO - PID 2892 | 17:42:32 INFO - PID 2892 | Cycle 1(1): loaded http://localhost:57675/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57675/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:42:33 INFO - PID 2892 | RSS: Main: 267800576 17:42:33 INFO - PID 2892 | 17:42:35 INFO - PID 2892 | Cycle 1(1): loaded http://localhost:57675/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57675/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:42:36 INFO - PID 2892 | RSS: Main: 267841536 17:42:36 INFO - PID 2892 | 17:42:38 INFO - PID 2892 | Cycle 1(1): loaded http://localhost:57675/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57675/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:42:39 INFO - PID 2892 | RSS: Main: 267464704 17:42:39 INFO - PID 2892 | 17:42:41 INFO - PID 2892 | Cycle 1(1): loaded http://localhost:57675/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:42:42 INFO - PID 2892 | RSS: Main: 267763712 17:42:42 INFO - PID 2892 | 17:42:45 INFO - PID 2892 | Cycle 1(1): loaded http://localhost:57675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:42:46 INFO - PID 2892 | RSS: Main: 267780096 17:42:46 INFO - PID 2892 | 17:42:48 INFO - PID 2892 | Cycle 1(1): loaded http://localhost:57675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57675/tests/kraken/driver.html?testName=ai-astar) 17:42:48 INFO - PID 2892 | RSS: Main: 269484032 17:42:48 INFO - PID 2892 | 17:42:48 INFO - PID 2892 | __start_tp_report 17:42:48 INFO - PID 2892 | _x_x_mozilla_page_load 17:42:48 INFO - PID 2892 | _x_x_mozilla_page_load_details 17:42:48 INFO - PID 2892 | |i|pagename|runs| 17:42:48 INFO - PID 2892 | |0;ai-astar;107;166;172;113;115;115;114;115;115;114 17:42:48 INFO - PID 2892 | |1;audio-beat-detection;147;115;131;149;116;155;132;111;147;110 17:42:48 INFO - PID 2892 | |2;audio-dft;207;196;210;222;208;208;197;200;193;196 17:42:48 INFO - PID 2892 | |3;audio-fft;79;56;57;85;56;57;60;58;76;56 17:42:48 INFO - PID 2892 | |4;audio-oscillator;82;69;83;72;69;69;89;71;69;91 17:42:48 INFO - PID 2892 | |5;imaging-gaussian-blur;87;88;88;87;88;87;88;89;101;87 17:42:48 INFO - PID 2892 | |6;imaging-darkroom;96;96;96;120;135;101;97;149;108;162 17:42:48 INFO - PID 2892 | |7;imaging-desaturate;91;94;93;99;92;90;104;138;92;95 17:42:48 INFO - PID 2892 | |8;json-parse-financial;50;48;46;51;48;50;51;49;52;53 17:42:48 INFO - PID 2892 | |9;json-stringify-tinderbox;58;69;57;59;77;91;87;70;53;79 17:42:48 INFO - PID 2892 | |10;stanford-crypto-aes;84;106;104;82;82;90;106;71;97;109 17:42:48 INFO - PID 2892 | |11;stanford-crypto-ccm;144;129;134;163;178;158;137;138;185;141 17:42:48 INFO - PID 2892 | |12;stanford-crypto-pbkdf2;222;192;243;187;197;234;185;183;189;181 17:42:48 INFO - PID 2892 | |13;stanford-crypto-sha256-iterative;66;90;83;69;68;68;66;67;72;108 17:42:48 INFO - PID 2892 | __end_tp_report 17:42:48 INFO - PID 2892 | __start_cc_report 17:42:48 INFO - PID 2892 | _x_x_mozilla_cycle_collect,980 17:42:48 INFO - PID 2892 | __end_cc_report 17:42:48 INFO - PID 2892 | __startTimestamp1493685768571__endTimestamp 17:42:48 INFO - PID 2892 | 17:42:48 INFO - PID 2892 | ------- Summary: start ------- 17:42:48 INFO - PID 2892 | Number of tests: 14 17:42:48 INFO - PID 2892 | 17:42:48 INFO - PID 2892 | [#0] ai-astar Cycles:10 Average:124.60 Median:115.00 stddev:23.57 (20.5%) stddev-sans-first:24.12 17:42:48 INFO - PID 2892 | Values: 107.0 166.0 172.0 113.0 115.0 115.0 114.0 115.0 115.0 114.0 17:42:48 INFO - PID 2892 | 17:42:48 INFO - PID 2892 | [#1] audio-beat-detection Cycles:10 Average:131.30 Median:139.50 stddev:17.43 (12.5%) stddev-sans-first:17.54 17:42:48 INFO - PID 2892 | Values: 147.0 115.0 131.0 149.0 116.0 155.0 132.0 111.0 147.0 110.0 17:42:48 INFO - PID 2892 | 17:42:48 INFO - PID 2892 | [#2] audio-dft Cycles:10 Average:203.70 Median:207.50 stddev:8.91 (4.3%) stddev-sans-first:9.37 17:42:48 INFO - PID 2892 | Values: 207.0 196.0 210.0 222.0 208.0 208.0 197.0 200.0 193.0 196.0 17:42:48 INFO - PID 2892 | 17:42:48 INFO - PID 2892 | [#3] audio-fft Cycles:10 Average:64.00 Median:59.00 stddev:11.31 (19.2%) stddev-sans-first:10.62 17:42:48 INFO - PID 2892 | Values: 79.0 56.0 57.0 85.0 56.0 57.0 60.0 58.0 76.0 56.0 17:42:48 INFO - PID 2892 | 17:42:48 INFO - PID 2892 | [#4] audio-oscillator Cycles:10 Average:76.40 Median:77.00 stddev:8.91 (11.6%) stddev-sans-first:9.22 17:42:48 INFO - PID 2892 | Values: 82.0 69.0 83.0 72.0 69.0 69.0 89.0 71.0 69.0 91.0 17:42:48 INFO - PID 2892 | 17:42:48 INFO - PID 2892 | [#5] imaging-gaussian-blur Cycles:10 Average:89.00 Median:88.00 stddev:4.27 (4.9%) stddev-sans-first:4.47 17:42:48 INFO - PID 2892 | Values: 87.0 88.0 88.0 87.0 88.0 87.0 88.0 89.0 101.0 87.0 17:42:48 INFO - PID 2892 | 17:42:48 INFO - PID 2892 | [#6] imaging-darkroom Cycles:10 Average:116.00 Median:129.00 stddev:24.57 (19.0%) stddev-sans-first:24.97 17:42:48 INFO - PID 2892 | Values: 96.0 96.0 96.0 120.0 135.0 101.0 97.0 149.0 108.0 162.0 17:42:48 INFO - PID 2892 | 17:42:48 INFO - PID 2892 | [#7] imaging-desaturate Cycles:10 Average:98.80 Median:92.50 stddev:14.40 (15.6%) stddev-sans-first:14.99 17:42:48 INFO - PID 2892 | Values: 91.0 94.0 93.0 99.0 92.0 90.0 104.0 138.0 92.0 95.0 17:42:48 INFO - PID 2892 | 17:42:48 INFO - PID 2892 | [#8] json-parse-financial Cycles:10 Average:49.80 Median:50.50 stddev:2.10 (4.2%) stddev-sans-first:2.22 17:42:48 INFO - PID 2892 | Values: 50.0 48.0 46.0 51.0 48.0 50.0 51.0 49.0 52.0 53.0 17:42:48 INFO - PID 2892 | 17:42:48 INFO - PID 2892 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:73.50 stddev:13.27 (18.0%) stddev-sans-first:13.34 17:42:48 INFO - PID 2892 | Values: 58.0 69.0 57.0 59.0 77.0 91.0 87.0 70.0 53.0 79.0 17:42:48 INFO - PID 2892 | 17:42:48 INFO - PID 2892 | [#10] stanford-crypto-aes Cycles:10 Average:93.10 Median:82.00 stddev:13.11 (16.0%) stddev-sans-first:13.49 17:42:48 INFO - PID 2892 | Values: 84.0 106.0 104.0 82.0 82.0 90.0 106.0 71.0 97.0 109.0 17:42:48 INFO - PID 2892 | 17:42:48 INFO - PID 2892 | [#11] stanford-crypto-ccm Cycles:10 Average:150.70 Median:151.00 stddev:19.33 (12.8%) stddev-sans-first:20.35 17:42:48 INFO - PID 2892 | Values: 144.0 129.0 134.0 163.0 178.0 158.0 137.0 138.0 185.0 141.0 17:42:48 INFO - PID 2892 | 17:42:48 INFO - PID 2892 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:201.30 Median:194.50 stddev:22.88 (11.8%) stddev-sans-first:23.01 17:42:48 INFO - PID 2892 | Values: 222.0 192.0 243.0 187.0 197.0 234.0 185.0 183.0 189.0 181.0 17:42:48 INFO - PID 2892 | 17:42:48 INFO - PID 2892 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.70 Median:68.50 stddev:13.91 (20.3%) stddev-sans-first:14.31 17:42:48 INFO - PID 2892 | Values: 66.0 90.0 83.0 69.0 68.0 68.0 66.0 67.0 72.0 108.0 17:42:48 INFO - PID 2892 | -------- Summary: end -------- 17:42:48 INFO - PID 2892 | 17:42:49 INFO - TEST-INFO | 2892: exit 0 17:42:49 INFO - TEST-OK | kraken | took 61223ms 17:42:49 INFO - SUITE-END | took 1176s 17:42:49 INFO - Completed test suite (00:19:36) 17:42:49 INFO - javascript benchmark 17:42:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7909.096540111528, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3009.518477043673, 3570.161012162143, 3623.9637603623955, 3628.872989445368, 3634.7455678102533, 6022.247219097613, 6171.352008039153, 6212.130301757752, 6221.782237621678, 6279.968600157004, 4827.951720482794, 6149.046897730859, 6199.907001394983, 6228.314885362618, 6257.843553911154, 5357.8392648220615, 5392.595555333346, 5400.837974860741, 5402.540784033362, 5428.83713488595, 5465.508104270615, 5486.3690675572225, 5502.339719233698, 5515.917261241085, 5522.447755224465, 4482.9551704482865, 4885.267209918505, 4927.6304277179, 5481.177823326493, 5516.282883225195, 4356.542563030868, 5062.898742025176, 5434.049041417736, 5474.808381706621, 5477.178423236506, 5370.731463426852, 5416.593755468316, 5416.674999500043, 5426.864328391822, 5491.917621235684, 5025.271335656309, 6137.162486020116, 6155.507559395282, 6295.213098362705, 6295.307516173218, 6592.868142637169, 6635.834104147387, 6687.933120668779, 6694.330566943267, 6732.764353247613, 6819.795406137824, 6840.623765692885, 6842.247352791189, 6843.0, 6860.108185935846, 6233.2208473940755, 6286.622802631811, 6313.589616674947, 6319.368063193644, 6329.556931014785, 6776.42400395962, 6829.556078854858, 6879.3120687931805, 6889.104416425833, 6926.341997510229, 6385.2656944451055, 6472.676366181672, 6554.246261679968, 6624.6025238485845, 6679.398854103154, 5988.28140623128, 6716.597004179765, 6791.524593278522, 6808.148981377328, 6827.795166144924, 6728.091707619506, 6744.6627668616375, 6749.42629876466, 6761.391474767294, 6783.050372947791, 6440.903386449207, 6563.638999855054, 6570.277269500351, 6598.0, 6719.395254427125, 4751.83368582098, 4783.736894470768, 5318.627696061239, 5391.919121213185, 5405.8107966221, 4496.887577810516, 4729.219678753036, 4739.620830333634, 4776.880577985508, 4786.0, 6193.81418557444, 6327.082573026885, 6340.904886426707, 6361.745530178833, 6389.233292004989, 6656.467482601477, 6742.056112144303, 6764.0868482754195, 6860.0, 6864.965675171692, 6304.401081897213, 6343.809685709436, 6345.96827015862, 6353.714082866282, 6359.427651511293, 5757.021306377926, 5834.766609335664, 5868.2664666916635, 5901.704914754245, 5914.733836977346, 6597.670116494252, 6790.830229244309, 6912.0, 6964.895526567207, 7042.330978557029, 6859.691313890787, 6875.656217189221, 6879.759208427681, 6900.585964842126, 6901.62041087745, 6988.0, 7078.68145933424, 7109.969054486967, 7129.322714342129, 7140.892886606601, 6492.156019717407, 6565.967170164118, 6603.570767900071, 6737.2252190996705, 6775.119234499483, 6794.422474089758, 6836.863262734817, 6839.93160068393, 6843.692033858588, 6890.31096890327, 6350.301466838737, 6354.205724284465, 6581.967090164519, 6608.603483790988, 6617.6029438231935, 6406.903896441464, 6439.452646525097, 6489.9351006491215, 6604.108445359815, 6613.735450581923, 6255.374462553708, 6273.874522509433, 6460.418562329225, 6485.383888530582, 6486.383793539606, 4874.5856602189215, 6416.871662566629, 6488.513361497812, 6526.510511711545, 6635.867282654223, 6420.06908998202, 6434.163558737334, 6444.9355506444335, 6457.289698133108, 6467.579607325509], "value": 6087.59130208627, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.5388551327151, 783.0485959559135, 843.0010437631405, 1153.9884601153985, 1232.6548566401405, 35827.64172358279, 37396.0, 37443.81278093609, 37482.25035499292, 37562.8121859391, 38063.0, 38416.42375364365, 38508.80745596275, 38561.0, 38728.0, 6748.358905903931, 7874.370050395969, 8277.213664701843, 8502.957485212566, 8540.487570745745, 7146.249643787405, 8563.743087707378, 8609.139086091403, 8629.266512346458, 8640.611172497222, 7659.736143536337, 8144.877826832602, 8558.78603034926, 8644.0, 8653.653853845839, 8591.742247732578, 8592.914070859306, 8629.223369896708, 8638.654453821871, 8672.8699069514, 8357.12250213731, 8418.03192632849, 8445.788855278606, 8452.8732069019, 8453.873191902127, 36979.4453083204, 37031.0, 37194.62805371939, 37235.627643723485, 37320.626793731986, 3688.7233457490797, 3694.353488139565, 3716.479692843004, 3734.8506059757847, 3742.6070262622306, 30240.697593024008, 30371.69628303711, 30440.391192176256, 30537.0, 30570.08289751311, 3146.6695996920453, 3166.066010526877, 3186.283086305586, 3189.3302406494663, 3197.728193103566, 247284.76357618277, 251965.0, 282340.5882970572, 295514.0, 295962.0, 47292.763536182785, 47420.0, 47479.0, 47513.5248647516, 47637.28544071842, 49566.0, 49886.50113498818, 49947.50052499501, 50036.499635003915, 50096.49903500991, 14100.224487653073, 14198.787018194735, 14231.43074277038, 14234.715305694035, 14244.287785610679, 11580.76838463226, 11667.59163429276, 11731.88268117308, 11752.529898803952, 11771.764564708828, 13443.86556134426, 13467.12463689857, 13487.25820079905, 13492.392842321922, 13569.389377478037, 5901.911471327933, 5909.990603194934, 5956.421548289707, 5999.970000149971, 6004.969975150097, 842.8579275082297, 1011.7116621762763, 1046.3930920066343, 1046.7801761630144, 1082.2370228988543, 16493.17534123289, 20463.590728185354, 22758.65862012071, 23333.533329333317, 24645.507089858103, 899.595182168027, 1089.1885545268826, 1114.395270810031, 1134.444122380028, 1179.7168679516853, 9801.0, 11227.607033753779, 11913.689494155637, 12451.377431128407, 12480.188787728768, 317931.0, 319778.0, 321849.0, 322354.38822805736, 323004.76995230216, 54707.0, 54769.0, 54838.177427338625, 54841.72579137079, 55016.44983550193, 1532.9846701533065, 1576.5664442278464, 1582.849629285216, 1591.1487354265412, 1594.06747052973, 19631.607367852277, 21987.34037978799, 23852.403689907893, 23985.0, 24376.390590235387, 36850.44724329084, 37383.25233495369, 37392.62607373892, 37546.436803447425, 38053.4291985626, 289479.0, 290276.0, 290354.0, 290543.0, 291573.0, 32335.514967275038, 32877.383487815845, 32929.0, 34060.659393405746, 34079.82960085184, 42639.93400165021, 44900.0, 45242.77378613217, 45342.093158137315, 45375.77312113418, 29229.0, 29960.25099372533, 29999.0, 30370.392592148477, 30416.783328666606, 30319.545206822357, 30766.846165769028, 30850.69149308478, 31162.844185778926, 31424.0, 36012.63987360093, 36173.09567260734, 37108.072298191684, 37466.438003430514, 37654.811725941196, 31566.0, 31666.208344791565, 31704.048878533682, 31833.522497163023, 31969.68030319667, 22963.540729184988, 23508.882455587613, 24208.51582968366, 24225.515489689755, 24307.63538546888], "value": 17397.377851747573, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [435.33828580557554, 436.90388114614774, 439.37827973417615, 456.7670488051094, 465.07450174153445, 19575.902120489394, 21179.57640847184, 21885.452863678416, 22039.889800551016, 22080.558388832214, 21426.14295428181, 22667.546649067008, 23225.535489290203, 23273.418164545852, 23458.413539661517, 6045.214122164112, 6097.817065488031, 6275.278342990546, 6306.62160270383, 6320.051992201161, 6083.270007599072, 6285.811425657238, 6289.748410063592, 6293.339199384068, 6298.212723409574, 5914.733836977325, 6155.384461553854, 6202.255729312489, 6244.781432649858, 6244.906326405085, 6137.508999280047, 6144.5698801083945, 6145.047517634774, 6147.047207682816, 6184.814455566295, 4642.605378542828, 5456.0997435423105, 5472.50747432733, 5484.287042684426, 5552.86117847053, 26906.86546567274, 27697.446051079067, 27913.162605121877, 28117.0, 28557.57163642547, 2258.5934531784274, 2306.215886598548, 2307.204014614955, 2309.1802410144323, 2311.8150547956125, 15275.770863437057, 17932.462026139106, 18022.91862488255, 18294.542636434195, 18481.907590462095, 2150.053976250445, 2162.794534519234, 2208.646616541346, 2215.8670479771267, 2216.2797090945505, 132329.99999999904, 139390.0, 144644.0, 146561.0, 147102.0, 12252.0, 12774.23354598727, 12785.0, 12799.680007999874, 12891.35543222835, 16491.5877103071, 16515.58711032234, 16533.33866645345, 16547.255373507982, 16699.415520456725, 8465.238128568335, 8704.695335663222, 8707.6516939323, 8745.47527148373, 8825.249853762374, 8060.717874874468, 8069.435139540294, 8072.878906816402, 8222.259996600334, 8247.340212782963, 8026.317762990211, 8147.940767700161, 8163.775433684876, 8172.713955011665, 8219.095899451055, 1746.9301227950739, 2234.2180236916947, 2241.462049108235, 2248.4716091718433, 2417.5164967006667, 754.6868049759398, 957.913787759105, 964.1322809471532, 979.2019504104132, 992.3202606214766, 21422.664586892657, 21609.027593758317, 21625.351239462525, 21653.458663533223, 21982.560348792933, 908.2007833106956, 980.8087422952456, 1009.369144284822, 1011.6661501704419, 1012.7670635753818, 11056.502457389437, 11260.43697815106, 11286.20996530235, 11288.661340159808, 11300.0, 564205.0, 565461.0, 567833.0, 571010.0, 577145.0, 125741.37129314295, 134559.29042483467, 141826.0, 142220.28889855483, 151479.0, 1188.8038473651923, 1214.1743614342156, 1261.5836773864603, 1264.3804535777404, 1271.936403179856, 16599.50201493957, 21985.0, 22485.88757056204, 22985.310440686808, 23217.0, 57120.42879571151, 57790.42209577851, 59145.81708365895, 59966.10050849154, 60723.0, 55740.44259557353, 77482.22517774976, 78051.82922256057, 78809.0, 79389.0, 8853.557322133738, 8910.509921954095, 9140.634374625206, 9219.723408297761, 9395.0, 14327.426902923766, 14486.565403037926, 14654.78017829712, 14736.042157259744, 14785.038972467186, 12255.325957072446, 12325.260484370967, 12354.949829264253, 12358.50565977351, 12520.686982825502, 10138.442385668859, 10950.671479855617, 11548.364839933884, 11569.595064172714, 11886.524539018343, 12276.140670153003, 12334.938325308316, 12434.37828108609, 12469.812952805534, 12558.0, 9052.185303322733, 9061.77345566366, 9142.908570914471, 9170.082991700776, 9199.448033117767, 12101.394930253628, 12257.938710306391, 12300.507979680713, 12300.954418874497, 12466.376681166086], "value": 10605.06794185303, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1214.4170798016946, 1236.4806781151915, 1337.9130356526825, 1468.1117923656188, 1468.5447511271502, 11109.388983605899, 11478.253913495617, 11512.654620361382, 11573.421328933562, 11829.585964491245, 11574.884251157486, 11723.413829308522, 11729.53081876724, 11748.823767643471, 11879.643610691694, 2512.346789834647, 2549.1332946798084, 2549.337172335197, 2551.8516667499607, 2554.0805310088354, 2470.4318006858434, 2518.937026574341, 2521.281434791085, 2531.6455696202547, 2532.328932832801, 2477.5168842075805, 2486.080150344366, 2515.207709571488, 2517.0435234610914, 2522.697276326843, 2451.3381387025493, 2480.776730094291, 2513.208339373092, 2517.0, 2526.494701059786, 2419.987900060506, 2501.737317581646, 2502.674652295208, 2520.798336133105, 2528.127795910408, 10637.680869573926, 11749.177557570973, 11864.822027669592, 11870.0, 11885.5840045598, 6275.309715931244, 6838.623875686835, 6845.247022827485, 6855.965720171417, 6856.211535673411, 3998.1204135090234, 4305.720128191658, 4318.719283246579, 4335.826566937319, 4376.912461750747, 1252.2298786246483, 1266.9303188324639, 1305.725797582509, 1319.9340032998407, 1321.319520446961, 13718.039737218398, 15586.922065389714, 16251.756223656655, 16312.0, 16329.0, 5477.698726569997, 5545.419555426684, 5689.118186681071, 5698.059820129715, 5734.053881109654, 11685.88314116865, 11689.181757276909, 11775.23460975034, 11784.351860647575, 11841.467133978991, 6506.41442270198, 6579.111819904348, 6581.2102547694585, 6582.3746744059235, 6591.077249185118, 6060.666663333471, 6064.848378790565, 6170.660613666201, 6240.5319601030105, 6250.1874756281395, 4243.511996120424, 4380.540043295408, 4415.536368681306, 4440.267355886307, 4453.1093781243235, 1253.9122261441612, 1265.4811527273773, 1268.1630124118037, 1280.4238092858252, 1288.5361269942814, 794.162158922331, 796.9760907172794, 813.2436833744556, 825.8678611422143, 849.1466076592984, 6093.603915745551, 6140.600860944113, 6286.779962701284, 6345.936540634627, 6346.2067241594805, 595.8689088400545, 600.2586805295457, 601.1643815097019, 603.9516838652897, 623.9719212635442, 3438.862445502152, 3892.2410130024373, 4013.7190396671954, 4132.690048246393, 4394.033312671208, 11120.888791111985, 14764.630884227765, 14843.109413435228, 14902.627434314012, 14962.850371496146, 14627.544012985392, 14836.70326593462, 14841.183734894468, 14853.777193342108, 14865.033772804733, 7497.700091996259, 8209.630566624517, 8614.095519970439, 8669.26311263537, 8676.0, 6273.215848018997, 6912.723491060301, 6964.303569643198, 7165.3551180394015, 7212.134543854771, 13125.868741312464, 13167.209967401986, 13462.798058028942, 13499.730005400033, 13576.456941722221, 13281.335933203109, 13648.044636875324, 13768.931155344158, 13803.792943106062, 13993.930030349784, 8236.83526329458, 8907.910920890708, 9242.584083716114, 9328.533573321443, 9355.953220233856, 10962.0, 11046.944765276123, 11050.778984420427, 11053.336799792038, 11100.61147859821, 7608.972788673458, 8871.733847984313, 9155.633774648939, 9163.633454661738, 9312.301577381859, 8905.599248033725, 8938.329625278, 8958.0, 9016.729498115066, 9128.406653567497, 6825.931740682529, 8034.598270086589, 8166.142555031636, 8234.835303294021, 8257.669693212205, 5088.516590923857, 5192.636515443883, 5870.503021729432, 5959.821205363846, 6080.118382834553, 6086.239220097488, 6138.202033735586, 6253.562250642593, 6293.118963345227, 6327.905081423874], "value": 5286.235628007736, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.85436844683005, 402.86906755304517, 416.72079706596577, 421.33639517759536, 421.87976426718393, 5398.460153984604, 6156.538259630534, 6429.646369449679, 6543.7055332510035, 6588.769393071243, 5035.672681275714, 6290.96854515728, 6302.716377763, 6316.431521163095, 6375.617462952227, 4079.6129316032543, 4779.068081724065, 4808.643764555378, 4814.7351895645725, 4822.228443449048, 4818.638602104857, 4825.806967721304, 4846.0, 4852.684575502581, 4857.0, 3919.4708714323488, 4277.978610106945, 4373.278409062501, 4520.801987473305, 4563.680542362036, 3724.8510059597584, 4470.217711900421, 4542.523035081302, 4559.817607295704, 4564.7717614119165, 3874.341361968472, 3879.12719638082, 3885.3977633466857, 3891.1439483313625, 3896.9867834362985, 5267.420583735786, 5560.360558535739, 5952.851178720523, 6178.574282745939, 6271.937280627181, 4685.554872287127, 5229.137192363255, 5350.197470379435, 5399.487048730364, 5417.945820541783, 5406.459354064601, 6578.539502234846, 6729.1252137221845, 6772.864542709118, 6810.829729256809, 4321.416608757809, 4357.629601483878, 4377.299632058855, 4380.978095109536, 4392.209402307583, 5984.97007514964, 6829.078074459934, 6949.826254343631, 7028.789136325919, 7122.252163522808, 4423.933640995388, 4432.246518091933, 4458.286674132188, 4460.107978404332, 4467.329900514948, 4525.185466616041, 4536.639008297498, 4542.841000564964, 4544.227481328182, 4545.431821022372, 5266.815661451831, 5391.32608423947, 5432.348118225759, 5442.550852116563, 5468.91796623051, 5713.542916566665, 6765.492588055817, 6815.556988795713, 6830.453563714891, 6848.931510684929, 1520.5058356034333, 1534.6571749718996, 1544.3204989804674, 1551.6431220819275, 1551.9301631426613, 1089.2919602258437, 1101.8430647819757, 1225.3199474291853, 1227.3617718786359, 1233.907456940733, 6511.28375878653, 6514.348565143542, 6515.306020434627, 6554.606723596599, 6597.86804263912, 6226.501879849601, 6694.8284050291, 6876.449884009267, 6943.270956549591, 7152.213256541776, 5876.882462350729, 5907.911381329283, 6502.772402965874, 6613.3056029117215, 6654.83362915931, 2962.4963756161505, 3277.557529733503, 3544.5923718772156, 3667.5965643779164, 3799.411091280856, 5604.887902242014, 7193.568385896863, 7355.154157271875, 7392.852142957218, 7397.741079062314, 6044.280073966733, 6113.32753397126, 6718.966405167943, 6957.9304206958295, 7361.190269070398, 5958.033848829876, 7356.926430735624, 7373.926260737431, 7432.739854105297, 7449.664765085476, 6827.351401616838, 7099.645017748989, 7126.857462850818, 7131.96891321176, 7142.999980002907, 5722.484976352148, 6866.622335771581, 7045.57726536389, 7047.365737083482, 7056.364927156581, 6122.836471199627, 7400.037995060823, 7446.664900079401, 7454.739084132029, 7458.0, 3737.551493820759, 4462.34893089559, 4480.843170489017, 4481.126180394792, 4486.327050942385, 7046.471514636525, 7082.893756593552, 7100.325469080429, 7118.822029449305, 7155.284471553011, 6529.444997175293, 6586.6678651506845, 6830.624315662686, 6859.7256109757045, 6870.27862074495, 6041.848953776191, 6079.696015199311, 6692.862213423632, 6770.695318710768, 6773.205184501761, 5437.972810135924, 5950.702464876826, 6724.226713927766, 6743.426808721314, 6861.313868613099, 5286.841394758163, 5907.616004959664, 6692.564983276072, 6856.965715171392, 6872.656367181521, 6188.721507532262, 6677.599344039373, 6697.01072700841, 6736.93263067363, 6751.738167713675], "value": 4904.950541607285, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.6780616528727, 754.3625636337297, 779.894714213581, 808.7343307723417, 870.1037930931141, 16507.42224022158, 17006.404775832834, 17029.829701702994, 18179.636407271846, 19464.318748843794, 18090.909545452287, 18418.355357562454, 18594.442166734985, 18765.0, 18879.43361699148, 985.8866230383508, 1030.8247597908337, 1031.9845202321972, 1034.0125180452649, 1036.383351905615, 996.7059717383389, 1039.469870366115, 1045.7333379988092, 1047.005344922323, 1047.2302857399804, 1088.4448931045144, 1097.7310558913077, 1099.6041425086962, 1101.2126329674281, 1101.251149218531, 1073.3023534702468, 1096.5339730614496, 1097.3525619884226, 1099.3019432660237, 1111.222144498854, 811.4401063266328, 816.0941355095839, 817.4972391978949, 818.2267756969666, 818.3126174013797, 15911.920440397724, 16034.278457469441, 16202.946808457413, 16868.746968795476, 16986.235619397157, 17306.0, 17360.39238626642, 17598.472045838516, 17713.822861771347, 17716.291348346178, 11743.001844843198, 12254.754904901853, 13976.860231397657, 14135.505257316048, 14304.427822887072, 3492.109512074405, 3516.4549494828343, 3518.20840310928, 3521.0, 3524.859005639771, 101567.49216253945, 125188.74811251953, 129729.35135324263, 130668.0, 131956.0, 13365.064445488722, 13439.664008399868, 13440.529581464602, 13562.0, 13589.0, 24318.87840560786, 26199.21402357894, 26200.737992620212, 26255.343616409362, 26759.598606020925, 7937.880931786028, 8090.271875531231, 8116.959415202886, 8118.3099436548555, 8140.104588495261, 3796.37359835624, 3925.5878132796215, 3977.721559490808, 4059.0055436417674, 4064.5935406459707, 4185.937210941838, 4274.658027357804, 4280.379344994958, 4287.506936702257, 4288.442502474721, 942.9811403771886, 945.8439357506072, 953.8330792111353, 956.6081351633356, 960.9903900961041, 632.7816903168399, 645.3159650770199, 659.9769008084694, 661.8180000499805, 677.9186497620317, 10113.848292275621, 11160.776784464266, 13436.664083397798, 13628.250446225553, 13734.862651373558, 634.6890023888261, 640.8718256348749, 645.2740666749906, 661.7121552124842, 680.5406350713348, 5131.61512886535, 5352.866178345573, 5451.591130665216, 5567.805126820623, 5629.127485239713, 98032.50983745178, 98060.0, 98118.50940745251, 98684.01315986892, 99613.0, 90754.0, 91224.07043542148, 91388.0, 92039.61940570897, 93929.0607093934, 80212.0, 80478.0, 81034.59482702667, 81569.0, 82074.0, 7624.80937976555, 8851.69019084329, 9347.597860320735, 10426.0, 10812.45937703096, 23657.0, 27721.584176237775, 30926.0, 31159.0, 39777.60222397739, 52116.0, 52489.0, 52767.416977490735, 71055.0, 75575.7972673682, 16183.271752771388, 16591.0, 16678.49964501067, 16871.66256674884, 16921.83078169252, 15369.692606148039, 18211.635767284846, 18568.81431185671, 19010.809891900903, 19591.412257632295, 17062.829371706124, 17590.824091758917, 18367.724484133018, 18505.259789608805, 18653.160607772956, 17296.567585810455, 17790.110494475484, 18345.72481412753, 18436.801607895442, 18496.537586559905, 16493.34026638969, 17009.91495042517, 17043.65912681764, 17052.0, 17190.828091718922, 9790.951045244728, 10576.576936922436, 11091.223614346918, 11504.61944566624, 11745.765084698087, 13388.19670819754, 13769.931150344184, 13809.585712428241, 13947.721045578828, 14073.859261407664], "value": 8404.409692278676, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 166.0, 172.0, 113.0, 115.0, 115.0, 114.0, 115.0, 115.0, 114.0], "value": 124.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 115.0, 131.0, 149.0, 116.0, 155.0, 132.0, 111.0, 147.0, 110.0], "value": 131.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [207.0, 196.0, 210.0, 222.0, 208.0, 208.0, 197.0, 200.0, 193.0, 196.0], "value": 203.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 56.0, 57.0, 85.0, 56.0, 57.0, 60.0, 58.0, 76.0, 56.0], "value": 64.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 69.0, 83.0, 72.0, 69.0, 69.0, 89.0, 71.0, 69.0, 91.0], "value": 76.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 88.0, 87.0, 88.0, 87.0, 88.0, 89.0, 101.0, 87.0], "value": 89.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 120.0, 135.0, 101.0, 97.0, 149.0, 108.0, 162.0], "value": 116.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 94.0, 93.0, 99.0, 92.0, 90.0, 104.0, 138.0, 92.0, 95.0], "value": 98.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 48.0, 46.0, 51.0, 48.0, 50.0, 51.0, 49.0, 52.0, 53.0], "value": 49.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 69.0, 57.0, 59.0, 77.0, 91.0, 87.0, 70.0, 53.0, 79.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 106.0, 104.0, 82.0, 82.0, 90.0, 106.0, 71.0, 97.0, 109.0], "value": 93.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 129.0, 134.0, 163.0, 178.0, 158.0, 137.0, 138.0, 185.0, 141.0], "value": 150.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [222.0, 192.0, 243.0, 187.0, 197.0, 234.0, 185.0, 183.0, 189.0, 181.0], "value": 201.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 90.0, 83.0, 69.0, 68.0, 68.0, 66.0, 67.0, 72.0, 108.0], "value": 75.7, "unit": "score"}]}]} 17:42:49 INFO - Return code: 0 17:42:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:42:49 ERROR - # TBPL SUCCESS # 17:42:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:42:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:42:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:42:49 INFO - 2017-05-01 17:42:49.859 screenresolution[2898:39221] starting screenresolution argv=screenresolution get 17:42:49 INFO - 2017-05-01 17:42:49.862 screenresolution[2898:39221] Display 0: 1600x1200x32@60 17:42:49 INFO - 2017-05-01 17:42:49.868 screenresolution[2899:39224] starting screenresolution argv=screenresolution list 17:42:49 INFO - Available Modes on Display 0 17:42:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:42:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:42:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:42:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:42:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:42:50 INFO - Intel Iris: 17:42:50 INFO - Chipset Model: Intel Iris 17:42:50 INFO - Type: GPU 17:42:50 INFO - Bus: Built-In 17:42:50 INFO - VRAM (Dynamic, Max): 1536 MB 17:42:50 INFO - Vendor: Intel (0x8086) 17:42:50 INFO - Device ID: 0x0a2e 17:42:50 INFO - Revision ID: 0x0009 17:42:50 INFO - Displays: 17:42:50 INFO - Display: 17:42:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:42:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:42:50 INFO - Display Serial Number: 1600x1200 60 17:42:50 INFO - Main Display: Yes 17:42:50 INFO - Mirror: Off 17:42:50 INFO - Online: Yes 17:42:50 INFO - Rotation: Supported 17:42:50 INFO - Return code: 0 17:42:50 INFO - Running post-action listener: _resource_record_post_action 17:42:50 INFO - [mozharness: 2017-05-02 00:42:50.115810Z] Finished run-tests step (success) 17:42:50 INFO - Running post-run listener: _resource_record_post_run 17:42:50 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 315904; Write bytes: 510983168; Read time: 3; Write time: 1616 17:42:50 INFO - TinderboxPrint: CPU usage
54.2% 17:42:50 INFO - TinderboxPrint: I/O read bytes / time
315,904 / 3 17:42:50 INFO - TinderboxPrint: I/O write bytes / time
510,983,168 / 1,616 17:42:50 INFO - TinderboxPrint: CPU idle
2,190.9 (45.8%) 17:42:50 INFO - TinderboxPrint: CPU system
966.9 (20.2%) 17:42:50 INFO - TinderboxPrint: CPU user
1,628.0 (34.0%) 17:42:50 INFO - TinderboxPrint: Swap in / out
208,461,824 / 0 17:42:50 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 196870656; Write bytes: 194291712; Read time: 14865; Write time: 415 17:42:50 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 315904; Write bytes: 299844608; Read time: 3; Write time: 1148 17:42:50 INFO - Running post-run listener: _upload_blobber_files 17:42:50 INFO - Blob upload gear active. 17:42:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:42:50 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 17:42:50 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'] 17:42:50 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 17:42:51 INFO - (blobuploader) - INFO - Open directory for files ... 17:42:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:42:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:42:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:42:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:42:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:42:51 INFO - (blobuploader) - INFO - Done attempting. 17:42:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:42:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:42:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:42:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:42:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:42:53 INFO - (blobuploader) - INFO - Done attempting. 17:42:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:42:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:42:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:42:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:42:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:42:54 INFO - (blobuploader) - INFO - Done attempting. 17:42:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:42:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:42:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:42:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:42:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:42:56 INFO - (blobuploader) - INFO - Done attempting. 17:42:56 INFO - (blobuploader) - INFO - Iteration through files over. 17:42:56 INFO - Return code: 0 17:42:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:42:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:42:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/009cdf1bcf247e7bd768a30ab117f777b17c7f1196b3a81353f3374cba446c147c722e9a3c6f5dfa3b9c3dca8eb4d0adfc5d0d5646b5e1c190bf6e46e1c9d3c7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b6df02f425948aa551d319c08489ef2fab140a73970107ff66d2739e82d856ccc1f16e582afd3a5b55831f6002184de3c0722b3ae4711154515633439e22600", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61fab80f6bc8e2c6132a513ddd713d478951dbdf8d2ad16cf9348c2c0084f0015770f7d359e7ae9c46ee44d62f2ed9a3e4902785dee4042c33696199a02e438e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3548cc3051bbe0fed3efe951752e8080854dcf21ea65c8a5eb7cf35c8c1f9ac67e9455c3d44fb5310f495fa422c23f435290450ddb9fd8087d34d753ffd9f55a"} 17:42:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:42:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:42:56 INFO - Contents: 17:42:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/009cdf1bcf247e7bd768a30ab117f777b17c7f1196b3a81353f3374cba446c147c722e9a3c6f5dfa3b9c3dca8eb4d0adfc5d0d5646b5e1c190bf6e46e1c9d3c7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b6df02f425948aa551d319c08489ef2fab140a73970107ff66d2739e82d856ccc1f16e582afd3a5b55831f6002184de3c0722b3ae4711154515633439e22600", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61fab80f6bc8e2c6132a513ddd713d478951dbdf8d2ad16cf9348c2c0084f0015770f7d359e7ae9c46ee44d62f2ed9a3e4902785dee4042c33696199a02e438e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3548cc3051bbe0fed3efe951752e8080854dcf21ea65c8a5eb7cf35c8c1f9ac67e9455c3d44fb5310f495fa422c23f435290450ddb9fd8087d34d753ffd9f55a"} 17:42:56 INFO - Running post-run listener: copy_logs_to_upload_dir 17:42:56 INFO - Copying logs to upload dir... 17:42:56 INFO - mkdir: /builds/slave/test/build/upload/logs 17:42:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.627796 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-05-01 17:42:56.569325) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-01 17:42:56.573454) ========= 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.qCh5dsvPAY/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.BDIbPfnKgc/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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/009cdf1bcf247e7bd768a30ab117f777b17c7f1196b3a81353f3374cba446c147c722e9a3c6f5dfa3b9c3dca8eb4d0adfc5d0d5646b5e1c190bf6e46e1c9d3c7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b6df02f425948aa551d319c08489ef2fab140a73970107ff66d2739e82d856ccc1f16e582afd3a5b55831f6002184de3c0722b3ae4711154515633439e22600", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61fab80f6bc8e2c6132a513ddd713d478951dbdf8d2ad16cf9348c2c0084f0015770f7d359e7ae9c46ee44d62f2ed9a3e4902785dee4042c33696199a02e438e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3548cc3051bbe0fed3efe951752e8080854dcf21ea65c8a5eb7cf35c8c1f9ac67e9455c3d44fb5310f495fa422c23f435290450ddb9fd8087d34d753ffd9f55a"} build_url:https://queue.taskcluster.net/v1/task/GXUTVu_CT2SoWeCAVwNIVg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011381 build_url: 'https://queue.taskcluster.net/v1/task/GXUTVu_CT2SoWeCAVwNIVg/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/009cdf1bcf247e7bd768a30ab117f777b17c7f1196b3a81353f3374cba446c147c722e9a3c6f5dfa3b9c3dca8eb4d0adfc5d0d5646b5e1c190bf6e46e1c9d3c7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b6df02f425948aa551d319c08489ef2fab140a73970107ff66d2739e82d856ccc1f16e582afd3a5b55831f6002184de3c0722b3ae4711154515633439e22600", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61fab80f6bc8e2c6132a513ddd713d478951dbdf8d2ad16cf9348c2c0084f0015770f7d359e7ae9c46ee44d62f2ed9a3e4902785dee4042c33696199a02e438e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3548cc3051bbe0fed3efe951752e8080854dcf21ea65c8a5eb7cf35c8c1f9ac67e9455c3d44fb5310f495fa422c23f435290450ddb9fd8087d34d753ffd9f55a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-01 17:42:56.609616) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 17:42:56.610036) ========= 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.qCh5dsvPAY/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.BDIbPfnKgc/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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.005203 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 17:42:56.659734) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-01 17:42:56.660103) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-01 17:42:56.660637) ========= ========= Total master_lag: 0.19 =========