builder: pine_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0028 starttime: 1491417672.29 results: success (0) buildid: 20170405080221 builduid: e66679fe27f74005b950f62ba1831f4d revision: 943472295ee61812ffea25699d548d53ca7bcb22 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 11:41:12.289230) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 11:41:12.289632) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 11:41:12.289911) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 11:41:12.316376) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 11:41:12.317049) ========= 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.SDBgVGKaUM/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.C9qKv5Ez9O/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-05 11:41:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.5M=0.001s 2017-04-05 11:41:12 (20.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.147113 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 11:41:12.489833) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 11:41:12.490142) ========= 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.SDBgVGKaUM/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.C9qKv5Ez9O/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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.027771 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 11:41:12.541569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-05 11:41:12.542297) ========= bash -c 'python archiver_client.py mozharness --repo projects/pine --rev 943472295ee61812ffea25699d548d53ca7bcb22 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/pine --rev 943472295ee61812ffea25699d548d53ca7bcb22 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SDBgVGKaUM/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.C9qKv5Ez9O/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-05 11:41:12,686 truncating revision to first 12 chars 2017-04-05 11:41:12,686 Setting DEBUG logging. 2017-04-05 11:41:12,686 attempt 1/10 2017-04-05 11:41:12,686 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/pine/943472295ee6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-05 11:41:14,176 unpacking tar archive at: pine-943472295ee6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.762373 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-05 11:41:14.329685) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 11:41:14.330054) ========= script_repo_revision: 943472295ee61812ffea25699d548d53ca7bcb22 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 11:41:14.330548) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 11:41:14.330856) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 11:41:14.351012) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-05 11:41:14.351580) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 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', 'Pine', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Pine'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SDBgVGKaUM/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.C9qKv5Ez9O/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 11:41:14 INFO - MultiFileLogger online at 20170405 11:41:14 in /builds/slave/test 11:41:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 11:41:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:41:14 INFO - {'append_to_log': False, 11:41:14 INFO - 'base_work_dir': '/builds/slave/test', 11:41:14 INFO - 'blob_upload_branch': 'Pine', 11:41:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:41:14 INFO - 'branch': 'Pine', 11:41:14 INFO - 'buildbot_json_path': 'buildprops.json', 11:41:14 INFO - 'config_files': ('talos/mac_config.py',), 11:41:14 INFO - 'default_actions': ('clobber', 11:41:14 INFO - 'read-buildbot-config', 11:41:14 INFO - 'download-and-extract', 11:41:14 INFO - 'populate-webroot', 11:41:14 INFO - 'create-virtualenv', 11:41:14 INFO - 'install', 11:41:14 INFO - 'run-tests'), 11:41:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:41:14 INFO - 'download_minidump_stackwalk': True, 11:41:14 INFO - 'download_symbols': 'ondemand', 11:41:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:41:14 INFO - 'tooltool.py': '/tools/tooltool.py', 11:41:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:41:14 INFO - '/tools/misc-python/virtualenv.py')}, 11:41:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:41:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:41:14 INFO - 'gecko_profile': False, 11:41:14 INFO - 'gecko_profile_interval': 0, 11:41:14 INFO - 'installer_path': 'installer.exe', 11:41:14 INFO - 'log_level': 'info', 11:41:14 INFO - 'log_name': 'talos', 11:41:14 INFO - 'log_to_console': True, 11:41:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:41:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:41:14 INFO - 'opt_config_files': (), 11:41:14 INFO - 'pip_index': False, 11:41:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:41:14 INFO - 'cmd': ('bash', 11:41:14 INFO - '-c', 11:41:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:41:14 INFO - 'enabled': True, 11:41:14 INFO - 'halt_on_failure': False, 11:41:14 INFO - 'name': 'check_screen_resolution'},), 11:41:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:41:14 INFO - 'cmd': ('bash', 11:41:14 INFO - '-c', 11:41:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:41:14 INFO - 'enabled': True, 11:41:14 INFO - 'halt_on_failure': False, 11:41:14 INFO - 'name': 'check_screen_resolution'},), 11:41:14 INFO - 'run_cmd_checks_enabled': True, 11:41:14 INFO - 'suite': 'dromaeojs-e10s', 11:41:14 INFO - 'system_bits': '32', 11:41:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:41:14 INFO - 'title': 't-yosemite-r7-0028', 11:41:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:41:14 INFO - 'use_talos_json': True, 11:41:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:41:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:41:14 INFO - 'work_dir': 'build'} 11:41:14 INFO - [mozharness: 2017-04-05 18:41:14.606031Z] Running clobber step. 11:41:14 INFO - Running pre-action listener: _resource_record_pre_action 11:41:14 INFO - Running main action method: clobber 11:41:14 INFO - rmtree: /builds/slave/test/build 11:41:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:41:17 INFO - Running post-action listener: _resource_record_post_action 11:41:17 INFO - [mozharness: 2017-04-05 18:41:17.158396Z] Finished clobber step (success) 11:41:17 INFO - [mozharness: 2017-04-05 18:41:17.158525Z] Running read-buildbot-config step. 11:41:17 INFO - Running pre-action listener: _resource_record_pre_action 11:41:17 INFO - Running main action method: read_buildbot_config 11:41:17 INFO - Using buildbot properties: 11:41:17 INFO - { 11:41:17 INFO - "project": "", 11:41:17 INFO - "product": "firefox", 11:41:17 INFO - "script_repo_revision": "default", 11:41:17 INFO - "builddir": "pine_yosemite_r7_test-dromaeojs-e10s", 11:41:17 INFO - "repository": "", 11:41:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 pine talos dromaeojs-e10s", 11:41:17 INFO - "buildid": "20170405080221", 11:41:17 INFO - "pgo_build": "False", 11:41:17 INFO - "basedir": "/builds/slave/test", 11:41:17 INFO - "buildnumber": 3, 11:41:17 INFO - "slavename": "t-yosemite-r7-0028", 11:41:17 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 11:41:17 INFO - "platform": "yosemite_r7", 11:41:17 INFO - "scheduler": "tests-pine-macosx64-talos", 11:41:17 INFO - "branch": "pine", 11:41:17 INFO - "repo_path": "projects/pine", 11:41:17 INFO - "revision": "943472295ee61812ffea25699d548d53ca7bcb22", 11:41:17 INFO - "stage_platform": "macosx64", 11:41:17 INFO - "builduid": "e66679fe27f74005b950f62ba1831f4d", 11:41:17 INFO - "slavebuilddir": "test" 11:41:17 INFO - } 11:41:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 11:41:17 INFO - Running post-action listener: _resource_record_post_action 11:41:17 INFO - [mozharness: 2017-04-05 18:41:17.161945Z] Finished read-buildbot-config step (success) 11:41:17 INFO - [mozharness: 2017-04-05 18:41:17.162063Z] Running download-and-extract step. 11:41:17 INFO - Running pre-action listener: _resource_record_pre_action 11:41:17 INFO - Running main action method: download_and_extract 11:41:17 INFO - mkdir: /builds/slave/test/build/tests 11:41: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')]} 11:41:17 INFO - trying https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 11:41:17 INFO - Downloading https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/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 11:41:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/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 11:41:18 INFO - Downloaded 1325 bytes. 11:41:18 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 11:41:18 INFO - Using the following test package requirements: 11:41:18 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:41:18 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 11:41:18 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 11:41:18 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:41:18 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 11:41:18 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:41:18 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 11:41:18 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:41:18 INFO - u'jsshell-mac.zip'], 11:41:18 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:41:18 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 11:41:18 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 11:41:18 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:41:18 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 11:41:18 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:41:18 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 11:41:18 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:41:18 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 11:41:18 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:41:18 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 11:41:18 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:41:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 11:41:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:41:18 INFO - Fetch https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 11:41:19 INFO - Expected file size: 52520938 11:41:19 INFO - Obtained file size: 52520938 11:41:35 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 11:41:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 11:41:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:41:35 INFO - Fetch https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 11:41:37 INFO - Expected file size: 52520938 11:41:37 INFO - Obtained file size: 52520938 11:41:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 11:41:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:41:52 INFO - Fetch https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 11:41:53 INFO - Expected file size: 14404152 11:41:53 INFO - Obtained file size: 14404152 11:41: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')]} 11:41:54 INFO - trying https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 11:41:54 INFO - Downloading https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 11:41:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/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 11:41:56 INFO - Downloaded 70981168 bytes. 11:41:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 11:41:56 INFO - mkdir: /builds/slave/test/properties 11:41:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:41:56 INFO - Writing to file /builds/slave/test/properties/build_url 11:41:56 INFO - Contents: 11:41:56 INFO - build_url:https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 11:41:56 INFO - Running post-action listener: _resource_record_post_action 11:41:56 INFO - Running post-action listener: set_extra_try_arguments 11:41:56 INFO - [mozharness: 2017-04-05 18:41:56.931372Z] Finished download-and-extract step (success) 11:41:56 INFO - [mozharness: 2017-04-05 18:41:56.931497Z] Running populate-webroot step. 11:41:56 INFO - Running pre-action listener: _resource_record_pre_action 11:41:56 INFO - Running main action method: populate_webroot 11:41:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:41:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:41:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:41:56 INFO - '--tppagecycles', 11:41:56 INFO - '7'], 11:41:56 INFO - 'tests': ['tsvgm']}}, 11:41:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:41:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:41:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:41:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:41:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:41:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:41:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:41:56 INFO - 'talos_options': ['--disable-e10s'], 11:41:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:41:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:41:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:41:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:41:56 INFO - 'talos_options': ['--disable-e10s'], 11:41:56 INFO - 'tests': ['damp', 'tps']}, 11:41:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:41:56 INFO - 'tests': ['damp', 'tps']}, 11:41:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:41:56 INFO - 'tests': ['dromaeo_dom']}, 11:41:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:41:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:41:56 INFO - 'tests': ['basic_compositor_video']}, 11:41:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:41:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:41:56 INFO - 'tests': ['a11yr', 11:41:56 INFO - 'ts_paint', 11:41:56 INFO - 'tpaint', 11:41:56 INFO - 'sessionrestore', 11:41:56 INFO - 'sessionrestore_no_auto_restore', 11:41:56 INFO - 'tabpaint']}, 11:41:56 INFO - 'other-e10s': {'tests': ['a11yr', 11:41:56 INFO - 'ts_paint', 11:41:56 INFO - 'tpaint', 11:41:56 INFO - 'sessionrestore', 11:41:56 INFO - 'sessionrestore_no_auto_restore', 11:41:56 INFO - 'tabpaint']}, 11:41:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:41:56 INFO - 'ts_paint', 11:41:56 INFO - 'tpaint', 11:41:56 INFO - 'sessionrestore', 11:41:56 INFO - 'sessionrestore_no_auto_restore', 11:41:56 INFO - 'tabpaint']}, 11:41:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:41:56 INFO - 'ts_paint', 11:41:56 INFO - 'tpaint', 11:41:56 INFO - 'sessionrestore', 11:41:56 INFO - 'sessionrestore_no_auto_restore', 11:41:56 INFO - 'tabpaint']}, 11:41:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:41:56 INFO - 'tests': ['a11yr', 11:41:56 INFO - 'ts_paint', 11:41:56 INFO - 'tpaint', 11:41:56 INFO - 'sessionrestore', 11:41:56 INFO - 'sessionrestore_no_auto_restore', 11:41:56 INFO - 'tabpaint']}, 11:41:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:41:56 INFO - 'tests': ['a11yr', 11:41:56 INFO - 'ts_paint', 11:41:56 INFO - 'tpaint', 11:41:56 INFO - 'sessionrestore', 11:41:56 INFO - 'sessionrestore_no_auto_restore', 11:41:56 INFO - 'tabpaint']}, 11:41:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:41:56 INFO - 'tests': ['tsvgx', 11:41:56 INFO - 'tsvgr_opacity', 11:41:56 INFO - 'tart', 11:41:56 INFO - 'tscrollx', 11:41:56 INFO - 'cart', 11:41:56 INFO - 'tsvg_static']}, 11:41:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:41:56 INFO - 'tsvgr_opacity', 11:41:56 INFO - 'tart', 11:41:56 INFO - 'tscrollx', 11:41:56 INFO - 'cart', 11:41:56 INFO - 'tsvg_static']}, 11:41:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:41:56 INFO - 'talos_options': ['--disable-e10s'], 11:41:56 INFO - 'tests': ['tp5o']}, 11:41:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:41:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:41:56 INFO - 'talos_options': ['--disable-e10s', 11:41:56 INFO - '--xperf_path', 11:41:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:41:56 INFO - 'tests': ['tp5n']}, 11:41:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:41:56 INFO - 'talos_options': ['--xperf_path', 11:41:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:41:56 INFO - 'tests': ['tp5n']}}, 11:41:56 INFO - 'talos.zip': {'path': '', 11:41:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:41:56 INFO - Running post-action listener: _resource_record_post_action 11:41:56 INFO - [mozharness: 2017-04-05 18:41:56.949975Z] Finished populate-webroot step (success) 11:41:56 INFO - [mozharness: 2017-04-05 18:41:56.950108Z] Running create-virtualenv step. 11:41:56 INFO - Running pre-action listener: _resource_record_pre_action 11:41:56 INFO - Running main action method: create_virtualenv 11:41:56 INFO - Creating virtualenv /builds/slave/test/build/venv 11:41:56 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 11:41:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:41:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:41:57 INFO - Using real prefix '/tools/python27' 11:41:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:41:57 INFO - Installing distribute.............................................................................................................................................................................................done. 11:42:00 INFO - Installing pip.................done. 11:42:00 INFO - Return code: 0 11:42:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:42:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:42:00 INFO - Reading from file tmpfile_stdout 11:42:00 INFO - Output received: 11:42:00 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) 11:42:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:01 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 0x109d27b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d2a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f843bd9d950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b05d30>, '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 0x109a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109afabe8>, '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.SDBgVGKaUM/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.C9qKv5Ez9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 11:42:01 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 11:42:01 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 11:42:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDBgVGKaUM/Render', 11:42:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:01 INFO - 'HOME': '/Users/cltbld', 11:42:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:01 INFO - 'LOGNAME': 'cltbld', 11:42:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:01 INFO - 'MOZ_NO_REMOTE': '1', 11:42:01 INFO - 'NO_EM_RESTART': '1', 11:42:01 INFO - 'PAGER': '/bin/cat', 11:42:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:01 INFO - 'PWD': '/builds/slave/test', 11:42:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:01 INFO - 'SHELL': '/bin/bash', 11:42:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C9qKv5Ez9O/Listeners', 11:42:01 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 11:42:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:01 INFO - 'USER': 'cltbld', 11:42:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:01 INFO - 'XPC_FLAGS': '0x0', 11:42:01 INFO - 'XPC_SERVICE_NAME': '0', 11:42:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:01 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 11:42:01 INFO - Cleaning up... 11:42:01 INFO - Return code: 0 11:42:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:42:01 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')]} 11:42:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:01 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')]} 11:42:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:01 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 0x109d27b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d2a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f843bd9d950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b05d30>, '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 0x109a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109afabe8>, '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.SDBgVGKaUM/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.C9qKv5Ez9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 11:42:01 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 11:42:01 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 11:42:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDBgVGKaUM/Render', 11:42:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:01 INFO - 'HOME': '/Users/cltbld', 11:42:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:01 INFO - 'LOGNAME': 'cltbld', 11:42:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:01 INFO - 'MOZ_NO_REMOTE': '1', 11:42:01 INFO - 'NO_EM_RESTART': '1', 11:42:01 INFO - 'PAGER': '/bin/cat', 11:42:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:01 INFO - 'PWD': '/builds/slave/test', 11:42:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:01 INFO - 'SHELL': '/bin/bash', 11:42:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C9qKv5Ez9O/Listeners', 11:42:01 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 11:42:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:01 INFO - 'USER': 'cltbld', 11:42:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:01 INFO - 'XPC_FLAGS': '0x0', 11:42:01 INFO - 'XPC_SERVICE_NAME': '0', 11:42:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:01 INFO - Downloading/unpacking psutil>=3.1.1 11:42:01 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 11:42:01 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 11:42:01 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 11:42:01 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 11:42:01 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 11:42:01 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 11:42:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:42:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:42:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:42:05 INFO - Installing collected packages: psutil 11:42:05 INFO - Running setup.py install for psutil 11:42:05 INFO - building 'psutil._psutil_osx' extension 11:42:05 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 11:42:05 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 11:42:05 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 11:42:05 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 11:42:06 INFO - building 'psutil._psutil_posix' extension 11:42:06 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 11:42:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:42:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:42:06 INFO - ^ 11:42:06 INFO - 1 warning generated. 11:42:06 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 11:42:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:42:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:42:06 INFO - Successfully installed psutil 11:42:06 INFO - Cleaning up... 11:42:06 INFO - Return code: 0 11:42:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:42:06 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')]} 11:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:06 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')]} 11:42:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:06 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 0x109d27b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d2a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f843bd9d950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b05d30>, '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 0x109a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109afabe8>, '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.SDBgVGKaUM/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.C9qKv5Ez9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 11:42:06 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 11:42:06 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 11:42:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDBgVGKaUM/Render', 11:42:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:06 INFO - 'HOME': '/Users/cltbld', 11:42:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:06 INFO - 'LOGNAME': 'cltbld', 11:42:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:06 INFO - 'MOZ_NO_REMOTE': '1', 11:42:06 INFO - 'NO_EM_RESTART': '1', 11:42:06 INFO - 'PAGER': '/bin/cat', 11:42:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:06 INFO - 'PWD': '/builds/slave/test', 11:42:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:06 INFO - 'SHELL': '/bin/bash', 11:42:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C9qKv5Ez9O/Listeners', 11:42:06 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 11:42:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:06 INFO - 'USER': 'cltbld', 11:42:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:06 INFO - 'XPC_FLAGS': '0x0', 11:42:06 INFO - 'XPC_SERVICE_NAME': '0', 11:42:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:42:06 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 11:42:06 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 11:42:06 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 11:42:06 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 11:42:06 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 11:42:06 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 11:42:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:42:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:42:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:42:09 INFO - Installing collected packages: mozsystemmonitor 11:42:09 INFO - Running setup.py install for mozsystemmonitor 11:42:09 INFO - Successfully installed mozsystemmonitor 11:42:09 INFO - Cleaning up... 11:42:09 INFO - Return code: 0 11:42:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109d27b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d2a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f843bd9d950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b05d30>, '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 0x109a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109afabe8>, '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.SDBgVGKaUM/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.C9qKv5Ez9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 11:42:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:42:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:42:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDBgVGKaUM/Render', 11:42:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:10 INFO - 'HOME': '/Users/cltbld', 11:42:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:10 INFO - 'LOGNAME': 'cltbld', 11:42:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:10 INFO - 'MOZ_NO_REMOTE': '1', 11:42:10 INFO - 'NO_EM_RESTART': '1', 11:42:10 INFO - 'PAGER': '/bin/cat', 11:42:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:10 INFO - 'PWD': '/builds/slave/test', 11:42:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:10 INFO - 'SHELL': '/bin/bash', 11:42:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C9qKv5Ez9O/Listeners', 11:42:10 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 11:42:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:10 INFO - 'USER': 'cltbld', 11:42:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:10 INFO - 'XPC_FLAGS': '0x0', 11:42:10 INFO - 'XPC_SERVICE_NAME': '0', 11:42:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:10 INFO - Downloading/unpacking jsonschema==2.5.1 11:42: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 11:42: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 11:42: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 11:42: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 11:42: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 11:42: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 11:42:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:42:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:42:13 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 11:42:13 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 11:42:13 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 11:42:13 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 11:42:13 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 11:42:13 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 11:42:13 INFO - Downloading functools32-3.2.3-2.tar.gz 11:42:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:42:14 INFO - warning: no files found matching '*.txt' 11:42:14 INFO - no previously-included directories found matching 'build' 11:42:14 INFO - no previously-included directories found matching 'dist' 11:42:14 INFO - no previously-included directories found matching '.git*' 11:42:14 INFO - Installing collected packages: jsonschema, functools32 11:42:14 INFO - Running setup.py install for functools32 11:42:14 INFO - warning: no files found matching '*.txt' 11:42:14 INFO - no previously-included directories found matching 'build' 11:42:14 INFO - no previously-included directories found matching 'dist' 11:42:14 INFO - no previously-included directories found matching '.git*' 11:42:14 INFO - Successfully installed jsonschema functools32 11:42:14 INFO - Cleaning up... 11:42:14 INFO - Return code: 0 11:42:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:14 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 0x109d27b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d2a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f843bd9d950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b05d30>, '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 0x109a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109afabe8>, '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.SDBgVGKaUM/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.C9qKv5Ez9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 11:42:14 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 11:42:14 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 11:42:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDBgVGKaUM/Render', 11:42:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:14 INFO - 'HOME': '/Users/cltbld', 11:42:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:14 INFO - 'LOGNAME': 'cltbld', 11:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:14 INFO - 'MOZ_NO_REMOTE': '1', 11:42:14 INFO - 'NO_EM_RESTART': '1', 11:42:14 INFO - 'PAGER': '/bin/cat', 11:42:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:14 INFO - 'PWD': '/builds/slave/test', 11:42:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:14 INFO - 'SHELL': '/bin/bash', 11:42:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C9qKv5Ez9O/Listeners', 11:42:14 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 11:42:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:14 INFO - 'USER': 'cltbld', 11:42:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:14 INFO - 'XPC_FLAGS': '0x0', 11:42:14 INFO - 'XPC_SERVICE_NAME': '0', 11:42:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:42:14 INFO - Cleaning up... 11:42:14 INFO - Return code: 0 11:42:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:14 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 0x109d27b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d2a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f843bd9d950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b05d30>, '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 0x109a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109afabe8>, '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.SDBgVGKaUM/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.C9qKv5Ez9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 11:42:14 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 11:42:14 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 11:42:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDBgVGKaUM/Render', 11:42:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:14 INFO - 'HOME': '/Users/cltbld', 11:42:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:14 INFO - 'LOGNAME': 'cltbld', 11:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:14 INFO - 'MOZ_NO_REMOTE': '1', 11:42:14 INFO - 'NO_EM_RESTART': '1', 11:42:14 INFO - 'PAGER': '/bin/cat', 11:42:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:14 INFO - 'PWD': '/builds/slave/test', 11:42:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:14 INFO - 'SHELL': '/bin/bash', 11:42:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C9qKv5Ez9O/Listeners', 11:42:14 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 11:42:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:14 INFO - 'USER': 'cltbld', 11:42:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:14 INFO - 'XPC_FLAGS': '0x0', 11:42:14 INFO - 'XPC_SERVICE_NAME': '0', 11:42:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:14 INFO - Downloading/unpacking blobuploader==1.2.4 11:42: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 11:42: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 11:42: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 11:42: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 11:42: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 11:42: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 11:42:17 INFO - Downloading blobuploader-1.2.4.tar.gz 11:42:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:42:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:42:17 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 11:42:17 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 11:42:17 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 11:42:17 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 11:42:17 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 11:42:17 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 11:42:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:42:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:42: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 11:42: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 11:42: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 11:42: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 11:42: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 11:42: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 11:42:18 INFO - Downloading docopt-0.6.1.tar.gz 11:42:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:42:18 INFO - Installing collected packages: blobuploader, requests, docopt 11:42:18 INFO - Running setup.py install for blobuploader 11:42:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:42:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:42:19 INFO - Running setup.py install for requests 11:42:19 INFO - Running setup.py install for docopt 11:42:19 INFO - Successfully installed blobuploader requests docopt 11:42:19 INFO - Cleaning up... 11:42:19 INFO - Return code: 0 11:42:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:19 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 0x109d27b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d2a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f843bd9d950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b05d30>, '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 0x109a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109afabe8>, '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.SDBgVGKaUM/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.C9qKv5Ez9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 11:42:19 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 11:42:19 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 11:42:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDBgVGKaUM/Render', 11:42:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:19 INFO - 'HOME': '/Users/cltbld', 11:42:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:19 INFO - 'LOGNAME': 'cltbld', 11:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:19 INFO - 'MOZ_NO_REMOTE': '1', 11:42:19 INFO - 'NO_EM_RESTART': '1', 11:42:19 INFO - 'PAGER': '/bin/cat', 11:42:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:19 INFO - 'PWD': '/builds/slave/test', 11:42:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:19 INFO - 'SHELL': '/bin/bash', 11:42:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C9qKv5Ez9O/Listeners', 11:42:19 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 11:42:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:19 INFO - 'USER': 'cltbld', 11:42:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:19 INFO - 'XPC_FLAGS': '0x0', 11:42:19 INFO - 'XPC_SERVICE_NAME': '0', 11:42:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:42:20 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-jgI3CC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:42:20 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-5hU6MO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:42:20 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-wER3hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:42:20 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-y30OFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:42:20 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-HfDP9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:42:20 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-_dB731-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:42:20 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-toncxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:42:20 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-b20gW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:42:20 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-u0jKUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:42:20 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-FsyiOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:42:21 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-OC_o1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:42:21 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-XfXWKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:42:21 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-5lhvNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:42:21 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-5qdVzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:21 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-HyO6Pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:42:21 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-GUg5Cy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:42:21 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-6OncdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:42:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:42:21 INFO - Running setup.py install for manifestparser 11:42:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:42:21 INFO - Running setup.py install for mozcrash 11:42:22 INFO - Running setup.py install for mozdebug 11:42:22 INFO - Running setup.py install for mozdevice 11:42:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:42:22 INFO - Running setup.py install for mozfile 11:42:22 INFO - Running setup.py install for mozhttpd 11:42:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:42:22 INFO - Running setup.py install for mozinfo 11:42:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:42:22 INFO - Running setup.py install for mozInstall 11:42:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:42:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:42:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:42:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:42:22 INFO - Running setup.py install for mozleak 11:42:23 INFO - Running setup.py install for mozlog 11:42:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:42:23 INFO - Running setup.py install for moznetwork 11:42:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:42:23 INFO - Running setup.py install for mozprocess 11:42:23 INFO - Running setup.py install for mozprofile 11:42:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:42:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:42:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:42:23 INFO - Running setup.py install for mozrunner 11:42:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:42:23 INFO - Running setup.py install for mozscreenshot 11:42:24 INFO - Running setup.py install for moztest 11:42:24 INFO - Running setup.py install for mozversion 11:42:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:42:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:42:24 INFO - Cleaning up... 11:42:24 INFO - Return code: 0 11:42:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:24 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 0x109d27b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d2a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f843bd9d950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b05d30>, '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 0x109a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109afabe8>, '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.SDBgVGKaUM/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.C9qKv5Ez9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 11:42:24 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 11:42:24 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 11:42:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDBgVGKaUM/Render', 11:42:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:24 INFO - 'HOME': '/Users/cltbld', 11:42:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:24 INFO - 'LOGNAME': 'cltbld', 11:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:24 INFO - 'MOZ_NO_REMOTE': '1', 11:42:24 INFO - 'NO_EM_RESTART': '1', 11:42:24 INFO - 'PAGER': '/bin/cat', 11:42:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:24 INFO - 'PWD': '/builds/slave/test', 11:42:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:24 INFO - 'SHELL': '/bin/bash', 11:42:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C9qKv5Ez9O/Listeners', 11:42:24 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 11:42:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:24 INFO - 'USER': 'cltbld', 11:42:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:24 INFO - 'XPC_FLAGS': '0x0', 11:42:24 INFO - 'XPC_SERVICE_NAME': '0', 11:42:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:42:24 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-DgPJkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:42:24 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)) 11:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:42:24 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-prxkL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:42:24 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)) 11:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:42:24 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-NZphdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:42:24 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)) 11:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:42:24 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-r27W8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:42:25 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-ka0WzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:42:25 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)) 11:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:42:25 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-fFoUng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:42:25 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)) 11:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:42:25 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-DjiPlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:42:25 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)) 11:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:42:25 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-3_ZhYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:42:25 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)) 11:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:42:25 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-kSVT_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:42:25 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)) 11:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:42:25 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-kLUWNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:42:25 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)) 11:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:42:25 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-IuoFkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:42:25 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)) 11:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:42:25 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-dtxyFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:42:25 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)) 11:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:42:25 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-TJTcKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:42:26 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)) 11:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:42:26 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-t9DoqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:42:26 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)) 11:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:26 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-vzdlFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:26 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)) 11:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:42:26 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-wHmN_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:42:26 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)) 11:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:42:26 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-6iWicW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:42:26 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)) 11:42:26 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)) 11:42:26 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)) 11:42:26 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)) 11:42:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:42:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:42:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:42:26 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 11:42:26 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 11:42:26 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 11:42:26 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 11:42:26 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 11:42:26 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 11:42:29 INFO - Downloading blessings-1.6.tar.gz 11:42:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:42:29 INFO - Installing collected packages: blessings 11:42:29 INFO - Running setup.py install for blessings 11:42:29 INFO - Successfully installed blessings 11:42:29 INFO - Cleaning up... 11:42:29 INFO - Return code: 0 11:42:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:42:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:42:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:42:29 INFO - Reading from file tmpfile_stdout 11:42:29 INFO - Current package versions: 11:42:29 INFO - blessings == 1.6 11:42:29 INFO - blobuploader == 1.2.4 11:42:29 INFO - docopt == 0.6.1 11:42:29 INFO - functools32 == 3.2.3-2 11:42:29 INFO - jsonschema == 2.5.1 11:42:29 INFO - manifestparser == 1.1 11:42:29 INFO - mozInstall == 1.12 11:42:29 INFO - mozcrash == 1.0 11:42:29 INFO - mozdebug == 0.1 11:42:29 INFO - mozdevice == 0.49 11:42:29 INFO - mozfile == 1.2 11:42:29 INFO - mozhttpd == 0.7 11:42:29 INFO - mozinfo == 0.9 11:42:29 INFO - mozleak == 0.1 11:42:29 INFO - mozlog == 3.4 11:42:29 INFO - moznetwork == 0.27 11:42:29 INFO - mozprocess == 0.25 11:42:29 INFO - mozprofile == 0.28 11:42:29 INFO - mozrunner == 6.13 11:42:29 INFO - mozscreenshot == 0.1 11:42:29 INFO - mozsystemmonitor == 0.3 11:42:29 INFO - moztest == 0.8 11:42:29 INFO - mozversion == 1.4 11:42:29 INFO - psutil == 3.1.1 11:42:29 INFO - requests == 1.2.3 11:42:29 INFO - wsgiref == 0.1.2 11:42:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:29 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 0x109d27b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d2a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f843bd9d950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b05d30>, '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 0x109a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109afabe8>, '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.SDBgVGKaUM/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.C9qKv5Ez9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 11:42:29 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 11:42:29 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 11:42:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDBgVGKaUM/Render', 11:42:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:29 INFO - 'HOME': '/Users/cltbld', 11:42:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:29 INFO - 'LOGNAME': 'cltbld', 11:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:29 INFO - 'MOZ_NO_REMOTE': '1', 11:42:29 INFO - 'NO_EM_RESTART': '1', 11:42:29 INFO - 'PAGER': '/bin/cat', 11:42:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:29 INFO - 'PWD': '/builds/slave/test', 11:42:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:29 INFO - 'SHELL': '/bin/bash', 11:42:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C9qKv5Ez9O/Listeners', 11:42:29 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 11:42:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:29 INFO - 'USER': 'cltbld', 11:42:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:29 INFO - 'XPC_FLAGS': '0x0', 11:42:29 INFO - 'XPC_SERVICE_NAME': '0', 11:42:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:29 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)) 11:42:29 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)) 11:42:29 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)) 11:42:29 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)) 11:42:29 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)) 11:42:29 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)) 11:42:29 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)) 11:42:29 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)) 11:42:29 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)) 11:42:29 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)) 11:42:29 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)) 11:42:29 INFO - Cleaning up... 11:42:29 INFO - Return code: 0 11:42:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109d27b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d2a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f843bd9d950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b05d30>, '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 0x109a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109afabe8>, '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.SDBgVGKaUM/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.C9qKv5Ez9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 11:42:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:42:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:42:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDBgVGKaUM/Render', 11:42:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:29 INFO - 'HOME': '/Users/cltbld', 11:42:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:29 INFO - 'LOGNAME': 'cltbld', 11:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:29 INFO - 'MOZ_NO_REMOTE': '1', 11:42:29 INFO - 'NO_EM_RESTART': '1', 11:42:29 INFO - 'PAGER': '/bin/cat', 11:42:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:29 INFO - 'PWD': '/builds/slave/test', 11:42:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:29 INFO - 'SHELL': '/bin/bash', 11:42:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C9qKv5Ez9O/Listeners', 11:42:29 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 11:42:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:29 INFO - 'USER': 'cltbld', 11:42:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:29 INFO - 'XPC_FLAGS': '0x0', 11:42:29 INFO - 'XPC_SERVICE_NAME': '0', 11:42:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:42:30 INFO - Cleaning up... 11:42:30 INFO - Return code: 0 11:42:30 INFO - Running post-action listener: _resource_record_post_action 11:42:30 INFO - Running post-action listener: _start_resource_monitoring 11:42:30 INFO - Starting resource monitoring. 11:42:30 INFO - [mozharness: 2017-04-05 18:42:30.241075Z] Finished create-virtualenv step (success) 11:42:30 INFO - [mozharness: 2017-04-05 18:42:30.242108Z] Running install step. 11:42:30 INFO - Running pre-action listener: _resource_record_pre_action 11:42:30 INFO - Running main action method: install 11:42:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:42:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:42:30 INFO - Reading from file tmpfile_stdout 11:42:30 INFO - Detecting whether we're running mozinstall >=1.0... 11:42:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:42:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:42:30 INFO - Reading from file tmpfile_stdout 11:42:30 INFO - Output received: 11:42:30 INFO - Usage: mozinstall [options] installer 11:42:30 INFO - Options: 11:42:30 INFO - -h, --help show this help message and exit 11:42:30 INFO - -d DEST, --destination=DEST 11:42:30 INFO - Directory to install application into. [default: 11:42:30 INFO - "/builds/slave/test"] 11:42:30 INFO - --app=APP Application being installed. [default: firefox] 11:42:30 INFO - mkdir: /builds/slave/test/build/application 11:42:30 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'] 11:42:30 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 11:42:50 INFO - Reading from file tmpfile_stdout 11:42:50 INFO - Output received: 11:42:50 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:42:50 INFO - Running post-action listener: _resource_record_post_action 11:42:50 INFO - [mozharness: 2017-04-05 18:42:50.021583Z] Finished install step (success) 11:42:50 INFO - [mozharness: 2017-04-05 18:42:50.021716Z] Running run-tests step. 11:42:50 INFO - Running pre-action listener: _resource_record_pre_action 11:42:50 INFO - Running main action method: run_tests 11:42:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:42:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:42:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:42:50 INFO - 2017-04-05 11:42:50.036 screenresolution[1623:7569] starting screenresolution argv=screenresolution get 11:42:50 INFO - 2017-04-05 11:42:50.038 screenresolution[1623:7569] Display 0: 1600x1200x32@60 11:42:50 INFO - 2017-04-05 11:42:50.044 screenresolution[1624:7572] starting screenresolution argv=screenresolution list 11:42:50 INFO - Available Modes on Display 0 11:42:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:42:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:42:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:42:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:42:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:42:50 INFO - Intel Iris: 11:42:50 INFO - Chipset Model: Intel Iris 11:42:50 INFO - Type: GPU 11:42:50 INFO - Bus: Built-In 11:42:50 INFO - VRAM (Dynamic, Max): 1536 MB 11:42:50 INFO - Vendor: Intel (0x8086) 11:42:50 INFO - Device ID: 0x0a2e 11:42:50 INFO - Revision ID: 0x0009 11:42:50 INFO - Displays: 11:42:50 INFO - Display: 11:42:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:42:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:42:50 INFO - Display Serial Number: 1600x1200 60 11:42:50 INFO - Main Display: Yes 11:42:50 INFO - Mirror: Off 11:42:50 INFO - Online: Yes 11:42:50 INFO - Rotation: Supported 11:42:50 INFO - Return code: 0 11:42:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:42:50 INFO - Python 2.7.3 11:42:50 INFO - Return code: 0 11:42:50 INFO - grabbing minidump binary from tooltool 11:42:50 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')]} 11:42:50 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 0x109b05d30>, '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 0x109a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109afabe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:42:50 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 11:42:50 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 11:42:50 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 11:42:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:42:50 INFO - Return code: 0 11:42:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:42:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:42:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:42:50 INFO - ENV: RUST_BACKTRACE is now 1 11:42:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:42:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:42:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0028', '--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 11:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Pine --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0028 --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 11:42:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDBgVGKaUM/Render', 11:42:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:50 INFO - 'HOME': '/Users/cltbld', 11:42:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:50 INFO - 'LOGNAME': 'cltbld', 11:42:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:42:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:50 INFO - 'MOZ_NO_REMOTE': '1', 11:42:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:42:50 INFO - 'NO_EM_RESTART': '1', 11:42:50 INFO - 'PAGER': '/bin/cat', 11:42:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:50 INFO - 'PWD': '/builds/slave/test', 11:42:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:42:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:50 INFO - 'RUST_BACKTRACE': '1', 11:42:50 INFO - 'SHELL': '/bin/bash', 11:42:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C9qKv5Ez9O/Listeners', 11:42:50 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 11:42:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:50 INFO - 'USER': 'cltbld', 11:42:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:50 INFO - 'XPC_FLAGS': '0x0', 11:42:50 INFO - 'XPC_SERVICE_NAME': '0', 11:42:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0028', '--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 11:42:50 INFO - mozversion application_buildid: 20170405080221 11:42:50 INFO - mozversion application_changeset: 943472295ee61812ffea25699d548d53ca7bcb22 11:42:50 INFO - mozversion application_display_name: Nightly 11:42:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:42:50 INFO - mozversion application_name: Firefox 11:42:50 INFO - mozversion application_remotingname: firefox 11:42:50 INFO - mozversion application_repository: https://hg.mozilla.org/projects/pine 11:42:50 INFO - mozversion application_vendor: Mozilla 11:42:50 INFO - mozversion application_version: 55.0a1 11:42:50 INFO - mozversion platform_buildid: 20170405080221 11:42:50 INFO - mozversion platform_changeset: 943472295ee61812ffea25699d548d53ca7bcb22 11:42:50 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/pine 11:42:50 INFO - mozversion platform_version: 55.0a1 11:42:50 INFO - using testdate: 1491417770 11:42:50 INFO - actual date: 1491417770 11:42:50 INFO - starting webserver on 'localhost:49243' 11:42:50 INFO - SUITE-START | Running 2 tests 11:42:50 INFO - TEST-START | dromaeo_css 11:42:50 INFO - operating with platform_type : mac_ 11:42:50 INFO - Initialising browser for dromaeo_css test... 11:42:50 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpZxuAr6/profile http://localhost:49243/getInfo.html) 11:42:53 INFO - PID 1634 | 2017-04-05 11:42:53.743 plugin-container[1636:7762] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b47, name = 'com.apple.tsm.portname' 11:42:53 INFO - PID 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:42:53 INFO - PID 1634 | 2017-04-05 11:42:53.746 plugin-container[1636:7762] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9603, name = 'com.apple.CFPasteboardClient' 11:42:53 INFO - PID 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:42:53 INFO - PID 1634 | 2017-04-05 11:42:53.746 plugin-container[1636:7762] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:42:53 INFO - PID 1634 | __metrics Screen width/height:1600/1200 11:42:53 INFO - PID 1634 | colorDepth:24 11:42:53 INFO - PID 1634 | Browser inner width/height: 1024/689 11:42:53 INFO - PID 1634 | __metrics 11:42:53 ERROR - PID 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 11:42:54 INFO - TEST-INFO | 1634: exit 0 11:42:54 INFO - Browser initialized. 11:42:54 INFO - Running cycle 1/1 for dromaeo_css test... 11:42:54 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpZxuAr6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:42:57 INFO - PID 1637 | 2017-04-05 11:42:57.470 plugin-container[1638:7891] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8937, name = 'com.apple.tsm.portname' 11:42:57 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:42:57 INFO - PID 1637 | 2017-04-05 11:42:57.471 plugin-container[1638:7891] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a27, name = 'com.apple.CFPasteboardClient' 11:42:57 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:42:57 INFO - PID 1637 | 2017-04-05 11:42:57.471 plugin-container[1638:7891] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:43:07 INFO - PID 1637 | RSS: Main: 235954176 11:43:07 INFO - PID 1637 | 11:46:12 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 11:46:13 INFO - PID 1637 | RSS: Main: 253661184 11:46:13 INFO - PID 1637 | 11:47:55 INFO - PID 1637 | ************************* 11:47:55 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 11:47:55 INFO - PID 1637 | 11:47:55 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:47:55 INFO - PID 1637 | Full stack: 11:47:55 INFO - PID 1637 | ************************* 11:47:55 INFO - PID 1637 | ************************* 11:47:55 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 11:47:55 INFO - PID 1637 | 11:47:55 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:47:55 INFO - PID 1637 | Full stack: 11:47:55 INFO - PID 1637 | ************************* 11:47:55 INFO - PID 1637 | ************************* 11:47:55 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 11:47:55 INFO - PID 1637 | 11:47:55 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:47:55 INFO - PID 1637 | Full stack: 11:47:55 INFO - PID 1637 | ************************* 11:47:55 INFO - PID 1637 | ************************* 11:47:55 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 11:47:55 INFO - PID 1637 | 11:47:55 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:47:55 INFO - PID 1637 | Full stack: 11:47:55 INFO - PID 1637 | ************************* 11:49:15 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 11:49:16 INFO - PID 1637 | RSS: Main: 260706304 11:49:16 INFO - PID 1637 | 11:52:18 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 11:52:18 INFO - PID 1637 | RSS: Main: 272777216 11:52:18 INFO - PID 1637 | 11:55:20 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 11:55:21 INFO - PID 1637 | RSS: Main: 265359360 11:55:21 INFO - PID 1637 | 11:58:23 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 11:58:24 INFO - PID 1637 | RSS: Main: 275996672 11:58:24 INFO - PID 1637 | 12:01:27 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 12:01:27 INFO - PID 1637 | RSS: Main: 269668352 12:01:27 INFO - PID 1637 | 12:01:27 INFO - PID 1637 | __start_tp_report 12:01:27 INFO - PID 1637 | _x_x_mozilla_page_load 12:01:27 INFO - PID 1637 | _x_x_mozilla_page_load_details 12:01:27 INFO - PID 1637 | |i|pagename|runs| 12:01:27 INFO - PID 1637 | |0;dojo.html;3560.2345495718423;3588.1567831559596;3616.8734094306706;3617.9276414471697;3621.9456708149382;6122.887389030165;6229.439350458452;6247.71885265163;6255.218097737783;6282.842928926779;6131.407250743225;6160.59956102853;6168.352323006087;6296.212973378328;6302.46429053531;5499.312585926759;5501.834944951658;5532.059549876531;5585.441455854402;5613.719314034302;4622.4684161321375;5538.363088244843;5617.988762022835;5633.239512665778;5647.774089036434;5395.7032363220005;5444.3194600674915;5560.86097847553;5573.219749235111;5614.101743721006;4483.260262056757;4546.8863278417975;5469.316335458067;5470.8085217017615;5520.613557051008;5368.979893820162;5446.618736688433;5446.782128714846;5490.039243132436;5494.697791621459;6122.295935967376;6155.199824022849;6180.907286390708;6239.87520249597;6243.157173781527;6666.83332916681;6784.050232967388;6787.898181527281;6794;6795.898061529081;6859.862802743917;6878.3465570770695;6892;6894.24163342032;6898.275681053467;6291.653959032205;6344.746210151635;6346.333634968354;6380.936190638081;6382.946813775768;5740.655560666373;6757.763478278335;6853.4174595158975;6932.306769323128;6932.688029038705;6433;6514.674266286666;6524.739010439529;6624.470042396597;6682.83292917681;6724.7646332378135;6816.863662726718;6823.522353435212;6846.486513511507;6852.177738671391;6769.3907548320885;6788.253292137861;6801;6824.897626535606;6840.452763778985;6514.446272066927;6575.408213260829;6684.86630267392;6757.729690812313;6794.8301292467095;5411.2965314508865;5419.132938729863;5423.430539793344;5435.1303791393975;5443.727813609304;4801.087793319258;4802;4819.614430845524;4832.516748325139;4866.46468888422;6188.597741146901;6227.657478838707;6255.218097737783;6317.873642527124;6397;6822.658867056726;6835.897461538081;6885.242623311432;6911.997760324724;6944.097267355211;6394.584352017104;6416.839579010562;6419.935800642027;6420.807375778734;6425.132607097982;5862.794802181903;5961.701914904237;6025.608335458269;6068.453839154409;6121.387861213843;6936.861262774615;7077.115360579927;7113.253108423541;7139.107611548557;7139.357457828821;5686.4029276926985;6489.707963141575;6841.692123854538;6860.211075726355;6883.483738719516;6087.269527656709;7030.718771249093;7112.822179445348;7139.500234983501;7166.498345115792;5588.916166257591;6475.481961443167;6567.474602031731;6674.399304062464;6740.865182696417;5656.321241451053;6654.900176497454;6674.599524028574;6695.866082678416;6697.196336439463;6247.718852651732;6379.96810015947;6431.163948686641;6599.0761293418;6612.437942774918;6425.58233714807;6623.933760662524;6654.866902662016;6669.166354205724;6682.83292917681;6267.4045965633195;6350.428461438492;6384.712687928962;6411.326810684811;6442.130312407952;6663.566868153554;6674.733010679518;6675.833104172434;6701.664916754045;6713.261541230363;6468.126802881551;6471.255805582418;6502.414782669583;6505.349465053646;6507.772227971998 12:01:27 INFO - PID 1637 | |1;ext.html;752.8042708895686;797.4577287444539;839.2656425627574;1268.6511209417408;1280.5390059578556;38179;39172;39221;39283.214335713266;39354.8032259839;38936.41595376072;38971.805140974255;39286.41070383939;39311;39454.40818387726;7459.850802983937;7980.640871160812;8119.675212991473;8621.741347759576;8626.266767324785;8562.657493700244;8623.827523449527;8637.3521985851;8665.17680820321;8688.522131282776;8583.613737381802;8684.43551169172;8694.39139260252;8697.869531957025;8699.739007829776;8624;8667.306615470747;8668.306535477146;8669.479831210148;8669.869951950726;8513.872291915626;8550.52972086535;8626.741197764077;8639.179277968646;8645.567721613957;37732.81133594342;37896.24207515834;37979.810100949595;38018;38028.04929876747;3394.253264281854;3438.48422736589;3441.4493681010917;3443.5867695876404;3445.2937147884873;29991.70008299911;30409;30486.237844053856;30508.237294067603;30552.8472357639;3073.861676224553;3110.377924415126;3116.532520121977;3135;3135.404273188087;266711;268538;284731;289680;375525.1223743891;53390.73304633452;53675.19487207695;53727.73136134294;53760.19359709608;53786.462135378926;51321.743391282806;51729.48270517322;56333.43666563282;56511.71744141253;56875.43124568784;14514.419423222953;14537.273136343141;14650.633734156518;14692.706145877022;14699;10207.642732504326;11840.348780816965;11882.346470944009;11930.701732456584;11951.103667224992;12522.123451358317;12977.935110324388;14331.78502322466;14402.351894164787;14482;6157.199564056734;6160.199174107337;6230.221222347207;6268.435840774261;6276.623402595859;964.1467301438138;979.603260679426;990.8266053440764;992.4888682328462;1014;22418.887905560696;23942.88028559846;24371.147009854925;24413.633795493082;24482.14312499054;1043.2384359417667;1092.3718861654581;1114.6934592986831;1117.8770335263114;1124.9156313276537;10308.175345972304;12159.601645810844;12395.876041239471;12402.75194496105;12420.689482763004;458602;505079;505632;506139;506316.93683063437;54615.72692136593;54831;54939;55024.72487637536;55313;1489.6424858033993;1489.6871656952162;1527.2898102382446;1529.0443472829481;1529.1436795394616;20032.198712051355;22427;23584.29247122589;23782.286531404086;23805.285841424786;36574.085647859014;38083;38487.03782405462;38524.6147538521;38533.807330964286;443510;447969;449027;449635;450355;33216;33587.49618755672;34321.97034088981;34720.82639586786;35041;41515;42364.36453453262;42527.787361063;42605.78697106495;42646.93382665458;28004.49382099613;28890.30358492798;29222.123336299945;29383.559246611745;30086.69913300839;29141.271468213465;29576;29732.851335743184;29894.701052989192;30014.849925751107;34164.316713666085;34710.65289347074;34918.12704682403;35352.29295414129;35620.28759424849;29079.418411631224;29333.55999659964;30038.549421758253;30054.699453006066;30121.698783012765;22115.668264975717;23967.280981569882;24019.039238430967;24139.034438622963;24169.75830241675 12:01:27 INFO - PID 1637 | |2;jquery.html;388.34176071558704;405.1471652172178;423.28042328042335;435.2948223877317;459.2078664304076;21518.139274429024;21734.021969011374;22419.775802241973;22731.977061032252;23008.424789380275;22006.559868802615;22595.661065084038;22671.546569068607;23161.884190579065;23311.999999999956;6088.238970128734;6284.088807122976;6467.579607325509;6523.543351965364;6531.412172904437;6206;6312.431881130698;6316.652584107896;6331.398517140864;6341.8097457076365;5031.2453132030305;6002.729877155517;6272.623642581437;6275.497960163176;6284.8743025139465;6066.090086487018;6176.4132407421675;6198.721057552421;6220.875582488347;6277.309495955441;4534.773261336953;5489.011977843987;5529.0324193266015;5584.944150558483;5592.496675299242;22156.11375544976;25111.87444062768;27428.588571171247;27900.302492437648;28184.436311273865;2194.857334273267;2246.7416247131464;2248.033345661365;2250.887455627212;2252.2905284835224;14403.91970602209;16696.332146714118;17938.282468701236;17992;18049.909750451163;2053.3121404329568;2100.7479102507646;2115.492281852344;2128.1487405037956;2166.1118941234017;161817.19091404584;162310;166238;166339.1683041577;167221.16389418097;10635.361878287327;12632.557860474839;12811.615651530468;12866.806997895039;13261.93369033168;16208.75686864698;16286.755698664529;16578.6684266314;16579.01051873759;16589.6682066358;8195.918040819515;8428.862103616057;8747.518886461306;9014.504202268807;9204.539773011456;7089.680964356617;8388.245057944814;8525.19010693983;8552.486850788848;8707.259882909897;8008.27925486709;8163.428560000862;8169.71406000799;8186.467879587808;8198.1391953844;1828.963420731578;2196.176433837311;2201.9449513762283;2203.10774136475;2351.247600767772;743.9218882017418;814.3973459639942;818.5048045932244;895.2703546609623;938.1228551304553;20638.38084857457;21174.153033878472;21208.575828483343;21213.681794773092;21277;966.8984756600456;977.2768151567931;1007.1187710753092;1008.68226508651;1020.2654089055868;10752.516136773864;10976;11025.338479691245;11039.668809935714;11082.833757493645;661453;730724;732417;744369;750543;157038.21480892523;158030;162319.97814153263;162601.18699406428;164520;1151.624079062132;1182.7338848758961;1202.104432198018;1207.728261141236;1210.267787988272;17981.73027404564;18157.91052536852;18201.635967280847;18332.17505212295;18384.448466546026;58815.70592147012;62732;62975.37024629695;63537.68231158815;64437.91182969776;82056.58971705103;82208.17791822006;83021.75467368115;84475.57762211395;85159;8579.442336248374;8721.65113395457;8767.906305118137;8844.646214151362;8886.333524985523;13193.670158246121;13212;13341.466341346237;13705.794413084011;13731.382087805872;11265.324080555192;11301.547938082385;11309.419685027577;11550;11625.24435911663;10505.369677819355;10612.204084693525;10789.460526973777;10815.97248261414;11086.279391839505;11753.177277590828;11832.053435725293;12066;12092;12138.089643276966;7062.964685176541;8683.392162548813;8720.168764559514;8774.429662071945;8952.597133128895;9418.199453046567;10906.727331816768;11289.661310160709;11483;11940.76118477643 12:01:27 INFO - PID 1637 | |3;mootools.html;1188.5542921404474;1287.5171810571037;1367.2138520350798;1432.7635940069886;1439.6976634906669;10868.72828179295;11316.26444281121;11338.206325557214;11399.658010259685;11648.708782280448;9931.205503559717;10896.509657065431;11342.546298148085;11510.482028308725;11512.424378781048;2471.5180539794746;2517.345490172559;2520.6093055576416;2523.962140567893;2529.759672831078;2340.496793189464;2364.8226383021256;2455.0916161020446;2525.444402231506;2529.557327467695;2479.3305807431984;2484.813638977075;2500.112460076674;2512.459821138455;2534.531111744333;2470.505898820225;2488.4525404411;2495.25142457263;2501.8123640726926;2526.065355818341;2032.7967203279554;2442.120836498859;2496.2386472125995;2529.6584961030208;2541.0471073347494;11439.59961401347;11556.364399957998;11579.247348922378;11595.01442377399;11598.652040438801;5314.468553144693;6644.83387915306;6665.9666701666665;6717.193936727624;6719.865602687968;4005.379166229239;4219.1139860629;4310.288802347609;4320.697551171388;4343.261645520269;1190.4405229149754;1239.9442025108801;1287.787515060014;1291.0381765584605;1294.8734600897185;14118.082324648967;14779.92610036943;15873.365065397371;15919.522414327474;15971;5060.671056381323;5716.599838011382;5724.284464441945;5724.341700704389;5736.110902810071;11694.649160525198;11830.88169118315;11832.053435725122;11861.406929653655;11874.287542747463;6504.317046710027;6542.803715888531;6551.868962620721;6554.475641948633;6563.671816409161;5955.987482128048;6181.289151747516;6254.874902501924;6260.5617606768;6269.8746025079245;4359.585839345257;4404.471463424409;4418.756968366706;4442.53353397895;4477.507474177838;1290.0647030902521;1306.9346532673328;1308.0843409613308;1308.1235572166672;1314.9408276627576;660.7324033766332;750.9549427034395;784.5684873319651;785.8899754034439;808.3815880851154;5011.6241281904;5965.164876917235;6092;6234.688265586702;6235.501159907197;560.0898539872707;565.5023579250234;576.1415490918585;589.7965202005302;603.5805115444812;3964.623360780721;4018.1561872006623;4086.1010577672864;4148;4247.787610619456;14285.500007499895;14913.105213687213;14917.40330386794;14936.32786524609;14937;14799.186044767426;14799.964002519935;14810.851891480947;14814.481493147689;14835.03572267799;10343.482825858677;10648.89351106479;10836.40399778004;10839.349639021684;10847.294925829796;6312.210973628296;6448.516361272829;6462.612243265419;6473.643949582818;6478.9309763890315;13000.544980925622;13261.801072984106;13311.66720831987;13316.533921312708;13324.133931294435;10183.898161018591;10885.891141088488;11781.705457363292;12823.166494177849;13417.664558385728;8241.857117149704;8445.915540844759;8448.66205351779;8472.74581762548;8482.109378515168;8505;10155.441450719985;10258.230632702427;10380.013898679614;10394.636187733393;8682.348823838363;8712.91287087121;8843.292536596928;8955.194032537103;9014.684486042957;8586.828263434822;8647.135286471554;8668.133186681282;8777.648894044421;8836.867446988428;7849.293563579306;7919.564423956507;7996.3602911768085;8000.51996880189;8038.276555110068;5124.718140502308;5844.649321040752;5918.674472903859;5955.076963070731;6005.429484198994;5930.377310382348;5997.956369480579;6106.236720409949;6130.264368275835;6225.688715564113 12:01:27 INFO - PID 1637 | |4;prototype.html;373.7719990805609;385.80902453285626;399.3271337795814;408.24678468226114;409.8934277087956;5447.046766815811;5828;6203.31763506014;6230.439260466568;6305.936940630592;5187.922181167285;5990.244487535728;6068;6124.020156774917;6138.754449822001;3586.748927575071;3673.7612055216327;4488.214562451574;4498.235299999;4508.165989291975;3886;3892.5328960524776;4252.511620932664;4459.44256967879;4504.572065653758;3617.855285788565;4414.359917811916;4423.933640995371;4438.267685831834;4444.400005999181;4434.512203657595;4438.423005009345;4447.8443254486265;4460.174867649495;4501.48232953208;3715.5727091384297;3834.65488106069;3863.130795571002;3863.961360386388;3866.2074274773886;5123.410807757118;5340.958513089949;5394.406615272317;5484.314460692413;5964.463198312173;5592.273004509429;5600.795828896766;5601.798651011742;5610.214569960168;5619.297587801525;5864.912026319608;5923.822285331447;6009.729562169713;6641.970494573349;6644.468442524635;4738.715677059387;4754.453237877654;4758.333833263346;4767.69010014348;4781.235002399634;5894.528437724972;6561.490857102845;6839.350261725128;6952.513324067318;7051.753188638424;3606.9819650901577;4265.869544570692;4836;4859.7327147006545;4873.80504779812;4214.704970652087;4965.4041515018425;4966.255061740768;4987.376577927759;4989.052080104769;5360.705161216092;5470.097433923358;5527.39198688152;5570.582206334541;5611.80358687444;6228.4705800007505;6458.8351707662905;6559.836004099936;6689.431398331099;6691.197056353269;1385.1342910680823;1626.983730162707;1691.687037897993;1696.7454881767833;1700.3963592924333;1144.1704764046167;1153.221575436577;1165.7468221661748;1167.620523329921;1178.6994316449423;4932;5375.811846585429;5739.642309249136;6245.313015568284;6293.3391993840905;6817.420519255918;6819.079424277659;6821.863562728718;6830.658467076626;6873.931260687429;5894.734736936848;6181.258249010148;6199.481127123883;6241.656708881055;6309.211348581427;3228.870845166167;3505.0228675281164;3550.5384300041346;3559.914226160994;3565.4117070683565;5926.496247818984;6315.242170939517;6498.902516462257;6761.875256093779;6962.268961758942;6009.098635204667;6047.697615119227;7020.7542736004;7045.365917067386;7045.401140902978;5370.6777593345305;5915.911261331084;6772.52592318533;7055.012298278142;7149.714011439588;6157.353477884758;6337.271213810471;6569.244536878129;6760.290169532128;6767.93232067673;5898.321693005188;5929.229200203946;6598.472122230306;6649.168853893263;6784.3554862288;5886.6173698709445;6956.7217311309005;7093.645317733989;7157.320054594805;7162.677679504331;4443.422355093817;4463.2635615123145;4466.709663871838;4477.910441791211;4497.77511124449;6599.4390476808085;6820.488463365366;6832.316768323128;6858.519903606899;6859.759908403182;6614.702338394687;6620.337966203341;6637.6349300788925;6637.6349300788925;6650.035744817072;5849.883002340014;6217.285012223471;6416.422521973045;6611.603303801788;6614.239362473377;6147.84630384244;6459.289478157305;6486.189226346707;6515.934840651723;6517.576357536745;6415.711292991733;6562.50781191403;6631.734730610721;6643.335666433318;6650.301718319507;6436.774712885027;6446.194225721785;6455.289918109098;6473.8705225896165;6495.837604059936 12:01:27 INFO - PID 1637 | |5;yui.html;775.4800590841953;822.6339279020837;822.9300509456696;833.582909054607;838.3460900497611;15896.841031589694;16337.183140842955;17585.3845115421;18665.440036798886;18739;17368.305267789307;17690.523326734266;17826.46520604384;17962.461126166203;18233.179506922188;863.2144748279068;922.1147698209693;947.351064520802;969.1181025267008;974.7319487141058;968.2883080935507;990.6235630460451;996.2528103922059;1010.0656892374561;1010.5957616953241;1047.0262655730169;1060.0035966191756;1061.8619579454698;1062.718379629399;1065.4193464561833;1043.572135424476;1054.0829478353844;1058.867641544807;1060.533365319257;1062.5112448273803;772.1390649425906;777.6150805351388;782.3271986091956;785;787.7361084036854;14058.789118163235;14649;16625.4181103662;17110.657786844316;17212.741808872877;14957.476488322856;14996.700065998619;15104.093754374773;15149.545513634608;15898.443554475538;13208.801867971892;13353.86646133536;13612.863871361258;13668.589942301647;13737;3045.7867949243564;3351.8659253629826;3357.5635167428322;3365.158710322419;3370.9831450842835;122215;123837;124294.13558796626;125534;125995.37002315022;11196.888031119748;11254.17500836255;11258.605948791754;11550.480228389742;11674.124440666985;23076.192333268256;24437.02251909904;25387.873060634578;25560.616590751153;25670.48659026809;7604.201558836353;7632.618369081523;7659.693612255559;7755.922440775633;7806.759644417116;4211.052513184571;4219.51475580306;4260.879105534553;4306.5262821089655;4321.395004699281;4186.958130418657;4276.444062271885;4281.892952676208;4285.871423857289;4301.892452688708;940.2055263302499;976.8730065091493;982.4989255479757;982.6658935961665;987.7234374375187;622.2843729710869;623.4856243599049;639.0318667219167;650.9487178207162;667.2926697700453;9759.26805489591;10204.897951020543;10355.326903751233;10442.477876106164;10545.367277963347;594.6075590110506;627.6108812536256;627.7394881124283;629.8236493781657;657.0997733105676;4324.210883979816;4363.36731173978;4698.412698412699;4816.349792778;4823.686460380134;102636;105809;106873.46563267289;107321;109112.4544377273;88201;88644.11355886358;89213;90184.5490772555;90576;81293;81481.59259203666;82346;82427.58786205911;84106;8176.918230817616;8404.028771264437;8949.836521252195;9658.033556480854;9679.516024198903;38576.42135368028;39512;39725.80822575327;40385.798071009456;40466.79766601148;37591;48987.75506122447;49608;49668;50377.49622503728;10752;11246.7750644985;11588.6523404298;11659.300441973508;11767.352795596324;11247.493862776031;11443.027342675965;11506.482208300478;11716.71116177237;12998.870011300145;10713.946430267799;11260.873912609;11733.76532469363;11735.295882247092;11831.349275789915;11010.953959373846;11648.184627076023;11894.34581098048;11941.880581194077;12207.511699532275;11597.362145082101;11641.88358116408;11646.94176529112;11649.941750291533;11825.349605771766;8474.3644226682;8797.47215167092;8945;9878.555465004236;10572.524236409226;9769.413835169913;10804.459777011276;11112.222144450134;11227.71930701739;11456 12:01:27 INFO - PID 1637 | __end_tp_report 12:01:27 INFO - PID 1637 | __start_cc_report 12:01:27 INFO - PID 1637 | _x_x_mozilla_cycle_collect,434 12:01:27 INFO - PID 1637 | __end_cc_report 12:01:27 INFO - PID 1637 | __startTimestamp1491418887611__endTimestamp 12:01:27 INFO - PID 1637 | 12:01:27 INFO - PID 1637 | ------- Summary: start ------- 12:01:27 INFO - PID 1637 | Number of tests: 6 12:01:27 INFO - PID 1637 | 12:01:27 INFO - PID 1637 | [#0] dojo.html Cycles:165 Average:6200.16 Median:6416.84 stddev:755.13 (11.8%) stddev-sans-first:728.50 12:01:27 INFO - PID 1637 | Values: 3560.2 3588.2 3616.9 3617.9 3621.9 6122.9 6229.4 6247.7 6255.2 6282.8 6131.4 6160.6 6168.4 6296.2 6302.5 5499.3 5501.8 5532.1 5585.4 5613.7 4622.5 5538.4 5618.0 5633.2 5647.8 5395.7 5444.3 5560.9 5573.2 5614.1 4483.3 4546.9 5469.3 5470.8 5520.6 5369.0 5446.6 5446.8 5490.0 5494.7 6122.3 6155.2 6180.9 6239.9 6243.2 6666.8 6784.1 6787.9 6794.0 6795.9 6859.9 6878.3 6892.0 6894.2 6898.3 6291.7 6344.7 6346.3 6380.9 6382.9 5740.7 6757.8 6853.4 6932.3 6932.7 6433.0 6514.7 6524.7 6624.5 6682.8 6724.8 6816.9 6823.5 6846.5 6852.2 6769.4 6788.3 6801.0 6824.9 6840.5 6514.4 6575.4 6684.9 6757.7 6794.8 5411.3 5419.1 5423.4 5435.1 5443.7 4801.1 4802.0 4819.6 4832.5 4866.5 6188.6 6227.7 6255.2 6317.9 6397.0 6822.7 6835.9 6885.2 6912.0 6944.1 6394.6 6416.8 6419.9 6420.8 6425.1 5862.8 5961.7 6025.6 6068.5 6121.4 6936.9 7077.1 7113.3 7139.1 7139.4 5686.4 6489.7 6841.7 6860.2 6883.5 6087.3 7030.7 7112.8 7139.5 7166.5 5588.9 6475.5 6567.5 6674.4 6740.9 5656.3 6654.9 6674.6 6695.9 6697.2 6247.7 6380.0 6431.2 6599.1 6612.4 6425.6 6623.9 6654.9 6669.2 6682.8 6267.4 6350.4 6384.7 6411.3 6442.1 6663.6 6674.7 6675.8 6701.7 6713.3 6468.1 6471.3 6502.4 6505.3 6507.8 12:01:27 INFO - PID 1637 | 12:01:27 INFO - PID 1637 | [#1] ext.html Cycles:180 Average:54763.97 Median:35486.29 stddev:112701.44 (317.6%) stddev-sans-first:112944.64 12:01:27 INFO - PID 1637 | Values: 752.8 797.5 839.3 1268.7 1280.5 38179.0 39172.0 39221.0 39283.2 39354.8 38936.4 38971.8 39286.4 39311.0 39454.4 7459.9 7980.6 8119.7 8621.7 8626.3 8562.7 8623.8 8637.4 8665.2 8688.5 8583.6 8684.4 8694.4 8697.9 8699.7 8624.0 8667.3 8668.3 8669.5 8669.9 8513.9 8550.5 8626.7 8639.2 8645.6 37732.8 37896.2 37979.8 38018.0 38028.0 3394.3 3438.5 3441.4 3443.6 3445.3 29991.7 30409.0 30486.2 30508.2 30552.8 3073.9 3110.4 3116.5 3135.0 3135.4 266711.0 268538.0 284731.0 289680.0 375525.1 53390.7 53675.2 53727.7 53760.2 53786.5 51321.7 51729.5 56333.4 56511.7 56875.4 14514.4 14537.3 14650.6 14692.7 14699.0 10207.6 11840.3 11882.3 11930.7 11951.1 12522.1 12977.9 14331.8 14402.4 14482.0 6157.2 6160.2 6230.2 6268.4 6276.6 964.1 979.6 990.8 992.5 1014.0 22418.9 23942.9 24371.1 24413.6 24482.1 1043.2 1092.4 1114.7 1117.9 1124.9 10308.2 12159.6 12395.9 12402.8 12420.7 458602.0 505079.0 505632.0 506139.0 506316.9 54615.7 54831.0 54939.0 55024.7 55313.0 1489.6 1489.7 1527.3 1529.0 1529.1 20032.2 22427.0 23584.3 23782.3 23805.3 36574.1 38083.0 38487.0 38524.6 38533.8 443510.0 447969.0 449027.0 449635.0 450355.0 33216.0 33587.5 34322.0 34720.8 35041.0 41515.0 42364.4 42527.8 42605.8 42646.9 28004.5 28890.3 29222.1 29383.6 30086.7 29141.3 29576.0 29732.9 29894.7 30014.8 34164.3 34710.7 34918.1 35352.3 35620.3 29079.4 29333.6 30038.5 30054.7 30121.7 22115.7 23967.3 24019.0 24139.0 24169.8 12:01:27 INFO - PID 1637 | 12:01:27 INFO - PID 1637 | [#2] jquery.html Cycles:180 Average:41775.29 Median:12423.98 stddev:121757.25 (980.0%) stddev-sans-first:122059.16 12:01:27 INFO - PID 1637 | Values: 388.3 405.1 423.3 435.3 459.2 21518.1 21734.0 22419.8 22732.0 23008.4 22006.6 22595.7 22671.5 23161.9 23312.0 6088.2 6284.1 6467.6 6523.5 6531.4 6206.0 6312.4 6316.7 6331.4 6341.8 5031.2 6002.7 6272.6 6275.5 6284.9 6066.1 6176.4 6198.7 6220.9 6277.3 4534.8 5489.0 5529.0 5584.9 5592.5 22156.1 25111.9 27428.6 27900.3 28184.4 2194.9 2246.7 2248.0 2250.9 2252.3 14403.9 16696.3 17938.3 17992.0 18049.9 2053.3 2100.7 2115.5 2128.1 2166.1 161817.2 162310.0 166238.0 166339.2 167221.2 10635.4 12632.6 12811.6 12866.8 13261.9 16208.8 16286.8 16578.7 16579.0 16589.7 8195.9 8428.9 8747.5 9014.5 9204.5 7089.7 8388.2 8525.2 8552.5 8707.3 8008.3 8163.4 8169.7 8186.5 8198.1 1829.0 2196.2 2201.9 2203.1 2351.2 743.9 814.4 818.5 895.3 938.1 20638.4 21174.2 21208.6 21213.7 21277.0 966.9 977.3 1007.1 1008.7 1020.3 10752.5 10976.0 11025.3 11039.7 11082.8 661453.0 730724.0 732417.0 744369.0 750543.0 157038.2 158030.0 162320.0 162601.2 164520.0 1151.6 1182.7 1202.1 1207.7 1210.3 17981.7 18157.9 18201.6 18332.2 18384.4 58815.7 62732.0 62975.4 63537.7 64437.9 82056.6 82208.2 83021.8 84475.6 85159.0 8579.4 8721.7 8767.9 8844.6 8886.3 13193.7 13212.0 13341.5 13705.8 13731.4 11265.3 11301.5 11309.4 11550.0 11625.2 10505.4 10612.2 10789.5 10816.0 11086.3 11753.2 11832.1 12066.0 12092.0 12138.1 7063.0 8683.4 8720.2 8774.4 8952.6 9418.2 10906.7 11289.7 11483.0 11940.8 12:01:27 INFO - PID 1637 | 12:01:27 INFO - PID 1637 | [#3] mootools.html Cycles:180 Average:6932.81 Median:2532.15 stddev:4350.22 (171.8%) stddev-sans-first:4341.01 12:01:27 INFO - PID 1637 | Values: 1188.6 1287.5 1367.2 1432.8 1439.7 10868.7 11316.3 11338.2 11399.7 11648.7 9931.2 10896.5 11342.5 11510.5 11512.4 2471.5 2517.3 2520.6 2524.0 2529.8 2340.5 2364.8 2455.1 2525.4 2529.6 2479.3 2484.8 2500.1 2512.5 2534.5 2470.5 2488.5 2495.3 2501.8 2526.1 2032.8 2442.1 2496.2 2529.7 2541.0 11439.6 11556.4 11579.2 11595.0 11598.7 5314.5 6644.8 6666.0 6717.2 6719.9 4005.4 4219.1 4310.3 4320.7 4343.3 1190.4 1239.9 1287.8 1291.0 1294.9 14118.1 14779.9 15873.4 15919.5 15971.0 5060.7 5716.6 5724.3 5724.3 5736.1 11694.6 11830.9 11832.1 11861.4 11874.3 6504.3 6542.8 6551.9 6554.5 6563.7 5956.0 6181.3 6254.9 6260.6 6269.9 4359.6 4404.5 4418.8 4442.5 4477.5 1290.1 1306.9 1308.1 1308.1 1314.9 660.7 751.0 784.6 785.9 808.4 5011.6 5965.2 6092.0 6234.7 6235.5 560.1 565.5 576.1 589.8 603.6 3964.6 4018.2 4086.1 4148.0 4247.8 14285.5 14913.1 14917.4 14936.3 14937.0 14799.2 14800.0 14810.9 14814.5 14835.0 10343.5 10648.9 10836.4 10839.3 10847.3 6312.2 6448.5 6462.6 6473.6 6478.9 13000.5 13261.8 13311.7 13316.5 13324.1 10183.9 10885.9 11781.7 12823.2 13417.7 8241.9 8445.9 8448.7 8472.7 8482.1 8505.0 10155.4 10258.2 10380.0 10394.6 8682.3 8712.9 8843.3 8955.2 9014.7 8586.8 8647.1 8668.1 8777.6 8836.9 7849.3 7919.6 7996.4 8000.5 8038.3 5124.7 5844.6 5918.7 5955.1 6005.4 5930.4 5998.0 6106.2 6130.3 6225.7 12:01:27 INFO - PID 1637 | 12:01:27 INFO - PID 1637 | [#4] prototype.html Cycles:180 Average:5312.75 Median:5896.53 stddev:1644.74 (27.9%) stddev-sans-first:1607.03 12:01:27 INFO - PID 1637 | Values: 373.8 385.8 399.3 408.2 409.9 5447.0 5828.0 6203.3 6230.4 6305.9 5187.9 5990.2 6068.0 6124.0 6138.8 3586.7 3673.8 4488.2 4498.2 4508.2 3886.0 3892.5 4252.5 4459.4 4504.6 3617.9 4414.4 4423.9 4438.3 4444.4 4434.5 4438.4 4447.8 4460.2 4501.5 3715.6 3834.7 3863.1 3864.0 3866.2 5123.4 5341.0 5394.4 5484.3 5964.5 5592.3 5600.8 5601.8 5610.2 5619.3 5864.9 5923.8 6009.7 6642.0 6644.5 4738.7 4754.5 4758.3 4767.7 4781.2 5894.5 6561.5 6839.4 6952.5 7051.8 3607.0 4265.9 4836.0 4859.7 4873.8 4214.7 4965.4 4966.3 4987.4 4989.1 5360.7 5470.1 5527.4 5570.6 5611.8 6228.5 6458.8 6559.8 6689.4 6691.2 1385.1 1627.0 1691.7 1696.7 1700.4 1144.2 1153.2 1165.7 1167.6 1178.7 4932.0 5375.8 5739.6 6245.3 6293.3 6817.4 6819.1 6821.9 6830.7 6873.9 5894.7 6181.3 6199.5 6241.7 6309.2 3228.9 3505.0 3550.5 3559.9 3565.4 5926.5 6315.2 6498.9 6761.9 6962.3 6009.1 6047.7 7020.8 7045.4 7045.4 5370.7 5915.9 6772.5 7055.0 7149.7 6157.4 6337.3 6569.2 6760.3 6767.9 5898.3 5929.2 6598.5 6649.2 6784.4 5886.6 6956.7 7093.6 7157.3 7162.7 4443.4 4463.3 4466.7 4477.9 4497.8 6599.4 6820.5 6832.3 6858.5 6859.8 6614.7 6620.3 6637.6 6637.6 6650.0 5849.9 6217.3 6416.4 6611.6 6614.2 6147.8 6459.3 6486.2 6515.9 6517.6 6415.7 6562.5 6631.7 6643.3 6650.3 6436.8 6446.2 6455.3 6473.9 6495.8 12:01:27 INFO - PID 1637 | 12:01:27 INFO - PID 1637 | [#5] yui.html Cycles:180 Average:20418.11 Median:14358.14 stddev:30645.42 (213.4%) stddev-sans-first:30695.90 12:01:27 INFO - PID 1637 | Values: 775.5 822.6 822.9 833.6 838.3 15896.8 16337.2 17585.4 18665.4 18739.0 17368.3 17690.5 17826.5 17962.5 18233.2 863.2 922.1 947.4 969.1 974.7 968.3 990.6 996.3 1010.1 1010.6 1047.0 1060.0 1061.9 1062.7 1065.4 1043.6 1054.1 1058.9 1060.5 1062.5 772.1 777.6 782.3 785.0 787.7 14058.8 14649.0 16625.4 17110.7 17212.7 14957.5 14996.7 15104.1 15149.5 15898.4 13208.8 13353.9 13612.9 13668.6 13737.0 3045.8 3351.9 3357.6 3365.2 3371.0 122215.0 123837.0 124294.1 125534.0 125995.4 11196.9 11254.2 11258.6 11550.5 11674.1 23076.2 24437.0 25387.9 25560.6 25670.5 7604.2 7632.6 7659.7 7755.9 7806.8 4211.1 4219.5 4260.9 4306.5 4321.4 4187.0 4276.4 4281.9 4285.9 4301.9 940.2 976.9 982.5 982.7 987.7 622.3 623.5 639.0 650.9 667.3 9759.3 10204.9 10355.3 10442.5 10545.4 594.6 627.6 627.7 629.8 657.1 4324.2 4363.4 4698.4 4816.3 4823.7 102636.0 105809.0 106873.5 107321.0 109112.5 88201.0 88644.1 89213.0 90184.5 90576.0 81293.0 81481.6 82346.0 82427.6 84106.0 8176.9 8404.0 8949.8 9658.0 9679.5 38576.4 39512.0 39725.8 40385.8 40466.8 37591.0 48987.8 49608.0 49668.0 50377.5 10752.0 11246.8 11588.7 11659.3 11767.4 11247.5 11443.0 11506.5 11716.7 12998.9 10713.9 11260.9 11733.8 11735.3 11831.3 11011.0 11648.2 11894.3 11941.9 12207.5 11597.4 11641.9 11646.9 11649.9 11825.3 8474.4 8797.5 8945.0 9878.6 10572.5 9769.4 10804.5 11112.2 11227.7 11456.0 12:01:27 INFO - PID 1637 | -------- Summary: end -------- 12:01:27 INFO - PID 1637 | 12:01:28 INFO - TEST-INFO | 1637: exit 0 12:01:28 INFO - TEST-OK | dromaeo_css | took 1117664ms 12:01:28 INFO - TEST-START | kraken 12:01:28 INFO - operating with platform_type : mac_ 12:01:28 INFO - Initialising browser for kraken test... 12:01:28 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmphQVNm4/profile http://localhost:49243/getInfo.html) 12:01:31 INFO - PID 1649 | 2017-04-05 12:01:31.001 plugin-container[1650:10455] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x872b, name = 'com.apple.tsm.portname' 12:01:31 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:01:31 INFO - PID 1649 | 2017-04-05 12:01:31.004 plugin-container[1650:10455] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 12:01:31 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:01:31 INFO - PID 1649 | 2017-04-05 12:01:31.004 plugin-container[1650:10455] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:01:31 INFO - PID 1649 | __metrics Screen width/height:1600/1200 12:01:31 INFO - PID 1649 | colorDepth:24 12:01:31 INFO - PID 1649 | Browser inner width/height: 1024/689 12:01:31 INFO - PID 1649 | __metrics 12:01:31 ERROR - PID 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 12:01:32 INFO - TEST-INFO | 1649: exit 0 12:01:32 INFO - Browser initialized. 12:01:32 INFO - Running cycle 1/1 for kraken test... 12:01:32 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmphQVNm4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:01:35 INFO - PID 1651 | 2017-04-05 12:01:35.284 plugin-container[1652:10569] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 12:01:35 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:01:35 INFO - PID 1651 | 2017-04-05 12:01:35.284 plugin-container[1652:10569] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 12:01:35 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:01:35 INFO - PID 1651 | 2017-04-05 12:01:35.284 plugin-container[1652:10569] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:01:45 INFO - PID 1651 | RSS: Main: 250302464 12:01:45 INFO - PID 1651 | 12:01:47 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 12:01:48 INFO - PID 1651 | RSS: Main: 259665920 12:01:48 INFO - PID 1651 | 12:01:51 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 12:01:52 INFO - PID 1651 | RSS: Main: 266760192 12:01:52 INFO - PID 1651 | 12:01:55 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 12:01:56 INFO - PID 1651 | RSS: Main: 262860800 12:01:56 INFO - PID 1651 | 12:01:58 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 12:01:59 INFO - PID 1651 | RSS: Main: 264839168 12:01:59 INFO - PID 1651 | 12:02:01 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:02:01 INFO - PID 1651 | RSS: Main: 265166848 12:02:01 INFO - PID 1651 | 12:02:04 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 12:02:05 INFO - PID 1651 | RSS: Main: 270827520 12:02:05 INFO - PID 1651 | 12:02:08 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 12:02:09 INFO - PID 1651 | RSS: Main: 271351808 12:02:09 INFO - PID 1651 | 12:02:12 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 12:02:13 INFO - PID 1651 | RSS: Main: 271122432 12:02:13 INFO - PID 1651 | 12:02:15 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:02:15 INFO - PID 1651 | RSS: Main: 270778368 12:02:15 INFO - PID 1651 | 12:02:17 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:02:18 INFO - PID 1651 | RSS: Main: 270757888 12:02:18 INFO - PID 1651 | 12:02:20 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:02:21 INFO - PID 1651 | RSS: Main: 270802944 12:02:21 INFO - PID 1651 | 12:02:24 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:02:25 INFO - PID 1651 | RSS: Main: 271314944 12:02:25 INFO - PID 1651 | 12:02:28 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:02:29 INFO - PID 1651 | RSS: Main: 268292096 12:02:29 INFO - PID 1651 | 12:02:31 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 12:02:31 INFO - PID 1651 | RSS: Main: 271269888 12:02:31 INFO - PID 1651 | 12:02:31 INFO - PID 1651 | __start_tp_report 12:02:31 INFO - PID 1651 | _x_x_mozilla_page_load 12:02:31 INFO - PID 1651 | _x_x_mozilla_page_load_details 12:02:31 INFO - PID 1651 | |i|pagename|runs| 12:02:31 INFO - PID 1651 | |0;ai-astar;107;120;121;120;129;149;119;103;178;180 12:02:31 INFO - PID 1651 | |1;audio-beat-detection;148;110;156;155;120;115;117;113;140;161 12:02:31 INFO - PID 1651 | |2;audio-dft;228;218;250;311;247;215;214;212;208;216 12:02:31 INFO - PID 1651 | |3;audio-fft;79;58;60;88;63;62;63;62;74;60 12:02:31 INFO - PID 1651 | |4;audio-oscillator;79;109;129;103;73;71;90;71;76;116 12:02:31 INFO - PID 1651 | |5;imaging-gaussian-blur;89;142;92;91;98;90;91;90;90;91 12:02:31 INFO - PID 1651 | |6;imaging-darkroom;109;166;119;129;113;122;100;100;99;140 12:02:31 INFO - PID 1651 | |7;imaging-desaturate;161;122;102;102;103;100;161;151;103;102 12:02:31 INFO - PID 1651 | |8;json-parse-financial;54;52;54;51;53;53;54;53;53;52 12:02:31 INFO - PID 1651 | |9;json-stringify-tinderbox;55;61;57;63;66;63;61;60;59;61 12:02:31 INFO - PID 1651 | |10;stanford-crypto-aes;87;88;89;104;115;111;88;116;112;89 12:02:31 INFO - PID 1651 | |11;stanford-crypto-ccm;155;180;164;160;164;177;143;171;224;199 12:02:31 INFO - PID 1651 | |12;stanford-crypto-pbkdf2;221;184;187;274;255;198;197;193;197;199 12:02:31 INFO - PID 1651 | |13;stanford-crypto-sha256-iterative;75;93;111;111;60;78;107;77;71;71 12:02:31 INFO - PID 1651 | __end_tp_report 12:02:31 INFO - PID 1651 | __start_cc_report 12:02:31 INFO - PID 1651 | _x_x_mozilla_cycle_collect,1034 12:02:31 INFO - PID 1651 | __end_cc_report 12:02:31 INFO - PID 1651 | __startTimestamp1491418951412__endTimestamp 12:02:31 INFO - PID 1651 | 12:02:31 INFO - PID 1651 | ------- Summary: start ------- 12:02:31 INFO - PID 1651 | Number of tests: 14 12:02:31 INFO - PID 1651 | 12:02:31 INFO - PID 1651 | [#0] ai-astar Cycles:10 Average:132.60 Median:125.00 stddev:27.40 (21.9%) stddev-sans-first:27.46 12:02:31 INFO - PID 1651 | Values: 107.0 120.0 121.0 120.0 129.0 149.0 119.0 103.0 178.0 180.0 12:02:31 INFO - PID 1651 | 12:02:31 INFO - PID 1651 | [#1] audio-beat-detection Cycles:10 Average:133.50 Median:144.00 stddev:20.40 (14.2%) stddev-sans-first:20.95 12:02:31 INFO - PID 1651 | Values: 148.0 110.0 156.0 155.0 120.0 115.0 117.0 113.0 140.0 161.0 12:02:31 INFO - PID 1651 | 12:02:31 INFO - PID 1651 | [#2] audio-dft Cycles:10 Average:231.90 Median:223.00 stddev:31.35 (14.1%) stddev-sans-first:33.22 12:02:31 INFO - PID 1651 | Values: 228.0 218.0 250.0 311.0 247.0 215.0 214.0 212.0 208.0 216.0 12:02:31 INFO - PID 1651 | 12:02:31 INFO - PID 1651 | [#3] audio-fft Cycles:10 Average:66.90 Median:63.00 stddev:9.97 (15.8%) stddev-sans-first:9.57 12:02:31 INFO - PID 1651 | Values: 79.0 58.0 60.0 88.0 63.0 62.0 63.0 62.0 74.0 60.0 12:02:31 INFO - PID 1651 | 12:02:31 INFO - PID 1651 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:72.00 stddev:21.15 (29.4%) stddev-sans-first:21.93 12:02:31 INFO - PID 1651 | Values: 79.0 109.0 129.0 103.0 73.0 71.0 90.0 71.0 76.0 116.0 12:02:31 INFO - PID 1651 | 12:02:31 INFO - PID 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:96.40 Median:91.00 stddev:16.22 (17.8%) stddev-sans-first:16.98 12:02:31 INFO - PID 1651 | Values: 89.0 142.0 92.0 91.0 98.0 90.0 91.0 90.0 90.0 91.0 12:02:31 INFO - PID 1651 | 12:02:31 INFO - PID 1651 | [#6] imaging-darkroom Cycles:10 Average:119.70 Median:125.50 stddev:21.11 (16.8%) stddev-sans-first:22.04 12:02:31 INFO - PID 1651 | Values: 109.0 166.0 119.0 129.0 113.0 122.0 100.0 100.0 99.0 140.0 12:02:31 INFO - PID 1651 | 12:02:31 INFO - PID 1651 | [#7] imaging-desaturate Cycles:10 Average:120.70 Median:112.50 stddev:26.40 (23.5%) stddev-sans-first:23.63 12:02:31 INFO - PID 1651 | Values: 161.0 122.0 102.0 102.0 103.0 100.0 161.0 151.0 103.0 102.0 12:02:31 INFO - PID 1651 | 12:02:31 INFO - PID 1651 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:0.99 (1.9%) stddev-sans-first:0.97 12:02:31 INFO - PID 1651 | Values: 54.0 52.0 54.0 51.0 53.0 53.0 54.0 53.0 53.0 52.0 12:02:31 INFO - PID 1651 | 12:02:31 INFO - PID 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:3.13 (5.1%) stddev-sans-first:2.59 12:02:31 INFO - PID 1651 | Values: 55.0 61.0 57.0 63.0 66.0 63.0 61.0 60.0 59.0 61.0 12:02:31 INFO - PID 1651 | 12:02:31 INFO - PID 1651 | [#10] stanford-crypto-aes Cycles:10 Average:99.90 Median:87.50 stddev:12.74 (14.6%) stddev-sans-first:12.63 12:02:31 INFO - PID 1651 | Values: 87.0 88.0 89.0 104.0 115.0 111.0 88.0 116.0 112.0 89.0 12:02:31 INFO - PID 1651 | 12:02:31 INFO - PID 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:173.70 Median:174.00 stddev:23.32 (13.4%) stddev-sans-first:23.74 12:02:31 INFO - PID 1651 | Values: 155.0 180.0 164.0 160.0 164.0 177.0 143.0 171.0 224.0 199.0 12:02:31 INFO - PID 1651 | 12:02:31 INFO - PID 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:210.50 Median:198.50 stddev:30.43 (15.3%) stddev-sans-first:32.04 12:02:31 INFO - PID 1651 | Values: 221.0 184.0 187.0 274.0 255.0 198.0 197.0 193.0 197.0 199.0 12:02:31 INFO - PID 1651 | 12:02:31 INFO - PID 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:85.40 Median:73.00 stddev:18.64 (25.5%) stddev-sans-first:19.39 12:02:31 INFO - PID 1651 | Values: 75.0 93.0 111.0 111.0 60.0 78.0 107.0 77.0 71.0 71.0 12:02:31 INFO - PID 1651 | -------- Summary: end -------- 12:02:31 INFO - PID 1651 | 12:02:32 INFO - TEST-INFO | 1651: exit 0 12:02:32 INFO - TEST-OK | kraken | took 64307ms 12:02:32 INFO - SUITE-END | took 1181s 12:02:33 INFO - Completed test suite (00:19:42) 12:02:33 INFO - javascript benchmark 12:02:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7788.612461809394, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3560.2345495718423, 3588.1567831559596, 3616.8734094306706, 3617.9276414471697, 3621.9456708149382, 6122.887389030165, 6229.439350458452, 6247.71885265163, 6255.218097737783, 6282.842928926779, 6131.407250743225, 6160.59956102853, 6168.352323006087, 6296.212973378328, 6302.46429053531, 5499.312585926759, 5501.834944951658, 5532.059549876531, 5585.441455854402, 5613.719314034302, 4622.4684161321375, 5538.363088244843, 5617.988762022835, 5633.239512665778, 5647.774089036434, 5395.7032363220005, 5444.3194600674915, 5560.86097847553, 5573.219749235111, 5614.101743721006, 4483.260262056757, 4546.8863278417975, 5469.316335458067, 5470.8085217017615, 5520.613557051008, 5368.979893820162, 5446.618736688433, 5446.782128714846, 5490.039243132436, 5494.697791621459, 6122.295935967376, 6155.199824022849, 6180.907286390708, 6239.87520249597, 6243.157173781527, 6666.83332916681, 6784.050232967388, 6787.898181527281, 6794.0, 6795.898061529081, 6859.862802743917, 6878.3465570770695, 6892.0, 6894.24163342032, 6898.275681053467, 6291.653959032205, 6344.746210151635, 6346.333634968354, 6380.936190638081, 6382.946813775768, 5740.655560666373, 6757.763478278335, 6853.4174595158975, 6932.306769323128, 6932.688029038705, 6433.0, 6514.674266286666, 6524.739010439529, 6624.470042396597, 6682.83292917681, 6724.7646332378135, 6816.863662726718, 6823.522353435212, 6846.486513511507, 6852.177738671391, 6769.3907548320885, 6788.253292137861, 6801.0, 6824.897626535606, 6840.452763778985, 6514.446272066927, 6575.408213260829, 6684.86630267392, 6757.729690812313, 6794.8301292467095, 5411.2965314508865, 5419.132938729863, 5423.430539793344, 5435.1303791393975, 5443.727813609304, 4801.087793319258, 4802.0, 4819.614430845524, 4832.516748325139, 4866.46468888422, 6188.597741146901, 6227.657478838707, 6255.218097737783, 6317.873642527124, 6397.0, 6822.658867056726, 6835.897461538081, 6885.242623311432, 6911.997760324724, 6944.097267355211, 6394.584352017104, 6416.839579010562, 6419.935800642027, 6420.807375778734, 6425.132607097982, 5862.794802181903, 5961.701914904237, 6025.608335458269, 6068.453839154409, 6121.387861213843, 6936.861262774615, 7077.115360579927, 7113.253108423541, 7139.107611548557, 7139.357457828821, 5686.4029276926985, 6489.707963141575, 6841.692123854538, 6860.211075726355, 6883.483738719516, 6087.269527656709, 7030.718771249093, 7112.822179445348, 7139.500234983501, 7166.498345115792, 5588.916166257591, 6475.481961443167, 6567.474602031731, 6674.399304062464, 6740.865182696417, 5656.321241451053, 6654.900176497454, 6674.599524028574, 6695.866082678416, 6697.196336439463, 6247.718852651732, 6379.96810015947, 6431.163948686641, 6599.0761293418, 6612.437942774918, 6425.58233714807, 6623.933760662524, 6654.866902662016, 6669.166354205724, 6682.83292917681, 6267.4045965633195, 6350.428461438492, 6384.712687928962, 6411.326810684811, 6442.130312407952, 6663.566868153554, 6674.733010679518, 6675.833104172434, 6701.664916754045, 6713.261541230363, 6468.126802881551, 6471.255805582418, 6502.414782669583, 6505.349465053646, 6507.772227971998], "value": 6150.207196019659, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.8042708895686, 797.4577287444539, 839.2656425627574, 1268.6511209417408, 1280.5390059578556, 38179.0, 39172.0, 39221.0, 39283.214335713266, 39354.8032259839, 38936.41595376072, 38971.805140974255, 39286.41070383939, 39311.0, 39454.40818387726, 7459.850802983937, 7980.640871160812, 8119.675212991473, 8621.741347759576, 8626.266767324785, 8562.657493700244, 8623.827523449527, 8637.3521985851, 8665.17680820321, 8688.522131282776, 8583.613737381802, 8684.43551169172, 8694.39139260252, 8697.869531957025, 8699.739007829776, 8624.0, 8667.306615470747, 8668.306535477146, 8669.479831210148, 8669.869951950726, 8513.872291915626, 8550.52972086535, 8626.741197764077, 8639.179277968646, 8645.567721613957, 37732.81133594342, 37896.24207515834, 37979.810100949595, 38018.0, 38028.04929876747, 3394.253264281854, 3438.48422736589, 3441.4493681010917, 3443.5867695876404, 3445.2937147884873, 29991.70008299911, 30409.0, 30486.237844053856, 30508.237294067603, 30552.8472357639, 3073.861676224553, 3110.377924415126, 3116.532520121977, 3135.0, 3135.404273188087, 266711.0, 268538.0, 284731.0, 289680.0, 375525.1223743891, 53390.73304633452, 53675.19487207695, 53727.73136134294, 53760.19359709608, 53786.462135378926, 51321.743391282806, 51729.48270517322, 56333.43666563282, 56511.71744141253, 56875.43124568784, 14514.419423222953, 14537.273136343141, 14650.633734156518, 14692.706145877022, 14699.0, 10207.642732504326, 11840.348780816965, 11882.346470944009, 11930.701732456584, 11951.103667224992, 12522.123451358317, 12977.935110324388, 14331.78502322466, 14402.351894164787, 14482.0, 6157.199564056734, 6160.199174107337, 6230.221222347207, 6268.435840774261, 6276.623402595859, 964.1467301438138, 979.603260679426, 990.8266053440764, 992.4888682328462, 1014.0, 22418.887905560696, 23942.88028559846, 24371.147009854925, 24413.633795493082, 24482.14312499054, 1043.2384359417667, 1092.3718861654581, 1114.6934592986831, 1117.8770335263114, 1124.9156313276537, 10308.175345972304, 12159.601645810844, 12395.876041239471, 12402.75194496105, 12420.689482763004, 458602.0, 505079.0, 505632.0, 506139.0, 506316.93683063437, 54615.72692136593, 54831.0, 54939.0, 55024.72487637536, 55313.0, 1489.6424858033993, 1489.6871656952162, 1527.2898102382446, 1529.0443472829481, 1529.1436795394616, 20032.198712051355, 22427.0, 23584.29247122589, 23782.286531404086, 23805.285841424786, 36574.085647859014, 38083.0, 38487.03782405462, 38524.6147538521, 38533.807330964286, 443510.0, 447969.0, 449027.0, 449635.0, 450355.0, 33216.0, 33587.49618755672, 34321.97034088981, 34720.82639586786, 35041.0, 41515.0, 42364.36453453262, 42527.787361063, 42605.78697106495, 42646.93382665458, 28004.49382099613, 28890.30358492798, 29222.123336299945, 29383.559246611745, 30086.69913300839, 29141.271468213465, 29576.0, 29732.851335743184, 29894.701052989192, 30014.849925751107, 34164.316713666085, 34710.65289347074, 34918.12704682403, 35352.29295414129, 35620.28759424849, 29079.418411631224, 29333.55999659964, 30038.549421758253, 30054.699453006066, 30121.698783012765, 22115.668264975717, 23967.280981569882, 24019.039238430967, 24139.034438622963, 24169.75830241675], "value": 18025.406382426194, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.34176071558704, 405.1471652172178, 423.28042328042335, 435.2948223877317, 459.2078664304076, 21518.139274429024, 21734.021969011374, 22419.775802241973, 22731.977061032252, 23008.424789380275, 22006.559868802615, 22595.661065084038, 22671.546569068607, 23161.884190579065, 23311.999999999956, 6088.238970128734, 6284.088807122976, 6467.579607325509, 6523.543351965364, 6531.412172904437, 6206.0, 6312.431881130698, 6316.652584107896, 6331.398517140864, 6341.8097457076365, 5031.2453132030305, 6002.729877155517, 6272.623642581437, 6275.497960163176, 6284.8743025139465, 6066.090086487018, 6176.4132407421675, 6198.721057552421, 6220.875582488347, 6277.309495955441, 4534.773261336953, 5489.011977843987, 5529.0324193266015, 5584.944150558483, 5592.496675299242, 22156.11375544976, 25111.87444062768, 27428.588571171247, 27900.302492437648, 28184.436311273865, 2194.857334273267, 2246.7416247131464, 2248.033345661365, 2250.887455627212, 2252.2905284835224, 14403.91970602209, 16696.332146714118, 17938.282468701236, 17992.0, 18049.909750451163, 2053.3121404329568, 2100.7479102507646, 2115.492281852344, 2128.1487405037956, 2166.1118941234017, 161817.19091404584, 162310.0, 166238.0, 166339.1683041577, 167221.16389418097, 10635.361878287327, 12632.557860474839, 12811.615651530468, 12866.806997895039, 13261.93369033168, 16208.75686864698, 16286.755698664529, 16578.6684266314, 16579.01051873759, 16589.6682066358, 8195.918040819515, 8428.862103616057, 8747.518886461306, 9014.504202268807, 9204.539773011456, 7089.680964356617, 8388.245057944814, 8525.19010693983, 8552.486850788848, 8707.259882909897, 8008.27925486709, 8163.428560000862, 8169.71406000799, 8186.467879587808, 8198.1391953844, 1828.963420731578, 2196.176433837311, 2201.9449513762283, 2203.10774136475, 2351.247600767772, 743.9218882017418, 814.3973459639942, 818.5048045932244, 895.2703546609623, 938.1228551304553, 20638.38084857457, 21174.153033878472, 21208.575828483343, 21213.681794773092, 21277.0, 966.8984756600456, 977.2768151567931, 1007.1187710753092, 1008.68226508651, 1020.2654089055868, 10752.516136773864, 10976.0, 11025.338479691245, 11039.668809935714, 11082.833757493645, 661453.0, 730724.0, 732417.0, 744369.0, 750543.0, 157038.21480892523, 158030.0, 162319.97814153263, 162601.18699406428, 164520.0, 1151.624079062132, 1182.7338848758961, 1202.104432198018, 1207.728261141236, 1210.267787988272, 17981.73027404564, 18157.91052536852, 18201.635967280847, 18332.17505212295, 18384.448466546026, 58815.70592147012, 62732.0, 62975.37024629695, 63537.68231158815, 64437.91182969776, 82056.58971705103, 82208.17791822006, 83021.75467368115, 84475.57762211395, 85159.0, 8579.442336248374, 8721.65113395457, 8767.906305118137, 8844.646214151362, 8886.333524985523, 13193.670158246121, 13212.0, 13341.466341346237, 13705.794413084011, 13731.382087805872, 11265.324080555192, 11301.547938082385, 11309.419685027577, 11550.0, 11625.24435911663, 10505.369677819355, 10612.204084693525, 10789.460526973777, 10815.97248261414, 11086.279391839505, 11753.177277590828, 11832.053435725293, 12066.0, 12092.0, 12138.089643276966, 7062.964685176541, 8683.392162548813, 8720.168764559514, 8774.429662071945, 8952.597133128895, 9418.199453046567, 10906.727331816768, 11289.661310160709, 11483.0, 11940.76118477643], "value": 10524.92848072597, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1188.5542921404474, 1287.5171810571037, 1367.2138520350798, 1432.7635940069886, 1439.6976634906669, 10868.72828179295, 11316.26444281121, 11338.206325557214, 11399.658010259685, 11648.708782280448, 9931.205503559717, 10896.509657065431, 11342.546298148085, 11510.482028308725, 11512.424378781048, 2471.5180539794746, 2517.345490172559, 2520.6093055576416, 2523.962140567893, 2529.759672831078, 2340.496793189464, 2364.8226383021256, 2455.0916161020446, 2525.444402231506, 2529.557327467695, 2479.3305807431984, 2484.813638977075, 2500.112460076674, 2512.459821138455, 2534.531111744333, 2470.505898820225, 2488.4525404411, 2495.25142457263, 2501.8123640726926, 2526.065355818341, 2032.7967203279554, 2442.120836498859, 2496.2386472125995, 2529.6584961030208, 2541.0471073347494, 11439.59961401347, 11556.364399957998, 11579.247348922378, 11595.01442377399, 11598.652040438801, 5314.468553144693, 6644.83387915306, 6665.9666701666665, 6717.193936727624, 6719.865602687968, 4005.379166229239, 4219.1139860629, 4310.288802347609, 4320.697551171388, 4343.261645520269, 1190.4405229149754, 1239.9442025108801, 1287.787515060014, 1291.0381765584605, 1294.8734600897185, 14118.082324648967, 14779.92610036943, 15873.365065397371, 15919.522414327474, 15971.0, 5060.671056381323, 5716.599838011382, 5724.284464441945, 5724.341700704389, 5736.110902810071, 11694.649160525198, 11830.88169118315, 11832.053435725122, 11861.406929653655, 11874.287542747463, 6504.317046710027, 6542.803715888531, 6551.868962620721, 6554.475641948633, 6563.671816409161, 5955.987482128048, 6181.289151747516, 6254.874902501924, 6260.5617606768, 6269.8746025079245, 4359.585839345257, 4404.471463424409, 4418.756968366706, 4442.53353397895, 4477.507474177838, 1290.0647030902521, 1306.9346532673328, 1308.0843409613308, 1308.1235572166672, 1314.9408276627576, 660.7324033766332, 750.9549427034395, 784.5684873319651, 785.8899754034439, 808.3815880851154, 5011.6241281904, 5965.164876917235, 6092.0, 6234.688265586702, 6235.501159907197, 560.0898539872707, 565.5023579250234, 576.1415490918585, 589.7965202005302, 603.5805115444812, 3964.623360780721, 4018.1561872006623, 4086.1010577672864, 4148.0, 4247.787610619456, 14285.500007499895, 14913.105213687213, 14917.40330386794, 14936.32786524609, 14937.0, 14799.186044767426, 14799.964002519935, 14810.851891480947, 14814.481493147689, 14835.03572267799, 10343.482825858677, 10648.89351106479, 10836.40399778004, 10839.349639021684, 10847.294925829796, 6312.210973628296, 6448.516361272829, 6462.612243265419, 6473.643949582818, 6478.9309763890315, 13000.544980925622, 13261.801072984106, 13311.66720831987, 13316.533921312708, 13324.133931294435, 10183.898161018591, 10885.891141088488, 11781.705457363292, 12823.166494177849, 13417.664558385728, 8241.857117149704, 8445.915540844759, 8448.66205351779, 8472.74581762548, 8482.109378515168, 8505.0, 10155.441450719985, 10258.230632702427, 10380.013898679614, 10394.636187733393, 8682.348823838363, 8712.91287087121, 8843.292536596928, 8955.194032537103, 9014.684486042957, 8586.828263434822, 8647.135286471554, 8668.133186681282, 8777.648894044421, 8836.867446988428, 7849.293563579306, 7919.564423956507, 7996.3602911768085, 8000.51996880189, 8038.276555110068, 5124.718140502308, 5844.649321040752, 5918.674472903859, 5955.076963070731, 6005.429484198994, 5930.377310382348, 5997.956369480579, 6106.236720409949, 6130.264368275835, 6225.688715564113], "value": 5213.837590796237, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.7719990805609, 385.80902453285626, 399.3271337795814, 408.24678468226114, 409.8934277087956, 5447.046766815811, 5828.0, 6203.31763506014, 6230.439260466568, 6305.936940630592, 5187.922181167285, 5990.244487535728, 6068.0, 6124.020156774917, 6138.754449822001, 3586.748927575071, 3673.7612055216327, 4488.214562451574, 4498.235299999, 4508.165989291975, 3886.0, 3892.5328960524776, 4252.511620932664, 4459.44256967879, 4504.572065653758, 3617.855285788565, 4414.359917811916, 4423.933640995371, 4438.267685831834, 4444.400005999181, 4434.512203657595, 4438.423005009345, 4447.8443254486265, 4460.174867649495, 4501.48232953208, 3715.5727091384297, 3834.65488106069, 3863.130795571002, 3863.961360386388, 3866.2074274773886, 5123.410807757118, 5340.958513089949, 5394.406615272317, 5484.314460692413, 5964.463198312173, 5592.273004509429, 5600.795828896766, 5601.798651011742, 5610.214569960168, 5619.297587801525, 5864.912026319608, 5923.822285331447, 6009.729562169713, 6641.970494573349, 6644.468442524635, 4738.715677059387, 4754.453237877654, 4758.333833263346, 4767.69010014348, 4781.235002399634, 5894.528437724972, 6561.490857102845, 6839.350261725128, 6952.513324067318, 7051.753188638424, 3606.9819650901577, 4265.869544570692, 4836.0, 4859.7327147006545, 4873.80504779812, 4214.704970652087, 4965.4041515018425, 4966.255061740768, 4987.376577927759, 4989.052080104769, 5360.705161216092, 5470.097433923358, 5527.39198688152, 5570.582206334541, 5611.80358687444, 6228.4705800007505, 6458.8351707662905, 6559.836004099936, 6689.431398331099, 6691.197056353269, 1385.1342910680823, 1626.983730162707, 1691.687037897993, 1696.7454881767833, 1700.3963592924333, 1144.1704764046167, 1153.221575436577, 1165.7468221661748, 1167.620523329921, 1178.6994316449423, 4932.0, 5375.811846585429, 5739.642309249136, 6245.313015568284, 6293.3391993840905, 6817.420519255918, 6819.079424277659, 6821.863562728718, 6830.658467076626, 6873.931260687429, 5894.734736936848, 6181.258249010148, 6199.481127123883, 6241.656708881055, 6309.211348581427, 3228.870845166167, 3505.0228675281164, 3550.5384300041346, 3559.914226160994, 3565.4117070683565, 5926.496247818984, 6315.242170939517, 6498.902516462257, 6761.875256093779, 6962.268961758942, 6009.098635204667, 6047.697615119227, 7020.7542736004, 7045.365917067386, 7045.401140902978, 5370.6777593345305, 5915.911261331084, 6772.52592318533, 7055.012298278142, 7149.714011439588, 6157.353477884758, 6337.271213810471, 6569.244536878129, 6760.290169532128, 6767.93232067673, 5898.321693005188, 5929.229200203946, 6598.472122230306, 6649.168853893263, 6784.3554862288, 5886.6173698709445, 6956.7217311309005, 7093.645317733989, 7157.320054594805, 7162.677679504331, 4443.422355093817, 4463.2635615123145, 4466.709663871838, 4477.910441791211, 4497.77511124449, 6599.4390476808085, 6820.488463365366, 6832.316768323128, 6858.519903606899, 6859.759908403182, 6614.702338394687, 6620.337966203341, 6637.6349300788925, 6637.6349300788925, 6650.035744817072, 5849.883002340014, 6217.285012223471, 6416.422521973045, 6611.603303801788, 6614.239362473377, 6147.84630384244, 6459.289478157305, 6486.189226346707, 6515.934840651723, 6517.576357536745, 6415.711292991733, 6562.50781191403, 6631.734730610721, 6643.335666433318, 6650.301718319507, 6436.774712885027, 6446.194225721785, 6455.289918109098, 6473.8705225896165, 6495.837604059936], "value": 4811.461375209934, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.4800590841953, 822.6339279020837, 822.9300509456696, 833.582909054607, 838.3460900497611, 15896.841031589694, 16337.183140842955, 17585.3845115421, 18665.440036798886, 18739.0, 17368.305267789307, 17690.523326734266, 17826.46520604384, 17962.461126166203, 18233.179506922188, 863.2144748279068, 922.1147698209693, 947.351064520802, 969.1181025267008, 974.7319487141058, 968.2883080935507, 990.6235630460451, 996.2528103922059, 1010.0656892374561, 1010.5957616953241, 1047.0262655730169, 1060.0035966191756, 1061.8619579454698, 1062.718379629399, 1065.4193464561833, 1043.572135424476, 1054.0829478353844, 1058.867641544807, 1060.533365319257, 1062.5112448273803, 772.1390649425906, 777.6150805351388, 782.3271986091956, 785.0, 787.7361084036854, 14058.789118163235, 14649.0, 16625.4181103662, 17110.657786844316, 17212.741808872877, 14957.476488322856, 14996.700065998619, 15104.093754374773, 15149.545513634608, 15898.443554475538, 13208.801867971892, 13353.86646133536, 13612.863871361258, 13668.589942301647, 13737.0, 3045.7867949243564, 3351.8659253629826, 3357.5635167428322, 3365.158710322419, 3370.9831450842835, 122215.0, 123837.0, 124294.13558796626, 125534.0, 125995.37002315022, 11196.888031119748, 11254.17500836255, 11258.605948791754, 11550.480228389742, 11674.124440666985, 23076.192333268256, 24437.02251909904, 25387.873060634578, 25560.616590751153, 25670.48659026809, 7604.201558836353, 7632.618369081523, 7659.693612255559, 7755.922440775633, 7806.759644417116, 4211.052513184571, 4219.51475580306, 4260.879105534553, 4306.5262821089655, 4321.395004699281, 4186.958130418657, 4276.444062271885, 4281.892952676208, 4285.871423857289, 4301.892452688708, 940.2055263302499, 976.8730065091493, 982.4989255479757, 982.6658935961665, 987.7234374375187, 622.2843729710869, 623.4856243599049, 639.0318667219167, 650.9487178207162, 667.2926697700453, 9759.26805489591, 10204.897951020543, 10355.326903751233, 10442.477876106164, 10545.367277963347, 594.6075590110506, 627.6108812536256, 627.7394881124283, 629.8236493781657, 657.0997733105676, 4324.210883979816, 4363.36731173978, 4698.412698412699, 4816.349792778, 4823.686460380134, 102636.0, 105809.0, 106873.46563267289, 107321.0, 109112.4544377273, 88201.0, 88644.11355886358, 89213.0, 90184.5490772555, 90576.0, 81293.0, 81481.59259203666, 82346.0, 82427.58786205911, 84106.0, 8176.918230817616, 8404.028771264437, 8949.836521252195, 9658.033556480854, 9679.516024198903, 38576.42135368028, 39512.0, 39725.80822575327, 40385.798071009456, 40466.79766601148, 37591.0, 48987.75506122447, 49608.0, 49668.0, 50377.49622503728, 10752.0, 11246.7750644985, 11588.6523404298, 11659.300441973508, 11767.352795596324, 11247.493862776031, 11443.027342675965, 11506.482208300478, 11716.71116177237, 12998.870011300145, 10713.946430267799, 11260.873912609, 11733.76532469363, 11735.295882247092, 11831.349275789915, 11010.953959373846, 11648.184627076023, 11894.34581098048, 11941.880581194077, 12207.511699532275, 11597.362145082101, 11641.88358116408, 11646.94176529112, 11649.941750291533, 11825.349605771766, 8474.3644226682, 8797.47215167092, 8945.0, 9878.555465004236, 10572.524236409226, 9769.413835169913, 10804.459777011276, 11112.222144450134, 11227.71930701739, 11456.0], "value": 7626.059564913716, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1676.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 120.0, 121.0, 120.0, 129.0, 149.0, 119.0, 103.0, 178.0, 180.0], "value": 132.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 110.0, 156.0, 155.0, 120.0, 115.0, 117.0, 113.0, 140.0, 161.0], "value": 133.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [228.0, 218.0, 250.0, 311.0, 247.0, 215.0, 214.0, 212.0, 208.0, 216.0], "value": 231.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 60.0, 88.0, 63.0, 62.0, 63.0, 62.0, 74.0, 60.0], "value": 66.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 109.0, 129.0, 103.0, 73.0, 71.0, 90.0, 71.0, 76.0, 116.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 142.0, 92.0, 91.0, 98.0, 90.0, 91.0, 90.0, 90.0, 91.0], "value": 96.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 166.0, 119.0, 129.0, 113.0, 122.0, 100.0, 100.0, 99.0, 140.0], "value": 119.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 122.0, 102.0, 102.0, 103.0, 100.0, 161.0, 151.0, 103.0, 102.0], "value": 120.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 54.0, 51.0, 53.0, 53.0, 54.0, 53.0, 53.0, 52.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 61.0, 57.0, 63.0, 66.0, 63.0, 61.0, 60.0, 59.0, 61.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 89.0, 104.0, 115.0, 111.0, 88.0, 116.0, 112.0, 89.0], "value": 99.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 180.0, 164.0, 160.0, 164.0, 177.0, 143.0, 171.0, 224.0, 199.0], "value": 173.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [221.0, 184.0, 187.0, 274.0, 255.0, 198.0, 197.0, 193.0, 197.0, 199.0], "value": 210.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 93.0, 111.0, 111.0, 60.0, 78.0, 107.0, 77.0, 71.0, 71.0], "value": 85.4, "unit": "score"}]}]} 12:02:33 INFO - Return code: 0 12:02:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:02:33 ERROR - # TBPL SUCCESS # 12:02:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:02:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:02:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:02:33 INFO - 2017-04-05 12:02:33.236 screenresolution[1656:10955] starting screenresolution argv=screenresolution get 12:02:33 INFO - 2017-04-05 12:02:33.239 screenresolution[1656:10955] Display 0: 1600x1200x32@60 12:02:33 INFO - 2017-04-05 12:02:33.245 screenresolution[1657:10958] starting screenresolution argv=screenresolution list 12:02:33 INFO - Available Modes on Display 0 12:02:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:02:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:02:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:02:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:02:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:02:33 INFO - Intel Iris: 12:02:33 INFO - Chipset Model: Intel Iris 12:02:33 INFO - Type: GPU 12:02:33 INFO - Bus: Built-In 12:02:33 INFO - VRAM (Dynamic, Max): 1536 MB 12:02:33 INFO - Vendor: Intel (0x8086) 12:02:33 INFO - Device ID: 0x0a2e 12:02:33 INFO - Revision ID: 0x0009 12:02:33 INFO - Displays: 12:02:33 INFO - Display: 12:02:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:02:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:02:33 INFO - Display Serial Number: 1600x1200 60 12:02:33 INFO - Main Display: Yes 12:02:33 INFO - Mirror: Off 12:02:33 INFO - Online: Yes 12:02:33 INFO - Rotation: Supported 12:02:33 INFO - Return code: 0 12:02:33 INFO - Running post-action listener: _resource_record_post_action 12:02:33 INFO - [mozharness: 2017-04-05 19:02:33.485467Z] Finished run-tests step (success) 12:02:33 INFO - Running post-run listener: _resource_record_post_run 12:02:33 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 40528384; Write bytes: 521976832; Read time: 386; Write time: 1695 12:02:33 INFO - TinderboxPrint: CPU usage
54.2% 12:02:33 INFO - TinderboxPrint: I/O read bytes / time
40,528,384 / 386 12:02:33 INFO - TinderboxPrint: I/O write bytes / time
521,976,832 / 1,695 12:02:33 INFO - TinderboxPrint: CPU idle
2,203.4 (45.8%) 12:02:33 INFO - TinderboxPrint: CPU system
968.6 (20.1%) 12:02:33 INFO - TinderboxPrint: CPU user
1,637.7 (34.1%) 12:02:33 INFO - TinderboxPrint: Swap in / out
247,709,696 / 0 12:02:33 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 195877376; Write bytes: 194324480; Read time: 14875; Write time: 461 12:02:33 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 39561728; Write bytes: 310809600; Read time: 371; Write time: 1187 12:02:33 INFO - Running post-run listener: _upload_blobber_files 12:02:33 INFO - Blob upload gear active. 12:02:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:02:33 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 12:02:33 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', 'Pine', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:02:33 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 Pine -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:02:34 INFO - (blobuploader) - INFO - Open directory for files ... 12:02:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:02:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:02:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:02:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:02:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:02:35 INFO - (blobuploader) - INFO - Done attempting. 12:02:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:02:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:02:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:02:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:02:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:02:36 INFO - (blobuploader) - INFO - Done attempting. 12:02:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:02:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:02:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:02:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:02:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:02:37 INFO - (blobuploader) - INFO - Done attempting. 12:02:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:02:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:02:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:02:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:02:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:02:39 INFO - (blobuploader) - INFO - Done attempting. 12:02:39 INFO - (blobuploader) - INFO - Iteration through files over. 12:02:39 INFO - Return code: 0 12:02:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:02:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:02:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/fb813dbb12e16758a09cd4d4a64a4de5f309957196b651cac123782b251d2e3bbd0a053e452fe5858c2b96aea48bb24d4e29070a6675c4944b8e6825d66a118f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/98ae7b064e11162ec62b255282bdc5b8c3b58ad7bc2034c3a1a3202889302e95febf397e46a5fb1f13d15a13ae032c434e9b07caf55a0bda078b942cf2b4d2f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/63f1d76affb472dffa84f0379541f9b31e9b3e464dfc3ae20fb69e496110233f800eb3b6a929e67d8cb5ea4d50ac5fe7b7cdd96635a7dc1e189c21f8eae8cfc1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/502aef9c1557e5678182f0fbe012813038b477c27401921630e365233dfeb0262586fe299b63c5e0ed441dd3b725dd3ef155b64de1d403842eecf87e5c2cea74"} 12:02:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:02:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:02:39 INFO - Contents: 12:02:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/fb813dbb12e16758a09cd4d4a64a4de5f309957196b651cac123782b251d2e3bbd0a053e452fe5858c2b96aea48bb24d4e29070a6675c4944b8e6825d66a118f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/98ae7b064e11162ec62b255282bdc5b8c3b58ad7bc2034c3a1a3202889302e95febf397e46a5fb1f13d15a13ae032c434e9b07caf55a0bda078b942cf2b4d2f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/63f1d76affb472dffa84f0379541f9b31e9b3e464dfc3ae20fb69e496110233f800eb3b6a929e67d8cb5ea4d50ac5fe7b7cdd96635a7dc1e189c21f8eae8cfc1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/502aef9c1557e5678182f0fbe012813038b477c27401921630e365233dfeb0262586fe299b63c5e0ed441dd3b725dd3ef155b64de1d403842eecf87e5c2cea74"} 12:02:39 INFO - Running post-run listener: copy_logs_to_upload_dir 12:02:39 INFO - Copying logs to upload dir... 12:02:39 INFO - mkdir: /builds/slave/test/build/upload/logs 12:02:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.844378 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-05 12:02:39.241445) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 12:02:39.244586) ========= 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.SDBgVGKaUM/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.C9qKv5Ez9O/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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/Pine/sha512/fb813dbb12e16758a09cd4d4a64a4de5f309957196b651cac123782b251d2e3bbd0a053e452fe5858c2b96aea48bb24d4e29070a6675c4944b8e6825d66a118f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/98ae7b064e11162ec62b255282bdc5b8c3b58ad7bc2034c3a1a3202889302e95febf397e46a5fb1f13d15a13ae032c434e9b07caf55a0bda078b942cf2b4d2f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/63f1d76affb472dffa84f0379541f9b31e9b3e464dfc3ae20fb69e496110233f800eb3b6a929e67d8cb5ea4d50ac5fe7b7cdd96635a7dc1e189c21f8eae8cfc1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/502aef9c1557e5678182f0fbe012813038b477c27401921630e365233dfeb0262586fe299b63c5e0ed441dd3b725dd3ef155b64de1d403842eecf87e5c2cea74"} build_url:https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011453 build_url: 'https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/fb813dbb12e16758a09cd4d4a64a4de5f309957196b651cac123782b251d2e3bbd0a053e452fe5858c2b96aea48bb24d4e29070a6675c4944b8e6825d66a118f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/98ae7b064e11162ec62b255282bdc5b8c3b58ad7bc2034c3a1a3202889302e95febf397e46a5fb1f13d15a13ae032c434e9b07caf55a0bda078b942cf2b4d2f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/63f1d76affb472dffa84f0379541f9b31e9b3e464dfc3ae20fb69e496110233f800eb3b6a929e67d8cb5ea4d50ac5fe7b7cdd96635a7dc1e189c21f8eae8cfc1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/502aef9c1557e5678182f0fbe012813038b477c27401921630e365233dfeb0262586fe299b63c5e0ed441dd3b725dd3ef155b64de1d403842eecf87e5c2cea74"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 12:02:39.279112) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 12:02:39.279483) ========= 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.SDBgVGKaUM/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.C9qKv5Ez9O/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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.005259 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 12:02:39.328046) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 12:02:39.328386) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 12:02:39.328714) ========= ========= Total master_lag: 0.19 =========