builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0307 starttime: 1480570432.4 results: success (0) buildid: 20161130191844 builduid: 9db752e5c1f942b68789dc972c03c217 revision: a183d5c5a8f79b09be159329992ef958a55f23ed ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 21:33:52.400003) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 21:33:52.400494) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 21:33:52.400769) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 21:33:52.427288) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 21:33:52.427668) ========= 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.VbJg7c4oJR/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.d06sOCeEJr/Listeners TMPDIR=/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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 --2016-11-30 21:33:52-- 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% 184M=0s 2016-11-30 21:33:52 (184 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119569 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 21:33:52.574418) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 21:33:52.574735) ========= 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.VbJg7c4oJR/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.d06sOCeEJr/Listeners TMPDIR=/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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.024386 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 21:33:52.623058) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-30 21:33:52.626463) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a183d5c5a8f79b09be159329992ef958a55f23ed --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a183d5c5a8f79b09be159329992ef958a55f23ed --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VbJg7c4oJR/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.d06sOCeEJr/Listeners TMPDIR=/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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 2016-11-30 21:33:52,716 truncating revision to first 12 chars 2016-11-30 21:33:52,717 Setting DEBUG logging. 2016-11-30 21:33:52,717 attempt 1/10 2016-11-30 21:33:52,717 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a183d5c5a8f7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-30 21:33:53,480 unpacking tar archive at: mozilla-central-a183d5c5a8f7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.020891 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-30 21:33:53.670841) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 21:33:53.674178) ========= script_repo_revision: a183d5c5a8f79b09be159329992ef958a55f23ed ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 21:33:53.674626) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 21:33:53.674897) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 21:33:53.694744) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-11-30 21:33:53.695141) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VbJg7c4oJR/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.d06sOCeEJr/Listeners TMPDIR=/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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 21:33:53 INFO - MultiFileLogger online at 20161130 21:33:53 in /builds/slave/test 21:33:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:33:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:33:53 INFO - {'append_to_log': False, 21:33:53 INFO - 'base_work_dir': '/builds/slave/test', 21:33:53 INFO - 'blob_upload_branch': 'Firefox', 21:33:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:33:53 INFO - 'branch': 'Firefox', 21:33:53 INFO - 'buildbot_json_path': 'buildprops.json', 21:33:53 INFO - 'config_files': ('talos/mac_config.py',), 21:33:53 INFO - 'default_actions': ('clobber', 21:33:53 INFO - 'read-buildbot-config', 21:33:53 INFO - 'download-and-extract', 21:33:53 INFO - 'populate-webroot', 21:33:53 INFO - 'create-virtualenv', 21:33:53 INFO - 'install', 21:33:53 INFO - 'run-tests'), 21:33:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:33:53 INFO - 'download_minidump_stackwalk': True, 21:33:53 INFO - 'download_symbols': 'ondemand', 21:33:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:33:53 INFO - 'tooltool.py': '/tools/tooltool.py', 21:33:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:33:53 INFO - '/tools/misc-python/virtualenv.py')}, 21:33:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:33:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:33:53 INFO - 'installer_path': 'installer.exe', 21:33:53 INFO - 'log_level': 'info', 21:33:53 INFO - 'log_name': 'talos', 21:33:53 INFO - 'log_to_console': True, 21:33:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:33:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:33:53 INFO - 'opt_config_files': (), 21:33:53 INFO - 'pip_index': False, 21:33:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:33:53 INFO - 'cmd': ('bash', 21:33:53 INFO - '-c', 21:33:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:33:53 INFO - 'enabled': True, 21:33:53 INFO - 'halt_on_failure': False, 21:33:53 INFO - 'name': 'check_screen_resolution'},), 21:33:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:33:53 INFO - 'cmd': ('bash', 21:33:53 INFO - '-c', 21:33:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:33:53 INFO - 'enabled': True, 21:33:53 INFO - 'halt_on_failure': False, 21:33:53 INFO - 'name': 'check_screen_resolution'},), 21:33:53 INFO - 'run_cmd_checks_enabled': True, 21:33:53 INFO - 'sps_profile': False, 21:33:53 INFO - 'sps_profile_interval': 0, 21:33:53 INFO - 'suite': 'dromaeojs-e10s', 21:33:53 INFO - 'system_bits': '32', 21:33:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:33:53 INFO - 'title': 't-yosemite-r7-0307', 21:33:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:33:53 INFO - 'use_talos_json': True, 21:33:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:33:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:33:53 INFO - 'work_dir': 'build'} 21:33:53 INFO - [mozharness: 2016-12-01 05:33:53.891509Z] Running clobber step. 21:33:53 INFO - Running pre-action listener: _resource_record_pre_action 21:33:53 INFO - Running main action method: clobber 21:33:53 INFO - rmtree: /builds/slave/test/build 21:33:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:33:56 INFO - Running post-action listener: _resource_record_post_action 21:33:56 INFO - [mozharness: 2016-12-01 05:33:56.191465Z] Finished clobber step (success) 21:33:56 INFO - [mozharness: 2016-12-01 05:33:56.191600Z] Running read-buildbot-config step. 21:33:56 INFO - Running pre-action listener: _resource_record_pre_action 21:33:56 INFO - Running main action method: read_buildbot_config 21:33:56 INFO - Using buildbot properties: 21:33:56 INFO - { 21:33:56 INFO - "project": "", 21:33:56 INFO - "product": "firefox", 21:33:56 INFO - "script_repo_revision": "production", 21:33:56 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 21:33:56 INFO - "repository": "", 21:33:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 21:33:56 INFO - "buildid": "20161130191844", 21:33:56 INFO - "pgo_build": "False", 21:33:56 INFO - "basedir": "/builds/slave/test", 21:33:56 INFO - "buildnumber": 186, 21:33:56 INFO - "slavename": "t-yosemite-r7-0307", 21:33:56 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 21:33:56 INFO - "platform": "yosemite_r7", 21:33:56 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 21:33:56 INFO - "branch": "mozilla-central", 21:33:56 INFO - "repo_path": "mozilla-central", 21:33:56 INFO - "revision": "a183d5c5a8f79b09be159329992ef958a55f23ed", 21:33:56 INFO - "stage_platform": "macosx64", 21:33:56 INFO - "builduid": "9db752e5c1f942b68789dc972c03c217", 21:33:56 INFO - "slavebuilddir": "test" 21:33:56 INFO - } 21:33:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/YAsaPuFnR-CeRwzxRXQuLw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 21:33:56 INFO - Running post-action listener: _resource_record_post_action 21:33:56 INFO - [mozharness: 2016-12-01 05:33:56.194832Z] Finished read-buildbot-config step (success) 21:33:56 INFO - [mozharness: 2016-12-01 05:33:56.194969Z] Running download-and-extract step. 21:33:56 INFO - Running pre-action listener: _resource_record_pre_action 21:33:56 INFO - Running main action method: download_and_extract 21:33:56 INFO - mkdir: /builds/slave/test/build/tests 21:33:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:56 INFO - trying https://queue.taskcluster.net/v1/task/YAsaPuFnR-CeRwzxRXQuLw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 21:33:56 INFO - Downloading https://queue.taskcluster.net/v1/task/YAsaPuFnR-CeRwzxRXQuLw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 21:33:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YAsaPuFnR-CeRwzxRXQuLw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 21:33:57 INFO - Downloaded 1199 bytes. 21:33:57 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 21:33:57 INFO - Using the following test package requirements: 21:33:57 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 21:33:57 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:33:57 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 21:33:57 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:33:57 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 21:33:57 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:33:57 INFO - u'jsshell-mac.zip'], 21:33:57 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:33:57 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 21:33:57 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 21:33:57 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:33:57 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 21:33:57 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:33:57 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 21:33:57 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:33:57 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 21:33:57 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:33:57 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 21:33:57 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:33:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YAsaPuFnR-CeRwzxRXQuLw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 21:33:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YAsaPuFnR-CeRwzxRXQuLw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:33:57 INFO - Fetch https://queue.taskcluster.net/v1/task/YAsaPuFnR-CeRwzxRXQuLw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 21:33:58 INFO - Expected file size: 16275571 21:33:58 INFO - Obtained file size: 16275571 21:34:05 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:34:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YAsaPuFnR-CeRwzxRXQuLw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 21:34:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YAsaPuFnR-CeRwzxRXQuLw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:34:05 INFO - Fetch https://queue.taskcluster.net/v1/task/YAsaPuFnR-CeRwzxRXQuLw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 21:34:06 INFO - Expected file size: 16275571 21:34:06 INFO - Obtained file size: 16275571 21:34:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YAsaPuFnR-CeRwzxRXQuLw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 21:34:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YAsaPuFnR-CeRwzxRXQuLw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:34:12 INFO - Fetch https://queue.taskcluster.net/v1/task/YAsaPuFnR-CeRwzxRXQuLw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 21:34:14 INFO - Expected file size: 14409702 21:34:14 INFO - Obtained file size: 14409702 21:34: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')]} 21:34:14 INFO - trying https://queue.taskcluster.net/v1/task/YAsaPuFnR-CeRwzxRXQuLw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:34:14 INFO - Downloading https://queue.taskcluster.net/v1/task/YAsaPuFnR-CeRwzxRXQuLw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 21:34:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YAsaPuFnR-CeRwzxRXQuLw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 21:34:17 INFO - Downloaded 107610239 bytes. 21:34:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YAsaPuFnR-CeRwzxRXQuLw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:34:17 INFO - mkdir: /builds/slave/test/properties 21:34:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:34:17 INFO - Writing to file /builds/slave/test/properties/build_url 21:34:17 INFO - Contents: 21:34:17 INFO - build_url:https://queue.taskcluster.net/v1/task/YAsaPuFnR-CeRwzxRXQuLw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:34:18 INFO - Running post-action listener: _resource_record_post_action 21:34:18 INFO - Running post-action listener: set_extra_try_arguments 21:34:18 INFO - [mozharness: 2016-12-01 05:34:18.093686Z] Finished download-and-extract step (success) 21:34:18 INFO - [mozharness: 2016-12-01 05:34:18.093782Z] Running populate-webroot step. 21:34:18 INFO - Running pre-action listener: _resource_record_pre_action 21:34:18 INFO - Running main action method: populate_webroot 21:34:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:34:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:34:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:34:18 INFO - '--tppagecycles', 21:34:18 INFO - '7'], 21:34:18 INFO - 'tests': ['tsvgm']}}, 21:34:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:34:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:34:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:34:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:34:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:34:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:34:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:34:18 INFO - 'talos_options': ['--disable-e10s'], 21:34:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:34:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:34:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:34:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:34:18 INFO - 'talos_options': ['--disable-e10s'], 21:34:18 INFO - 'tests': ['damp', 'tps']}, 21:34:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:34:18 INFO - 'tests': ['damp', 'tps']}, 21:34:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:34:18 INFO - 'tests': ['dromaeo_dom']}, 21:34:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:34:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:34:18 INFO - 'tests': ['basic_compositor_video']}, 21:34:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:34:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:34:18 INFO - 'tests': ['a11yr', 21:34:18 INFO - 'ts_paint', 21:34:18 INFO - 'tpaint', 21:34:18 INFO - 'sessionrestore', 21:34:18 INFO - 'sessionrestore_no_auto_restore', 21:34:18 INFO - 'tabpaint']}, 21:34:18 INFO - 'other-e10s': {'tests': ['a11yr', 21:34:18 INFO - 'ts_paint', 21:34:18 INFO - 'tpaint', 21:34:18 INFO - 'sessionrestore', 21:34:18 INFO - 'sessionrestore_no_auto_restore', 21:34:18 INFO - 'tabpaint']}, 21:34:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:34:18 INFO - 'ts_paint', 21:34:18 INFO - 'tpaint', 21:34:18 INFO - 'sessionrestore', 21:34:18 INFO - 'sessionrestore_no_auto_restore', 21:34:18 INFO - 'tabpaint']}, 21:34:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:34:18 INFO - 'ts_paint', 21:34:18 INFO - 'tpaint', 21:34:18 INFO - 'sessionrestore', 21:34:18 INFO - 'sessionrestore_no_auto_restore', 21:34:18 INFO - 'tabpaint']}, 21:34:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:34:18 INFO - 'tests': ['a11yr', 21:34:18 INFO - 'ts_paint', 21:34:18 INFO - 'tpaint', 21:34:18 INFO - 'sessionrestore', 21:34:18 INFO - 'sessionrestore_no_auto_restore', 21:34:18 INFO - 'tabpaint']}, 21:34:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:34:18 INFO - 'tests': ['a11yr', 21:34:18 INFO - 'ts_paint', 21:34:18 INFO - 'tpaint', 21:34:18 INFO - 'sessionrestore', 21:34:18 INFO - 'sessionrestore_no_auto_restore', 21:34:18 INFO - 'tabpaint']}, 21:34:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:34:18 INFO - 'tests': ['tsvgx', 21:34:18 INFO - 'tsvgr_opacity', 21:34:18 INFO - 'tart', 21:34:18 INFO - 'tscrollx', 21:34:18 INFO - 'cart', 21:34:18 INFO - 'tsvg_static']}, 21:34:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:34:18 INFO - 'tsvgr_opacity', 21:34:18 INFO - 'tart', 21:34:18 INFO - 'tscrollx', 21:34:18 INFO - 'cart', 21:34:18 INFO - 'tsvg_static']}, 21:34:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:34:18 INFO - 'talos_options': ['--disable-e10s'], 21:34:18 INFO - 'tests': ['tp5o']}, 21:34:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:34:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:34:18 INFO - 'talos_options': ['--disable-e10s', 21:34:18 INFO - '--xperf_path', 21:34:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:34:18 INFO - 'tests': ['tp5n']}, 21:34:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:34:18 INFO - 'talos_options': ['--xperf_path', 21:34:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:34:18 INFO - 'tests': ['tp5n']}}, 21:34:18 INFO - 'talos.zip': {'path': '', 21:34:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:34:18 INFO - Running post-action listener: _resource_record_post_action 21:34:18 INFO - [mozharness: 2016-12-01 05:34:18.111661Z] Finished populate-webroot step (success) 21:34:18 INFO - [mozharness: 2016-12-01 05:34:18.111791Z] Running create-virtualenv step. 21:34:18 INFO - Running pre-action listener: _resource_record_pre_action 21:34:18 INFO - Running main action method: create_virtualenv 21:34:18 INFO - Creating virtualenv /builds/slave/test/build/venv 21:34:18 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 21:34:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:34:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:34:18 INFO - Using real prefix '/tools/python27' 21:34:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:34:18 INFO - Installing distribute.............................................................................................................................................................................................done. 21:34:21 INFO - Installing pip.................done. 21:34:21 INFO - Return code: 0 21:34:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:34:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:34:22 INFO - Reading from file tmpfile_stdout 21:34:22 INFO - Output received: 21:34:22 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) 21:34:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:22 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 0x1030d63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f997bc63950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eecd30>, '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 0x102d53db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ee4b20>, '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.VbJg7c4oJR/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.d06sOCeEJr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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 21:34:22 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 21:34:22 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 21:34:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VbJg7c4oJR/Render', 21:34:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:34:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:34:22 INFO - 'HOME': '/Users/cltbld', 21:34:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:34:22 INFO - 'LOGNAME': 'cltbld', 21:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:22 INFO - 'MOZ_NO_REMOTE': '1', 21:34:22 INFO - 'NO_EM_RESTART': '1', 21:34:22 INFO - 'PAGER': '/bin/cat', 21:34:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:22 INFO - 'PWD': '/builds/slave/test', 21:34:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:34:22 INFO - 'SHELL': '/bin/bash', 21:34:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d06sOCeEJr/Listeners', 21:34:22 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 21:34:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:34:22 INFO - 'USER': 'cltbld', 21:34:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:34:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:22 INFO - 'XPC_FLAGS': '0x0', 21:34:22 INFO - 'XPC_SERVICE_NAME': '0', 21:34:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:34:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:22 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 21:34:22 INFO - Cleaning up... 21:34:22 INFO - Return code: 0 21:34:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:22 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 0x1030d63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f997bc63950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eecd30>, '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 0x102d53db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ee4b20>, '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.VbJg7c4oJR/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.d06sOCeEJr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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 21:34:22 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 21:34:22 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 21:34:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VbJg7c4oJR/Render', 21:34:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:34:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:34:22 INFO - 'HOME': '/Users/cltbld', 21:34:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:34:22 INFO - 'LOGNAME': 'cltbld', 21:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:22 INFO - 'MOZ_NO_REMOTE': '1', 21:34:22 INFO - 'NO_EM_RESTART': '1', 21:34:22 INFO - 'PAGER': '/bin/cat', 21:34:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:22 INFO - 'PWD': '/builds/slave/test', 21:34:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:34:22 INFO - 'SHELL': '/bin/bash', 21:34:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d06sOCeEJr/Listeners', 21:34:22 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 21:34:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:34:22 INFO - 'USER': 'cltbld', 21:34:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:34:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:22 INFO - 'XPC_FLAGS': '0x0', 21:34:22 INFO - 'XPC_SERVICE_NAME': '0', 21:34:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:34:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:22 INFO - Downloading/unpacking psutil>=3.1.1 21:34:22 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 21:34:22 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 21:34:22 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 21:34:22 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 21:34:22 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 21:34:22 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 21:34:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:34:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:34:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:34:26 INFO - Installing collected packages: psutil 21:34:26 INFO - Running setup.py install for psutil 21:34:26 INFO - building 'psutil._psutil_osx' extension 21:34:26 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 21:34:26 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 21:34:26 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 21:34:27 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 21:34:27 INFO - building 'psutil._psutil_posix' extension 21:34:27 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 21:34:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:34:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:34:27 INFO - ^ 21:34:27 INFO - 1 warning generated. 21:34:27 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 21:34:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:34:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:34:27 INFO - Successfully installed psutil 21:34:27 INFO - Cleaning up... 21:34:27 INFO - Return code: 0 21:34:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:34:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:27 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 0x1030d63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f997bc63950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eecd30>, '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 0x102d53db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ee4b20>, '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.VbJg7c4oJR/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.d06sOCeEJr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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 21:34:27 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 21:34:27 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 21:34:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VbJg7c4oJR/Render', 21:34:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:34:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:34:27 INFO - 'HOME': '/Users/cltbld', 21:34:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:34:27 INFO - 'LOGNAME': 'cltbld', 21:34:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:27 INFO - 'MOZ_NO_REMOTE': '1', 21:34:27 INFO - 'NO_EM_RESTART': '1', 21:34:27 INFO - 'PAGER': '/bin/cat', 21:34:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:34:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:27 INFO - 'PWD': '/builds/slave/test', 21:34:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:34:27 INFO - 'SHELL': '/bin/bash', 21:34:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d06sOCeEJr/Listeners', 21:34:27 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 21:34:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:34:27 INFO - 'USER': 'cltbld', 21:34:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:34:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:34:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:27 INFO - 'XPC_FLAGS': '0x0', 21:34:27 INFO - 'XPC_SERVICE_NAME': '0', 21:34:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:34:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:34:27 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 21:34:27 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 21:34:27 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 21:34:27 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 21:34:27 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 21:34:27 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 21:34:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:34:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:34:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:34:30 INFO - Installing collected packages: mozsystemmonitor 21:34:30 INFO - Running setup.py install for mozsystemmonitor 21:34:30 INFO - Successfully installed mozsystemmonitor 21:34:30 INFO - Cleaning up... 21:34:30 INFO - Return code: 0 21:34:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:34:30 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')]} 21:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:30 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')]} 21:34:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:30 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 0x1030d63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f997bc63950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eecd30>, '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 0x102d53db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ee4b20>, '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.VbJg7c4oJR/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.d06sOCeEJr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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 21:34:30 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 21:34:30 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 21:34:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VbJg7c4oJR/Render', 21:34:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:34:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:34:30 INFO - 'HOME': '/Users/cltbld', 21:34:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:34:30 INFO - 'LOGNAME': 'cltbld', 21:34:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:30 INFO - 'MOZ_NO_REMOTE': '1', 21:34:30 INFO - 'NO_EM_RESTART': '1', 21:34:30 INFO - 'PAGER': '/bin/cat', 21:34:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:34:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:30 INFO - 'PWD': '/builds/slave/test', 21:34:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:34:30 INFO - 'SHELL': '/bin/bash', 21:34:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d06sOCeEJr/Listeners', 21:34:30 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 21:34:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:34:30 INFO - 'USER': 'cltbld', 21:34:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:34:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:34:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:30 INFO - 'XPC_FLAGS': '0x0', 21:34:30 INFO - 'XPC_SERVICE_NAME': '0', 21:34:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:34:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:30 INFO - Downloading/unpacking jsonschema==2.5.1 21:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:34:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:33 INFO - Downloading functools32-3.2.3-2.tar.gz 21:34:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:34:33 INFO - warning: no files found matching '*.txt' 21:34:33 INFO - no previously-included directories found matching 'build' 21:34:33 INFO - no previously-included directories found matching 'dist' 21:34:33 INFO - no previously-included directories found matching '.git*' 21:34:33 INFO - Installing collected packages: jsonschema, functools32 21:34:34 INFO - Running setup.py install for functools32 21:34:34 INFO - warning: no files found matching '*.txt' 21:34:34 INFO - no previously-included directories found matching 'build' 21:34:34 INFO - no previously-included directories found matching 'dist' 21:34:34 INFO - no previously-included directories found matching '.git*' 21:34:34 INFO - Successfully installed jsonschema functools32 21:34:34 INFO - Cleaning up... 21:34:34 INFO - Return code: 0 21:34:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:34 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 0x1030d63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f997bc63950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eecd30>, '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 0x102d53db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ee4b20>, '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.VbJg7c4oJR/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.d06sOCeEJr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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 21:34:34 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 21:34:34 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 21:34:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VbJg7c4oJR/Render', 21:34:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:34:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:34:34 INFO - 'HOME': '/Users/cltbld', 21:34:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:34:34 INFO - 'LOGNAME': 'cltbld', 21:34:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:34 INFO - 'MOZ_NO_REMOTE': '1', 21:34:34 INFO - 'NO_EM_RESTART': '1', 21:34:34 INFO - 'PAGER': '/bin/cat', 21:34:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:34:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:34 INFO - 'PWD': '/builds/slave/test', 21:34:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:34:34 INFO - 'SHELL': '/bin/bash', 21:34:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d06sOCeEJr/Listeners', 21:34:34 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 21:34:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:34:34 INFO - 'USER': 'cltbld', 21:34:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:34:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:34:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:34 INFO - 'XPC_FLAGS': '0x0', 21:34:34 INFO - 'XPC_SERVICE_NAME': '0', 21:34:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:34:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:34:34 INFO - Cleaning up... 21:34:34 INFO - Return code: 0 21:34:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:34 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 0x1030d63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f997bc63950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eecd30>, '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 0x102d53db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ee4b20>, '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.VbJg7c4oJR/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.d06sOCeEJr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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 21:34:34 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 21:34:34 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 21:34:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VbJg7c4oJR/Render', 21:34:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:34:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:34:34 INFO - 'HOME': '/Users/cltbld', 21:34:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:34:34 INFO - 'LOGNAME': 'cltbld', 21:34:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:34 INFO - 'MOZ_NO_REMOTE': '1', 21:34:34 INFO - 'NO_EM_RESTART': '1', 21:34:34 INFO - 'PAGER': '/bin/cat', 21:34:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:34:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:34 INFO - 'PWD': '/builds/slave/test', 21:34:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:34:34 INFO - 'SHELL': '/bin/bash', 21:34:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d06sOCeEJr/Listeners', 21:34:34 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 21:34:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:34:34 INFO - 'USER': 'cltbld', 21:34:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:34:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:34:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:34 INFO - 'XPC_FLAGS': '0x0', 21:34:34 INFO - 'XPC_SERVICE_NAME': '0', 21:34:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:34:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:34 INFO - Downloading/unpacking blobuploader==1.2.4 21:34:34 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 21:34:34 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 21:34:34 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 21:34:34 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 21:34:34 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 21:34:34 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 21:34:37 INFO - Downloading blobuploader-1.2.4.tar.gz 21:34:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:34:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:34:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:34:38 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 21:34:38 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 21:34:38 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 21:34:38 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 21:34:38 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 21:34:38 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 21:34:38 INFO - Downloading docopt-0.6.1.tar.gz 21:34:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:34:38 INFO - Installing collected packages: blobuploader, requests, docopt 21:34:38 INFO - Running setup.py install for blobuploader 21:34:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:34:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:34:38 INFO - Running setup.py install for requests 21:34:39 INFO - Running setup.py install for docopt 21:34:39 INFO - Successfully installed blobuploader requests docopt 21:34:39 INFO - Cleaning up... 21:34:39 INFO - Return code: 0 21:34:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:34:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:40 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 0x1030d63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f997bc63950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eecd30>, '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 0x102d53db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ee4b20>, '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.VbJg7c4oJR/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.d06sOCeEJr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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 21:34:40 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 21:34:40 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 21:34:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VbJg7c4oJR/Render', 21:34:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:34:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:34:40 INFO - 'HOME': '/Users/cltbld', 21:34:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:34:40 INFO - 'LOGNAME': 'cltbld', 21:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:40 INFO - 'MOZ_NO_REMOTE': '1', 21:34:40 INFO - 'NO_EM_RESTART': '1', 21:34:40 INFO - 'PAGER': '/bin/cat', 21:34:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:40 INFO - 'PWD': '/builds/slave/test', 21:34:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:34:40 INFO - 'SHELL': '/bin/bash', 21:34:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d06sOCeEJr/Listeners', 21:34:40 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 21:34:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:34:40 INFO - 'USER': 'cltbld', 21:34:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:34:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:40 INFO - 'XPC_FLAGS': '0x0', 21:34:40 INFO - 'XPC_SERVICE_NAME': '0', 21:34:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:34:40 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-E_w29x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:34:40 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-YyF19O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:34:40 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-RaAe69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:34:40 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-zX6UyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:34:40 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-yT2kjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:34:41 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-LiCufn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:34:41 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-tgAoxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:34:41 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-5ku9JH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:34:41 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-b9G959-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:34:41 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-EEPgNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:34:41 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-JQKpkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:34:41 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-L3IMLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:34:41 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-ZkMOzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:34:41 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-qdRwdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:34:41 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-a0NW_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:34:42 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-ySuCdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:34:42 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-OEuyLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:34:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:34:42 INFO - Running setup.py install for manifestparser 21:34:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:34:42 INFO - Running setup.py install for mozcrash 21:34:42 INFO - Running setup.py install for mozdebug 21:34:42 INFO - Running setup.py install for mozdevice 21:34:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:34:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:34:42 INFO - Running setup.py install for mozfile 21:34:43 INFO - Running setup.py install for mozhttpd 21:34:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:34:43 INFO - Running setup.py install for mozinfo 21:34:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:34:43 INFO - Running setup.py install for mozInstall 21:34:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:34:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:34:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:34:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:34:43 INFO - Running setup.py install for mozleak 21:34:43 INFO - Running setup.py install for mozlog 21:34:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:34:43 INFO - Running setup.py install for moznetwork 21:34:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:34:43 INFO - Running setup.py install for mozprocess 21:34:44 INFO - Running setup.py install for mozprofile 21:34:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:34:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:34:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:34:44 INFO - Running setup.py install for mozrunner 21:34:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:34:44 INFO - Running setup.py install for mozscreenshot 21:34:44 INFO - Running setup.py install for moztest 21:34:44 INFO - Running setup.py install for mozversion 21:34:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:34:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:34:44 INFO - Cleaning up... 21:34:44 INFO - Return code: 0 21:34:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:34:44 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')]} 21:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:44 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')]} 21:34:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:45 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 0x1030d63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f997bc63950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eecd30>, '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 0x102d53db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ee4b20>, '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.VbJg7c4oJR/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.d06sOCeEJr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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 21:34:45 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 21:34:45 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 21:34:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VbJg7c4oJR/Render', 21:34:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:34:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:34:45 INFO - 'HOME': '/Users/cltbld', 21:34:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:34:45 INFO - 'LOGNAME': 'cltbld', 21:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:45 INFO - 'MOZ_NO_REMOTE': '1', 21:34:45 INFO - 'NO_EM_RESTART': '1', 21:34:45 INFO - 'PAGER': '/bin/cat', 21:34:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:34:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:45 INFO - 'PWD': '/builds/slave/test', 21:34:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:34:45 INFO - 'SHELL': '/bin/bash', 21:34:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d06sOCeEJr/Listeners', 21:34:45 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 21:34:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:34:45 INFO - 'USER': 'cltbld', 21:34:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:34:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:45 INFO - 'XPC_FLAGS': '0x0', 21:34:45 INFO - 'XPC_SERVICE_NAME': '0', 21:34:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:34:45 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-955KYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:34:45 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)) 21:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:34:45 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-4nP3yu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:34:45 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)) 21:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:34:45 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-DS8usI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:34:45 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)) 21:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:34:45 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-blZ8n1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:34:45 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)) 21:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:34:45 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-3X9VqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:34:46 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)) 21:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:34:46 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-0dd3WK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:34:46 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)) 21:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:34:46 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-lvI8Ay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:34:46 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)) 21:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:34:46 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-fYYFVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:34:46 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)) 21:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:34:46 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-PcFf54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:34:46 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)) 21:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:34:46 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-R_FrUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:34:46 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)) 21:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:34:46 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-7Id297-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:34:46 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)) 21:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:34:46 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-xqEOXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:34:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 21:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:34:46 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-LlFr8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:34:46 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)) 21:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:34:46 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-wkqv7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:34:47 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)) 21:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:34:47 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-zlwv8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:34:47 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)) 21:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:34:47 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-WZjIKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:34:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 21:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:34:47 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-ENbujJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:34:47 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)) 21:34:47 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)) 21:34:47 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)) 21:34:47 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)) 21:34:47 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)) 21:34:47 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)) 21:34:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:50 INFO - Downloading blessings-1.6.tar.gz 21:34:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:34:50 INFO - Installing collected packages: blessings 21:34:50 INFO - Running setup.py install for blessings 21:34:50 INFO - Successfully installed blessings 21:34:50 INFO - Cleaning up... 21:34:50 INFO - Return code: 0 21:34:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:34:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:34:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:34:51 INFO - Reading from file tmpfile_stdout 21:34:51 INFO - Current package versions: 21:34:51 INFO - blessings == 1.6 21:34:51 INFO - blobuploader == 1.2.4 21:34:51 INFO - docopt == 0.6.1 21:34:51 INFO - functools32 == 3.2.3-2 21:34:51 INFO - jsonschema == 2.5.1 21:34:51 INFO - manifestparser == 1.1 21:34:51 INFO - mozInstall == 1.12 21:34:51 INFO - mozcrash == 1.0 21:34:51 INFO - mozdebug == 0.1 21:34:51 INFO - mozdevice == 0.49 21:34:51 INFO - mozfile == 1.2 21:34:51 INFO - mozhttpd == 0.7 21:34:51 INFO - mozinfo == 0.9 21:34:51 INFO - mozleak == 0.1 21:34:51 INFO - mozlog == 3.4 21:34:51 INFO - moznetwork == 0.27 21:34:51 INFO - mozprocess == 0.23 21:34:51 INFO - mozprofile == 0.28 21:34:51 INFO - mozrunner == 6.13 21:34:51 INFO - mozscreenshot == 0.1 21:34:51 INFO - mozsystemmonitor == 0.3 21:34:51 INFO - moztest == 0.7 21:34:51 INFO - mozversion == 1.4 21:34:51 INFO - psutil == 3.1.1 21:34:51 INFO - requests == 1.2.3 21:34:51 INFO - wsgiref == 0.1.2 21:34:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:51 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 0x1030d63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f997bc63950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eecd30>, '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 0x102d53db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ee4b20>, '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.VbJg7c4oJR/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.d06sOCeEJr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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 21:34:51 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 21:34:51 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 21:34:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VbJg7c4oJR/Render', 21:34:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:34:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:34:51 INFO - 'HOME': '/Users/cltbld', 21:34:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:34:51 INFO - 'LOGNAME': 'cltbld', 21:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:51 INFO - 'MOZ_NO_REMOTE': '1', 21:34:51 INFO - 'NO_EM_RESTART': '1', 21:34:51 INFO - 'PAGER': '/bin/cat', 21:34:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:51 INFO - 'PWD': '/builds/slave/test', 21:34:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:34:51 INFO - 'SHELL': '/bin/bash', 21:34:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d06sOCeEJr/Listeners', 21:34:51 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 21:34:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:34:51 INFO - 'USER': 'cltbld', 21:34:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:34:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:51 INFO - 'XPC_FLAGS': '0x0', 21:34:51 INFO - 'XPC_SERVICE_NAME': '0', 21:34:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:51 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)) 21:34:51 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)) 21:34:51 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)) 21:34:51 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)) 21:34:51 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)) 21:34:51 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)) 21:34:51 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)) 21:34:51 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)) 21:34:51 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)) 21:34:51 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)) 21:34:51 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)) 21:34:51 INFO - Cleaning up... 21:34:51 INFO - Return code: 0 21:34:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1030d63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f997bc63950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eecd30>, '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 0x102d53db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ee4b20>, '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.VbJg7c4oJR/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.d06sOCeEJr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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 21:34:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:34:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:34:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VbJg7c4oJR/Render', 21:34:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:34:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:34:51 INFO - 'HOME': '/Users/cltbld', 21:34:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:34:51 INFO - 'LOGNAME': 'cltbld', 21:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:51 INFO - 'MOZ_NO_REMOTE': '1', 21:34:51 INFO - 'NO_EM_RESTART': '1', 21:34:51 INFO - 'PAGER': '/bin/cat', 21:34:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:51 INFO - 'PWD': '/builds/slave/test', 21:34:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:34:51 INFO - 'SHELL': '/bin/bash', 21:34:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d06sOCeEJr/Listeners', 21:34:51 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 21:34:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:34:51 INFO - 'USER': 'cltbld', 21:34:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:34:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:51 INFO - 'XPC_FLAGS': '0x0', 21:34:51 INFO - 'XPC_SERVICE_NAME': '0', 21:34:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:34:51 INFO - Cleaning up... 21:34:51 INFO - Return code: 0 21:34:51 INFO - Running post-action listener: _resource_record_post_action 21:34:51 INFO - Running post-action listener: _start_resource_monitoring 21:34:51 INFO - Starting resource monitoring. 21:34:51 INFO - [mozharness: 2016-12-01 05:34:51.651673Z] Finished create-virtualenv step (success) 21:34:51 INFO - [mozharness: 2016-12-01 05:34:51.652700Z] Running install step. 21:34:51 INFO - Running pre-action listener: _resource_record_pre_action 21:34:51 INFO - Running main action method: install 21:34:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:34:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:34:51 INFO - Reading from file tmpfile_stdout 21:34:51 INFO - Detecting whether we're running mozinstall >=1.0... 21:34:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:34:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:34:52 INFO - Reading from file tmpfile_stdout 21:34:52 INFO - Output received: 21:34:52 INFO - Usage: mozinstall [options] installer 21:34:52 INFO - Options: 21:34:52 INFO - -h, --help show this help message and exit 21:34:52 INFO - -d DEST, --destination=DEST 21:34:52 INFO - Directory to install application into. [default: 21:34:52 INFO - "/builds/slave/test"] 21:34:52 INFO - --app=APP Application being installed. [default: firefox] 21:34:52 INFO - mkdir: /builds/slave/test/build/application 21:34:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:34:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 21:35:25 INFO - Reading from file tmpfile_stdout 21:35:25 INFO - Output received: 21:35:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:35:25 INFO - Running post-action listener: _resource_record_post_action 21:35:25 INFO - [mozharness: 2016-12-01 05:35:25.004363Z] Finished install step (success) 21:35:25 INFO - [mozharness: 2016-12-01 05:35:25.004527Z] Running run-tests step. 21:35:25 INFO - Running pre-action listener: _resource_record_pre_action 21:35:25 INFO - Running main action method: run_tests 21:35:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:35:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:35:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:35:25 INFO - 2016-11-30 21:35:25.019 screenresolution[1621:7368] starting screenresolution argv=screenresolution get 21:35:25 INFO - 2016-11-30 21:35:25.022 screenresolution[1621:7368] Display 0: 1600x1200x32@60 21:35:25 INFO - 2016-11-30 21:35:25.028 screenresolution[1622:7370] starting screenresolution argv=screenresolution list 21:35:25 INFO - Available Modes on Display 0 21:35:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:35:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:35:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:35:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:35:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:35:25 INFO - Intel Iris: 21:35:25 INFO - Chipset Model: Intel Iris 21:35:25 INFO - Type: GPU 21:35:25 INFO - Bus: Built-In 21:35:25 INFO - VRAM (Dynamic, Max): 1536 MB 21:35:25 INFO - Vendor: Intel (0x8086) 21:35:25 INFO - Device ID: 0x0a2e 21:35:25 INFO - Revision ID: 0x0009 21:35:25 INFO - Displays: 21:35:25 INFO - Display: 21:35:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:35:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:35:25 INFO - Display Serial Number: 1600x1200 60 21:35:25 INFO - Main Display: Yes 21:35:25 INFO - Mirror: Off 21:35:25 INFO - Online: Yes 21:35:25 INFO - Rotation: Supported 21:35:25 INFO - Return code: 0 21:35:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:35:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:35:25 INFO - Python 2.7.3 21:35:25 INFO - Return code: 0 21:35:25 INFO - grabbing minidump binary from tooltool 21:35:25 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')]} 21:35:25 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 0x102eecd30>, '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 0x102d53db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ee4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:35:25 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 21:35:25 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 21:35:25 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 21:35:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:35:25 INFO - Return code: 0 21:35:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:35:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:35:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:35:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:35:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:35:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YAsaPuFnR-CeRwzxRXQuLw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0307', '--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 21:35:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YAsaPuFnR-CeRwzxRXQuLw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0307 --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 21:35:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VbJg7c4oJR/Render', 21:35:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:35:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:35:25 INFO - 'HOME': '/Users/cltbld', 21:35:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:35:25 INFO - 'LOGNAME': 'cltbld', 21:35:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:35:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:35:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:25 INFO - 'MOZ_NO_REMOTE': '1', 21:35:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:35:25 INFO - 'NO_EM_RESTART': '1', 21:35:25 INFO - 'PAGER': '/bin/cat', 21:35:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:35:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:25 INFO - 'PWD': '/builds/slave/test', 21:35:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:35:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:35:25 INFO - 'SHELL': '/bin/bash', 21:35:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d06sOCeEJr/Listeners', 21:35:25 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 21:35:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:35:25 INFO - 'USER': 'cltbld', 21:35:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:35:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:35:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:25 INFO - 'XPC_FLAGS': '0x0', 21:35:25 INFO - 'XPC_SERVICE_NAME': '0', 21:35:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:35:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YAsaPuFnR-CeRwzxRXQuLw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0307', '--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 21:35:25 INFO - mozversion application_buildid: 20161130191844 21:35:25 INFO - mozversion application_changeset: a183d5c5a8f79b09be159329992ef958a55f23ed 21:35:25 INFO - mozversion application_display_name: Nightly 21:35:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:35:25 INFO - mozversion application_name: Firefox 21:35:25 INFO - mozversion application_remotingname: firefox 21:35:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:35:25 INFO - mozversion application_vendor: Mozilla 21:35:25 INFO - mozversion application_version: 53.0a1 21:35:25 INFO - mozversion platform_buildid: 20161130191844 21:35:25 INFO - mozversion platform_changeset: a183d5c5a8f79b09be159329992ef958a55f23ed 21:35:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:35:25 INFO - mozversion platform_version: 53.0a1 21:35:25 INFO - using testdate: 1480570525 21:35:25 INFO - actual date: 1480570525 21:35:25 INFO - starting webserver on 'localhost:49243' 21:35:25 INFO - SUITE-START | Running 2 tests 21:35:25 INFO - TEST-START | dromaeo_css 21:35:25 INFO - operating with platform_type : mac_ 21:35:25 INFO - Initialising browser for dromaeo_css test... 21:35:25 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/tmpBp4fwA/profile http://localhost:49243/getInfo.html) 21:35:28 INFO - PROCESS | 1632 | 2016-11-30 21:35:28.970 plugin-container[1637:7596] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e37, name = 'com.apple.tsm.portname' 21:35:28 INFO - PROCESS | 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:35:28 INFO - PROCESS | 1632 | 2016-11-30 21:35:28.973 plugin-container[1637:7596] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c07, name = 'com.apple.CFPasteboardClient' 21:35:28 INFO - PROCESS | 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:35:28 INFO - PROCESS | 1632 | 2016-11-30 21:35:28.973 plugin-container[1637:7596] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:35:29 INFO - PROCESS | 1632 | __metrics Screen width/height:1600/1200 21:35:29 INFO - PROCESS | 1632 | colorDepth:24 21:35:29 INFO - PROCESS | 1632 | Browser inner width/height: 1024/663 21:35:29 INFO - PROCESS | 1632 | __metrics 21:35:29 ERROR - PROCESS | 1632 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 21:35:29 INFO - TEST-INFO | 1632: exit 0 21:35:29 INFO - Browser initialized. 21:35:29 INFO - Running cycle 1/1 for dromaeo_css test... 21:35:29 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/tmpBp4fwA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:35:32 INFO - PROCESS | 1638 | 2016-11-30 21:35:32.579 plugin-container[1639:7716] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 21:35:32 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:35:32 INFO - PROCESS | 1638 | 2016-11-30 21:35:32.582 plugin-container[1639:7716] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x891b, name = 'com.apple.CFPasteboardClient' 21:35:32 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:35:32 INFO - PROCESS | 1638 | 2016-11-30 21:35:32.582 plugin-container[1639:7716] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:35:42 INFO - PROCESS | 1638 | RSS: Main: 250224640 21:35:42 INFO - PROCESS | 1638 | 21:36:31 INFO - PROCESS | 1638 | 1480570591838 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:38:45 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 21:38:46 INFO - PROCESS | 1638 | RSS: Main: 257056768 21:38:46 INFO - PROCESS | 1638 | 21:41:49 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 21:41:50 INFO - PROCESS | 1638 | RSS: Main: 267710464 21:41:50 INFO - PROCESS | 1638 | 21:44:52 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 21:44:52 INFO - PROCESS | 1638 | RSS: Main: 272257024 21:44:52 INFO - PROCESS | 1638 | 21:47:54 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 21:47:55 INFO - PROCESS | 1638 | RSS: Main: 271036416 21:47:55 INFO - PROCESS | 1638 | 21:50:57 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 21:50:58 INFO - PROCESS | 1638 | RSS: Main: 275525632 21:50:58 INFO - PROCESS | 1638 | 21:54:01 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 21:54:01 INFO - PROCESS | 1638 | RSS: Main: 277639168 21:54:01 INFO - PROCESS | 1638 | 21:54:01 INFO - PROCESS | 1638 | __start_tp_report 21:54:01 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 21:54:01 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 21:54:01 INFO - PROCESS | 1638 | |i|pagename|runs| 21:54:01 INFO - PROCESS | 1638 | |0;dojo.html;3316.2704205074906;3357.4963755436684;3366.46136618141;3374.240795820942;3376.1053320869964;4680.531946805327;4873.7075775453495;5094.617903657222;5581.358143813462;5608.298962629671;4921.286413470045;5563.833085007446;5608.214849921004;5633.774649014034;5703.458171473703;5043.495650434964;5086.618503612225;5143.871403214912;5196.844094677147;5247.711375874325;5087.058894104603;5258.106121959276;5277.8944421111555;5297.020051290504;5297.735113244342;5059.747012649353;5094.847154585332;5193.324867767204;5223.529882310591;5234.26720259164;5092.770825312869;5129.333186685707;5174.146265866128;5229.712365819878;5254.369475662907;5048.116579598555;5065.645404821664;5076.695398276115;5097.2608971699265;5103.2855400244;4765.475797662254;5575.2473416088715;5597.552195824324;5645.520130788888;5673.971630141823;6101.938980610182;6118.619179173164;6127.3727867283405;6133.395871484098;6216.782412615582;6231.626102433868;6234.251889773256;6236.189295391616;6244.438000579969;6253.405926436982;4833.879153021203;5797;5811.418858114239;5840.853978650568;5888.97055514724;6136.517817949635;6159.23009623797;6171.506279497629;6183.907241391383;6219.160413344141;6115.458908337835;6139.982816839433;6148.9854174061675;6153.353897840662;6155.47678447337;6094.238220222473;6231;6240.937590624127;6245.219347581552;6246.125542424064;6114.327423983358;6116.960116780158;6137.263528376623;6158.291796443376;6165;5114.28400023997;6182.474489668429;6190.380961903864;6206.844828879314;6211.565190436626;4833.540813622701;4877.244027175793;4911.287863259808;4925.75371231437;4958.6776859504735;4308.332208507686;4337.240982827992;4348.978255108705;4360.106178233455;4392.824287028547;5463.699496527729;5696.743646535916;5776.566757493205;5788.855278618068;5822.359540450547;6229.937700623026;6251.4061164189325;6251.59364641306;6257.092721555349;6270.811875643738;5547.611667183259;5613.354464236583;5626.268585083994;5626.465485778845;5758.481736643722;5350.732463376893;5357.946420535823;5368.651037682538;5368.7047212403695;5372.355317361941;6171.228596425447;6184.907226391698;6211.782587609412;6229.283632382334;6264.906026409608;6199.411055949678;6223.3465486123305;6251.218597675291;6259.2488901332135;6291.874162516816;6264.31092579825;6286.37136286386;6311.779087731908;6313.40022697843;6319.368063193644;4978.303037574815;5258.764190415326;5891.027980383189;6029.668368239613;6210.5031597473;5141.203113517411;6141.271221159771;6147.877042459037;6211.81364559064;6226.097215903578;5070.670406423571;5996.520278377632;6043.12374705674;6048.153258543895;6084.166296553339;4959.528844759742;5874.911876321944;6090.421409966046;6092.725827337692;6108.633481991094;4851.636127290397;5782.277215348082;5858.882822343615;5866.325372582037;5867.9413205869105;5466.781328746964;5698.689301460604;6074.453299203093;6081.270247570143;6140.447359737466;5763.567732420001;5878.500327472042;5893.70531473416;5906.0255057914965;5923.348431672426 21:54:01 INFO - PROCESS | 1638 | |1;ext.html;454.34574213133067;478.6099329046825;489.808974499945;527.9788808447662;531.8643745844809;37682.434763478566;39140;39218.82343529699;41287.38068928961;41353.37969930446;40371;40818.7959060205;40820.79589602055;41047.79476102623;41093.58906410935;7261.419086473096;9278.860817087749;9307.11582399671;9500.762480937963;9543.952280238589;8455.19675630817;11164.609238676649;11388.487518061707;11407.54369825206;11567.710807229845;11293.4917928693;11336.546538138464;11362.886371136306;11373.431328433586;11392.373419461926;11262.662120136409;11291.378974156418;11321.981021708045;11342.63888333397;11349.148813838912;11241.83137252942;11268.267562608486;11308.208425410225;11318.434078296052;11343.092552595772;38445.23109537794;38641.613583864084;38698;38838.029049273995;38935.221295574214;3184.601924759405;3290.2925870937866;3346.849391777376;3718.8326525306425;4061.2486689962157;29176.41647167066;29588.112356629335;29962.55056174159;30806.69193308083;30811.38377232465;3168.651448340681;3194.073718621597;3196.0571631368803;3282.720968717662;3353.6814002669707;396440;397182;397598.0120099381;399244.00377998216;401011;55952.720236398556;56573;56903;56909.43090569124;57056;60702.39297607056;61151;61305.38694613086;61636.07545886815;61680.69159654173;15626.687466250838;15849.841501585068;15875.841241587666;15879.047257164377;15885.523434296989;10980.835287470694;11133.498992545356;11890.702732431759;12049.457774400173;12115.454804533818;13722.725545489035;17266.050367229673;17409.65180696379;17447.73828392575;17536.82463175352;7574.886376704354;7670.7698769037015;7676.616169191518;7715.729949451742;7721.92278077212;871.812560299526;887.9600417981206;967;1005.4369553050316;1123.730304726876;24527.018919243386;26998.460030799273;28372.290692732848;29536.852315738284;30017.249568760955;868.913108689126;912.9452232865916;1030.1655658916302;1031.0565832263544;1053.3574519543072;12333.50665973351;14278.429372768987;14764.114153150631;15315;15568.143752093743;364638;427661.8616906958;429448;431841.1342979147;432984;44426.55573444289;54508.45491545113;55192.724036379564;55407;55656.721716391155;1137.4142316706902;1332.3871019331023;1344.9058565900293;1360.0683531780564;1362.3733082782032;25639.974401023752;26747.598786018614;28180.71819281781;29528;29556.852215738785;48416.75791621019;48539.27191092207;48669.99999999858;48874.511254886995;49047;475908;478032;480740;481230.5938470285;482502;20895.477613059797;25161.370965726004;25455.87272063628;25707.10025149111;25738.613920791577;44223.33664994963;44625;45172.548274516834;45415;45919.540804591525;31904.36191276208;32016.199595010312;35594.46608300929;37043;38251;32417.837910810296;33205.66794332026;37205.813970931056;38058;38605.806970964964;36101;36564.81717591395;37061.44407833831;37465.5013799445;38357;26523.867380662974;29421.26446838846;29551.113466596038;29919;30090;22402;22771.430714232276;23099.88450057739;23108.537829243658;23142.537149257256 21:54:01 INFO - PROCESS | 1638 | |2;jquery.html;367.2984599415118;372.4543543708467;376.67982215117155;381.05688421157623;394.9730700179534;18615.162317695704;19607;19940.60118797625;20245.88647624382;20455.284065057727;19125.426237212872;19320.22719091235;19907.900460497676;19929.900350498265;20219;4537.773111344436;5511.53151982082;5781.942180578203;5784.652920824743;5797.942020579782;4078.5717499662555;4318.179545886287;4782.995570930108;5672.943270567303;6234.812955611339;5460.6177567570285;6360;6381.266154392258;6387.808365749035;6402.935970640304;5314.4951229633125;6107.5113990880845;6259.217597800275;6338.207724034496;6347.492200623962;5397.541208997201;5483.903219356105;5541.639793413416;5548.86127846803;5557.944420555824;24412.26763197107;24646.753532464627;24691.50616987668;24914.377140571632;25008.49983000348;2292.3695983604475;2545.745425457458;2702.8918843246247;3007.7443417309555;3032.166154307561;14612.634684132981;14621.488247911271;15121.621959450991;15812.288447019797;16005.039697618064;1569.8618501586259;1636.2636813434003;1678.1441464853012;1749.9387521436688;1781.4922747017038;75526;107881.46059269653;108921.99999999921;109906.90093099046;110838;9040.649431147818;11066.612668556723;11338.319700817978;11391.316521008766;11559.422028898689;14226.644333891529;14245.85754142466;14262;14273.78589321161;14285.57143285703;6505.284418714033;8200.38497112707;8200.42597018215;8316.209960053786;8353.039400468902;7965.322947549407;7993.840123197503;8024.157463466252;8144.389170812213;8178.754637360769;3827.770333779982;4287.413656946949;4331.740095594275;4448.421705178306;4492.618127459137;1548.9380424783108;1648.3571407151221;1652.2812576529248;1877.981220187808;1926.5376309685576;818.7748369198399;934.509382574154;947.8436058050345;954.3939598355095;980.460746589373;19790;20658.58682826335;20798.584028319652;20846.06192721331;20928.686069708965;873.1661263493348;912.1790388650135;913.4108500017452;934.8550974598948;951.8239125761756;10507.684769456928;10940.835887461695;10942.945285273681;10953.890461095287;10973.670789876316;476467;503534;514360;544258;547620.2618986879;107582.46208768905;112975;115506.87177846373;116631;118994.40502797431;922.686286662538;954.1317401164906;986.4032260482448;991.177322822056;991.8413053911339;18735.250589976793;19145.712814307517;19190.520236994187;19198.328058517884;19249.941253231205;50786.49213507966;51508;52241.7387913058;53499.930001400535;54846.72576637091;75179.62410187913;76015;76246.61876690581;76555;76886;5936.851578710567;6500.934990650222;6543.312952139957;7227.566346019255;8059.6776128956535;9294.442333460014;12054;12378.319192444502;12934.741305173655;13189.736205275649;10828.025477707044;11116.61091861781;11216.158788090763;11373.658790236306;11470.311781293149;8653.783655408413;10187.08316251541;10202.33684810485;10597.993190646876;11179.441027948733;11134.944325278646;11202.495887685236;11326.773464530828;11482.94258528702;11520.654380368602;7569.3566046886635;7974;8037.437379383387;8411.158884111539;8431.704890328809;9537.618495260389;11019.669409917715;11069.83395249088;11287.435628218393;11313.830292545783 21:54:01 INFO - PROCESS | 1638 | |3;mootools.html;1459.1536908593016;1486.2197346393143;1653.9338426462941;1742.2247100040488;1809.1677828199036;7468.813279668011;7769.844603107935;7923.643436045385;8219.342452603792;8221.83556328873;7946.64240109195;8266.62800173992;8298.502089874612;8334.583270836449;8337.83324333513;2271.0461606125427;2309.4919117794057;2311.8612883226974;2313.947154044914;2324.2097686786487;1890.6124244529908;1964.9705254421194;2057.753069631646;2316.6177580699164;2344.179537161997;1929.53691114133;2283.6232021716396;2297.1959814065112;2311.4221444638843;2315.1086831569883;1913.770347558295;2266.4447210433386;2290.816734661223;2297.7242730872235;2301.1600765720477;1846.9445916622524;1865.981340186608;2236.731592208929;2242.6299660555987;2244.9887750561306;8258.132896045889;8312.584370781437;8394.79013024673;8400.789980250482;8409.20112589303;4985.277134815467;5045.873853153664;5212;5224.346956630421;5224.843254702365;3276.3774882772195;3316.9717387609676;3413.9758072578375;3505.9123521912156;3508.2632647143873;1034.7930413917247;1054.2988912373262;1070.464767616192;1090.1769164280918;1094.4254266510065;10807.83788243177;10872.565097396095;10874.72813179669;11015.559377624966;11041.944790275997;4114.691398145151;4359.280718681445;4610.792514336863;4699.17764391237;4712.882177945578;8295.336373090138;8986.55067246635;9421.858672119924;9433.764155896157;9473.336866419284;5108.540231379194;5151.896962060813;5173.042987047408;5176.4047134580005;5200.6619569727845;4231.513375961742;4390.209762242763;4596.724196548218;4747.810087596457;4749.073930583572;3113.4551453495546;3728.5339332583426;3768.698504119664;3800.7149463790324;3845.8461661533224;1238.5355491690616;1243.0863315463127;1248.9625311240677;1255.610760664197;1266.8859802617808;761.7257787196605;855.2858363266741;890.1027156605209;895.6283142495921;905.2034209895381;4583.839565615254;5348.679079255257;5736.827895163152;5761.88476230473;5781.4507621775865;889.9231929365541;892.4110087342452;899.9560509808722;919.9172074513326;950.1496160935924;3192;3420.538227339327;3612.566492020922;3636.890893273206;3682.926341473209;7796.5711885845685;9891.703248902544;10050.195984321237;10168.135708464715;10267;8282.213189746964;10075.445850478147;10079.5464204111;10093.142082923034;10097.394156350643;7516.6993320267675;7834.843303134019;7895.131535531087;7920.920790792134;7924.603769811486;4301.268784306612;5498.175273708815;5549.694766787866;5585.581081418829;5693.117566777156;9278.489683067226;9325.440473571607;9361.344705870524;9467.005964373642;9478.38390504615;9421.29340299494;9508.191803696764;9519.381240219363;9553.283503737108;9686.85469717969;5709.628874123168;5856.94143058581;6589;6642.43539299165;6773.796786096425;7932.16712245206;8022.318102961313;8025.197480251928;8026.157253488534;8051.8792218115605;7005.299470052954;7089.539179953286;7132.322429369202;7191.640417978975;7220.4945653805835;6786.898196526958;6817.488688348294;6825.761098361533;6869.793906182823;6881.793546193622;6458.063580780855;6610.768623098168;6706.262311145868;6716.992451132369;6775.1531058617675;4768.02255537607;4793.113274044313;4807.759612019315;4834.806607735792;4865.58642515376;3856.3444214484166;3955.4857868476915;4750.8337208197545;4814.542618451242;5094.133997220407 21:54:01 INFO - PROCESS | 1638 | |4;prototype.html;262.7385751177579;283.981541199822;307.9384123175366;311.6400557356253;314.50465516811016;5259.9474005259935;5358.758855851486;5386.946130538693;5405.59458040647;5449.7820087196515;5294.947050529494;5297.735113244342;5374.865628359284;5398.811041613544;5411.431799661038;3217.75866809989;3891.4746509221245;3949.8815035548837;4097.803713103784;4129.752214867102;3744.457053727208;4049.4533238012787;4061.73598716084;4112.067328355668;4116.526599441073;3577.1398872586237;3911.393733971239;3923.6664883484937;4089.488813898263;4127.153933443652;3308.4541050726602;3636.000099972529;3968.940465893014;4102.651274641644;4156.397322388252;3113.5869700981693;3125;3277.2626159114006;3558.448440491728;3569.857645553424;5200.713960732158;5253.711045892474;5287.154055351125;5290.418054014055;5311.468853114697;4214.377464676122;4503.707259028152;4612.3542704021465;4697.318888761145;4763.04739052191;4969.8012079516775;5101.974490127525;5209.2446595243855;5640.520555752766;5664.6601203927485;3688.1517251032415;3828.636279553438;3841.387856257744;3883.2233553289175;3885.572587015426;5487.79268560916;5671.177679236487;5750.712464376807;5978.850528736816;6034.280230134391;3499.61504234534;3755.3803622401997;3829.1767270036516;3833.3674943633987;3903.7703123516003;3318.93793985927;3954.723169378116;3961.7622942623534;3962.484876965976;3963.246983073207;3705.2959937611768;4625.7687115644085;4630.61081675496;4630.758469071663;4648.814047438064;4813.95406952044;5379.73101344939;5734.942650573525;5802.361740208574;5816.360200377955;1059.5285098131258;1118.82658187981;1127.4306475229957;1129.6215767717742;1290.3806173036808;777.5218240781878;814.8859159717645;882.1795729971188;887.1572006593633;887.924526415249;4417.558244175621;4919.704817710877;5316.867078323073;5365.54392876602;5479.287752562427;4861.368022157168;5879.706014699248;5905.852353691193;5919.792807251725;5954.702264886739;4404.4714634243455;4631.791569379386;5140.331756871583;5437.700926449083;5524.530414914777;2411.9879400602886;2460.6186041163646;2498.9500209996063;2918.533034714478;2924.6490421149174;4605.447346318463;5254.456548341536;5336.546393556514;5828.164128299572;5828.912566311508;5360.105543006811;5614.719264036864;5742.224799652077;5752.36723960364;5829.562782791223;4698.459677137104;5005.34930459038;5232.712200828991;5792.247007888947;5841.970790146107;5160.767765450489;5206.687598744087;5321.308229930084;5650.745716442852;5670.744816483186;5378.381486129145;5396.0556902542685;5628.831135065954;5801.94198058014;5870.853228669317;5256.89486210266;5726.570507212059;5816.82549523515;6070.514358851193;6107.6640784757265;3258.5296659058026;3924.803759812055;3927.2341893330527;3944.3097457944173;3957.3074711925874;5499.285092937893;5647.764176867349;5849.519535876317;5905.763769449174;5909.818036392825;5667.773289068556;5668.659880407189;5671.319441667027;5694.886102278014;5708.57185711065;4869.342638743724;5447.455254474521;5636.520895723909;5703.8859222816145;5716.342620598518;4975.0796102721115;5330.866728331823;5558.249636299048;5605.747741351567;5622.718864056863;5479.287692599936;5519.668819870821;5636.577256705681;5736.827895163152;5791.247137872049;4959;5291.867703307448;5623.212750215055;5683.943160568507;5699.432656019628 21:54:01 INFO - PROCESS | 1638 | |5;yui.html;669.6417416682075;698.8986596943447;758.1281526244821;762.7711686494054;793.1434051224676;14459.132452052883;15232.390704371812;15252.313645885934;15326.080435173897;15345.30946107425;12227.633171004883;12291.20107193034;12294.815577766341;12332.4450399732;12333.691657708561;639.5682914033009;656.4190691238241;800.5796956597803;814.100419036963;823.8352329534088;816.0941355095839;820.0610301205116;826.3719573124408;826.4008593769499;829.7966998085477;873.1574031060026;874.7375787263827;876.0494863073573;877.5436772878099;879.0681877210178;863.6200071968314;865.8484765166103;866.6879923227665;869.395769939892;872.8472517309445;633.9207599050119;641.6118248459708;647.6567419267795;647.6955830759536;648.2739331948201;13318.600441986757;14003.64990875226;14247.78628320576;14262;14275.714485710228;13400.865991340059;13886.375113119933;14045.087069340563;14269.286535673278;14334.51524264042;11589.30464172144;11625.825612615732;11662.183647144704;11695.122865785015;11697.649070527897;2999.7207706729364;3352.5474061001696;3679.6136405677553;3758.229562939591;3800.5059342285604;93234.13531729396;93802.53098734531;95136;95336.52331738296;95384;9204.815903681889;10794.946025269823;10814.405207713495;10863.967923047298;11040.282381645167;17338.739918901225;21172.15311387558;21374.893125534272;21388.14447422086;21397;7118.822029449305;7684.346830519356;7693.230676932262;7726.652300646484;7871.212878712197;4269.1034882674985;4276.657867370665;4327.199468098412;4363.978180109079;4457.710248833815;3284.753643476749;3381.7970921744773;3390.2541440882965;3391.2878295558207;3393.2874096440023;570.1049352516509;602.8010756450361;619.5941658213877;636.8344230500011;646.6766616691655;527.8310940499003;546.8906218756265;556.9443055694398;596.1862058290488;605.2253116011512;7352.926470735331;8138.186181381814;8684.43551169172;8708.651653933899;8877.911220887838;574.6035235687363;576.9278840144982;588.6997631208029;604.2175382879182;604.6009633641863;3610.5306310180035;4145.97927010363;4309.719868208556;4313.676474264443;4322.956770432255;104162.8751137467;105764;105796;107003.46498267459;110358.02432127217;91082.54458727664;94179.52910235542;94765.52617237008;96232.51883740677;97064;55986.72006640022;84757;85894.99999999875;85968.57015714882;86125.56937215274;7731.963883066879;8217.30152937007;8260.628271727666;8304.833903321778;8484.278836298983;55443.72278138583;56149.15776263278;56256.5935851607;56433.71783141058;57001.71499142478;74326.62836685783;76531.61734191293;76537.23462765302;77415;80033.59983200047;10484.737881553023;10615;10690.62582809598;10752.301100428447;10828.187885908746;10441.843372349269;11580.305181689126;11729.589464368706;11761.353125577833;11976.46105925253;10030.749231268985;10158.74603134898;10259.384436933808;10265.332753371007;10588.258821882395;11037.503312350804;11198.552057917592;11414.714632134263;11559.595414160463;11567.652970410565;10908.290961087503;11103;11151.052160566443;11346.375949322866;11509.424528773696;9064.864027039732;9211.355205135576;9327.626894924128;9350.158485736316;9371.578278977599;9245.72262832116;9540.856887146838;9555.522223888916;9561.952190239004;9647.469389183661 21:54:01 INFO - PROCESS | 1638 | __end_tp_report 21:54:01 INFO - PROCESS | 1638 | __start_cc_report 21:54:01 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,363 21:54:01 INFO - PROCESS | 1638 | __end_cc_report 21:54:01 INFO - PROCESS | 1638 | __startTimestamp1480571641672__endTimestamp 21:54:01 INFO - PROCESS | 1638 | 21:54:01 INFO - PROCESS | 1638 | ------- Summary: start ------- 21:54:01 INFO - PROCESS | 1638 | Number of tests: 6 21:54:01 INFO - PROCESS | 1638 | 21:54:01 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5625.06 Median:5811.42 stddev:660.46 (11.4%) stddev-sans-first:637.16 21:54:01 INFO - PROCESS | 1638 | Values: 3316.3 3357.5 3366.5 3374.2 3376.1 4680.5 4873.7 5094.6 5581.4 5608.3 4921.3 5563.8 5608.2 5633.8 5703.5 5043.5 5086.6 5143.9 5196.8 5247.7 5087.1 5258.1 5277.9 5297.0 5297.7 5059.7 5094.8 5193.3 5223.5 5234.3 5092.8 5129.3 5174.1 5229.7 5254.4 5048.1 5065.6 5076.7 5097.3 5103.3 4765.5 5575.2 5597.6 5645.5 5674.0 6101.9 6118.6 6127.4 6133.4 6216.8 6231.6 6234.3 6236.2 6244.4 6253.4 4833.9 5797.0 5811.4 5840.9 5889.0 6136.5 6159.2 6171.5 6183.9 6219.2 6115.5 6140.0 6149.0 6153.4 6155.5 6094.2 6231.0 6240.9 6245.2 6246.1 6114.3 6117.0 6137.3 6158.3 6165.0 5114.3 6182.5 6190.4 6206.8 6211.6 4833.5 4877.2 4911.3 4925.8 4958.7 4308.3 4337.2 4349.0 4360.1 4392.8 5463.7 5696.7 5776.6 5788.9 5822.4 6229.9 6251.4 6251.6 6257.1 6270.8 5547.6 5613.4 5626.3 5626.5 5758.5 5350.7 5357.9 5368.7 5368.7 5372.4 6171.2 6184.9 6211.8 6229.3 6264.9 6199.4 6223.3 6251.2 6259.2 6291.9 6264.3 6286.4 6311.8 6313.4 6319.4 4978.3 5258.8 5891.0 6029.7 6210.5 5141.2 6141.3 6147.9 6211.8 6226.1 5070.7 5996.5 6043.1 6048.2 6084.2 4959.5 5874.9 6090.4 6092.7 6108.6 4851.6 5782.3 5858.9 5866.3 5867.9 5466.8 5698.7 6074.5 6081.3 6140.4 5763.6 5878.5 5893.7 5906.0 5923.3 21:54:01 INFO - PROCESS | 1638 | 21:54:01 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:57786.93 Median:19474.07 stddev:114850.72 (589.8%) stddev-sans-first:115092.24 21:54:01 INFO - PROCESS | 1638 | Values: 454.3 478.6 489.8 528.0 531.9 37682.4 39140.0 39218.8 41287.4 41353.4 40371.0 40818.8 40820.8 41047.8 41093.6 7261.4 9278.9 9307.1 9500.8 9544.0 8455.2 11164.6 11388.5 11407.5 11567.7 11293.5 11336.5 11362.9 11373.4 11392.4 11262.7 11291.4 11322.0 11342.6 11349.1 11241.8 11268.3 11308.2 11318.4 11343.1 38445.2 38641.6 38698.0 38838.0 38935.2 3184.6 3290.3 3346.8 3718.8 4061.2 29176.4 29588.1 29962.6 30806.7 30811.4 3168.7 3194.1 3196.1 3282.7 3353.7 396440.0 397182.0 397598.0 399244.0 401011.0 55952.7 56573.0 56903.0 56909.4 57056.0 60702.4 61151.0 61305.4 61636.1 61680.7 15626.7 15849.8 15875.8 15879.0 15885.5 10980.8 11133.5 11890.7 12049.5 12115.5 13722.7 17266.1 17409.7 17447.7 17536.8 7574.9 7670.8 7676.6 7715.7 7721.9 871.8 888.0 967.0 1005.4 1123.7 24527.0 26998.5 28372.3 29536.9 30017.2 868.9 912.9 1030.2 1031.1 1053.4 12333.5 14278.4 14764.1 15315.0 15568.1 364638.0 427661.9 429448.0 431841.1 432984.0 44426.6 54508.5 55192.7 55407.0 55656.7 1137.4 1332.4 1344.9 1360.1 1362.4 25640.0 26747.6 28180.7 29528.0 29556.9 48416.8 48539.3 48670.0 48874.5 49047.0 475908.0 478032.0 480740.0 481230.6 482502.0 20895.5 25161.4 25455.9 25707.1 25738.6 44223.3 44625.0 45172.5 45415.0 45919.5 31904.4 32016.2 35594.5 37043.0 38251.0 32417.8 33205.7 37205.8 38058.0 38605.8 36101.0 36564.8 37061.4 37465.5 38357.0 26523.9 29421.3 29551.1 29919.0 30090.0 22402.0 22771.4 23099.9 23108.5 23142.5 21:54:01 INFO - PROCESS | 1638 | 21:54:01 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:31844.82 Median:369.88 stddev:86526.00 (23393.2%) stddev-sans-first:86736.45 21:54:01 INFO - PROCESS | 1638 | Values: 367.3 372.5 376.7 381.1 395.0 18615.2 19607.0 19940.6 20245.9 20455.3 19125.4 19320.2 19907.9 19929.9 20219.0 4537.8 5511.5 5781.9 5784.7 5797.9 4078.6 4318.2 4783.0 5672.9 6234.8 5460.6 6360.0 6381.3 6387.8 6402.9 5314.5 6107.5 6259.2 6338.2 6347.5 5397.5 5483.9 5541.6 5548.9 5557.9 24412.3 24646.8 24691.5 24914.4 25008.5 2292.4 2545.7 2702.9 3007.7 3032.2 14612.6 14621.5 15121.6 15812.3 16005.0 1569.9 1636.3 1678.1 1749.9 1781.5 75526.0 107881.5 108922.0 109906.9 110838.0 9040.6 11066.6 11338.3 11391.3 11559.4 14226.6 14245.9 14262.0 14273.8 14285.6 6505.3 8200.4 8200.4 8316.2 8353.0 7965.3 7993.8 8024.2 8144.4 8178.8 3827.8 4287.4 4331.7 4448.4 4492.6 1548.9 1648.4 1652.3 1878.0 1926.5 818.8 934.5 947.8 954.4 980.5 19790.0 20658.6 20798.6 20846.1 20928.7 873.2 912.2 913.4 934.9 951.8 10507.7 10940.8 10942.9 10953.9 10973.7 476467.0 503534.0 514360.0 544258.0 547620.3 107582.5 112975.0 115506.9 116631.0 118994.4 922.7 954.1 986.4 991.2 991.8 18735.3 19145.7 19190.5 19198.3 19249.9 50786.5 51508.0 52241.7 53499.9 54846.7 75179.6 76015.0 76246.6 76555.0 76886.0 5936.9 6500.9 6543.3 7227.6 8059.7 9294.4 12054.0 12378.3 12934.7 13189.7 10828.0 11116.6 11216.2 11373.7 11470.3 8653.8 10187.1 10202.3 10598.0 11179.4 11134.9 11202.5 11326.8 11482.9 11520.7 7569.4 7974.0 8037.4 8411.2 8431.7 9537.6 11019.7 11069.8 11287.4 11313.8 21:54:01 INFO - PROCESS | 1638 | 21:54:01 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5340.41 Median:5101.34 stddev:2971.43 (58.2%) stddev-sans-first:2965.45 21:54:01 INFO - PROCESS | 1638 | Values: 1459.2 1486.2 1653.9 1742.2 1809.2 7468.8 7769.8 7923.6 8219.3 8221.8 7946.6 8266.6 8298.5 8334.6 8337.8 2271.0 2309.5 2311.9 2313.9 2324.2 1890.6 1965.0 2057.8 2316.6 2344.2 1929.5 2283.6 2297.2 2311.4 2315.1 1913.8 2266.4 2290.8 2297.7 2301.2 1846.9 1866.0 2236.7 2242.6 2245.0 8258.1 8312.6 8394.8 8400.8 8409.2 4985.3 5045.9 5212.0 5224.3 5224.8 3276.4 3317.0 3414.0 3505.9 3508.3 1034.8 1054.3 1070.5 1090.2 1094.4 10807.8 10872.6 10874.7 11015.6 11041.9 4114.7 4359.3 4610.8 4699.2 4712.9 8295.3 8986.6 9421.9 9433.8 9473.3 5108.5 5151.9 5173.0 5176.4 5200.7 4231.5 4390.2 4596.7 4747.8 4749.1 3113.5 3728.5 3768.7 3800.7 3845.8 1238.5 1243.1 1249.0 1255.6 1266.9 761.7 855.3 890.1 895.6 905.2 4583.8 5348.7 5736.8 5761.9 5781.5 889.9 892.4 900.0 919.9 950.1 3192.0 3420.5 3612.6 3636.9 3682.9 7796.6 9891.7 10050.2 10168.1 10267.0 8282.2 10075.4 10079.5 10093.1 10097.4 7516.7 7834.8 7895.1 7920.9 7924.6 4301.3 5498.2 5549.7 5585.6 5693.1 9278.5 9325.4 9361.3 9467.0 9478.4 9421.3 9508.2 9519.4 9553.3 9686.9 5709.6 5856.9 6589.0 6642.4 6773.8 7932.2 8022.3 8025.2 8026.2 8051.9 7005.3 7089.5 7132.3 7191.6 7220.5 6786.9 6817.5 6825.8 6869.8 6881.8 6458.1 6610.8 6706.3 6717.0 6775.2 4768.0 4793.1 4807.8 4834.8 4865.6 3856.3 3955.5 4750.8 4814.5 5094.1 21:54:01 INFO - PROCESS | 1638 | 21:54:01 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4531.88 Median:5254.08 stddev:1435.57 (27.3%) stddev-sans-first:1403.38 21:54:01 INFO - PROCESS | 1638 | Values: 262.7 284.0 307.9 311.6 314.5 5259.9 5358.8 5386.9 5405.6 5449.8 5294.9 5297.7 5374.9 5398.8 5411.4 3217.8 3891.5 3949.9 4097.8 4129.8 3744.5 4049.5 4061.7 4112.1 4116.5 3577.1 3911.4 3923.7 4089.5 4127.2 3308.5 3636.0 3968.9 4102.7 4156.4 3113.6 3125.0 3277.3 3558.4 3569.9 5200.7 5253.7 5287.2 5290.4 5311.5 4214.4 4503.7 4612.4 4697.3 4763.0 4969.8 5102.0 5209.2 5640.5 5664.7 3688.2 3828.6 3841.4 3883.2 3885.6 5487.8 5671.2 5750.7 5978.9 6034.3 3499.6 3755.4 3829.2 3833.4 3903.8 3318.9 3954.7 3961.8 3962.5 3963.2 3705.3 4625.8 4630.6 4630.8 4648.8 4814.0 5379.7 5734.9 5802.4 5816.4 1059.5 1118.8 1127.4 1129.6 1290.4 777.5 814.9 882.2 887.2 887.9 4417.6 4919.7 5316.9 5365.5 5479.3 4861.4 5879.7 5905.9 5919.8 5954.7 4404.5 4631.8 5140.3 5437.7 5524.5 2412.0 2460.6 2499.0 2918.5 2924.6 4605.4 5254.5 5336.5 5828.2 5828.9 5360.1 5614.7 5742.2 5752.4 5829.6 4698.5 5005.3 5232.7 5792.2 5842.0 5160.8 5206.7 5321.3 5650.7 5670.7 5378.4 5396.1 5628.8 5801.9 5870.9 5256.9 5726.6 5816.8 6070.5 6107.7 3258.5 3924.8 3927.2 3944.3 3957.3 5499.3 5647.8 5849.5 5905.8 5909.8 5667.8 5668.7 5671.3 5694.9 5708.6 4869.3 5447.5 5636.5 5703.9 5716.3 4975.1 5330.9 5558.2 5605.7 5622.7 5479.3 5519.7 5636.6 5736.8 5791.2 4959.0 5291.9 5623.2 5683.9 5699.4 21:54:01 INFO - PROCESS | 1638 | 21:54:01 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:20187.86 Median:56345.16 stddev:30218.83 (53.6%) stddev-sans-first:30268.07 21:54:01 INFO - PROCESS | 1638 | Values: 669.6 698.9 758.1 762.8 793.1 14459.1 15232.4 15252.3 15326.1 15345.3 12227.6 12291.2 12294.8 12332.4 12333.7 639.6 656.4 800.6 814.1 823.8 816.1 820.1 826.4 826.4 829.8 873.2 874.7 876.0 877.5 879.1 863.6 865.8 866.7 869.4 872.8 633.9 641.6 647.7 647.7 648.3 13318.6 14003.6 14247.8 14262.0 14275.7 13400.9 13886.4 14045.1 14269.3 14334.5 11589.3 11625.8 11662.2 11695.1 11697.6 2999.7 3352.5 3679.6 3758.2 3800.5 93234.1 93802.5 95136.0 95336.5 95384.0 9204.8 10794.9 10814.4 10864.0 11040.3 17338.7 21172.2 21374.9 21388.1 21397.0 7118.8 7684.3 7693.2 7726.7 7871.2 4269.1 4276.7 4327.2 4364.0 4457.7 3284.8 3381.8 3390.3 3391.3 3393.3 570.1 602.8 619.6 636.8 646.7 527.8 546.9 556.9 596.2 605.2 7352.9 8138.2 8684.4 8708.7 8877.9 574.6 576.9 588.7 604.2 604.6 3610.5 4146.0 4309.7 4313.7 4323.0 104162.9 105764.0 105796.0 107003.5 110358.0 91082.5 94179.5 94765.5 96232.5 97064.0 55986.7 84757.0 85895.0 85968.6 86125.6 7732.0 8217.3 8260.6 8304.8 8484.3 55443.7 56149.2 56256.6 56433.7 57001.7 74326.6 76531.6 76537.2 77415.0 80033.6 10484.7 10615.0 10690.6 10752.3 10828.2 10441.8 11580.3 11729.6 11761.4 11976.5 10030.7 10158.7 10259.4 10265.3 10588.3 11037.5 11198.6 11414.7 11559.6 11567.7 10908.3 11103.0 11151.1 11346.4 11509.4 9064.9 9211.4 9327.6 9350.2 9371.6 9245.7 9540.9 9555.5 9562.0 9647.5 21:54:01 INFO - PROCESS | 1638 | -------- Summary: end -------- 21:54:01 INFO - PROCESS | 1638 | 21:54:02 INFO - TEST-INFO | 1638: exit 0 21:54:02 INFO - TEST-OK | dromaeo_css | took 1116804ms 21:54:02 INFO - TEST-START | kraken 21:54:02 INFO - operating with platform_type : mac_ 21:54:02 INFO - Initialising browser for kraken test... 21:54:02 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/tmpRX83F_/profile http://localhost:49243/getInfo.html) 21:54:05 INFO - PROCESS | 1647 | 2016-11-30 21:54:05.608 plugin-container[1648:10029] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 21:54:05 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:54:05 INFO - PROCESS | 1647 | 2016-11-30 21:54:05.611 plugin-container[1648:10029] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 21:54:05 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:54:05 INFO - PROCESS | 1647 | 2016-11-30 21:54:05.611 plugin-container[1648:10029] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:54:05 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 21:54:05 INFO - PROCESS | 1647 | colorDepth:24 21:54:05 INFO - PROCESS | 1647 | Browser inner width/height: 1024/663 21:54:05 INFO - PROCESS | 1647 | __metrics 21:54:05 ERROR - PROCESS | 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 21:54:06 INFO - TEST-INFO | 1647: exit 0 21:54:06 INFO - Browser initialized. 21:54:06 INFO - Running cycle 1/1 for kraken test... 21:54:06 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/tmpRX83F_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:54:09 INFO - PROCESS | 1649 | 2016-11-30 21:54:09.381 plugin-container[1650:10151] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4543, name = 'com.apple.tsm.portname' 21:54:09 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:54:09 INFO - PROCESS | 1649 | 2016-11-30 21:54:09.381 plugin-container[1650:10151] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x461b, name = 'com.apple.CFPasteboardClient' 21:54:09 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:54:09 INFO - PROCESS | 1649 | 2016-11-30 21:54:09.381 plugin-container[1650:10151] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:54:18 INFO - PROCESS | 1649 | RSS: Main: 249061376 21:54:18 INFO - PROCESS | 1649 | 21:54:21 INFO - PROCESS | 1649 | 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) 21:54:22 INFO - PROCESS | 1649 | RSS: Main: 258813952 21:54:22 INFO - PROCESS | 1649 | 21:54:25 INFO - PROCESS | 1649 | 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) 21:54:25 INFO - PROCESS | 1649 | RSS: Main: 266584064 21:54:25 INFO - PROCESS | 1649 | 21:54:29 INFO - PROCESS | 1649 | 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) 21:54:30 INFO - PROCESS | 1649 | RSS: Main: 266457088 21:54:30 INFO - PROCESS | 1649 | 21:54:32 INFO - PROCESS | 1649 | 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) 21:54:32 INFO - PROCESS | 1649 | RSS: Main: 267083776 21:54:32 INFO - PROCESS | 1649 | 21:54:34 INFO - PROCESS | 1649 | 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) 21:54:35 INFO - PROCESS | 1649 | RSS: Main: 268333056 21:54:35 INFO - PROCESS | 1649 | 21:54:38 INFO - PROCESS | 1649 | 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) 21:54:39 INFO - PROCESS | 1649 | RSS: Main: 274460672 21:54:39 INFO - PROCESS | 1649 | 21:54:42 INFO - PROCESS | 1649 | 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) 21:54:42 INFO - PROCESS | 1649 | RSS: Main: 273694720 21:54:42 INFO - PROCESS | 1649 | 21:54:45 INFO - PROCESS | 1649 | 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) 21:54:46 INFO - PROCESS | 1649 | RSS: Main: 273412096 21:54:46 INFO - PROCESS | 1649 | 21:54:48 INFO - PROCESS | 1649 | 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) 21:54:48 INFO - PROCESS | 1649 | RSS: Main: 272334848 21:54:48 INFO - PROCESS | 1649 | 21:54:50 INFO - PROCESS | 1649 | 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) 21:54:51 INFO - PROCESS | 1649 | RSS: Main: 272363520 21:54:51 INFO - PROCESS | 1649 | 21:54:53 INFO - PROCESS | 1649 | 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) 21:54:54 INFO - PROCESS | 1649 | RSS: Main: 272404480 21:54:54 INFO - PROCESS | 1649 | 21:54:57 INFO - PROCESS | 1649 | 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) 21:54:58 INFO - PROCESS | 1649 | RSS: Main: 272678912 21:54:58 INFO - PROCESS | 1649 | 21:55:01 INFO - PROCESS | 1649 | 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) 21:55:01 INFO - PROCESS | 1649 | RSS: Main: 272568320 21:55:01 INFO - PROCESS | 1649 | 21:55:03 INFO - PROCESS | 1649 | 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) 21:55:03 INFO - PROCESS | 1649 | RSS: Main: 274472960 21:55:03 INFO - PROCESS | 1649 | 21:55:03 INFO - PROCESS | 1649 | __start_tp_report 21:55:03 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 21:55:03 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 21:55:03 INFO - PROCESS | 1649 | |i|pagename|runs| 21:55:03 INFO - PROCESS | 1649 | |0;ai-astar;109;123;120;120;121;119;119;120;117;118 21:55:03 INFO - PROCESS | 1649 | |1;audio-beat-detection;147;115;119;154;115;117;122;146;124;102 21:55:03 INFO - PROCESS | 1649 | |2;audio-dft;195;198;202;272;273;247;223;198;192;277 21:55:03 INFO - PROCESS | 1649 | |3;audio-fft;87;85;52;108;87;84;84;61;71;84 21:55:03 INFO - PROCESS | 1649 | |4;audio-oscillator;103;97;116;104;88;71;83;71;77;98 21:55:03 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;89;89;134;87;84;119;137;121;89;77 21:55:03 INFO - PROCESS | 1649 | |6;imaging-darkroom;96;97;99;96;151;94;151;154;94;95 21:55:03 INFO - PROCESS | 1649 | |7;imaging-desaturate;93;79;145;143;94;118;144;96;109;123 21:55:03 INFO - PROCESS | 1649 | |8;json-parse-financial;59;57;58;58;58;59;58;60;58;60 21:55:03 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;73;69;76;78;70;91;102;105;89;72 21:55:03 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;101;113;112;106;91;93;91;92;87;95 21:55:03 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;152;153;149;147;150;152;152;187;209;163 21:55:03 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;178;179;177;177;201;181;179;175;176;177 21:55:03 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;71;71;72;72;70;76;87;92;96;94 21:55:03 INFO - PROCESS | 1649 | __end_tp_report 21:55:03 INFO - PROCESS | 1649 | __start_cc_report 21:55:03 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,964 21:55:03 INFO - PROCESS | 1649 | __end_cc_report 21:55:03 INFO - PROCESS | 1649 | __startTimestamp1480571703902__endTimestamp 21:55:03 INFO - PROCESS | 1649 | 21:55:03 INFO - PROCESS | 1649 | ------- Summary: start ------- 21:55:03 INFO - PROCESS | 1649 | Number of tests: 14 21:55:03 INFO - PROCESS | 1649 | 21:55:03 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:118.60 Median:120.00 stddev:3.75 (3.1%) stddev-sans-first:1.73 21:55:03 INFO - PROCESS | 1649 | Values: 109.0 123.0 120.0 120.0 121.0 119.0 119.0 120.0 117.0 118.0 21:55:03 INFO - PROCESS | 1649 | 21:55:03 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:126.10 Median:123.00 stddev:16.97 (13.8%) stddev-sans-first:16.23 21:55:03 INFO - PROCESS | 1649 | Values: 147.0 115.0 119.0 154.0 115.0 117.0 122.0 146.0 124.0 102.0 21:55:03 INFO - PROCESS | 1649 | 21:55:03 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:227.70 Median:235.00 stddev:35.91 (15.3%) stddev-sans-first:36.09 21:55:03 INFO - PROCESS | 1649 | Values: 195.0 198.0 202.0 272.0 273.0 247.0 223.0 198.0 192.0 277.0 21:55:03 INFO - PROCESS | 1649 | 21:55:03 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:80.30 Median:84.00 stddev:15.56 (18.5%) stddev-sans-first:16.32 21:55:03 INFO - PROCESS | 1649 | Values: 87.0 85.0 52.0 108.0 87.0 84.0 84.0 61.0 71.0 84.0 21:55:03 INFO - PROCESS | 1649 | 21:55:03 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:90.80 Median:80.00 stddev:15.24 (19.1%) stddev-sans-first:15.52 21:55:03 INFO - PROCESS | 1649 | Values: 103.0 97.0 116.0 104.0 88.0 71.0 83.0 71.0 77.0 98.0 21:55:03 INFO - PROCESS | 1649 | 21:55:03 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:102.60 Median:85.50 stddev:22.55 (26.4%) stddev-sans-first:23.37 21:55:03 INFO - PROCESS | 1649 | Values: 89.0 89.0 134.0 87.0 84.0 119.0 137.0 121.0 89.0 77.0 21:55:03 INFO - PROCESS | 1649 | 21:55:03 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:112.70 Median:95.50 stddev:27.17 (28.5%) stddev-sans-first:28.14 21:55:03 INFO - PROCESS | 1649 | Values: 96.0 97.0 99.0 96.0 151.0 94.0 151.0 154.0 94.0 95.0 21:55:03 INFO - PROCESS | 1649 | 21:55:03 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:114.40 Median:112.00 stddev:24.07 (21.5%) stddev-sans-first:24.25 21:55:03 INFO - PROCESS | 1649 | Values: 93.0 79.0 145.0 143.0 94.0 118.0 144.0 96.0 109.0 123.0 21:55:03 INFO - PROCESS | 1649 | 21:55:03 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:58.50 stddev:0.97 (1.7%) stddev-sans-first:1.01 21:55:03 INFO - PROCESS | 1649 | Values: 59.0 57.0 58.0 58.0 58.0 59.0 58.0 60.0 58.0 60.0 21:55:03 INFO - PROCESS | 1649 | 21:55:03 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:82.50 Median:74.50 stddev:13.34 (17.9%) stddev-sans-first:13.70 21:55:03 INFO - PROCESS | 1649 | Values: 73.0 69.0 76.0 78.0 70.0 91.0 102.0 105.0 89.0 72.0 21:55:03 INFO - PROCESS | 1649 | 21:55:03 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:98.10 Median:91.00 stddev:9.33 (10.2%) stddev-sans-first:9.83 21:55:03 INFO - PROCESS | 1649 | Values: 101.0 113.0 112.0 106.0 91.0 93.0 91.0 92.0 87.0 95.0 21:55:03 INFO - PROCESS | 1649 | 21:55:03 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:161.40 Median:152.50 stddev:20.41 (13.4%) stddev-sans-first:21.37 21:55:03 INFO - PROCESS | 1649 | Values: 152.0 153.0 149.0 147.0 150.0 152.0 152.0 187.0 209.0 163.0 21:55:03 INFO - PROCESS | 1649 | 21:55:03 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.00 Median:178.50 stddev:7.57 (4.2%) stddev-sans-first:8.00 21:55:03 INFO - PROCESS | 1649 | Values: 178.0 179.0 177.0 177.0 201.0 181.0 179.0 175.0 176.0 177.0 21:55:03 INFO - PROCESS | 1649 | 21:55:03 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.10 Median:81.50 stddev:10.81 (13.3%) stddev-sans-first:10.95 21:55:03 INFO - PROCESS | 1649 | Values: 71.0 71.0 72.0 72.0 70.0 76.0 87.0 92.0 96.0 94.0 21:55:03 INFO - PROCESS | 1649 | -------- Summary: end -------- 21:55:03 INFO - PROCESS | 1649 | 21:55:04 INFO - TEST-INFO | 1649: exit 0 21:55:05 INFO - TEST-OK | kraken | took 62625ms 21:55:05 INFO - SUITE-END | took 1179s 21:55:05 INFO - Completed test suite (00:19:39) 21:55:05 INFO - javascript benchmark 21:55:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7036.69115039708, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3316.2704205074906, 3357.4963755436684, 3366.46136618141, 3374.240795820942, 3376.1053320869964, 4680.531946805327, 4873.7075775453495, 5094.617903657222, 5581.358143813462, 5608.298962629671, 4921.286413470045, 5563.833085007446, 5608.214849921004, 5633.774649014034, 5703.458171473703, 5043.495650434964, 5086.618503612225, 5143.871403214912, 5196.844094677147, 5247.711375874325, 5087.058894104603, 5258.106121959276, 5277.8944421111555, 5297.020051290504, 5297.735113244342, 5059.747012649353, 5094.847154585332, 5193.324867767204, 5223.529882310591, 5234.26720259164, 5092.770825312869, 5129.333186685707, 5174.146265866128, 5229.712365819878, 5254.369475662907, 5048.116579598555, 5065.645404821664, 5076.695398276115, 5097.2608971699265, 5103.2855400244, 4765.475797662254, 5575.2473416088715, 5597.552195824324, 5645.520130788888, 5673.971630141823, 6101.938980610182, 6118.619179173164, 6127.3727867283405, 6133.395871484098, 6216.782412615582, 6231.626102433868, 6234.251889773256, 6236.189295391616, 6244.438000579969, 6253.405926436982, 4833.879153021203, 5797.0, 5811.418858114239, 5840.853978650568, 5888.97055514724, 6136.517817949635, 6159.23009623797, 6171.506279497629, 6183.907241391383, 6219.160413344141, 6115.458908337835, 6139.982816839433, 6148.9854174061675, 6153.353897840662, 6155.47678447337, 6094.238220222473, 6231.0, 6240.937590624127, 6245.219347581552, 6246.125542424064, 6114.327423983358, 6116.960116780158, 6137.263528376623, 6158.291796443376, 6165.0, 5114.28400023997, 6182.474489668429, 6190.380961903864, 6206.844828879314, 6211.565190436626, 4833.540813622701, 4877.244027175793, 4911.287863259808, 4925.75371231437, 4958.6776859504735, 4308.332208507686, 4337.240982827992, 4348.978255108705, 4360.106178233455, 4392.824287028547, 5463.699496527729, 5696.743646535916, 5776.566757493205, 5788.855278618068, 5822.359540450547, 6229.937700623026, 6251.4061164189325, 6251.59364641306, 6257.092721555349, 6270.811875643738, 5547.611667183259, 5613.354464236583, 5626.268585083994, 5626.465485778845, 5758.481736643722, 5350.732463376893, 5357.946420535823, 5368.651037682538, 5368.7047212403695, 5372.355317361941, 6171.228596425447, 6184.907226391698, 6211.782587609412, 6229.283632382334, 6264.906026409608, 6199.411055949678, 6223.3465486123305, 6251.218597675291, 6259.2488901332135, 6291.874162516816, 6264.31092579825, 6286.37136286386, 6311.779087731908, 6313.40022697843, 6319.368063193644, 4978.303037574815, 5258.764190415326, 5891.027980383189, 6029.668368239613, 6210.5031597473, 5141.203113517411, 6141.271221159771, 6147.877042459037, 6211.81364559064, 6226.097215903578, 5070.670406423571, 5996.520278377632, 6043.12374705674, 6048.153258543895, 6084.166296553339, 4959.528844759742, 5874.911876321944, 6090.421409966046, 6092.725827337692, 6108.633481991094, 4851.636127290397, 5782.277215348082, 5858.882822343615, 5866.325372582037, 5867.9413205869105, 5466.781328746964, 5698.689301460604, 6074.453299203093, 6081.270247570143, 6140.447359737466, 5763.567732420001, 5878.500327472042, 5893.70531473416, 5906.0255057914965, 5923.348431672426], "value": 5585.392700160461, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [454.34574213133067, 478.6099329046825, 489.808974499945, 527.9788808447662, 531.8643745844809, 37682.434763478566, 39140.0, 39218.82343529699, 41287.38068928961, 41353.37969930446, 40371.0, 40818.7959060205, 40820.79589602055, 41047.79476102623, 41093.58906410935, 7261.419086473096, 9278.860817087749, 9307.11582399671, 9500.762480937963, 9543.952280238589, 8455.19675630817, 11164.609238676649, 11388.487518061707, 11407.54369825206, 11567.710807229845, 11293.4917928693, 11336.546538138464, 11362.886371136306, 11373.431328433586, 11392.373419461926, 11262.662120136409, 11291.378974156418, 11321.981021708045, 11342.63888333397, 11349.148813838912, 11241.83137252942, 11268.267562608486, 11308.208425410225, 11318.434078296052, 11343.092552595772, 38445.23109537794, 38641.613583864084, 38698.0, 38838.029049273995, 38935.221295574214, 3184.601924759405, 3290.2925870937866, 3346.849391777376, 3718.8326525306425, 4061.2486689962157, 29176.41647167066, 29588.112356629335, 29962.55056174159, 30806.69193308083, 30811.38377232465, 3168.651448340681, 3194.073718621597, 3196.0571631368803, 3282.720968717662, 3353.6814002669707, 396440.0, 397182.0, 397598.0120099381, 399244.00377998216, 401011.0, 55952.720236398556, 56573.0, 56903.0, 56909.43090569124, 57056.0, 60702.39297607056, 61151.0, 61305.38694613086, 61636.07545886815, 61680.69159654173, 15626.687466250838, 15849.841501585068, 15875.841241587666, 15879.047257164377, 15885.523434296989, 10980.835287470694, 11133.498992545356, 11890.702732431759, 12049.457774400173, 12115.454804533818, 13722.725545489035, 17266.050367229673, 17409.65180696379, 17447.73828392575, 17536.82463175352, 7574.886376704354, 7670.7698769037015, 7676.616169191518, 7715.729949451742, 7721.92278077212, 871.812560299526, 887.9600417981206, 967.0, 1005.4369553050316, 1123.730304726876, 24527.018919243386, 26998.460030799273, 28372.290692732848, 29536.852315738284, 30017.249568760955, 868.913108689126, 912.9452232865916, 1030.1655658916302, 1031.0565832263544, 1053.3574519543072, 12333.50665973351, 14278.429372768987, 14764.114153150631, 15315.0, 15568.143752093743, 364638.0, 427661.8616906958, 429448.0, 431841.1342979147, 432984.0, 44426.55573444289, 54508.45491545113, 55192.724036379564, 55407.0, 55656.721716391155, 1137.4142316706902, 1332.3871019331023, 1344.9058565900293, 1360.0683531780564, 1362.3733082782032, 25639.974401023752, 26747.598786018614, 28180.71819281781, 29528.0, 29556.852215738785, 48416.75791621019, 48539.27191092207, 48669.99999999858, 48874.511254886995, 49047.0, 475908.0, 478032.0, 480740.0, 481230.5938470285, 482502.0, 20895.477613059797, 25161.370965726004, 25455.87272063628, 25707.10025149111, 25738.613920791577, 44223.33664994963, 44625.0, 45172.548274516834, 45415.0, 45919.540804591525, 31904.36191276208, 32016.199595010312, 35594.46608300929, 37043.0, 38251.0, 32417.837910810296, 33205.66794332026, 37205.813970931056, 38058.0, 38605.806970964964, 36101.0, 36564.81717591395, 37061.44407833831, 37465.5013799445, 38357.0, 26523.867380662974, 29421.26446838846, 29551.113466596038, 29919.0, 30090.0, 22402.0, 22771.430714232276, 23099.88450057739, 23108.537829243658, 23142.537149257256], "value": 19065.29553264774, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.2984599415118, 372.4543543708467, 376.67982215117155, 381.05688421157623, 394.9730700179534, 18615.162317695704, 19607.0, 19940.60118797625, 20245.88647624382, 20455.284065057727, 19125.426237212872, 19320.22719091235, 19907.900460497676, 19929.900350498265, 20219.0, 4537.773111344436, 5511.53151982082, 5781.942180578203, 5784.652920824743, 5797.942020579782, 4078.5717499662555, 4318.179545886287, 4782.995570930108, 5672.943270567303, 6234.812955611339, 5460.6177567570285, 6360.0, 6381.266154392258, 6387.808365749035, 6402.935970640304, 5314.4951229633125, 6107.5113990880845, 6259.217597800275, 6338.207724034496, 6347.492200623962, 5397.541208997201, 5483.903219356105, 5541.639793413416, 5548.86127846803, 5557.944420555824, 24412.26763197107, 24646.753532464627, 24691.50616987668, 24914.377140571632, 25008.49983000348, 2292.3695983604475, 2545.745425457458, 2702.8918843246247, 3007.7443417309555, 3032.166154307561, 14612.634684132981, 14621.488247911271, 15121.621959450991, 15812.288447019797, 16005.039697618064, 1569.8618501586259, 1636.2636813434003, 1678.1441464853012, 1749.9387521436688, 1781.4922747017038, 75526.0, 107881.46059269653, 108921.99999999921, 109906.90093099046, 110838.0, 9040.649431147818, 11066.612668556723, 11338.319700817978, 11391.316521008766, 11559.422028898689, 14226.644333891529, 14245.85754142466, 14262.0, 14273.78589321161, 14285.57143285703, 6505.284418714033, 8200.38497112707, 8200.42597018215, 8316.209960053786, 8353.039400468902, 7965.322947549407, 7993.840123197503, 8024.157463466252, 8144.389170812213, 8178.754637360769, 3827.770333779982, 4287.413656946949, 4331.740095594275, 4448.421705178306, 4492.618127459137, 1548.9380424783108, 1648.3571407151221, 1652.2812576529248, 1877.981220187808, 1926.5376309685576, 818.7748369198399, 934.509382574154, 947.8436058050345, 954.3939598355095, 980.460746589373, 19790.0, 20658.58682826335, 20798.584028319652, 20846.06192721331, 20928.686069708965, 873.1661263493348, 912.1790388650135, 913.4108500017452, 934.8550974598948, 951.8239125761756, 10507.684769456928, 10940.835887461695, 10942.945285273681, 10953.890461095287, 10973.670789876316, 476467.0, 503534.0, 514360.0, 544258.0, 547620.2618986879, 107582.46208768905, 112975.0, 115506.87177846373, 116631.0, 118994.40502797431, 922.686286662538, 954.1317401164906, 986.4032260482448, 991.177322822056, 991.8413053911339, 18735.250589976793, 19145.712814307517, 19190.520236994187, 19198.328058517884, 19249.941253231205, 50786.49213507966, 51508.0, 52241.7387913058, 53499.930001400535, 54846.72576637091, 75179.62410187913, 76015.0, 76246.61876690581, 76555.0, 76886.0, 5936.851578710567, 6500.934990650222, 6543.312952139957, 7227.566346019255, 8059.6776128956535, 9294.442333460014, 12054.0, 12378.319192444502, 12934.741305173655, 13189.736205275649, 10828.025477707044, 11116.61091861781, 11216.158788090763, 11373.658790236306, 11470.311781293149, 8653.783655408413, 10187.08316251541, 10202.33684810485, 10597.993190646876, 11179.441027948733, 11134.944325278646, 11202.495887685236, 11326.773464530828, 11482.94258528702, 11520.654380368602, 7569.3566046886635, 7974.0, 8037.437379383387, 8411.158884111539, 8431.704890328809, 9537.618495260389, 11019.669409917715, 11069.83395249088, 11287.435628218393, 11313.830292545783], "value": 9337.912859658927, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1459.1536908593016, 1486.2197346393143, 1653.9338426462941, 1742.2247100040488, 1809.1677828199036, 7468.813279668011, 7769.844603107935, 7923.643436045385, 8219.342452603792, 8221.83556328873, 7946.64240109195, 8266.62800173992, 8298.502089874612, 8334.583270836449, 8337.83324333513, 2271.0461606125427, 2309.4919117794057, 2311.8612883226974, 2313.947154044914, 2324.2097686786487, 1890.6124244529908, 1964.9705254421194, 2057.753069631646, 2316.6177580699164, 2344.179537161997, 1929.53691114133, 2283.6232021716396, 2297.1959814065112, 2311.4221444638843, 2315.1086831569883, 1913.770347558295, 2266.4447210433386, 2290.816734661223, 2297.7242730872235, 2301.1600765720477, 1846.9445916622524, 1865.981340186608, 2236.731592208929, 2242.6299660555987, 2244.9887750561306, 8258.132896045889, 8312.584370781437, 8394.79013024673, 8400.789980250482, 8409.20112589303, 4985.277134815467, 5045.873853153664, 5212.0, 5224.346956630421, 5224.843254702365, 3276.3774882772195, 3316.9717387609676, 3413.9758072578375, 3505.9123521912156, 3508.2632647143873, 1034.7930413917247, 1054.2988912373262, 1070.464767616192, 1090.1769164280918, 1094.4254266510065, 10807.83788243177, 10872.565097396095, 10874.72813179669, 11015.559377624966, 11041.944790275997, 4114.691398145151, 4359.280718681445, 4610.792514336863, 4699.17764391237, 4712.882177945578, 8295.336373090138, 8986.55067246635, 9421.858672119924, 9433.764155896157, 9473.336866419284, 5108.540231379194, 5151.896962060813, 5173.042987047408, 5176.4047134580005, 5200.6619569727845, 4231.513375961742, 4390.209762242763, 4596.724196548218, 4747.810087596457, 4749.073930583572, 3113.4551453495546, 3728.5339332583426, 3768.698504119664, 3800.7149463790324, 3845.8461661533224, 1238.5355491690616, 1243.0863315463127, 1248.9625311240677, 1255.610760664197, 1266.8859802617808, 761.7257787196605, 855.2858363266741, 890.1027156605209, 895.6283142495921, 905.2034209895381, 4583.839565615254, 5348.679079255257, 5736.827895163152, 5761.88476230473, 5781.4507621775865, 889.9231929365541, 892.4110087342452, 899.9560509808722, 919.9172074513326, 950.1496160935924, 3192.0, 3420.538227339327, 3612.566492020922, 3636.890893273206, 3682.926341473209, 7796.5711885845685, 9891.703248902544, 10050.195984321237, 10168.135708464715, 10267.0, 8282.213189746964, 10075.445850478147, 10079.5464204111, 10093.142082923034, 10097.394156350643, 7516.6993320267675, 7834.843303134019, 7895.131535531087, 7920.920790792134, 7924.603769811486, 4301.268784306612, 5498.175273708815, 5549.694766787866, 5585.581081418829, 5693.117566777156, 9278.489683067226, 9325.440473571607, 9361.344705870524, 9467.005964373642, 9478.38390504615, 9421.29340299494, 9508.191803696764, 9519.381240219363, 9553.283503737108, 9686.85469717969, 5709.628874123168, 5856.94143058581, 6589.0, 6642.43539299165, 6773.796786096425, 7932.16712245206, 8022.318102961313, 8025.197480251928, 8026.157253488534, 8051.8792218115605, 7005.299470052954, 7089.539179953286, 7132.322429369202, 7191.640417978975, 7220.4945653805835, 6786.898196526958, 6817.488688348294, 6825.761098361533, 6869.793906182823, 6881.793546193622, 6458.063580780855, 6610.768623098168, 6706.262311145868, 6716.992451132369, 6775.1531058617675, 4768.02255537607, 4793.113274044313, 4807.759612019315, 4834.806607735792, 4865.58642515376, 3856.3444214484166, 3955.4857868476915, 4750.8337208197545, 4814.542618451242, 5094.133997220407], "value": 4318.60478751727, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [262.7385751177579, 283.981541199822, 307.9384123175366, 311.6400557356253, 314.50465516811016, 5259.9474005259935, 5358.758855851486, 5386.946130538693, 5405.59458040647, 5449.7820087196515, 5294.947050529494, 5297.735113244342, 5374.865628359284, 5398.811041613544, 5411.431799661038, 3217.75866809989, 3891.4746509221245, 3949.8815035548837, 4097.803713103784, 4129.752214867102, 3744.457053727208, 4049.4533238012787, 4061.73598716084, 4112.067328355668, 4116.526599441073, 3577.1398872586237, 3911.393733971239, 3923.6664883484937, 4089.488813898263, 4127.153933443652, 3308.4541050726602, 3636.000099972529, 3968.940465893014, 4102.651274641644, 4156.397322388252, 3113.5869700981693, 3125.0, 3277.2626159114006, 3558.448440491728, 3569.857645553424, 5200.713960732158, 5253.711045892474, 5287.154055351125, 5290.418054014055, 5311.468853114697, 4214.377464676122, 4503.707259028152, 4612.3542704021465, 4697.318888761145, 4763.04739052191, 4969.8012079516775, 5101.974490127525, 5209.2446595243855, 5640.520555752766, 5664.6601203927485, 3688.1517251032415, 3828.636279553438, 3841.387856257744, 3883.2233553289175, 3885.572587015426, 5487.79268560916, 5671.177679236487, 5750.712464376807, 5978.850528736816, 6034.280230134391, 3499.61504234534, 3755.3803622401997, 3829.1767270036516, 3833.3674943633987, 3903.7703123516003, 3318.93793985927, 3954.723169378116, 3961.7622942623534, 3962.484876965976, 3963.246983073207, 3705.2959937611768, 4625.7687115644085, 4630.61081675496, 4630.758469071663, 4648.814047438064, 4813.95406952044, 5379.73101344939, 5734.942650573525, 5802.361740208574, 5816.360200377955, 1059.5285098131258, 1118.82658187981, 1127.4306475229957, 1129.6215767717742, 1290.3806173036808, 777.5218240781878, 814.8859159717645, 882.1795729971188, 887.1572006593633, 887.924526415249, 4417.558244175621, 4919.704817710877, 5316.867078323073, 5365.54392876602, 5479.287752562427, 4861.368022157168, 5879.706014699248, 5905.852353691193, 5919.792807251725, 5954.702264886739, 4404.4714634243455, 4631.791569379386, 5140.331756871583, 5437.700926449083, 5524.530414914777, 2411.9879400602886, 2460.6186041163646, 2498.9500209996063, 2918.533034714478, 2924.6490421149174, 4605.447346318463, 5254.456548341536, 5336.546393556514, 5828.164128299572, 5828.912566311508, 5360.105543006811, 5614.719264036864, 5742.224799652077, 5752.36723960364, 5829.562782791223, 4698.459677137104, 5005.34930459038, 5232.712200828991, 5792.247007888947, 5841.970790146107, 5160.767765450489, 5206.687598744087, 5321.308229930084, 5650.745716442852, 5670.744816483186, 5378.381486129145, 5396.0556902542685, 5628.831135065954, 5801.94198058014, 5870.853228669317, 5256.89486210266, 5726.570507212059, 5816.82549523515, 6070.514358851193, 6107.6640784757265, 3258.5296659058026, 3924.803759812055, 3927.2341893330527, 3944.3097457944173, 3957.3074711925874, 5499.285092937893, 5647.764176867349, 5849.519535876317, 5905.763769449174, 5909.818036392825, 5667.773289068556, 5668.659880407189, 5671.319441667027, 5694.886102278014, 5708.57185711065, 4869.342638743724, 5447.455254474521, 5636.520895723909, 5703.8859222816145, 5716.342620598518, 4975.0796102721115, 5330.866728331823, 5558.249636299048, 5605.747741351567, 5622.718864056863, 5479.287692599936, 5519.668819870821, 5636.577256705681, 5736.827895163152, 5791.247137872049, 4959.0, 5291.867703307448, 5623.212750215055, 5683.943160568507, 5699.432656019628], "value": 4059.529101843456, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.6417416682075, 698.8986596943447, 758.1281526244821, 762.7711686494054, 793.1434051224676, 14459.132452052883, 15232.390704371812, 15252.313645885934, 15326.080435173897, 15345.30946107425, 12227.633171004883, 12291.20107193034, 12294.815577766341, 12332.4450399732, 12333.691657708561, 639.5682914033009, 656.4190691238241, 800.5796956597803, 814.100419036963, 823.8352329534088, 816.0941355095839, 820.0610301205116, 826.3719573124408, 826.4008593769499, 829.7966998085477, 873.1574031060026, 874.7375787263827, 876.0494863073573, 877.5436772878099, 879.0681877210178, 863.6200071968314, 865.8484765166103, 866.6879923227665, 869.395769939892, 872.8472517309445, 633.9207599050119, 641.6118248459708, 647.6567419267795, 647.6955830759536, 648.2739331948201, 13318.600441986757, 14003.64990875226, 14247.78628320576, 14262.0, 14275.714485710228, 13400.865991340059, 13886.375113119933, 14045.087069340563, 14269.286535673278, 14334.51524264042, 11589.30464172144, 11625.825612615732, 11662.183647144704, 11695.122865785015, 11697.649070527897, 2999.7207706729364, 3352.5474061001696, 3679.6136405677553, 3758.229562939591, 3800.5059342285604, 93234.13531729396, 93802.53098734531, 95136.0, 95336.52331738296, 95384.0, 9204.815903681889, 10794.946025269823, 10814.405207713495, 10863.967923047298, 11040.282381645167, 17338.739918901225, 21172.15311387558, 21374.893125534272, 21388.14447422086, 21397.0, 7118.822029449305, 7684.346830519356, 7693.230676932262, 7726.652300646484, 7871.212878712197, 4269.1034882674985, 4276.657867370665, 4327.199468098412, 4363.978180109079, 4457.710248833815, 3284.753643476749, 3381.7970921744773, 3390.2541440882965, 3391.2878295558207, 3393.2874096440023, 570.1049352516509, 602.8010756450361, 619.5941658213877, 636.8344230500011, 646.6766616691655, 527.8310940499003, 546.8906218756265, 556.9443055694398, 596.1862058290488, 605.2253116011512, 7352.926470735331, 8138.186181381814, 8684.43551169172, 8708.651653933899, 8877.911220887838, 574.6035235687363, 576.9278840144982, 588.6997631208029, 604.2175382879182, 604.6009633641863, 3610.5306310180035, 4145.97927010363, 4309.719868208556, 4313.676474264443, 4322.956770432255, 104162.8751137467, 105764.0, 105796.0, 107003.46498267459, 110358.02432127217, 91082.54458727664, 94179.52910235542, 94765.52617237008, 96232.51883740677, 97064.0, 55986.72006640022, 84757.0, 85894.99999999875, 85968.57015714882, 86125.56937215274, 7731.963883066879, 8217.30152937007, 8260.628271727666, 8304.833903321778, 8484.278836298983, 55443.72278138583, 56149.15776263278, 56256.5935851607, 56433.71783141058, 57001.71499142478, 74326.62836685783, 76531.61734191293, 76537.23462765302, 77415.0, 80033.59983200047, 10484.737881553023, 10615.0, 10690.62582809598, 10752.301100428447, 10828.187885908746, 10441.843372349269, 11580.305181689126, 11729.589464368706, 11761.353125577833, 11976.46105925253, 10030.749231268985, 10158.74603134898, 10259.384436933808, 10265.332753371007, 10588.258821882395, 11037.503312350804, 11198.552057917592, 11414.714632134263, 11559.595414160463, 11567.652970410565, 10908.290961087503, 11103.0, 11151.052160566443, 11346.375949322866, 11509.424528773696, 9064.864027039732, 9211.355205135576, 9327.626894924128, 9350.158485736316, 9371.578278977599, 9245.72262832116, 9540.856887146838, 9555.522223888916, 9561.952190239004, 9647.469389183661], "value": 6963.027492332117, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1633.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 123.0, 120.0, 120.0, 121.0, 119.0, 119.0, 120.0, 117.0, 118.0], "value": 118.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 115.0, 119.0, 154.0, 115.0, 117.0, 122.0, 146.0, 124.0, 102.0], "value": 126.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 198.0, 202.0, 272.0, 273.0, 247.0, 223.0, 198.0, 192.0, 277.0], "value": 227.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 52.0, 108.0, 87.0, 84.0, 84.0, 61.0, 71.0, 84.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 97.0, 116.0, 104.0, 88.0, 71.0, 83.0, 71.0, 77.0, 98.0], "value": 90.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 134.0, 87.0, 84.0, 119.0, 137.0, 121.0, 89.0, 77.0], "value": 102.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 99.0, 96.0, 151.0, 94.0, 151.0, 154.0, 94.0, 95.0], "value": 112.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 79.0, 145.0, 143.0, 94.0, 118.0, 144.0, 96.0, 109.0, 123.0], "value": 114.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 58.0, 58.0, 58.0, 59.0, 58.0, 60.0, 58.0, 60.0], "value": 58.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 69.0, 76.0, 78.0, 70.0, 91.0, 102.0, 105.0, 89.0, 72.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 112.0, 106.0, 91.0, 93.0, 91.0, 92.0, 87.0, 95.0], "value": 98.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 153.0, 149.0, 147.0, 150.0, 152.0, 152.0, 187.0, 209.0, 163.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 179.0, 177.0, 177.0, 201.0, 181.0, 179.0, 175.0, 176.0, 177.0], "value": 180.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 72.0, 72.0, 70.0, 76.0, 87.0, 92.0, 96.0, 94.0], "value": 80.1, "unit": "score"}]}]} 21:55:05 INFO - Return code: 0 21:55:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:55:05 ERROR - # TBPL SUCCESS # 21:55:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:55:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:55:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:55:05 INFO - 2016-11-30 21:55:05.711 screenresolution[1654:10537] starting screenresolution argv=screenresolution get 21:55:05 INFO - 2016-11-30 21:55:05.713 screenresolution[1654:10537] Display 0: 1600x1200x32@60 21:55:05 INFO - 2016-11-30 21:55:05.719 screenresolution[1655:10540] starting screenresolution argv=screenresolution list 21:55:05 INFO - Available Modes on Display 0 21:55:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:55:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:55:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:55:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:55:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:55:05 INFO - Intel Iris: 21:55:05 INFO - Chipset Model: Intel Iris 21:55:05 INFO - Type: GPU 21:55:05 INFO - Bus: Built-In 21:55:05 INFO - VRAM (Dynamic, Max): 1536 MB 21:55:05 INFO - Vendor: Intel (0x8086) 21:55:05 INFO - Device ID: 0x0a2e 21:55:05 INFO - Revision ID: 0x0009 21:55:05 INFO - Displays: 21:55:05 INFO - Display: 21:55:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:55:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:55:05 INFO - Display Serial Number: 1600x1200 60 21:55:05 INFO - Main Display: Yes 21:55:05 INFO - Mirror: Off 21:55:05 INFO - Online: Yes 21:55:05 INFO - Rotation: Supported 21:55:05 INFO - Return code: 0 21:55:05 INFO - Running post-action listener: _resource_record_post_action 21:55:05 INFO - [mozharness: 2016-12-01 05:55:05.954463Z] Finished run-tests step (success) 21:55:05 INFO - Running post-run listener: _resource_record_post_run 21:55:06 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 38500864; Write bytes: 699159552; Read time: 256; Write time: 2047 21:55:06 INFO - TinderboxPrint: CPU usage
54.3% 21:55:06 INFO - TinderboxPrint: I/O read bytes / time
38,500,864 / 256 21:55:06 INFO - TinderboxPrint: I/O write bytes / time
699,159,552 / 2,047 21:55:06 INFO - TinderboxPrint: CPU idle
2,216.0 (45.7%) 21:55:06 INFO - TinderboxPrint: CPU system
978.2 (20.2%) 21:55:06 INFO - TinderboxPrint: CPU user
1,659.5 (34.2%) 21:55:06 INFO - TinderboxPrint: Swap in / out
422,121,472 / 0 21:55:06 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 378821120; Write bytes: 373598208; Read time: 29140; Write time: 792 21:55:06 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 36407808; Write bytes: 311188480; Read time: 237; Write time: 1208 21:55:06 INFO - Running post-run listener: _upload_blobber_files 21:55:06 INFO - Blob upload gear active. 21:55:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:55:06 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 21:55:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:55:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:55:06 INFO - (blobuploader) - INFO - Open directory for files ... 21:55:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:55:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:55:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:07 INFO - (blobuploader) - INFO - Done attempting. 21:55:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:55:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:55:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:08 INFO - (blobuploader) - INFO - Done attempting. 21:55:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:55:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:55:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:10 INFO - (blobuploader) - INFO - Done attempting. 21:55:10 INFO - (blobuploader) - INFO - Iteration through files over. 21:55:10 INFO - Return code: 0 21:55:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:55:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:55:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1127939f05c60b167dc925102562482a87ec63c761551e9425f5ffe01bff01324a75bc4b61c4153581905b33b267caac1d7701c37cff4d979f0690f93c351c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3cd9f6a7b872a06258221f98cb19819f8309b3ac0829c6dd89c5d09a122104a782317592dcbeb03e382062183231637bce93b4f2a1b629af116f7b67b77efd01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3789b885d487ca9204a3274a7f34ff4018a3d008c438845c7f125f57d783d913a2e8297905e1ff8a305108a6ede0707c1540d7d6778f688fd81730375f926525"} 21:55:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:55:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:55:10 INFO - Contents: 21:55:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1127939f05c60b167dc925102562482a87ec63c761551e9425f5ffe01bff01324a75bc4b61c4153581905b33b267caac1d7701c37cff4d979f0690f93c351c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3cd9f6a7b872a06258221f98cb19819f8309b3ac0829c6dd89c5d09a122104a782317592dcbeb03e382062183231637bce93b4f2a1b629af116f7b67b77efd01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3789b885d487ca9204a3274a7f34ff4018a3d008c438845c7f125f57d783d913a2e8297905e1ff8a305108a6ede0707c1540d7d6778f688fd81730375f926525"} 21:55:10 INFO - Running post-run listener: copy_logs_to_upload_dir 21:55:10 INFO - Copying logs to upload dir... 21:55:10 INFO - mkdir: /builds/slave/test/build/upload/logs 21:55:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.036697 ========= master_lag: 0.63 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-11-30 21:55:11.360564) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 21:55:11.364607) ========= 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.VbJg7c4oJR/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.d06sOCeEJr/Listeners TMPDIR=/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1127939f05c60b167dc925102562482a87ec63c761551e9425f5ffe01bff01324a75bc4b61c4153581905b33b267caac1d7701c37cff4d979f0690f93c351c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3cd9f6a7b872a06258221f98cb19819f8309b3ac0829c6dd89c5d09a122104a782317592dcbeb03e382062183231637bce93b4f2a1b629af116f7b67b77efd01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3789b885d487ca9204a3274a7f34ff4018a3d008c438845c7f125f57d783d913a2e8297905e1ff8a305108a6ede0707c1540d7d6778f688fd81730375f926525"} build_url:https://queue.taskcluster.net/v1/task/YAsaPuFnR-CeRwzxRXQuLw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011061 build_url: 'https://queue.taskcluster.net/v1/task/YAsaPuFnR-CeRwzxRXQuLw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1127939f05c60b167dc925102562482a87ec63c761551e9425f5ffe01bff01324a75bc4b61c4153581905b33b267caac1d7701c37cff4d979f0690f93c351c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3cd9f6a7b872a06258221f98cb19819f8309b3ac0829c6dd89c5d09a122104a782317592dcbeb03e382062183231637bce93b4f2a1b629af116f7b67b77efd01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3789b885d487ca9204a3274a7f34ff4018a3d008c438845c7f125f57d783d913a2e8297905e1ff8a305108a6ede0707c1540d7d6778f688fd81730375f926525"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 21:55:11.409302) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 21:55:11.409637) ========= 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.VbJg7c4oJR/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.d06sOCeEJr/Listeners TMPDIR=/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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.005057 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 21:55:11.457944) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 21:55:11.460298) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 21:55:11.460886) ========= ========= Total master_lag: 0.78 =========