builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0180 starttime: 1493638695.65 results: success (0) buildid: 20170501030204 builduid: ba6e4e2072514cbe9a82b58e9a0be0f9 revision: 076a7a66096f9e8d102548397254be32eb26bc3d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-01 04:38:15.649085) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-01 04:38:15.649615) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-01 04:38:15.649961) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-01 04:38:15.778869) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 04:38:15.779187) ========= 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.xTasaMHuum/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.NCm2W10WT9/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 04:38:15-- 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% 14.7M=0.001s 2017-05-01 04:38:15 (14.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.159487 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 04:38:15.972095) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 04:38:15.972416) ========= 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.xTasaMHuum/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.NCm2W10WT9/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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.029102 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 04:38:16.030876) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-01 04:38:16.031227) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 076a7a66096f9e8d102548397254be32eb26bc3d --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 076a7a66096f9e8d102548397254be32eb26bc3d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xTasaMHuum/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.NCm2W10WT9/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 04:38:16,104 truncating revision to first 12 chars 2017-05-01 04:38:16,104 Setting DEBUG logging. 2017-05-01 04:38:16,104 attempt 1/10 2017-05-01 04:38:16,104 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/076a7a66096f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-01 04:38:17,213 unpacking tar archive at: mozilla-central-076a7a66096f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.405977 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-01 04:38:17.465219) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-01 04:38:17.465977) ========= script_repo_revision: 076a7a66096f9e8d102548397254be32eb26bc3d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-01 04:38:17.466910) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-01 04:38:17.467571) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-01 04:38:17.490980) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-05-01 04:38:17.491292) ========= /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.xTasaMHuum/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.NCm2W10WT9/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:38:17 INFO - MultiFileLogger online at 20170501 04:38:17 in /builds/slave/test 04:38:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:38:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:38:17 INFO - {'append_to_log': False, 04:38:17 INFO - 'base_work_dir': '/builds/slave/test', 04:38:17 INFO - 'blob_upload_branch': 'Firefox', 04:38:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:38:17 INFO - 'branch': 'Firefox', 04:38:17 INFO - 'buildbot_json_path': 'buildprops.json', 04:38:17 INFO - 'config_files': ('talos/mac_config.py',), 04:38:17 INFO - 'default_actions': ('clobber', 04:38:17 INFO - 'read-buildbot-config', 04:38:17 INFO - 'download-and-extract', 04:38:17 INFO - 'populate-webroot', 04:38:17 INFO - 'create-virtualenv', 04:38:17 INFO - 'install', 04:38:17 INFO - 'run-tests'), 04:38:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:38:17 INFO - 'download_minidump_stackwalk': True, 04:38:17 INFO - 'download_symbols': 'ondemand', 04:38:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:38:17 INFO - 'tooltool.py': '/tools/tooltool.py', 04:38:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:38:17 INFO - '/tools/misc-python/virtualenv.py')}, 04:38:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:38:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:38:17 INFO - 'gecko_profile': False, 04:38:17 INFO - 'gecko_profile_interval': 0, 04:38:17 INFO - 'installer_path': 'installer.exe', 04:38:17 INFO - 'log_level': 'info', 04:38:17 INFO - 'log_name': 'talos', 04:38:17 INFO - 'log_to_console': True, 04:38:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:38:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:38:17 INFO - 'opt_config_files': (), 04:38:17 INFO - 'pip_index': False, 04:38:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:38:17 INFO - 'cmd': ('bash', 04:38:17 INFO - '-c', 04:38:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:38:17 INFO - 'enabled': True, 04:38:17 INFO - 'halt_on_failure': False, 04:38:17 INFO - 'name': 'check_screen_resolution'},), 04:38:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:38:17 INFO - 'cmd': ('bash', 04:38:17 INFO - '-c', 04:38:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:38:17 INFO - 'enabled': True, 04:38:17 INFO - 'halt_on_failure': False, 04:38:17 INFO - 'name': 'check_screen_resolution'},), 04:38:17 INFO - 'run_cmd_checks_enabled': True, 04:38:17 INFO - 'suite': 'dromaeojs-e10s', 04:38:17 INFO - 'system_bits': '32', 04:38:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:38:17 INFO - 'title': 't-yosemite-r7-0180', 04:38:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:38:17 INFO - 'use_talos_json': True, 04:38:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:38:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:38:17 INFO - 'work_dir': 'build'} 04:38:17 INFO - [mozharness: 2017-05-01 11:38:17.680105Z] Running clobber step. 04:38:17 INFO - Running pre-action listener: _resource_record_pre_action 04:38:17 INFO - Running main action method: clobber 04:38:17 INFO - rmtree: /builds/slave/test/build 04:38:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:38:20 INFO - Running post-action listener: _resource_record_post_action 04:38:20 INFO - [mozharness: 2017-05-01 11:38:20.218371Z] Finished clobber step (success) 04:38:20 INFO - [mozharness: 2017-05-01 11:38:20.218559Z] Running read-buildbot-config step. 04:38:20 INFO - Running pre-action listener: _resource_record_pre_action 04:38:20 INFO - Running main action method: read_buildbot_config 04:38:20 INFO - Using buildbot properties: 04:38:20 INFO - { 04:38:20 INFO - "project": "", 04:38:20 INFO - "product": "firefox", 04:38:20 INFO - "script_repo_revision": "production", 04:38:20 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:38:20 INFO - "repository": "", 04:38:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:38:20 INFO - "buildid": "20170501030204", 04:38:20 INFO - "stage_platform": "macosx64", 04:38:20 INFO - "basedir": "/builds/slave/test", 04:38:20 INFO - "nightly_build": "True", 04:38:20 INFO - "buildnumber": 58, 04:38:20 INFO - "slavename": "t-yosemite-r7-0180", 04:38:20 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 04:38:20 INFO - "platform": "yosemite_r7", 04:38:20 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:38:20 INFO - "branch": "mozilla-central", 04:38:20 INFO - "repo_path": "mozilla-central", 04:38:20 INFO - "revision": "076a7a66096f9e8d102548397254be32eb26bc3d", 04:38:20 INFO - "pgo_build": "False", 04:38:20 INFO - "builduid": "ba6e4e2072514cbe9a82b58e9a0be0f9", 04:38:20 INFO - "slavebuilddir": "test" 04:38:20 INFO - } 04:38:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:38:20 INFO - Running post-action listener: _resource_record_post_action 04:38:20 INFO - [mozharness: 2017-05-01 11:38:20.221961Z] Finished read-buildbot-config step (success) 04:38:20 INFO - [mozharness: 2017-05-01 11:38:20.222072Z] Running download-and-extract step. 04:38:20 INFO - Running pre-action listener: _resource_record_pre_action 04:38:20 INFO - Running main action method: download_and_extract 04:38:20 INFO - mkdir: /builds/slave/test/build/tests 04:38:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:20 INFO - trying https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:38:20 INFO - Downloading https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:38:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:38:21 INFO - Downloaded 1325 bytes. 04:38:21 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:38:21 INFO - Using the following test package requirements: 04:38:21 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:38:21 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:38:21 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:38:21 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:38:21 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:38:21 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:38:21 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:38:21 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:38:21 INFO - u'jsshell-mac.zip'], 04:38:21 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:38:21 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:38:21 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:38:21 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:38:21 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:38:21 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:38:21 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:38:21 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:38:21 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:38:21 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:38:21 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:38:21 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:38:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:38:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:38:21 INFO - Fetch https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:38:22 INFO - Content-Length response header: 52699090 04:38:22 INFO - Bytes received: 52699090 04:38:39 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:38:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:38:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:38:39 INFO - Fetch https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:38:41 INFO - Content-Length response header: 52699090 04:38:41 INFO - Bytes received: 52699090 04:38:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:38:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:38:56 INFO - Fetch https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:38:57 INFO - Content-Length response header: 14408811 04:38:57 INFO - Bytes received: 14408811 04:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:57 INFO - trying https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:38:57 INFO - Downloading https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:38:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:38:59 INFO - Downloaded 71324432 bytes. 04:38:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:38:59 INFO - mkdir: /builds/slave/test/properties 04:38:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:38:59 INFO - Writing to file /builds/slave/test/properties/build_url 04:38:59 INFO - Contents: 04:38:59 INFO - build_url:https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:39:00 INFO - Running post-action listener: _resource_record_post_action 04:39:00 INFO - Running post-action listener: set_extra_try_arguments 04:39:00 INFO - [mozharness: 2017-05-01 11:39:00.541764Z] Finished download-and-extract step (success) 04:39:00 INFO - [mozharness: 2017-05-01 11:39:00.541921Z] Running populate-webroot step. 04:39:00 INFO - Running pre-action listener: _resource_record_pre_action 04:39:00 INFO - Running main action method: populate_webroot 04:39:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:39:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:39:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:39:00 INFO - '--tppagecycles', 04:39:00 INFO - '7'], 04:39:00 INFO - 'tests': ['tsvgm']}}, 04:39:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:39:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:39:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:39:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:39:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:39:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:39:00 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:39:00 INFO - 'talos_options': ['--disable-e10s'], 04:39:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:39:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:39:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:39:00 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:39:00 INFO - 'talos_options': ['--disable-e10s'], 04:39:00 INFO - 'tests': ['damp', 'tps']}, 04:39:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:39:00 INFO - 'tests': ['damp', 'tps']}, 04:39:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:39:00 INFO - 'tests': ['dromaeo_dom']}, 04:39:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:39:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:39:00 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:39:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:39:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:39:00 INFO - 'tests': ['a11yr', 04:39:00 INFO - 'ts_paint', 04:39:00 INFO - 'tpaint', 04:39:00 INFO - 'sessionrestore', 04:39:00 INFO - 'sessionrestore_no_auto_restore', 04:39:00 INFO - 'tabpaint']}, 04:39:00 INFO - 'other-e10s': {'tests': ['a11yr', 04:39:00 INFO - 'ts_paint', 04:39:00 INFO - 'tpaint', 04:39:00 INFO - 'sessionrestore', 04:39:00 INFO - 'sessionrestore_no_auto_restore', 04:39:00 INFO - 'tabpaint']}, 04:39:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:39:00 INFO - 'ts_paint', 04:39:00 INFO - 'tpaint', 04:39:00 INFO - 'sessionrestore', 04:39:00 INFO - 'sessionrestore_no_auto_restore', 04:39:00 INFO - 'tabpaint']}, 04:39:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:39:00 INFO - 'ts_paint', 04:39:00 INFO - 'tpaint', 04:39:00 INFO - 'sessionrestore', 04:39:00 INFO - 'sessionrestore_no_auto_restore', 04:39:00 INFO - 'tabpaint']}, 04:39:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:39:00 INFO - 'tests': ['a11yr', 04:39:00 INFO - 'ts_paint', 04:39:00 INFO - 'tpaint', 04:39:00 INFO - 'sessionrestore', 04:39:00 INFO - 'sessionrestore_no_auto_restore', 04:39:00 INFO - 'tabpaint']}, 04:39:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:39:00 INFO - 'tests': ['a11yr', 04:39:00 INFO - 'ts_paint', 04:39:00 INFO - 'tpaint', 04:39:00 INFO - 'sessionrestore', 04:39:00 INFO - 'sessionrestore_no_auto_restore', 04:39:00 INFO - 'tabpaint']}, 04:39:00 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:39:00 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:39:00 INFO - 'bloom_basic_ref']}, 04:39:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:39:00 INFO - 'tests': ['tsvgx', 04:39:00 INFO - 'tsvgr_opacity', 04:39:00 INFO - 'tart', 04:39:00 INFO - 'tscrollx', 04:39:00 INFO - 'cart', 04:39:00 INFO - 'tsvg_static']}, 04:39:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:39:00 INFO - 'tsvgr_opacity', 04:39:00 INFO - 'tart', 04:39:00 INFO - 'tscrollx', 04:39:00 INFO - 'cart', 04:39:00 INFO - 'tsvg_static']}, 04:39:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:39:00 INFO - 'talos_options': ['--disable-e10s'], 04:39:00 INFO - 'tests': ['tp5o']}, 04:39:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:39:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:39:00 INFO - 'talos_options': ['--disable-e10s', 04:39:00 INFO - '--xperf_path', 04:39:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:39:00 INFO - 'tests': ['tp5n']}, 04:39:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:39:00 INFO - 'talos_options': ['--xperf_path', 04:39:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:39:00 INFO - 'tests': ['tp5n']}}, 04:39:00 INFO - 'talos.zip': {'path': '', 04:39:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:39:00 INFO - Running post-action listener: _resource_record_post_action 04:39:00 INFO - [mozharness: 2017-05-01 11:39:00.561515Z] Finished populate-webroot step (success) 04:39:00 INFO - [mozharness: 2017-05-01 11:39:00.561626Z] Running create-virtualenv step. 04:39:00 INFO - Running pre-action listener: _resource_record_pre_action 04:39:00 INFO - Running main action method: create_virtualenv 04:39:00 INFO - Creating virtualenv /builds/slave/test/build/venv 04:39:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:39:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:39:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:39:00 INFO - Using real prefix '/tools/python27' 04:39:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:39:01 INFO - Installing distribute.............................................................................................................................................................................................done. 04:39:04 INFO - Installing pip.................done. 04:39:04 INFO - Return code: 0 04:39:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:39:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:39:04 INFO - Reading from file tmpfile_stdout 04:39:04 INFO - Output received: 04:39:04 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:39:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e782b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e785768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcc9472850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e560d30>, '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 0x10e486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e555be8>, '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.xTasaMHuum/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.NCm2W10WT9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:39:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:39:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xTasaMHuum/Render', 04:39:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:04 INFO - 'HOME': '/Users/cltbld', 04:39:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:04 INFO - 'LOGNAME': 'cltbld', 04:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:04 INFO - 'MOZ_NO_REMOTE': '1', 04:39:04 INFO - 'NO_EM_RESTART': '1', 04:39:04 INFO - 'PAGER': '/bin/cat', 04:39:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:04 INFO - 'PWD': '/builds/slave/test', 04:39:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:04 INFO - 'SHELL': '/bin/bash', 04:39:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NCm2W10WT9/Listeners', 04:39:04 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 04:39:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:04 INFO - 'USER': 'cltbld', 04:39:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:04 INFO - 'XPC_FLAGS': '0x0', 04:39:04 INFO - 'XPC_SERVICE_NAME': '0', 04:39:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:39:04 INFO - Cleaning up... 04:39:04 INFO - Return code: 0 04:39:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e782b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e785768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcc9472850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e560d30>, '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 0x10e486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e555be8>, '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.xTasaMHuum/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.NCm2W10WT9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:39:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:39:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xTasaMHuum/Render', 04:39:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:04 INFO - 'HOME': '/Users/cltbld', 04:39:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:04 INFO - 'LOGNAME': 'cltbld', 04:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:04 INFO - 'MOZ_NO_REMOTE': '1', 04:39:04 INFO - 'NO_EM_RESTART': '1', 04:39:04 INFO - 'PAGER': '/bin/cat', 04:39:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:04 INFO - 'PWD': '/builds/slave/test', 04:39:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:04 INFO - 'SHELL': '/bin/bash', 04:39:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NCm2W10WT9/Listeners', 04:39:04 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 04:39:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:04 INFO - 'USER': 'cltbld', 04:39:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:04 INFO - 'XPC_FLAGS': '0x0', 04:39:04 INFO - 'XPC_SERVICE_NAME': '0', 04:39:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:05 INFO - Downloading/unpacking psutil>=3.1.1 04:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:39:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:09 INFO - Installing collected packages: psutil 04:39:09 INFO - Running setup.py install for psutil 04:39:09 INFO - building 'psutil._psutil_osx' extension 04:39:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:39:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:39:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:39:10 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:39:10 INFO - building 'psutil._psutil_posix' extension 04:39:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:39:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:39:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:39:10 INFO - ^ 04:39:10 INFO - 1 warning generated. 04:39:10 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:39:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:10 INFO - Successfully installed psutil 04:39:10 INFO - Cleaning up... 04:39:10 INFO - Return code: 0 04:39:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e782b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e785768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcc9472850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e560d30>, '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 0x10e486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e555be8>, '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.xTasaMHuum/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.NCm2W10WT9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:39:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xTasaMHuum/Render', 04:39:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:10 INFO - 'HOME': '/Users/cltbld', 04:39:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:10 INFO - 'LOGNAME': 'cltbld', 04:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:10 INFO - 'MOZ_NO_REMOTE': '1', 04:39:10 INFO - 'NO_EM_RESTART': '1', 04:39:10 INFO - 'PAGER': '/bin/cat', 04:39:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:10 INFO - 'PWD': '/builds/slave/test', 04:39:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:10 INFO - 'SHELL': '/bin/bash', 04:39:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NCm2W10WT9/Listeners', 04:39:10 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 04:39:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:10 INFO - 'USER': 'cltbld', 04:39:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:10 INFO - 'XPC_FLAGS': '0x0', 04:39:10 INFO - 'XPC_SERVICE_NAME': '0', 04:39:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:39:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:39:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:39:13 INFO - Installing collected packages: mozsystemmonitor 04:39:13 INFO - Running setup.py install for mozsystemmonitor 04:39:13 INFO - Successfully installed mozsystemmonitor 04:39:13 INFO - Cleaning up... 04:39:13 INFO - Return code: 0 04:39:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:39: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')]} 04:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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')]} 04:39:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:13 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 0x10e782b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e785768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcc9472850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e560d30>, '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 0x10e486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e555be8>, '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.xTasaMHuum/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.NCm2W10WT9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:39:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:39:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xTasaMHuum/Render', 04:39:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:13 INFO - 'HOME': '/Users/cltbld', 04:39:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:13 INFO - 'LOGNAME': 'cltbld', 04:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:13 INFO - 'MOZ_NO_REMOTE': '1', 04:39:13 INFO - 'NO_EM_RESTART': '1', 04:39:13 INFO - 'PAGER': '/bin/cat', 04:39:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:13 INFO - 'PWD': '/builds/slave/test', 04:39:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:13 INFO - 'SHELL': '/bin/bash', 04:39:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NCm2W10WT9/Listeners', 04:39:13 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 04:39:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:13 INFO - 'USER': 'cltbld', 04:39:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:13 INFO - 'XPC_FLAGS': '0x0', 04:39:13 INFO - 'XPC_SERVICE_NAME': '0', 04:39:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:14 INFO - Downloading/unpacking jsonschema==2.5.1 04:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:39:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:17 INFO - Downloading functools32-3.2.3-2.tar.gz 04:39:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:39:17 INFO - warning: no files found matching '*.txt' 04:39:17 INFO - no previously-included directories found matching 'build' 04:39:17 INFO - no previously-included directories found matching 'dist' 04:39:17 INFO - no previously-included directories found matching '.git*' 04:39:17 INFO - Installing collected packages: jsonschema, functools32 04:39:17 INFO - Running setup.py install for functools32 04:39:17 INFO - warning: no files found matching '*.txt' 04:39:17 INFO - no previously-included directories found matching 'build' 04:39:17 INFO - no previously-included directories found matching 'dist' 04:39:17 INFO - no previously-included directories found matching '.git*' 04:39:17 INFO - Successfully installed jsonschema functools32 04:39:17 INFO - Cleaning up... 04:39:17 INFO - Return code: 0 04:39:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:39: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')]} 04:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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')]} 04:39:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:17 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 0x10e782b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e785768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcc9472850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e560d30>, '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 0x10e486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e555be8>, '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.xTasaMHuum/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.NCm2W10WT9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:39:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xTasaMHuum/Render', 04:39:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:17 INFO - 'HOME': '/Users/cltbld', 04:39:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:17 INFO - 'LOGNAME': 'cltbld', 04:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:17 INFO - 'MOZ_NO_REMOTE': '1', 04:39:17 INFO - 'NO_EM_RESTART': '1', 04:39:17 INFO - 'PAGER': '/bin/cat', 04:39:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:17 INFO - 'PWD': '/builds/slave/test', 04:39:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:17 INFO - 'SHELL': '/bin/bash', 04:39:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NCm2W10WT9/Listeners', 04:39:17 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 04:39:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:17 INFO - 'USER': 'cltbld', 04:39:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:17 INFO - 'XPC_FLAGS': '0x0', 04:39:17 INFO - 'XPC_SERVICE_NAME': '0', 04:39:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:39:17 INFO - Cleaning up... 04:39:17 INFO - Return code: 0 04:39:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:39: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')]} 04:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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')]} 04:39:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:17 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 0x10e782b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e785768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcc9472850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e560d30>, '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 0x10e486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e555be8>, '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.xTasaMHuum/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.NCm2W10WT9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:39:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xTasaMHuum/Render', 04:39:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:17 INFO - 'HOME': '/Users/cltbld', 04:39:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:17 INFO - 'LOGNAME': 'cltbld', 04:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:17 INFO - 'MOZ_NO_REMOTE': '1', 04:39:17 INFO - 'NO_EM_RESTART': '1', 04:39:17 INFO - 'PAGER': '/bin/cat', 04:39:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:17 INFO - 'PWD': '/builds/slave/test', 04:39:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:17 INFO - 'SHELL': '/bin/bash', 04:39:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NCm2W10WT9/Listeners', 04:39:17 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 04:39:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:17 INFO - 'USER': 'cltbld', 04:39:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:17 INFO - 'XPC_FLAGS': '0x0', 04:39:17 INFO - 'XPC_SERVICE_NAME': '0', 04:39:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:17 INFO - Downloading/unpacking blobuploader==1.2.4 04:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:20 INFO - Downloading blobuploader-1.2.4.tar.gz 04:39:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:39:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:39:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:21 INFO - Downloading docopt-0.6.1.tar.gz 04:39:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:39:21 INFO - Installing collected packages: blobuploader, requests, docopt 04:39:21 INFO - Running setup.py install for blobuploader 04:39:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:39:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:39:22 INFO - Running setup.py install for requests 04:39:22 INFO - Running setup.py install for docopt 04:39:22 INFO - Successfully installed blobuploader requests docopt 04:39:22 INFO - Cleaning up... 04:39:22 INFO - Return code: 0 04:39:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:22 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 0x10e782b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e785768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcc9472850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e560d30>, '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 0x10e486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e555be8>, '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.xTasaMHuum/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.NCm2W10WT9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:39:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:39:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xTasaMHuum/Render', 04:39:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:22 INFO - 'HOME': '/Users/cltbld', 04:39:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:22 INFO - 'LOGNAME': 'cltbld', 04:39:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:22 INFO - 'MOZ_NO_REMOTE': '1', 04:39:22 INFO - 'NO_EM_RESTART': '1', 04:39:22 INFO - 'PAGER': '/bin/cat', 04:39:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:22 INFO - 'PWD': '/builds/slave/test', 04:39:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:22 INFO - 'SHELL': '/bin/bash', 04:39:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NCm2W10WT9/Listeners', 04:39:22 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 04:39:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:22 INFO - 'USER': 'cltbld', 04:39:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:22 INFO - 'XPC_FLAGS': '0x0', 04:39:22 INFO - 'XPC_SERVICE_NAME': '0', 04:39:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:23 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-wfhHE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:23 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-dC2LG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:23 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-ADzYfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:23 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-9s9Sj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:23 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-f38tYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:23 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-tjHa1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:23 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-M0RGK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:23 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-wJpZ5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:23 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Gd1ats-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:23 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-sAqvSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:24 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Ia89CC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:24 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-hszBIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:24 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-lTj8Up-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:24 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-96gbJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:24 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Zc1r93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:24 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Ix1eMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:24 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-xvAJQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:39:24 INFO - Running setup.py install for manifestparser 04:39:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:39:24 INFO - Running setup.py install for mozcrash 04:39:25 INFO - Running setup.py install for mozdebug 04:39:25 INFO - Running setup.py install for mozdevice 04:39:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:39:25 INFO - Running setup.py install for mozfile 04:39:25 INFO - Running setup.py install for mozhttpd 04:39:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:39:25 INFO - Running setup.py install for mozinfo 04:39:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:39:25 INFO - Running setup.py install for mozInstall 04:39:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:39:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:39:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:39:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:39:25 INFO - Running setup.py install for mozleak 04:39:26 INFO - Running setup.py install for mozlog 04:39:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:39:26 INFO - Running setup.py install for moznetwork 04:39:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:39:26 INFO - Running setup.py install for mozprocess 04:39:26 INFO - Running setup.py install for mozprofile 04:39:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:39:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:39:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:39:26 INFO - Running setup.py install for mozrunner 04:39:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:39:26 INFO - Running setup.py install for mozscreenshot 04:39:27 INFO - Running setup.py install for moztest 04:39:27 INFO - Running setup.py install for mozversion 04:39:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:39:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:39:27 INFO - Cleaning up... 04:39:27 INFO - Return code: 0 04:39:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:27 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 0x10e782b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e785768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcc9472850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e560d30>, '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 0x10e486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e555be8>, '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.xTasaMHuum/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.NCm2W10WT9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:39:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:39:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xTasaMHuum/Render', 04:39:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:27 INFO - 'HOME': '/Users/cltbld', 04:39:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:27 INFO - 'LOGNAME': 'cltbld', 04:39:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:27 INFO - 'MOZ_NO_REMOTE': '1', 04:39:27 INFO - 'NO_EM_RESTART': '1', 04:39:27 INFO - 'PAGER': '/bin/cat', 04:39:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:27 INFO - 'PWD': '/builds/slave/test', 04:39:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:27 INFO - 'SHELL': '/bin/bash', 04:39:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NCm2W10WT9/Listeners', 04:39:27 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 04:39:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:27 INFO - 'USER': 'cltbld', 04:39:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:27 INFO - 'XPC_FLAGS': '0x0', 04:39:27 INFO - 'XPC_SERVICE_NAME': '0', 04:39:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:27 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-1rTDBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:27 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-ee7K6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:27 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-LhwiH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:27 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-VmQd2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:28 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)) 04:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:28 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-k6KwpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:28 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-tlzz_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:28 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-KPNjNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:28 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-2uyNQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:28 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-A19r4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:28 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-XnKi0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:28 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-jV3trE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:28 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-cldLFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:28 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-2qHgG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:29 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-LNS3ED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:29 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-S0AkCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:29 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Wmcc8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:29 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-tPVsRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:39:29 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)) 04:39:29 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)) 04:39:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:32 INFO - Downloading blessings-1.6.tar.gz 04:39:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:39:32 INFO - Installing collected packages: blessings 04:39:32 INFO - Running setup.py install for blessings 04:39:32 INFO - Successfully installed blessings 04:39:32 INFO - Cleaning up... 04:39:32 INFO - Return code: 0 04:39:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:39:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:32 INFO - Reading from file tmpfile_stdout 04:39:32 INFO - Current package versions: 04:39:32 INFO - blessings == 1.6 04:39:32 INFO - blobuploader == 1.2.4 04:39:32 INFO - docopt == 0.6.1 04:39:32 INFO - functools32 == 3.2.3-2 04:39:32 INFO - jsonschema == 2.5.1 04:39:32 INFO - manifestparser == 1.1 04:39:32 INFO - mozInstall == 1.12 04:39:32 INFO - mozcrash == 1.0 04:39:32 INFO - mozdebug == 0.1 04:39:32 INFO - mozdevice == 0.50 04:39:32 INFO - mozfile == 1.2 04:39:32 INFO - mozhttpd == 0.7 04:39:32 INFO - mozinfo == 0.9 04:39:32 INFO - mozleak == 0.1 04:39:32 INFO - mozlog == 3.4 04:39:32 INFO - moznetwork == 0.27 04:39:32 INFO - mozprocess == 0.25 04:39:32 INFO - mozprofile == 0.28 04:39:32 INFO - mozrunner == 6.13 04:39:32 INFO - mozscreenshot == 0.1 04:39:32 INFO - mozsystemmonitor == 0.3 04:39:32 INFO - moztest == 0.8 04:39:32 INFO - mozversion == 1.4 04:39:32 INFO - psutil == 3.1.1 04:39:32 INFO - requests == 1.2.3 04:39:32 INFO - wsgiref == 0.1.2 04:39:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:32 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 0x10e782b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e785768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcc9472850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e560d30>, '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 0x10e486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e555be8>, '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.xTasaMHuum/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.NCm2W10WT9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:39:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:39:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xTasaMHuum/Render', 04:39:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:32 INFO - 'HOME': '/Users/cltbld', 04:39:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:32 INFO - 'LOGNAME': 'cltbld', 04:39:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:32 INFO - 'MOZ_NO_REMOTE': '1', 04:39:32 INFO - 'NO_EM_RESTART': '1', 04:39:32 INFO - 'PAGER': '/bin/cat', 04:39:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:32 INFO - 'PWD': '/builds/slave/test', 04:39:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:32 INFO - 'SHELL': '/bin/bash', 04:39:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NCm2W10WT9/Listeners', 04:39:32 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 04:39:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:32 INFO - 'USER': 'cltbld', 04:39:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:32 INFO - 'XPC_FLAGS': '0x0', 04:39:32 INFO - 'XPC_SERVICE_NAME': '0', 04:39:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:39:33 INFO - Cleaning up... 04:39:33 INFO - Return code: 0 04:39:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:39: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')]} 04:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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')]} 04:39:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e782b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e785768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcc9472850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e560d30>, '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 0x10e486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e555be8>, '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.xTasaMHuum/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.NCm2W10WT9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39: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'] in /builds/slave/test/build 04:39: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 04:39:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xTasaMHuum/Render', 04:39:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:33 INFO - 'HOME': '/Users/cltbld', 04:39:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:33 INFO - 'LOGNAME': 'cltbld', 04:39:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:33 INFO - 'MOZ_NO_REMOTE': '1', 04:39:33 INFO - 'NO_EM_RESTART': '1', 04:39:33 INFO - 'PAGER': '/bin/cat', 04:39:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:33 INFO - 'PWD': '/builds/slave/test', 04:39:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:33 INFO - 'SHELL': '/bin/bash', 04:39:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NCm2W10WT9/Listeners', 04:39:33 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 04:39:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:33 INFO - 'USER': 'cltbld', 04:39:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:33 INFO - 'XPC_FLAGS': '0x0', 04:39:33 INFO - 'XPC_SERVICE_NAME': '0', 04:39:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:39:33 INFO - Cleaning up... 04:39:33 INFO - Return code: 0 04:39:33 INFO - Running post-action listener: _resource_record_post_action 04:39:33 INFO - Running post-action listener: _start_resource_monitoring 04:39:33 INFO - Starting resource monitoring. 04:39:33 INFO - [mozharness: 2017-05-01 11:39:33.316168Z] Finished create-virtualenv step (success) 04:39:33 INFO - [mozharness: 2017-05-01 11:39:33.317163Z] Running install step. 04:39:33 INFO - Running pre-action listener: _resource_record_pre_action 04:39:33 INFO - Running main action method: install 04:39:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:33 INFO - Reading from file tmpfile_stdout 04:39:33 INFO - Detecting whether we're running mozinstall >=1.0... 04:39:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:39:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:39:33 INFO - Reading from file tmpfile_stdout 04:39:33 INFO - Output received: 04:39:33 INFO - Usage: mozinstall [options] installer 04:39:33 INFO - Options: 04:39:33 INFO - -h, --help show this help message and exit 04:39:33 INFO - -d DEST, --destination=DEST 04:39:33 INFO - Directory to install application into. [default: 04:39:33 INFO - "/builds/slave/test"] 04:39:33 INFO - --app=APP Application being installed. [default: firefox] 04:39:33 INFO - mkdir: /builds/slave/test/build/application 04:39:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:39:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:39:53 INFO - Reading from file tmpfile_stdout 04:39:53 INFO - Output received: 04:39:53 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:39:53 INFO - Running post-action listener: _resource_record_post_action 04:39:53 INFO - [mozharness: 2017-05-01 11:39:53.919662Z] Finished install step (success) 04:39:53 INFO - [mozharness: 2017-05-01 11:39:53.919831Z] Running run-tests step. 04:39:53 INFO - Running pre-action listener: _resource_record_pre_action 04:39:53 INFO - Running main action method: run_tests 04:39:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:39:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:39:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:39:53 INFO - 2017-05-01 04:39:53.935 screenresolution[1644:8513] starting screenresolution argv=screenresolution get 04:39:53 INFO - 2017-05-01 04:39:53.938 screenresolution[1644:8513] Display 0: 1600x1200x32@60 04:39:53 INFO - 2017-05-01 04:39:53.943 screenresolution[1645:8520] starting screenresolution argv=screenresolution list 04:39:53 INFO - Available Modes on Display 0 04:39:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:39:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:39:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:39:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:39:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:39:54 INFO - Intel Iris: 04:39:54 INFO - Chipset Model: Intel Iris 04:39:54 INFO - Type: GPU 04:39:54 INFO - Bus: Built-In 04:39:54 INFO - VRAM (Dynamic, Max): 1536 MB 04:39:54 INFO - Vendor: Intel (0x8086) 04:39:54 INFO - Device ID: 0x0a2e 04:39:54 INFO - Revision ID: 0x0009 04:39:54 INFO - Displays: 04:39:54 INFO - Display: 04:39:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:39:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:39:54 INFO - Display Serial Number: 1600x1200 60 04:39:54 INFO - Main Display: Yes 04:39:54 INFO - Mirror: Off 04:39:54 INFO - Online: Yes 04:39:54 INFO - Rotation: Supported 04:39:54 INFO - Return code: 0 04:39:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:39:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:39:54 INFO - Python 2.7.3 04:39:54 INFO - Return code: 0 04:39:54 INFO - grabbing minidump binary from tooltool 04:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:54 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 0x10e560d30>, '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 0x10e486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e555be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:39:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:39:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:39:54 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:39:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:39:54 INFO - Return code: 0 04:39:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:39:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:39:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:39:54 INFO - ENV: RUST_BACKTRACE is now 1 04:39:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:39:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:39:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0180', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:39:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0180 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:39:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xTasaMHuum/Render', 04:39:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:54 INFO - 'HOME': '/Users/cltbld', 04:39:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:54 INFO - 'LOGNAME': 'cltbld', 04:39:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:39:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:54 INFO - 'MOZ_NO_REMOTE': '1', 04:39:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:39:54 INFO - 'NO_EM_RESTART': '1', 04:39:54 INFO - 'PAGER': '/bin/cat', 04:39:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:54 INFO - 'PWD': '/builds/slave/test', 04:39:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:39:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:54 INFO - 'RUST_BACKTRACE': '1', 04:39:54 INFO - 'SHELL': '/bin/bash', 04:39:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NCm2W10WT9/Listeners', 04:39:54 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 04:39:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:54 INFO - 'USER': 'cltbld', 04:39:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:54 INFO - 'XPC_FLAGS': '0x0', 04:39:54 INFO - 'XPC_SERVICE_NAME': '0', 04:39:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0180', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:39:54 INFO - mozversion application_buildid: 20170501030204 04:39:54 INFO - mozversion application_changeset: 076a7a66096f9e8d102548397254be32eb26bc3d 04:39:54 INFO - mozversion application_display_name: Nightly 04:39:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:39:54 INFO - mozversion application_name: Firefox 04:39:54 INFO - mozversion application_remotingname: firefox 04:39:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:39:54 INFO - mozversion application_vendor: Mozilla 04:39:54 INFO - mozversion application_version: 55.0a1 04:39:54 INFO - mozversion platform_buildid: 20170501030204 04:39:54 INFO - mozversion platform_changeset: 076a7a66096f9e8d102548397254be32eb26bc3d 04:39:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:39:54 INFO - mozversion platform_version: 55.0a1 04:39:54 INFO - using testdate: 1493638794 04:39:54 INFO - actual date: 1493638794 04:39:54 INFO - starting webserver on 'localhost:49236' 04:39:54 INFO - SUITE-START | Running 2 tests 04:39:54 INFO - TEST-START | dromaeo_css 04:39:54 INFO - operating with platform_type : mac_ 04:39:54 INFO - Initialising browser for dromaeo_css test... 04:39:54 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpsPckYn/profile http://localhost:49236/getInfo.html) 04:39:57 INFO - PID 1655 | 2017-05-01 04:39:57.789 plugin-container[1658:8714] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x983f, name = 'com.apple.tsm.portname' 04:39:57 INFO - PID 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:39:57 INFO - PID 1655 | 2017-05-01 04:39:57.789 plugin-container[1658:8714] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d1b, name = 'com.apple.CFPasteboardClient' 04:39:57 INFO - PID 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:39:57 INFO - PID 1655 | 2017-05-01 04:39:57.789 plugin-container[1658:8714] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:39:57 INFO - PID 1655 | __metrics Screen width/height:1600/1200 04:39:57 INFO - PID 1655 | colorDepth:24 04:39:57 INFO - PID 1655 | Browser inner width/height: 1024/689 04:39:57 INFO - PID 1655 | __metrics 04:39:58 INFO - TEST-INFO | 1655: exit 0 04:39:58 INFO - Browser initialized. 04:39:58 INFO - Running cycle 1/1 for dromaeo_css test... 04:39:58 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpsPckYn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:01 INFO - PID 1659 | 2017-05-01 04:40:01.372 plugin-container[1660:8847] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 04:40:01 INFO - PID 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:40:01 INFO - PID 1659 | 2017-05-01 04:40:01.372 plugin-container[1660:8847] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 04:40:01 INFO - PID 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:40:01 INFO - PID 1659 | 2017-05-01 04:40:01.372 plugin-container[1660:8847] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:40:11 INFO - PID 1659 | RSS: Main: 235204608 04:40:11 INFO - PID 1659 | 04:43:14 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 04:43:16 INFO - PID 1659 | RSS: Main: 260186112 04:43:16 INFO - PID 1659 | 04:44:59 INFO - PID 1659 | ************************* 04:44:59 INFO - PID 1659 | A coding exception was thrown and uncaught in a Task. 04:44:59 INFO - PID 1659 | 04:44:59 ERROR - PID 1659 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:44:59 INFO - PID 1659 | Full stack: 04:44:59 INFO - PID 1659 | ************************* 04:44:59 INFO - PID 1659 | ************************* 04:44:59 INFO - PID 1659 | A coding exception was thrown and uncaught in a Task. 04:44:59 INFO - PID 1659 | 04:44:59 ERROR - PID 1659 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:44:59 INFO - PID 1659 | Full stack: 04:44:59 INFO - PID 1659 | ************************* 04:44:59 INFO - PID 1659 | ************************* 04:44:59 INFO - PID 1659 | A coding exception was thrown and uncaught in a Task. 04:44:59 INFO - PID 1659 | 04:44:59 ERROR - PID 1659 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:44:59 INFO - PID 1659 | Full stack: 04:44:59 INFO - PID 1659 | ************************* 04:44:59 INFO - PID 1659 | ************************* 04:44:59 INFO - PID 1659 | A coding exception was thrown and uncaught in a Task. 04:44:59 INFO - PID 1659 | 04:44:59 ERROR - PID 1659 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:44:59 INFO - PID 1659 | Full stack: 04:44:59 INFO - PID 1659 | ************************* 04:46:18 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 04:46:19 INFO - PID 1659 | RSS: Main: 261734400 04:46:19 INFO - PID 1659 | 04:49:20 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 04:49:21 INFO - PID 1659 | RSS: Main: 270520320 04:49:21 INFO - PID 1659 | 04:52:23 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 04:52:24 INFO - PID 1659 | RSS: Main: 263024640 04:52:24 INFO - PID 1659 | 04:55:26 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 04:55:27 INFO - PID 1659 | RSS: Main: 272134144 04:55:27 INFO - PID 1659 | 04:58:29 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 04:58:29 INFO - PID 1659 | RSS: Main: 266715136 04:58:29 INFO - PID 1659 | 04:58:29 INFO - PID 1659 | __start_tp_report 04:58:29 INFO - PID 1659 | _x_x_mozilla_page_load 04:58:29 INFO - PID 1659 | _x_x_mozilla_page_load_details 04:58:29 INFO - PID 1659 | |i|pagename|runs| 04:58:29 INFO - PID 1659 | |0;dojo.html;3364.4953257011443;3490.110021944404;3535.292941411718;3558.8042657653837;3614.9819250903743;4449.176902273081;6067.393260673931;6119.112728654348;6124.050772130327;6290.716917738701;6149.661768602725;6164.167837341957;6187.35032821554;6234.84412889678;6306.400891915261;4911.894823664665;4932.383452068491;5375.086235340002;5399.325084364455;5402.459754024605;4176.7911604419805;5470.753816078266;5515.310586176728;5560.77756889726;5574.442555744434;4360.280553708634;5328.92006619901;5383.650062745909;5438.972805135989;5547.805826796063;5432.75552600134;5440.265564148829;5451.727413629303;5492.945070549284;5501.724913754337;5394.352677678665;5426.972865135688;5453.945460545384;5456.727163641802;5485.424030476783;4842.878928026792;5874.676892770896;6120.294761999619;6236.235191178587;6305.432511074026;6530.902036469457;6629.303923088103;6678.799636010927;6682.298358672367;6695.899561506532;6811.421029212523;6814.046033555306;6819.897701534481;6825.385715285648;6826.4538836892925;6287.402696743802;6332.525060620472;6362.141110950009;6376.84057898547;6382.20222472191;6650.501212409089;6729.091572637729;6781.559198652072;6840.213375461885;6876.553024053421;6342.873142537123;6374.649394283359;6383.457406120532;6519.185101862267;6603.438707709898;6619.338066193439;6660.600363978177;6693.263740988487;6712.295209003082;6742.49431292655;6623.205215374186;6645.534812563171;6647.966760166169;6652.501062420338;6663.766768163188;6403.967980160162;6492.285848556655;6497;6567.310432404624;6672.499562532829;5274.472552744694;5306.389765176977;5313.415524292324;5329.680219186861;5351.3043304370185;4673.813047478131;4701.929471057937;4704.388429504211;4713.646476514206;4726.007538416902;6118.923762351665;6308.495320374359;6324.841878953063;6368.490520758328;6389.584676995981;6614.470842332602;6695.598264104169;6718.32816718334;6746.797596072126;6782.93217067823;6282.246130464282;6296.307406185316;6339.683015849189;6350.4284614384005;6362.650054247061;5625.774969001276;5874.353821079678;5882.058870580687;5887.058070708752;5897.734601942923;6760;6761.121054263012;6862.965685171542;6891.931080689129;6903.275156108536;5672.7163641816915;6705.865882682221;6776.2207346153855;6783.3555812197765;6803.659817009228;6874.587524748531;6938.826529336605;6951.548149370275;6951.652417379212;6957.304269573002;6441.645709486023;6497.967510162419;6571.737130514726;6649.534532582867;6691.297413771484;5843.912341314799;5972.313183983723;6769.661516924036;6800.693968771516;6809.659517024228;6278.372162783685;6393.2647745508;6550.737970481127;6563.0811686362995;6565.868682626226;6420.775272865428;6453.257875344396;6496.415322620986;6501.544891857525;6520.119783829312;6352.936470635234;6427.164468619237;6429.8714025720155;6450.354964503512;6470.773522926675;6334.303226645157;6369.87260254783;6394.616323020634;6455.806325810233;6478.2550006749825;6378.712957916812;6431.324710905475;6434.613923164437;6435.002574600944;6446.033095035595 04:58:29 INFO - PID 1659 | |1;ext.html;691.8895173246939;776.196636481242;822.9588520573972;1196.7068068323267;1255.4036832504555;37516.87449376519;38670;38689.806550967274;38720.61279387205;38732.83801485956;38749;38777.8061109694;39077.609223907755;39087.41368879469;39712.60287397125;7423.369013633847;7856.842863142762;7924.6433910474025;8520.275776559;8556.101609331025;7312;8670.566471676422;8685.392022558424;8689.217970382664;8693.913060869374;8644.222020018196;8707.869381959275;8723.996740374843;8736.126387361277;8737.388382813206;8638.308935285162;8673.436226645312;8677.826443471127;8680.34897382699;8686.305095592337;8486.915130848674;8539.487630742175;8549.102344253826;8569.228769410784;8574.914250857473;36845.447318290244;36884.446733298755;36980.63019369799;37083;37131.814340928126;3574.5889222739456;3607.2965771674535;3613.403788374915;3619.5294611700574;3619.6742293193474;30385.848070759726;30493.847530762203;30600.081997539888;30612.92854750073;31006.069817905274;3139.6389415217313;3180.8409579521162;3184.331290429013;3192.425363434581;3207.3905957867933;308516;309664;310050;314152;316285;48239;48263;48370;48502;48503;50557.24164137541;50909.49090509122;54234.728826356404;56037.439625604035;56068.719656402274;14405;14475.348609312607;14496.492622758153;14515.709685806225;14525.854741452662;11439.199256051996;11524.88475115255;11609.825852612217;11633.243839150427;11653.30080195191;11804.586839460577;13802.723945521033;14239.85760142406;14329.426822927175;14363.856361436252;6298.874022519524;6316;6333.271673757485;6338.176037115238;6339.873202535923;845.5964741913846;948.9288303377274;991.1872264742985;1063.0591926145416;1078.2182917384832;21757.891210543847;23608.055677772696;24643.87678061634;24704.011839526578;24745.762711864696;1097.1332647208776;1111.9610813621646;1122.7817817667758;1141.834434007081;1145.3299819605625;10915.563377464812;12497.25016499013;12550.12149149569;12687.682807929876;12709.428075736614;320401;320689;322414;323387;323580;54481.45518544843;54785.72607137018;54910.17634735482;54946.72526637341;55118.72440637851;1394.7071115065746;1447.088334349353;1474.5502621700484;1548.8760899128042;1558.5402306319663;20410;24108.758912410653;24111.517769644157;24138.275851724477;24205.878970605034;38387.80806095952;38478;38518.037049072875;38558.228835423695;38598.22803543857;290063;290535;291036;292323;292973.535132323;28873.133805985854;29181.854090729412;34980.47529287012;35747.64252357443;36093.819530902176;45411.54588454205;45470.635880923626;45533;45610.315845261684;45772.31341529946;29018.41963160767;29969;30115.397692045597;31500.68499315069;31735.04794856158;25279.494410112064;25537.616935745606;31268.687313127488;31475.685243147276;31561;28270.858645707463;29149;36480.45279320866;37469.06327341729;37755.62244377631;24225.63661545043;29250.414991700472;31495.685043149275;31579.894703685262;31981.840090799396;22358.105675773437;23719.881400592887;24543.754562454145;24666.260012199662;24936.127235546668 04:58:29 INFO - PID 1659 | |2;jquery.html;321.48562300319475;396.86506587760164;420.42821762403105;430.81690281630307;451.2283994369628;20864.47838804031;21221.151153953844;21747;21786.346409607737;22115;22179;22378.55242895141;22865;23091.884540577317;23347.416314592145;5993.130996005577;6240.188775459184;6252.531060170505;6254.280757712853;6259.06114082889;5807.709614519278;6081.361457047013;6148.692565371736;6151.569390142692;6154.476869466101;5978.940210597903;6074.301455332627;6094.146819445281;6108.633481991094;6117.5717699761035;5945.227120474354;6060.757569697207;6124.908126378108;6151.692415379213;6167.876642467148;4556.3621093047;5202.505761952609;5370.167624018283;5392.379876314235;5440.319960004999;27095;27571.448571028468;27641.585376219173;27858.721412785817;27946.720532794818;1998.740163778714;2130.4247853079582;2152.5156839711094;2192.0683709423593;2205.6029914615365;17673.823261767346;17823.73264401035;18035.368762093396;18340.54148646281;18919.148638311308;1717.2787429279608;1751.95620109497;1753.9125742040017;1754.307048715763;1754.929802807886;143155;161832;165888.17055914763;167472.3252767481;168561;10072.345297555781;10426.530806113591;12633.557825476064;12814;12863.614091577268;16536.6692666146;16590.336386544644;16609.335626575044;16613.584660383345;16649;8812.603432845537;8973.237274831581;9071.501067441222;9097.954510227406;9126.315526335551;8203.179682031749;8500.744977650556;8513.872291915626;8535.615897284637;8679.826403471896;6705.362990515893;7928.405369597303;8044.959775201087;8143.226393492609;8149.837003259901;2156.4716644422215;2161.81624561914;2162.264829957822;2167.4147980045614;2349.2717257650183;753.2730914667372;900.9819803603891;901.535709109809;926.3376685669779;959.6641175588488;17165.82834171667;19014.71477927832;19785.901070494845;20637.380878573666;21176.576468470852;930.6603089872283;976.6630512473328;988.2785566536469;990.7721224118349;999.0509016434416;10276.537555810006;10293.022162894513;10826.350418974887;10860.185486088574;10865;477954.4409111798;487179;526561;530086;532985;118130;127644;133708.9943650846;135599;135638;1087.472575800736;1122.814735568622;1143.4054291768234;1143.6683361824978;1148.7932172208916;13357.8868163636;17165.485035448957;17725.822741772416;17798.84307520007;17927.28290868403;58841.411585883594;59588.70205649117;59596.40403595909;60008.69995650168;60540.78918421695;82307.7653835181;82447;85956.57021714852;86628;88278.67581986403;8046.155153708776;8140.104588495143;9067.68263110788;9202.447853128833;9227.292950804123;11819.70450738704;14184.929075354557;14465.566033019026;14762.48331308399;15126.243687815786;8350.498970061815;9119.817603647758;11775.192717566706;12130.696732581757;12443.440045197807;9839.60641574329;11743.647690569296;11780.941095294469;11907;12132.939335303266;10942.835857461985;11366.261193022427;12368.567100151451;12668.809967850673;12787;8855.247303979233;8884;9118.40730352525;9129.77175570616;9242.353035287735;11955.701107472383;12034.157608967289;12199.817002744789;12317.07621928341;12341.876581234073 04:58:29 INFO - PID 1659 | |3;mootools.html;1219.3720234079449;1388.3197233355659;1465.1575942671218;1475.7161269695366;1484.3543058769435;11271.605493807698;11444.313341199524;11928.7614247715;11956.940215298933;11979.221350612215;11638.068954483642;11897.345645989468;11907.702307442318;11911.344876031837;12079.939600302008;2505.2359030495736;2562.9871850640816;2564.5768448206118;2567.165671156872;2568.550503661861;2478.4423504711385;2527.9747202527924;2541.2376287113884;2541.606051062079;2542.872856357184;2509.77412032917;2535.5055764126005;2563.512932542811;2565.602331638599;2567.820252582311;2474.418511649761;2498.287987923451;2530.519201351737;2535.5055764126005;2535.6450096986437;2442.7435119312395;2510.0336370497307;2516.584763514018;2552.4001859562986;2553.170219678612;11697.590584329593;11707.063434925185;11803.055755539537;11804.763904721944;11828.935395814418;6627.271000189975;6856.142982127234;6861.5539989901;6873.896891546631;6876.828079298008;4027.7784721840285;4344.739315641072;4418.469783625986;4430.556944305576;4438.955610443886;1237.5730373021293;1263.437770192265;1304.5760127958356;1306.3598836570106;1309.8428188617331;15168.165750883696;15739.842601574066;15764.369425222978;16132.59668508285;16144.112073835935;4879.804807807719;5054.418741844662;5951.880962380728;6224.564280500412;6236.908541005306;14000.649983750283;14122.435102595986;14128.858711412755;14134.50529231472;14200.857991419953;6914.585124892422;6973.58158510491;6980.616066116311;6988.336108069725;7014.842550979133;4686.36734040907;5177.404598471148;6041.395860413923;6289.119523266746;6307;4697.6711630185555;4800.279958006327;4823.927641085386;4840.249761287007;4851.151048566487;1441.740486712381;1493.6937927724791;1497.0867770659888;1516.113073851787;1518.1346632419636;770.1836053783007;775.8797386405116;791.9208079192035;800.5396896784372;806.7095845495617;6493.480521558264;6607.636579988147;6757.662116894136;6818.4886133540185;6860.5197636165985;904.8054668246227;909.7627226971314;912.6212621762027;921.5162039929091;936.2089034765612;4098.385242213632;4169.666426685919;4183.974926143114;4198.6221240088535;4277.786110694453;14837.629059273604;14938.850611493963;15143.318550665246;15179.924100379427;15205.391784328503;12435.316057616918;12804.295763733084;14176.574702758728;15226.390944362101;15247.161406122548;7416.25837416254;8458.87311690325;8645.567721613894;8727.869081963776;8757.036725960139;6006.519478441627;6729.52893297484;6891.173059232924;6932.688029038806;6948.305169483011;13126.540571079966;13311;13387.129836560593;13697.863021369658;13701.520446784314;13394.062415630813;13634.181949083088;13720.382582784;13761.587152385444;13829.723405532035;9119.544022798966;9266.629334826532;9463.526823658927;9470.337076404861;9489.335746497678;9074.818503629758;10674.73313167177;10729.195310351599;10813;10816.242862999514;7954.801129971797;8948.552572371225;9147.496887671243;9165.358424910459;9261.768455788659;8199.262066414052;8867.379283450355;9001.594928228114;9108.089191081104;9130.315226358183;7727.304542591194;7833.764987050397;7841.5687137208;7852;7854.646540905787;5772.884542309214;5898.852528686817;6010.759569617167;6058;6095.878082438415;4935.876603084952;5970;6021.946159422171;6085.148079268817;6233.407826256498 04:58:29 INFO - PID 1659 | |4;prototype.html;407.72478576960543;408.3160705817755;409.38796499233644;413.1365446217407;413.8013753398371;5699.860027994402;5933.643981361121;6163.291221509522;6237.906431403521;6283.811485655427;4606.60843828275;6034.24571928509;6097.115918191859;6116.296625888024;6128.295246046706;3513.894583162503;4345.565443455661;4433.046894917592;4470.949326908174;4499.1451624191295;4428.16231264025;4476.753778542179;4478.798454069559;4482.372467854503;4486.371907932892;3829;4400.667646147531;4401.36180253863;4409.007973206035;4414.227510185705;3623.7644553103964;4036.7577945323374;4435.246008178601;4442.666799989981;4453.398791163217;3622.8913132606062;3774.433834924756;3802.1445174835717;3817.4273858921383;3827;4853.927191092102;5792.178860245468;5976.581639285252;5988.970055149696;6010.368911264298;4957.529034741694;5075.883305672746;5250.06245316013;5263.842084737464;5347.887584404178;5568.470995255444;6207.503399728011;6490.415862572344;6535.346465353474;6633.336666333376;3553.680168784822;4277.037666525038;4345.652347812167;4349.673774466928;4351.129774045172;6708.463322934153;6888.588993852111;6906.309369063104;6994.405475534535;7004.614746188958;3633;4337.392765012901;4356.978215108968;4370.519242883281;4414.514403415622;4420.7126536775;4445.666575006888;4445.933311000337;4466.553344665573;4481.2381895077915;4412.955870441318;4834.903301933941;5136.255242989746;5223.399309079505;5309.362876454773;5468.945310546923;6528.445082168069;6573.769918052941;6573.83565410859;6579.210494740566;1492.3209939477513;1496.3640452807513;1507.766296224087;1508.6907184027248;1514.9772753408708;891.3715830339595;913.0960349254324;932.6782260120248;969.4682401805131;995.8605795188679;4814.735189564538;5181.896362072737;5441.292631957899;6176.227971503562;6364.663420681709;5482.835514934558;6526.771562995367;6675.920876505856;6744.7976560703255;6803.292205747879;5264.131418316011;5506.64206826563;6081.604695694766;6119.020956647004;6188.628682279078;2722.6732792065077;3135.952960705591;3513.3851575974104;3561.3589553880033;3567.9286414272087;5832.979228634972;6082.361352058058;6262.499000079983;6442.806715798533;7009.1939426966555;6028.457438830526;6224.9377506224355;6703.798886033427;6889.207741109736;6982;6291.276503202099;6873.621950792654;6963.895541566881;7015.649217539205;7072.469564782662;4980.551750342486;6853.348931851466;6853.9314606853295;6886.931130688629;6910.032595436543;5902.078471156805;6682.532222744361;6688.531802773759;6696.799096027127;6711.328867113445;6133.50931925436;6447.198889343947;6973.5118541701595;7039.683214255473;7056.894146587702;3896.4155376693725;3997.780122093313;4207.6423504002505;4337.154254920387;4384.232759267052;5497.080113298495;6769.93230067693;6884.345987131214;6912.792616221522;6924.653767311514;5667.4332566743;6404.903926441014;6486.870262594816;6621.437177839937;6663.200415949923;6316.557840951273;6530.444912182517;6601.9009714853355;6639.535232533676;6665.600063996176;5919.6744179070565;6288.402601752826;6413.556949686284;6433.581817181868;6503.642299673564;6360.522960777867;6403.231612206565;6632.635205063768;6667.266600674019;6674.16572928384;6298.260256788129;6491.610503369813;6512.251091124392;6522.34776522344;6532.510061745293 04:58:29 INFO - PID 1659 | |5;yui.html;832.4921797703396;837.0541288344174;841.1294310388747;841.586135292708;876.487254955851;15780.368785248576;16602.75095873563;16642;18626.627467450642;19316.3239286625;15280.388784448609;17990.010549419778;18155.636887262248;18259;18455;979.9167070798991;990.5146478225654;1003.4029752297372;1003.6136087606287;1006.1799633298874;1005.4570531912758;1008.1632245236473;1008.2740426892625;1014.5181039006486;1016;1058.7088550648557;1069.4492336446735;1070.29895418501;1070.3738313086853;1071.8177909755361;1046.9790604187913;1068.4604274841156;1069.636323649959;1070.1813112968507;1073.940933248667;591.8845825064114;750.898628685126;771.6836097200121;773.6557232031748;775.3680750188635;16649;16705.83294167055;16860.494185174466;16872.325106995704;16909.40817071409;16829.495115146565;17210.39763608268;17359.305627774873;17366.56583585408;17405.738913916302;11693.356865372401;13899.930500347535;14120.92939535306;14153.716925661429;14180.290985450789;3476.7392445566684;3536.1159710072484;3540.2211513466996;3544.2557063016798;3546.7871927684164;110794.89205108007;115674;126162.3691881544;133074.33462832624;135531;13370.866291337157;13681.931590341985;13735.656608584864;13744.175349479063;13750.724985500234;25431.491370172494;25803.096891608704;26012.73987260141;26149.823257953438;26421.867890660425;7920.366370690331;8046.275835174863;8057.033156021198;8080.959595201986;8101.230383113595;3832.1952389997855;3852.9614703852603;3877.592852750477;3910.393888947218;3913.8630147945255;4329.848455304049;4348.391225228407;4396.516383197845;4400.603945644907;4418.315161150027;925.8611208318806;963.8457846744487;966.7148191283588;967.6322997260996;973.7224890906199;644.2655372874926;664.5082638847218;676.3946268090032;677.2381071294793;693.6635731670136;11169.888301116885;11990.584668169451;12005.87994120065;12164.695882603006;12278.877211227951;610.7312782375741;651.1047309948821;664.1299897134769;680.8638272345551;687.8005378440196;4278.63631591312;4333.241682705514;5376.435474275145;5451.400345961941;5605.439456054443;112788.43605781918;113703;114249;115542.42228788802;115962;57989;73967.89048164281;74359;76386;81345;75720.62139689266;76689.61655191689;76743.08142296487;77746;78132.99999999886;10600.575976960836;10766.685162690059;12270.75458490843;12419.44112514921;12508.374581271082;39340;39562.80218598888;40485;40749.38875916923;40871.56949506753;43110;47511.09955601737;50370.74814625904;52249.47750522598;52950;12307.69230769238;15658.843411566195;16085.77759491602;16231.431899883448;16255.105969171336;17639.823601764332;17763.555911102325;18056.45830625083;18736.53158671044;18972.430827075208;13846.307684615931;13921.930390347983;16474.599659028638;17152.48542543726;17522.38671646537;16874.325026998784;16962.236699348807;17511.912440437718;17529;17533.649327013645;15722.606934826263;16589.921655092865;16770.0776457296;17021.40425085116;17048.40330588473;10325.690229293134;10387.2209584283;11172.608958686407;11783.234089784137;12179.02567794592;13072.673183170496;13765.587032389045;13800.516981905585;13892;13928.025038247226 04:58:29 INFO - PID 1659 | __end_tp_report 04:58:29 INFO - PID 1659 | __start_cc_report 04:58:29 INFO - PID 1659 | _x_x_mozilla_cycle_collect,420 04:58:29 INFO - PID 1659 | __end_cc_report 04:58:29 INFO - PID 1659 | __startTimestamp1493639909421__endTimestamp 04:58:29 INFO - PID 1659 | 04:58:29 INFO - PID 1659 | ------- Summary: start ------- 04:58:29 INFO - PID 1659 | Number of tests: 6 04:58:29 INFO - PID 1659 | 04:58:29 INFO - PID 1659 | [#0] dojo.html Cycles:165 Average:6109.34 Median:6378.71 stddev:770.72 (12.1%) stddev-sans-first:742.40 04:58:29 INFO - PID 1659 | Values: 3364.5 3490.1 3535.3 3558.8 3615.0 4449.2 6067.4 6119.1 6124.1 6290.7 6149.7 6164.2 6187.4 6234.8 6306.4 4911.9 4932.4 5375.1 5399.3 5402.5 4176.8 5470.8 5515.3 5560.8 5574.4 4360.3 5328.9 5383.7 5439.0 5547.8 5432.8 5440.3 5451.7 5492.9 5501.7 5394.4 5427.0 5453.9 5456.7 5485.4 4842.9 5874.7 6120.3 6236.2 6305.4 6530.9 6629.3 6678.8 6682.3 6695.9 6811.4 6814.0 6819.9 6825.4 6826.5 6287.4 6332.5 6362.1 6376.8 6382.2 6650.5 6729.1 6781.6 6840.2 6876.6 6342.9 6374.6 6383.5 6519.2 6603.4 6619.3 6660.6 6693.3 6712.3 6742.5 6623.2 6645.5 6648.0 6652.5 6663.8 6404.0 6492.3 6497.0 6567.3 6672.5 5274.5 5306.4 5313.4 5329.7 5351.3 4673.8 4701.9 4704.4 4713.6 4726.0 6118.9 6308.5 6324.8 6368.5 6389.6 6614.5 6695.6 6718.3 6746.8 6782.9 6282.2 6296.3 6339.7 6350.4 6362.7 5625.8 5874.4 5882.1 5887.1 5897.7 6760.0 6761.1 6863.0 6891.9 6903.3 5672.7 6705.9 6776.2 6783.4 6803.7 6874.6 6938.8 6951.5 6951.7 6957.3 6441.6 6498.0 6571.7 6649.5 6691.3 5843.9 5972.3 6769.7 6800.7 6809.7 6278.4 6393.3 6550.7 6563.1 6565.9 6420.8 6453.3 6496.4 6501.5 6520.1 6352.9 6427.2 6429.9 6450.4 6470.8 6334.3 6369.9 6394.6 6455.8 6478.3 6378.7 6431.3 6434.6 6435.0 6446.0 04:58:29 INFO - PID 1659 | 04:58:29 INFO - PID 1659 | [#1] ext.html Cycles:180 Average:45850.90 Median:322900.50 stddev:81019.31 (25.1%) stddev-sans-first:81175.64 04:58:29 INFO - PID 1659 | Values: 691.9 776.2 823.0 1196.7 1255.4 37516.9 38670.0 38689.8 38720.6 38732.8 38749.0 38777.8 39077.6 39087.4 39712.6 7423.4 7856.8 7924.6 8520.3 8556.1 7312.0 8670.6 8685.4 8689.2 8693.9 8644.2 8707.9 8724.0 8736.1 8737.4 8638.3 8673.4 8677.8 8680.3 8686.3 8486.9 8539.5 8549.1 8569.2 8574.9 36845.4 36884.4 36980.6 37083.0 37131.8 3574.6 3607.3 3613.4 3619.5 3619.7 30385.8 30493.8 30600.1 30612.9 31006.1 3139.6 3180.8 3184.3 3192.4 3207.4 308516.0 309664.0 310050.0 314152.0 316285.0 48239.0 48263.0 48370.0 48502.0 48503.0 50557.2 50909.5 54234.7 56037.4 56068.7 14405.0 14475.3 14496.5 14515.7 14525.9 11439.2 11524.9 11609.8 11633.2 11653.3 11804.6 13802.7 14239.9 14329.4 14363.9 6298.9 6316.0 6333.3 6338.2 6339.9 845.6 948.9 991.2 1063.1 1078.2 21757.9 23608.1 24643.9 24704.0 24745.8 1097.1 1112.0 1122.8 1141.8 1145.3 10915.6 12497.3 12550.1 12687.7 12709.4 320401.0 320689.0 322414.0 323387.0 323580.0 54481.5 54785.7 54910.2 54946.7 55118.7 1394.7 1447.1 1474.6 1548.9 1558.5 20410.0 24108.8 24111.5 24138.3 24205.9 38387.8 38478.0 38518.0 38558.2 38598.2 290063.0 290535.0 291036.0 292323.0 292973.5 28873.1 29181.9 34980.5 35747.6 36093.8 45411.5 45470.6 45533.0 45610.3 45772.3 29018.4 29969.0 30115.4 31500.7 31735.0 25279.5 25537.6 31268.7 31475.7 31561.0 28270.9 29149.0 36480.5 37469.1 37755.6 24225.6 29250.4 31495.7 31579.9 31981.8 22358.1 23719.9 24543.8 24666.3 24936.1 04:58:29 INFO - PID 1659 | 04:58:29 INFO - PID 1659 | [#2] jquery.html Cycles:180 Average:34873.74 Median:12848.34 stddev:87860.31 (683.8%) stddev-sans-first:88068.48 04:58:29 INFO - PID 1659 | Values: 321.5 396.9 420.4 430.8 451.2 20864.5 21221.2 21747.0 21786.3 22115.0 22179.0 22378.6 22865.0 23091.9 23347.4 5993.1 6240.2 6252.5 6254.3 6259.1 5807.7 6081.4 6148.7 6151.6 6154.5 5978.9 6074.3 6094.1 6108.6 6117.6 5945.2 6060.8 6124.9 6151.7 6167.9 4556.4 5202.5 5370.2 5392.4 5440.3 27095.0 27571.4 27641.6 27858.7 27946.7 1998.7 2130.4 2152.5 2192.1 2205.6 17673.8 17823.7 18035.4 18340.5 18919.1 1717.3 1752.0 1753.9 1754.3 1754.9 143155.0 161832.0 165888.2 167472.3 168561.0 10072.3 10426.5 12633.6 12814.0 12863.6 16536.7 16590.3 16609.3 16613.6 16649.0 8812.6 8973.2 9071.5 9098.0 9126.3 8203.2 8500.7 8513.9 8535.6 8679.8 6705.4 7928.4 8045.0 8143.2 8149.8 2156.5 2161.8 2162.3 2167.4 2349.3 753.3 901.0 901.5 926.3 959.7 17165.8 19014.7 19785.9 20637.4 21176.6 930.7 976.7 988.3 990.8 999.1 10276.5 10293.0 10826.4 10860.2 10865.0 477954.4 487179.0 526561.0 530086.0 532985.0 118130.0 127644.0 133709.0 135599.0 135638.0 1087.5 1122.8 1143.4 1143.7 1148.8 13357.9 17165.5 17725.8 17798.8 17927.3 58841.4 59588.7 59596.4 60008.7 60540.8 82307.8 82447.0 85956.6 86628.0 88278.7 8046.2 8140.1 9067.7 9202.4 9227.3 11819.7 14184.9 14465.6 14762.5 15126.2 8350.5 9119.8 11775.2 12130.7 12443.4 9839.6 11743.6 11780.9 11907.0 12132.9 10942.8 11366.3 12368.6 12668.8 12787.0 8855.2 8884.0 9118.4 9129.8 9242.4 11955.7 12034.2 12199.8 12317.1 12341.9 04:58:29 INFO - PID 1659 | 04:58:29 INFO - PID 1659 | [#3] mootools.html Cycles:180 Average:7151.44 Median:4134.03 stddev:4491.56 (108.6%) stddev-sans-first:4482.03 04:58:29 INFO - PID 1659 | Values: 1219.4 1388.3 1465.2 1475.7 1484.4 11271.6 11444.3 11928.8 11956.9 11979.2 11638.1 11897.3 11907.7 11911.3 12079.9 2505.2 2563.0 2564.6 2567.2 2568.6 2478.4 2528.0 2541.2 2541.6 2542.9 2509.8 2535.5 2563.5 2565.6 2567.8 2474.4 2498.3 2530.5 2535.5 2535.6 2442.7 2510.0 2516.6 2552.4 2553.2 11697.6 11707.1 11803.1 11804.8 11828.9 6627.3 6856.1 6861.6 6873.9 6876.8 4027.8 4344.7 4418.5 4430.6 4439.0 1237.6 1263.4 1304.6 1306.4 1309.8 15168.2 15739.8 15764.4 16132.6 16144.1 4879.8 5054.4 5951.9 6224.6 6236.9 14000.6 14122.4 14128.9 14134.5 14200.9 6914.6 6973.6 6980.6 6988.3 7014.8 4686.4 5177.4 6041.4 6289.1 6307.0 4697.7 4800.3 4823.9 4840.2 4851.2 1441.7 1493.7 1497.1 1516.1 1518.1 770.2 775.9 791.9 800.5 806.7 6493.5 6607.6 6757.7 6818.5 6860.5 904.8 909.8 912.6 921.5 936.2 4098.4 4169.7 4184.0 4198.6 4277.8 14837.6 14938.9 15143.3 15179.9 15205.4 12435.3 12804.3 14176.6 15226.4 15247.2 7416.3 8458.9 8645.6 8727.9 8757.0 6006.5 6729.5 6891.2 6932.7 6948.3 13126.5 13311.0 13387.1 13697.9 13701.5 13394.1 13634.2 13720.4 13761.6 13829.7 9119.5 9266.6 9463.5 9470.3 9489.3 9074.8 10674.7 10729.2 10813.0 10816.2 7954.8 8948.6 9147.5 9165.4 9261.8 8199.3 8867.4 9001.6 9108.1 9130.3 7727.3 7833.8 7841.6 7852.0 7854.6 5772.9 5898.9 6010.8 6058.0 6095.9 4935.9 5970.0 6021.9 6085.1 6233.4 04:58:29 INFO - PID 1659 | 04:58:29 INFO - PID 1659 | [#4] prototype.html Cycles:180 Average:5212.53 Median:5999.67 stddev:1686.50 (28.1%) stddev-sans-first:1652.22 04:58:29 INFO - PID 1659 | Values: 407.7 408.3 409.4 413.1 413.8 5699.9 5933.6 6163.3 6237.9 6283.8 4606.6 6034.2 6097.1 6116.3 6128.3 3513.9 4345.6 4433.0 4470.9 4499.1 4428.2 4476.8 4478.8 4482.4 4486.4 3829.0 4400.7 4401.4 4409.0 4414.2 3623.8 4036.8 4435.2 4442.7 4453.4 3622.9 3774.4 3802.1 3817.4 3827.0 4853.9 5792.2 5976.6 5989.0 6010.4 4957.5 5075.9 5250.1 5263.8 5347.9 5568.5 6207.5 6490.4 6535.3 6633.3 3553.7 4277.0 4345.7 4349.7 4351.1 6708.5 6888.6 6906.3 6994.4 7004.6 3633.0 4337.4 4357.0 4370.5 4414.5 4420.7 4445.7 4445.9 4466.6 4481.2 4413.0 4834.9 5136.3 5223.4 5309.4 5468.9 6528.4 6573.8 6573.8 6579.2 1492.3 1496.4 1507.8 1508.7 1515.0 891.4 913.1 932.7 969.5 995.9 4814.7 5181.9 5441.3 6176.2 6364.7 5482.8 6526.8 6675.9 6744.8 6803.3 5264.1 5506.6 6081.6 6119.0 6188.6 2722.7 3136.0 3513.4 3561.4 3567.9 5833.0 6082.4 6262.5 6442.8 7009.2 6028.5 6224.9 6703.8 6889.2 6982.0 6291.3 6873.6 6963.9 7015.6 7072.5 4980.6 6853.3 6853.9 6886.9 6910.0 5902.1 6682.5 6688.5 6696.8 6711.3 6133.5 6447.2 6973.5 7039.7 7056.9 3896.4 3997.8 4207.6 4337.2 4384.2 5497.1 6769.9 6884.3 6912.8 6924.7 5667.4 6404.9 6486.9 6621.4 6663.2 6316.6 6530.4 6601.9 6639.5 6665.6 5919.7 6288.4 6413.6 6433.6 6503.6 6360.5 6403.2 6632.6 6667.3 6674.2 6298.3 6491.6 6512.3 6522.3 6532.5 04:58:29 INFO - PID 1659 | 04:58:29 INFO - PID 1659 | [#5] yui.html Cycles:180 Average:21244.90 Median:17531.32 stddev:29946.72 (170.8%) stddev-sans-first:29991.51 04:58:29 INFO - PID 1659 | Values: 832.5 837.1 841.1 841.6 876.5 15780.4 16602.8 16642.0 18626.6 19316.3 15280.4 17990.0 18155.6 18259.0 18455.0 979.9 990.5 1003.4 1003.6 1006.2 1005.5 1008.2 1008.3 1014.5 1016.0 1058.7 1069.4 1070.3 1070.4 1071.8 1047.0 1068.5 1069.6 1070.2 1073.9 591.9 750.9 771.7 773.7 775.4 16649.0 16705.8 16860.5 16872.3 16909.4 16829.5 17210.4 17359.3 17366.6 17405.7 11693.4 13899.9 14120.9 14153.7 14180.3 3476.7 3536.1 3540.2 3544.3 3546.8 110794.9 115674.0 126162.4 133074.3 135531.0 13370.9 13681.9 13735.7 13744.2 13750.7 25431.5 25803.1 26012.7 26149.8 26421.9 7920.4 8046.3 8057.0 8081.0 8101.2 3832.2 3853.0 3877.6 3910.4 3913.9 4329.8 4348.4 4396.5 4400.6 4418.3 925.9 963.8 966.7 967.6 973.7 644.3 664.5 676.4 677.2 693.7 11169.9 11990.6 12005.9 12164.7 12278.9 610.7 651.1 664.1 680.9 687.8 4278.6 4333.2 5376.4 5451.4 5605.4 112788.4 113703.0 114249.0 115542.4 115962.0 57989.0 73967.9 74359.0 76386.0 81345.0 75720.6 76689.6 76743.1 77746.0 78133.0 10600.6 10766.7 12270.8 12419.4 12508.4 39340.0 39562.8 40485.0 40749.4 40871.6 43110.0 47511.1 50370.7 52249.5 52950.0 12307.7 15658.8 16085.8 16231.4 16255.1 17639.8 17763.6 18056.5 18736.5 18972.4 13846.3 13921.9 16474.6 17152.5 17522.4 16874.3 16962.2 17511.9 17529.0 17533.6 15722.6 16589.9 16770.1 17021.4 17048.4 10325.7 10387.2 11172.6 11783.2 12179.0 13072.7 13765.6 13800.5 13892.0 13928.0 04:58:29 INFO - PID 1659 | -------- Summary: end -------- 04:58:29 INFO - PID 1659 | 04:58:30 INFO - TEST-INFO | 1659: exit 0 04:58:30 INFO - TEST-OK | dromaeo_css | took 1115603ms 04:58:30 INFO - TEST-START | kraken 04:58:30 INFO - operating with platform_type : mac_ 04:58:30 INFO - Initialising browser for kraken test... 04:58:30 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpN9ocQM/profile http://localhost:49236/getInfo.html) 04:58:32 INFO - PID 1669 | 2017-05-01 04:58:32.839 plugin-container[1670:11138] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x943f, name = 'com.apple.tsm.portname' 04:58:32 INFO - PID 1669 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:58:32 INFO - PID 1669 | 2017-05-01 04:58:32.840 plugin-container[1670:11138] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4323, name = 'com.apple.CFPasteboardClient' 04:58:32 INFO - PID 1669 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:58:32 INFO - PID 1669 | 2017-05-01 04:58:32.840 plugin-container[1670:11138] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:58:32 INFO - PID 1669 | __metrics Screen width/height:1600/1200 04:58:32 INFO - PID 1669 | colorDepth:24 04:58:32 INFO - PID 1669 | Browser inner width/height: 1024/689 04:58:32 INFO - PID 1669 | __metrics 04:58:34 INFO - TEST-INFO | 1669: exit 0 04:58:34 INFO - Browser initialized. 04:58:34 INFO - Running cycle 1/1 for kraken test... 04:58:34 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpN9ocQM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:58:36 INFO - PID 1671 | 2017-05-01 04:58:36.496 plugin-container[1672:11266] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x933f, name = 'com.apple.tsm.portname' 04:58:36 INFO - PID 1671 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:58:36 INFO - PID 1671 | 2017-05-01 04:58:36.497 plugin-container[1672:11266] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4423, name = 'com.apple.CFPasteboardClient' 04:58:36 INFO - PID 1671 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:58:36 INFO - PID 1671 | 2017-05-01 04:58:36.497 plugin-container[1672:11266] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:58:46 INFO - PID 1671 | RSS: Main: 235020288 04:58:46 INFO - PID 1671 | 04:58:48 INFO - PID 1671 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 04:58:49 INFO - PID 1671 | RSS: Main: 248512512 04:58:49 INFO - PID 1671 | 04:58:52 INFO - PID 1671 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 04:58:53 INFO - PID 1671 | RSS: Main: 256696320 04:58:53 INFO - PID 1671 | 04:58:56 INFO - PID 1671 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 04:58:57 INFO - PID 1671 | RSS: Main: 259211264 04:58:57 INFO - PID 1671 | 04:58:59 INFO - PID 1671 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 04:58:59 INFO - PID 1671 | RSS: Main: 260239360 04:58:59 INFO - PID 1671 | 04:59:01 INFO - PID 1671 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:59:02 INFO - PID 1671 | RSS: Main: 260734976 04:59:02 INFO - PID 1671 | 04:59:05 INFO - PID 1671 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 04:59:06 INFO - PID 1671 | RSS: Main: 267550720 04:59:06 INFO - PID 1671 | 04:59:09 INFO - PID 1671 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 04:59:10 INFO - PID 1671 | RSS: Main: 268365824 04:59:10 INFO - PID 1671 | 04:59:13 INFO - PID 1671 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 04:59:13 INFO - PID 1671 | RSS: Main: 268337152 04:59:13 INFO - PID 1671 | 04:59:15 INFO - PID 1671 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:59:16 INFO - PID 1671 | RSS: Main: 267563008 04:59:16 INFO - PID 1671 | 04:59:17 INFO - PID 1671 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:59:18 INFO - PID 1671 | RSS: Main: 267710464 04:59:18 INFO - PID 1671 | 04:59:20 INFO - PID 1671 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:59:21 INFO - PID 1671 | RSS: Main: 267313152 04:59:21 INFO - PID 1671 | 04:59:24 INFO - PID 1671 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:59:25 INFO - PID 1671 | RSS: Main: 268025856 04:59:25 INFO - PID 1671 | 04:59:28 INFO - PID 1671 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:59:28 INFO - PID 1671 | RSS: Main: 267460608 04:59:28 INFO - PID 1671 | 04:59:30 INFO - PID 1671 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 04:59:30 INFO - PID 1671 | RSS: Main: 269234176 04:59:30 INFO - PID 1671 | 04:59:30 INFO - PID 1671 | __start_tp_report 04:59:30 INFO - PID 1671 | _x_x_mozilla_page_load 04:59:30 INFO - PID 1671 | _x_x_mozilla_page_load_details 04:59:30 INFO - PID 1671 | |i|pagename|runs| 04:59:30 INFO - PID 1671 | |0;ai-astar;101;117;115;114;114;113;114;116;116;115 04:59:30 INFO - PID 1671 | |1;audio-beat-detection;147;146;145;155;109;125;145;149;148;112 04:59:30 INFO - PID 1671 | |2;audio-dft;200;206;210;230;226;204;225;210;189;238 04:59:30 INFO - PID 1671 | |3;audio-fft;80;73;88;110;87;61;60;62;75;58 04:59:30 INFO - PID 1671 | |4;audio-oscillator;82;73;82;68;69;70;87;73;81;91 04:59:30 INFO - PID 1671 | |5;imaging-gaussian-blur;89;88;111;135;91;99;109;134;110;137 04:59:30 INFO - PID 1671 | |6;imaging-darkroom;96;102;96;97;122;155;91;139;155;117 04:59:30 INFO - PID 1671 | |7;imaging-desaturate;91;92;92;91;90;102;89;92;90;91 04:59:30 INFO - PID 1671 | |8;json-parse-financial;51;49;52;50;50;51;60;78;78;80 04:59:30 INFO - PID 1671 | |9;json-stringify-tinderbox;58;64;60;59;61;62;59;57;60;60 04:59:30 INFO - PID 1671 | |10;stanford-crypto-aes;81;84;84;83;75;90;82;104;95;108 04:59:30 INFO - PID 1671 | |11;stanford-crypto-ccm;157;159;136;142;164;139;150;164;237;154 04:59:30 INFO - PID 1671 | |12;stanford-crypto-pbkdf2;187;191;185;187;243;186;186;183;183;186 04:59:30 INFO - PID 1671 | |13;stanford-crypto-sha256-iterative;67;70;68;68;74;67;69;64;83;70 04:59:30 INFO - PID 1671 | __end_tp_report 04:59:30 INFO - PID 1671 | __start_cc_report 04:59:30 INFO - PID 1671 | _x_x_mozilla_cycle_collect,1009 04:59:30 INFO - PID 1671 | __end_cc_report 04:59:30 INFO - PID 1671 | __startTimestamp1493639970751__endTimestamp 04:59:30 INFO - PID 1671 | 04:59:30 INFO - PID 1671 | ------- Summary: start ------- 04:59:30 INFO - PID 1671 | Number of tests: 14 04:59:30 INFO - PID 1671 | 04:59:30 INFO - PID 1671 | [#0] ai-astar Cycles:10 Average:113.50 Median:115.00 stddev:4.55 (4.0%) stddev-sans-first:1.27 04:59:30 INFO - PID 1671 | Values: 101.0 117.0 115.0 114.0 114.0 113.0 114.0 116.0 116.0 115.0 04:59:30 INFO - PID 1671 | 04:59:30 INFO - PID 1671 | [#1] audio-beat-detection Cycles:10 Average:138.10 Median:146.50 stddev:16.46 (11.2%) stddev-sans-first:17.14 04:59:30 INFO - PID 1671 | Values: 147.0 146.0 145.0 155.0 109.0 125.0 145.0 149.0 148.0 112.0 04:59:30 INFO - PID 1671 | 04:59:30 INFO - PID 1671 | [#2] audio-dft Cycles:10 Average:213.80 Median:217.50 stddev:15.32 (7.0%) stddev-sans-first:15.42 04:59:30 INFO - PID 1671 | Values: 200.0 206.0 210.0 230.0 226.0 204.0 225.0 210.0 189.0 238.0 04:59:30 INFO - PID 1671 | 04:59:30 INFO - PID 1671 | [#3] audio-fft Cycles:10 Average:75.40 Median:74.00 stddev:16.48 (22.3%) stddev-sans-first:17.40 04:59:30 INFO - PID 1671 | Values: 80.0 73.0 88.0 110.0 87.0 61.0 60.0 62.0 75.0 58.0 04:59:30 INFO - PID 1671 | 04:59:30 INFO - PID 1671 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:81.50 stddev:8.06 (9.9%) stddev-sans-first:8.39 04:59:30 INFO - PID 1671 | Values: 82.0 73.0 82.0 68.0 69.0 70.0 87.0 73.0 81.0 91.0 04:59:30 INFO - PID 1671 | 04:59:30 INFO - PID 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:112.50 stddev:19.26 (17.1%) stddev-sans-first:18.82 04:59:30 INFO - PID 1671 | Values: 89.0 88.0 111.0 135.0 91.0 99.0 109.0 134.0 110.0 137.0 04:59:30 INFO - PID 1671 | 04:59:30 INFO - PID 1671 | [#6] imaging-darkroom Cycles:10 Average:117.00 Median:123.00 stddev:24.90 (20.2%) stddev-sans-first:25.22 04:59:30 INFO - PID 1671 | Values: 96.0 102.0 96.0 97.0 122.0 155.0 91.0 139.0 155.0 117.0 04:59:30 INFO - PID 1671 | 04:59:30 INFO - PID 1671 | [#7] imaging-desaturate Cycles:10 Average:92.00 Median:91.00 stddev:3.65 (4.0%) stddev-sans-first:3.86 04:59:30 INFO - PID 1671 | Values: 91.0 92.0 92.0 91.0 90.0 102.0 89.0 92.0 90.0 91.0 04:59:30 INFO - PID 1671 | 04:59:30 INFO - PID 1671 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:56.00 stddev:13.31 (23.8%) stddev-sans-first:13.72 04:59:30 INFO - PID 1671 | Values: 51.0 49.0 52.0 50.0 50.0 51.0 60.0 78.0 78.0 80.0 04:59:30 INFO - PID 1671 | 04:59:30 INFO - PID 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:2.00 (3.3%) stddev-sans-first:1.99 04:59:30 INFO - PID 1671 | Values: 58.0 64.0 60.0 59.0 61.0 62.0 59.0 57.0 60.0 60.0 04:59:30 INFO - PID 1671 | 04:59:30 INFO - PID 1671 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:83.50 stddev:10.63 (12.7%) stddev-sans-first:10.91 04:59:30 INFO - PID 1671 | Values: 81.0 84.0 84.0 83.0 75.0 90.0 82.0 104.0 95.0 108.0 04:59:30 INFO - PID 1671 | 04:59:30 INFO - PID 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:160.20 Median:158.00 stddev:28.77 (18.2%) stddev-sans-first:30.49 04:59:30 INFO - PID 1671 | Values: 157.0 159.0 136.0 142.0 164.0 139.0 150.0 164.0 237.0 154.0 04:59:30 INFO - PID 1671 | 04:59:30 INFO - PID 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.70 Median:186.50 stddev:18.17 (9.7%) stddev-sans-first:19.19 04:59:30 INFO - PID 1671 | Values: 187.0 191.0 185.0 187.0 243.0 186.0 186.0 183.0 183.0 186.0 04:59:30 INFO - PID 1671 | 04:59:30 INFO - PID 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:69.50 stddev:5.25 (7.6%) stddev-sans-first:5.45 04:59:30 INFO - PID 1671 | Values: 67.0 70.0 68.0 68.0 74.0 67.0 69.0 64.0 83.0 70.0 04:59:30 INFO - PID 1671 | -------- Summary: end -------- 04:59:30 INFO - PID 1671 | 04:59:31 INFO - TEST-INFO | 1671: exit 0 04:59:31 INFO - TEST-OK | kraken | took 61664ms 04:59:31 INFO - SUITE-END | took 1177s 04:59:31 INFO - Completed test suite (00:19:37) 04:59:31 INFO - javascript benchmark 04:59:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7841.427287041092, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3364.4953257011443, 3490.110021944404, 3535.292941411718, 3558.8042657653837, 3614.9819250903743, 4449.176902273081, 6067.393260673931, 6119.112728654348, 6124.050772130327, 6290.716917738701, 6149.661768602725, 6164.167837341957, 6187.35032821554, 6234.84412889678, 6306.400891915261, 4911.894823664665, 4932.383452068491, 5375.086235340002, 5399.325084364455, 5402.459754024605, 4176.7911604419805, 5470.753816078266, 5515.310586176728, 5560.77756889726, 5574.442555744434, 4360.280553708634, 5328.92006619901, 5383.650062745909, 5438.972805135989, 5547.805826796063, 5432.75552600134, 5440.265564148829, 5451.727413629303, 5492.945070549284, 5501.724913754337, 5394.352677678665, 5426.972865135688, 5453.945460545384, 5456.727163641802, 5485.424030476783, 4842.878928026792, 5874.676892770896, 6120.294761999619, 6236.235191178587, 6305.432511074026, 6530.902036469457, 6629.303923088103, 6678.799636010927, 6682.298358672367, 6695.899561506532, 6811.421029212523, 6814.046033555306, 6819.897701534481, 6825.385715285648, 6826.4538836892925, 6287.402696743802, 6332.525060620472, 6362.141110950009, 6376.84057898547, 6382.20222472191, 6650.501212409089, 6729.091572637729, 6781.559198652072, 6840.213375461885, 6876.553024053421, 6342.873142537123, 6374.649394283359, 6383.457406120532, 6519.185101862267, 6603.438707709898, 6619.338066193439, 6660.600363978177, 6693.263740988487, 6712.295209003082, 6742.49431292655, 6623.205215374186, 6645.534812563171, 6647.966760166169, 6652.501062420338, 6663.766768163188, 6403.967980160162, 6492.285848556655, 6497.0, 6567.310432404624, 6672.499562532829, 5274.472552744694, 5306.389765176977, 5313.415524292324, 5329.680219186861, 5351.3043304370185, 4673.813047478131, 4701.929471057937, 4704.388429504211, 4713.646476514206, 4726.007538416902, 6118.923762351665, 6308.495320374359, 6324.841878953063, 6368.490520758328, 6389.584676995981, 6614.470842332602, 6695.598264104169, 6718.32816718334, 6746.797596072126, 6782.93217067823, 6282.246130464282, 6296.307406185316, 6339.683015849189, 6350.4284614384005, 6362.650054247061, 5625.774969001276, 5874.353821079678, 5882.058870580687, 5887.058070708752, 5897.734601942923, 6760.0, 6761.121054263012, 6862.965685171542, 6891.931080689129, 6903.275156108536, 5672.7163641816915, 6705.865882682221, 6776.2207346153855, 6783.3555812197765, 6803.659817009228, 6874.587524748531, 6938.826529336605, 6951.548149370275, 6951.652417379212, 6957.304269573002, 6441.645709486023, 6497.967510162419, 6571.737130514726, 6649.534532582867, 6691.297413771484, 5843.912341314799, 5972.313183983723, 6769.661516924036, 6800.693968771516, 6809.659517024228, 6278.372162783685, 6393.2647745508, 6550.737970481127, 6563.0811686362995, 6565.868682626226, 6420.775272865428, 6453.257875344396, 6496.415322620986, 6501.544891857525, 6520.119783829312, 6352.936470635234, 6427.164468619237, 6429.8714025720155, 6450.354964503512, 6470.773522926675, 6334.303226645157, 6369.87260254783, 6394.616323020634, 6455.806325810233, 6478.2550006749825, 6378.712957916812, 6431.324710905475, 6434.613923164437, 6435.002574600944, 6446.033095035595], "value": 6057.45060723789, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.8895173246939, 776.196636481242, 822.9588520573972, 1196.7068068323267, 1255.4036832504555, 37516.87449376519, 38670.0, 38689.806550967274, 38720.61279387205, 38732.83801485956, 38749.0, 38777.8061109694, 39077.609223907755, 39087.41368879469, 39712.60287397125, 7423.369013633847, 7856.842863142762, 7924.6433910474025, 8520.275776559, 8556.101609331025, 7312.0, 8670.566471676422, 8685.392022558424, 8689.217970382664, 8693.913060869374, 8644.222020018196, 8707.869381959275, 8723.996740374843, 8736.126387361277, 8737.388382813206, 8638.308935285162, 8673.436226645312, 8677.826443471127, 8680.34897382699, 8686.305095592337, 8486.915130848674, 8539.487630742175, 8549.102344253826, 8569.228769410784, 8574.914250857473, 36845.447318290244, 36884.446733298755, 36980.63019369799, 37083.0, 37131.814340928126, 3574.5889222739456, 3607.2965771674535, 3613.403788374915, 3619.5294611700574, 3619.6742293193474, 30385.848070759726, 30493.847530762203, 30600.081997539888, 30612.92854750073, 31006.069817905274, 3139.6389415217313, 3180.8409579521162, 3184.331290429013, 3192.425363434581, 3207.3905957867933, 308516.0, 309664.0, 310050.0, 314152.0, 316285.0, 48239.0, 48263.0, 48370.0, 48502.0, 48503.0, 50557.24164137541, 50909.49090509122, 54234.728826356404, 56037.439625604035, 56068.719656402274, 14405.0, 14475.348609312607, 14496.492622758153, 14515.709685806225, 14525.854741452662, 11439.199256051996, 11524.88475115255, 11609.825852612217, 11633.243839150427, 11653.30080195191, 11804.586839460577, 13802.723945521033, 14239.85760142406, 14329.426822927175, 14363.856361436252, 6298.874022519524, 6316.0, 6333.271673757485, 6338.176037115238, 6339.873202535923, 845.5964741913846, 948.9288303377274, 991.1872264742985, 1063.0591926145416, 1078.2182917384832, 21757.891210543847, 23608.055677772696, 24643.87678061634, 24704.011839526578, 24745.762711864696, 1097.1332647208776, 1111.9610813621646, 1122.7817817667758, 1141.834434007081, 1145.3299819605625, 10915.563377464812, 12497.25016499013, 12550.12149149569, 12687.682807929876, 12709.428075736614, 320401.0, 320689.0, 322414.0, 323387.0, 323580.0, 54481.45518544843, 54785.72607137018, 54910.17634735482, 54946.72526637341, 55118.72440637851, 1394.7071115065746, 1447.088334349353, 1474.5502621700484, 1548.8760899128042, 1558.5402306319663, 20410.0, 24108.758912410653, 24111.517769644157, 24138.275851724477, 24205.878970605034, 38387.80806095952, 38478.0, 38518.037049072875, 38558.228835423695, 38598.22803543857, 290063.0, 290535.0, 291036.0, 292323.0, 292973.535132323, 28873.133805985854, 29181.854090729412, 34980.47529287012, 35747.64252357443, 36093.819530902176, 45411.54588454205, 45470.635880923626, 45533.0, 45610.315845261684, 45772.31341529946, 29018.41963160767, 29969.0, 30115.397692045597, 31500.68499315069, 31735.04794856158, 25279.494410112064, 25537.616935745606, 31268.687313127488, 31475.685243147276, 31561.0, 28270.858645707463, 29149.0, 36480.45279320866, 37469.06327341729, 37755.62244377631, 24225.63661545043, 29250.414991700472, 31495.685043149275, 31579.894703685262, 31981.840090799396, 22358.105675773437, 23719.881400592887, 24543.754562454145, 24666.260012199662, 24936.127235546668], "value": 17596.87874742, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.48562300319475, 396.86506587760164, 420.42821762403105, 430.81690281630307, 451.2283994369628, 20864.47838804031, 21221.151153953844, 21747.0, 21786.346409607737, 22115.0, 22179.0, 22378.55242895141, 22865.0, 23091.884540577317, 23347.416314592145, 5993.130996005577, 6240.188775459184, 6252.531060170505, 6254.280757712853, 6259.06114082889, 5807.709614519278, 6081.361457047013, 6148.692565371736, 6151.569390142692, 6154.476869466101, 5978.940210597903, 6074.301455332627, 6094.146819445281, 6108.633481991094, 6117.5717699761035, 5945.227120474354, 6060.757569697207, 6124.908126378108, 6151.692415379213, 6167.876642467148, 4556.3621093047, 5202.505761952609, 5370.167624018283, 5392.379876314235, 5440.319960004999, 27095.0, 27571.448571028468, 27641.585376219173, 27858.721412785817, 27946.720532794818, 1998.740163778714, 2130.4247853079582, 2152.5156839711094, 2192.0683709423593, 2205.6029914615365, 17673.823261767346, 17823.73264401035, 18035.368762093396, 18340.54148646281, 18919.148638311308, 1717.2787429279608, 1751.95620109497, 1753.9125742040017, 1754.307048715763, 1754.929802807886, 143155.0, 161832.0, 165888.17055914763, 167472.3252767481, 168561.0, 10072.345297555781, 10426.530806113591, 12633.557825476064, 12814.0, 12863.614091577268, 16536.6692666146, 16590.336386544644, 16609.335626575044, 16613.584660383345, 16649.0, 8812.603432845537, 8973.237274831581, 9071.501067441222, 9097.954510227406, 9126.315526335551, 8203.179682031749, 8500.744977650556, 8513.872291915626, 8535.615897284637, 8679.826403471896, 6705.362990515893, 7928.405369597303, 8044.959775201087, 8143.226393492609, 8149.837003259901, 2156.4716644422215, 2161.81624561914, 2162.264829957822, 2167.4147980045614, 2349.2717257650183, 753.2730914667372, 900.9819803603891, 901.535709109809, 926.3376685669779, 959.6641175588488, 17165.82834171667, 19014.71477927832, 19785.901070494845, 20637.380878573666, 21176.576468470852, 930.6603089872283, 976.6630512473328, 988.2785566536469, 990.7721224118349, 999.0509016434416, 10276.537555810006, 10293.022162894513, 10826.350418974887, 10860.185486088574, 10865.0, 477954.4409111798, 487179.0, 526561.0, 530086.0, 532985.0, 118130.0, 127644.0, 133708.9943650846, 135599.0, 135638.0, 1087.472575800736, 1122.814735568622, 1143.4054291768234, 1143.6683361824978, 1148.7932172208916, 13357.8868163636, 17165.485035448957, 17725.822741772416, 17798.84307520007, 17927.28290868403, 58841.411585883594, 59588.70205649117, 59596.40403595909, 60008.69995650168, 60540.78918421695, 82307.7653835181, 82447.0, 85956.57021714852, 86628.0, 88278.67581986403, 8046.155153708776, 8140.104588495143, 9067.68263110788, 9202.447853128833, 9227.292950804123, 11819.70450738704, 14184.929075354557, 14465.566033019026, 14762.48331308399, 15126.243687815786, 8350.498970061815, 9119.817603647758, 11775.192717566706, 12130.696732581757, 12443.440045197807, 9839.60641574329, 11743.647690569296, 11780.941095294469, 11907.0, 12132.939335303266, 10942.835857461985, 11366.261193022427, 12368.567100151451, 12668.809967850673, 12787.0, 8855.247303979233, 8884.0, 9118.40730352525, 9129.77175570616, 9242.353035287735, 11955.701107472383, 12034.157608967289, 12199.817002744789, 12317.07621928341, 12341.876581234073], "value": 10268.217977066737, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1219.3720234079449, 1388.3197233355659, 1465.1575942671218, 1475.7161269695366, 1484.3543058769435, 11271.605493807698, 11444.313341199524, 11928.7614247715, 11956.940215298933, 11979.221350612215, 11638.068954483642, 11897.345645989468, 11907.702307442318, 11911.344876031837, 12079.939600302008, 2505.2359030495736, 2562.9871850640816, 2564.5768448206118, 2567.165671156872, 2568.550503661861, 2478.4423504711385, 2527.9747202527924, 2541.2376287113884, 2541.606051062079, 2542.872856357184, 2509.77412032917, 2535.5055764126005, 2563.512932542811, 2565.602331638599, 2567.820252582311, 2474.418511649761, 2498.287987923451, 2530.519201351737, 2535.5055764126005, 2535.6450096986437, 2442.7435119312395, 2510.0336370497307, 2516.584763514018, 2552.4001859562986, 2553.170219678612, 11697.590584329593, 11707.063434925185, 11803.055755539537, 11804.763904721944, 11828.935395814418, 6627.271000189975, 6856.142982127234, 6861.5539989901, 6873.896891546631, 6876.828079298008, 4027.7784721840285, 4344.739315641072, 4418.469783625986, 4430.556944305576, 4438.955610443886, 1237.5730373021293, 1263.437770192265, 1304.5760127958356, 1306.3598836570106, 1309.8428188617331, 15168.165750883696, 15739.842601574066, 15764.369425222978, 16132.59668508285, 16144.112073835935, 4879.804807807719, 5054.418741844662, 5951.880962380728, 6224.564280500412, 6236.908541005306, 14000.649983750283, 14122.435102595986, 14128.858711412755, 14134.50529231472, 14200.857991419953, 6914.585124892422, 6973.58158510491, 6980.616066116311, 6988.336108069725, 7014.842550979133, 4686.36734040907, 5177.404598471148, 6041.395860413923, 6289.119523266746, 6307.0, 4697.6711630185555, 4800.279958006327, 4823.927641085386, 4840.249761287007, 4851.151048566487, 1441.740486712381, 1493.6937927724791, 1497.0867770659888, 1516.113073851787, 1518.1346632419636, 770.1836053783007, 775.8797386405116, 791.9208079192035, 800.5396896784372, 806.7095845495617, 6493.480521558264, 6607.636579988147, 6757.662116894136, 6818.4886133540185, 6860.5197636165985, 904.8054668246227, 909.7627226971314, 912.6212621762027, 921.5162039929091, 936.2089034765612, 4098.385242213632, 4169.666426685919, 4183.974926143114, 4198.6221240088535, 4277.786110694453, 14837.629059273604, 14938.850611493963, 15143.318550665246, 15179.924100379427, 15205.391784328503, 12435.316057616918, 12804.295763733084, 14176.574702758728, 15226.390944362101, 15247.161406122548, 7416.25837416254, 8458.87311690325, 8645.567721613894, 8727.869081963776, 8757.036725960139, 6006.519478441627, 6729.52893297484, 6891.173059232924, 6932.688029038806, 6948.305169483011, 13126.540571079966, 13311.0, 13387.129836560593, 13697.863021369658, 13701.520446784314, 13394.062415630813, 13634.181949083088, 13720.382582784, 13761.587152385444, 13829.723405532035, 9119.544022798966, 9266.629334826532, 9463.526823658927, 9470.337076404861, 9489.335746497678, 9074.818503629758, 10674.73313167177, 10729.195310351599, 10813.0, 10816.242862999514, 7954.801129971797, 8948.552572371225, 9147.496887671243, 9165.358424910459, 9261.768455788659, 8199.262066414052, 8867.379283450355, 9001.594928228114, 9108.089191081104, 9130.315226358183, 7727.304542591194, 7833.764987050397, 7841.5687137208, 7852.0, 7854.646540905787, 5772.884542309214, 5898.852528686817, 6010.759569617167, 6058.0, 6095.878082438415, 4935.876603084952, 5970.0, 6021.946159422171, 6085.148079268817, 6233.407826256498], "value": 5441.191935547024, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.72478576960543, 408.3160705817755, 409.38796499233644, 413.1365446217407, 413.8013753398371, 5699.860027994402, 5933.643981361121, 6163.291221509522, 6237.906431403521, 6283.811485655427, 4606.60843828275, 6034.24571928509, 6097.115918191859, 6116.296625888024, 6128.295246046706, 3513.894583162503, 4345.565443455661, 4433.046894917592, 4470.949326908174, 4499.1451624191295, 4428.16231264025, 4476.753778542179, 4478.798454069559, 4482.372467854503, 4486.371907932892, 3829.0, 4400.667646147531, 4401.36180253863, 4409.007973206035, 4414.227510185705, 3623.7644553103964, 4036.7577945323374, 4435.246008178601, 4442.666799989981, 4453.398791163217, 3622.8913132606062, 3774.433834924756, 3802.1445174835717, 3817.4273858921383, 3827.0, 4853.927191092102, 5792.178860245468, 5976.581639285252, 5988.970055149696, 6010.368911264298, 4957.529034741694, 5075.883305672746, 5250.06245316013, 5263.842084737464, 5347.887584404178, 5568.470995255444, 6207.503399728011, 6490.415862572344, 6535.346465353474, 6633.336666333376, 3553.680168784822, 4277.037666525038, 4345.652347812167, 4349.673774466928, 4351.129774045172, 6708.463322934153, 6888.588993852111, 6906.309369063104, 6994.405475534535, 7004.614746188958, 3633.0, 4337.392765012901, 4356.978215108968, 4370.519242883281, 4414.514403415622, 4420.7126536775, 4445.666575006888, 4445.933311000337, 4466.553344665573, 4481.2381895077915, 4412.955870441318, 4834.903301933941, 5136.255242989746, 5223.399309079505, 5309.362876454773, 5468.945310546923, 6528.445082168069, 6573.769918052941, 6573.83565410859, 6579.210494740566, 1492.3209939477513, 1496.3640452807513, 1507.766296224087, 1508.6907184027248, 1514.9772753408708, 891.3715830339595, 913.0960349254324, 932.6782260120248, 969.4682401805131, 995.8605795188679, 4814.735189564538, 5181.896362072737, 5441.292631957899, 6176.227971503562, 6364.663420681709, 5482.835514934558, 6526.771562995367, 6675.920876505856, 6744.7976560703255, 6803.292205747879, 5264.131418316011, 5506.64206826563, 6081.604695694766, 6119.020956647004, 6188.628682279078, 2722.6732792065077, 3135.952960705591, 3513.3851575974104, 3561.3589553880033, 3567.9286414272087, 5832.979228634972, 6082.361352058058, 6262.499000079983, 6442.806715798533, 7009.1939426966555, 6028.457438830526, 6224.9377506224355, 6703.798886033427, 6889.207741109736, 6982.0, 6291.276503202099, 6873.621950792654, 6963.895541566881, 7015.649217539205, 7072.469564782662, 4980.551750342486, 6853.348931851466, 6853.9314606853295, 6886.931130688629, 6910.032595436543, 5902.078471156805, 6682.532222744361, 6688.531802773759, 6696.799096027127, 6711.328867113445, 6133.50931925436, 6447.198889343947, 6973.5118541701595, 7039.683214255473, 7056.894146587702, 3896.4155376693725, 3997.780122093313, 4207.6423504002505, 4337.154254920387, 4384.232759267052, 5497.080113298495, 6769.93230067693, 6884.345987131214, 6912.792616221522, 6924.653767311514, 5667.4332566743, 6404.903926441014, 6486.870262594816, 6621.437177839937, 6663.200415949923, 6316.557840951273, 6530.444912182517, 6601.9009714853355, 6639.535232533676, 6665.600063996176, 5919.6744179070565, 6288.402601752826, 6413.556949686284, 6433.581817181868, 6503.642299673564, 6360.522960777867, 6403.231612206565, 6632.635205063768, 6667.266600674019, 6674.16572928384, 6298.260256788129, 6491.610503369813, 6512.251091124392, 6522.34776522344, 6532.510061745293], "value": 4690.445369633541, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [832.4921797703396, 837.0541288344174, 841.1294310388747, 841.586135292708, 876.487254955851, 15780.368785248576, 16602.75095873563, 16642.0, 18626.627467450642, 19316.3239286625, 15280.388784448609, 17990.010549419778, 18155.636887262248, 18259.0, 18455.0, 979.9167070798991, 990.5146478225654, 1003.4029752297372, 1003.6136087606287, 1006.1799633298874, 1005.4570531912758, 1008.1632245236473, 1008.2740426892625, 1014.5181039006486, 1016.0, 1058.7088550648557, 1069.4492336446735, 1070.29895418501, 1070.3738313086853, 1071.8177909755361, 1046.9790604187913, 1068.4604274841156, 1069.636323649959, 1070.1813112968507, 1073.940933248667, 591.8845825064114, 750.898628685126, 771.6836097200121, 773.6557232031748, 775.3680750188635, 16649.0, 16705.83294167055, 16860.494185174466, 16872.325106995704, 16909.40817071409, 16829.495115146565, 17210.39763608268, 17359.305627774873, 17366.56583585408, 17405.738913916302, 11693.356865372401, 13899.930500347535, 14120.92939535306, 14153.716925661429, 14180.290985450789, 3476.7392445566684, 3536.1159710072484, 3540.2211513466996, 3544.2557063016798, 3546.7871927684164, 110794.89205108007, 115674.0, 126162.3691881544, 133074.33462832624, 135531.0, 13370.866291337157, 13681.931590341985, 13735.656608584864, 13744.175349479063, 13750.724985500234, 25431.491370172494, 25803.096891608704, 26012.73987260141, 26149.823257953438, 26421.867890660425, 7920.366370690331, 8046.275835174863, 8057.033156021198, 8080.959595201986, 8101.230383113595, 3832.1952389997855, 3852.9614703852603, 3877.592852750477, 3910.393888947218, 3913.8630147945255, 4329.848455304049, 4348.391225228407, 4396.516383197845, 4400.603945644907, 4418.315161150027, 925.8611208318806, 963.8457846744487, 966.7148191283588, 967.6322997260996, 973.7224890906199, 644.2655372874926, 664.5082638847218, 676.3946268090032, 677.2381071294793, 693.6635731670136, 11169.888301116885, 11990.584668169451, 12005.87994120065, 12164.695882603006, 12278.877211227951, 610.7312782375741, 651.1047309948821, 664.1299897134769, 680.8638272345551, 687.8005378440196, 4278.63631591312, 4333.241682705514, 5376.435474275145, 5451.400345961941, 5605.439456054443, 112788.43605781918, 113703.0, 114249.0, 115542.42228788802, 115962.0, 57989.0, 73967.89048164281, 74359.0, 76386.0, 81345.0, 75720.62139689266, 76689.61655191689, 76743.08142296487, 77746.0, 78132.99999999886, 10600.575976960836, 10766.685162690059, 12270.75458490843, 12419.44112514921, 12508.374581271082, 39340.0, 39562.80218598888, 40485.0, 40749.38875916923, 40871.56949506753, 43110.0, 47511.09955601737, 50370.74814625904, 52249.47750522598, 52950.0, 12307.69230769238, 15658.843411566195, 16085.77759491602, 16231.431899883448, 16255.105969171336, 17639.823601764332, 17763.555911102325, 18056.45830625083, 18736.53158671044, 18972.430827075208, 13846.307684615931, 13921.930390347983, 16474.599659028638, 17152.48542543726, 17522.38671646537, 16874.325026998784, 16962.236699348807, 17511.912440437718, 17529.0, 17533.649327013645, 15722.606934826263, 16589.921655092865, 16770.0776457296, 17021.40425085116, 17048.40330588473, 10325.690229293134, 10387.2209584283, 11172.608958686407, 11783.234089784137, 12179.02567794592, 13072.673183170496, 13765.587032389045, 13800.516981905585, 13892.0, 13928.025038247226], "value": 8321.68047432825, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1568.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 117.0, 115.0, 114.0, 114.0, 113.0, 114.0, 116.0, 116.0, 115.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 155.0, 109.0, 125.0, 145.0, 149.0, 148.0, 112.0], "value": 138.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 206.0, 210.0, 230.0, 226.0, 204.0, 225.0, 210.0, 189.0, 238.0], "value": 213.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 73.0, 88.0, 110.0, 87.0, 61.0, 60.0, 62.0, 75.0, 58.0], "value": 75.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 73.0, 82.0, 68.0, 69.0, 70.0, 87.0, 73.0, 81.0, 91.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 111.0, 135.0, 91.0, 99.0, 109.0, 134.0, 110.0, 137.0], "value": 110.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 102.0, 96.0, 97.0, 122.0, 155.0, 91.0, 139.0, 155.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 92.0, 91.0, 90.0, 102.0, 89.0, 92.0, 90.0, 91.0], "value": 92.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 52.0, 50.0, 50.0, 51.0, 60.0, 78.0, 78.0, 80.0], "value": 59.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 64.0, 60.0, 59.0, 61.0, 62.0, 59.0, 57.0, 60.0, 60.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 84.0, 83.0, 75.0, 90.0, 82.0, 104.0, 95.0, 108.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 159.0, 136.0, 142.0, 164.0, 139.0, 150.0, 164.0, 237.0, 154.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 191.0, 185.0, 187.0, 243.0, 186.0, 186.0, 183.0, 183.0, 186.0], "value": 191.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 68.0, 68.0, 74.0, 67.0, 69.0, 64.0, 83.0, 70.0], "value": 70.0, "unit": "score"}]}]} 04:59:31 INFO - Return code: 0 04:59:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:59:32 ERROR - # TBPL SUCCESS # 04:59:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:59:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:59:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:59:32 INFO - 2017-05-01 04:59:32.071 screenresolution[1677:11654] starting screenresolution argv=screenresolution get 04:59:32 INFO - 2017-05-01 04:59:32.074 screenresolution[1677:11654] Display 0: 1600x1200x32@60 04:59:32 INFO - 2017-05-01 04:59:32.080 screenresolution[1678:11657] starting screenresolution argv=screenresolution list 04:59:32 INFO - Available Modes on Display 0 04:59:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:59:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:59:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:59:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:59:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:59:32 INFO - Intel Iris: 04:59:32 INFO - Chipset Model: Intel Iris 04:59:32 INFO - Type: GPU 04:59:32 INFO - Bus: Built-In 04:59:32 INFO - VRAM (Dynamic, Max): 1536 MB 04:59:32 INFO - Vendor: Intel (0x8086) 04:59:32 INFO - Device ID: 0x0a2e 04:59:32 INFO - Revision ID: 0x0009 04:59:32 INFO - Displays: 04:59:32 INFO - Display: 04:59:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:59:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:59:32 INFO - Display Serial Number: 1600x1200 60 04:59:32 INFO - Main Display: Yes 04:59:32 INFO - Mirror: Off 04:59:32 INFO - Online: Yes 04:59:32 INFO - Rotation: Supported 04:59:32 INFO - Return code: 0 04:59:32 INFO - Running post-action listener: _resource_record_post_action 04:59:32 INFO - [mozharness: 2017-05-01 11:59:32.323839Z] Finished run-tests step (success) 04:59:32 INFO - Running post-run listener: _resource_record_post_run 04:59:32 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 35197440; Write bytes: 513559552; Read time: 324; Write time: 1761 04:59:32 INFO - TinderboxPrint: CPU usage
54.0% 04:59:32 INFO - TinderboxPrint: I/O read bytes / time
35,197,440 / 324 04:59:32 INFO - TinderboxPrint: I/O write bytes / time
513,559,552 / 1,761 04:59:32 INFO - TinderboxPrint: CPU idle
2,206.5 (46.0%) 04:59:32 INFO - TinderboxPrint: CPU system
962.3 (20.1%) 04:59:32 INFO - TinderboxPrint: CPU user
1,624.8 (33.9%) 04:59:32 INFO - TinderboxPrint: Swap in / out
240,828,416 / 0 04:59:32 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203862528; Write bytes: 195780608; Read time: 16192; Write time: 363 04:59:32 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 33403392; Write bytes: 303217664; Read time: 307; Write time: 1348 04:59:32 INFO - Running post-run listener: _upload_blobber_files 04:59:32 INFO - Blob upload gear active. 04:59:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:59:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:59:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:59:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:59:33 INFO - (blobuploader) - INFO - Open directory for files ... 04:59:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:59:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:59:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:34 INFO - (blobuploader) - INFO - Done attempting. 04:59:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:59:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:59:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:35 INFO - (blobuploader) - INFO - Done attempting. 04:59:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:59:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:59:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:36 INFO - (blobuploader) - INFO - Done attempting. 04:59:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:59:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:59:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:38 INFO - (blobuploader) - INFO - Done attempting. 04:59:38 INFO - (blobuploader) - INFO - Iteration through files over. 04:59:38 INFO - Return code: 0 04:59:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:59:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:59:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e6ca778ae18f200c0295cc75a568bad6731f8310fb716f3250e23a42add72c338505c2fd2266241373d1c342491fb6e7c0c56ea1232abe6eac4b0f834697ca6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68f221e1430b345968f5827f98a7fd1a4e152d6e69799d1c83e3864c373891ea4b40de8476e59b090bf6c93704e804f44b788e2a00cd988bd5f029d12ed1ef6c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7fe21acc4c5af72b850aaffab3895ac5a3f956796c87f730190ee58542b9afd6d6b194f91756584df0840b719d5e8c18decf5569093d3d748a80bf6fb439ceed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c390447a8f0e52be078ba8b79f577a46d05eb951ae62cbe26ac352dc1f29d66e2bc4aa8eb50efcad2e24e8a35368b4cb497a385591d7df136b1068b597b33b74"} 04:59:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:59:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:59:38 INFO - Contents: 04:59:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e6ca778ae18f200c0295cc75a568bad6731f8310fb716f3250e23a42add72c338505c2fd2266241373d1c342491fb6e7c0c56ea1232abe6eac4b0f834697ca6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68f221e1430b345968f5827f98a7fd1a4e152d6e69799d1c83e3864c373891ea4b40de8476e59b090bf6c93704e804f44b788e2a00cd988bd5f029d12ed1ef6c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7fe21acc4c5af72b850aaffab3895ac5a3f956796c87f730190ee58542b9afd6d6b194f91756584df0840b719d5e8c18decf5569093d3d748a80bf6fb439ceed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c390447a8f0e52be078ba8b79f577a46d05eb951ae62cbe26ac352dc1f29d66e2bc4aa8eb50efcad2e24e8a35368b4cb497a385591d7df136b1068b597b33b74"} 04:59:38 INFO - Running post-run listener: copy_logs_to_upload_dir 04:59:38 INFO - Copying logs to upload dir... 04:59:38 INFO - mkdir: /builds/slave/test/build/upload/logs 04:59:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.775700 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-05-01 04:59:38.289443) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-01 04:59:38.293175) ========= 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.xTasaMHuum/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.NCm2W10WT9/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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/5e6ca778ae18f200c0295cc75a568bad6731f8310fb716f3250e23a42add72c338505c2fd2266241373d1c342491fb6e7c0c56ea1232abe6eac4b0f834697ca6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68f221e1430b345968f5827f98a7fd1a4e152d6e69799d1c83e3864c373891ea4b40de8476e59b090bf6c93704e804f44b788e2a00cd988bd5f029d12ed1ef6c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7fe21acc4c5af72b850aaffab3895ac5a3f956796c87f730190ee58542b9afd6d6b194f91756584df0840b719d5e8c18decf5569093d3d748a80bf6fb439ceed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c390447a8f0e52be078ba8b79f577a46d05eb951ae62cbe26ac352dc1f29d66e2bc4aa8eb50efcad2e24e8a35368b4cb497a385591d7df136b1068b597b33b74"} build_url:https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011268 build_url: 'https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/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/5e6ca778ae18f200c0295cc75a568bad6731f8310fb716f3250e23a42add72c338505c2fd2266241373d1c342491fb6e7c0c56ea1232abe6eac4b0f834697ca6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68f221e1430b345968f5827f98a7fd1a4e152d6e69799d1c83e3864c373891ea4b40de8476e59b090bf6c93704e804f44b788e2a00cd988bd5f029d12ed1ef6c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7fe21acc4c5af72b850aaffab3895ac5a3f956796c87f730190ee58542b9afd6d6b194f91756584df0840b719d5e8c18decf5569093d3d748a80bf6fb439ceed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c390447a8f0e52be078ba8b79f577a46d05eb951ae62cbe26ac352dc1f29d66e2bc4aa8eb50efcad2e24e8a35368b4cb497a385591d7df136b1068b597b33b74"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-01 04:59:38.329092) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 04:59:38.329437) ========= 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.xTasaMHuum/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.NCm2W10WT9/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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.005300 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 04:59:38.381118) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-01 04:59:38.381870) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-01 04:59:38.382495) ========= ========= Total master_lag: 0.18 =========