builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0320 starttime: 1481654326.19 results: success (0) buildid: 20161213091200 builduid: ace1b13492f34da99303ec294fac7598 revision: 489f981e8c2beb050d7faee956dd940431bdafe6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 10:38:46.192306) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 10:38:46.192776) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 10:38:46.193066) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 10:38:46.222501) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 10:38:46.222898) ========= 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.dfBtSggJSq/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.Y1HHKVYHIJ/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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-12-13 10:38:46-- 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% 14.0M=0.001s 2016-12-13 10:38:46 (14.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.152965 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 10:38:46.399303) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 10:38:46.399615) ========= 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.dfBtSggJSq/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.Y1HHKVYHIJ/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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.019429 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 10:38:46.448369) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-13 10:38:46.448728) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 489f981e8c2beb050d7faee956dd940431bdafe6 --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 489f981e8c2beb050d7faee956dd940431bdafe6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dfBtSggJSq/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.Y1HHKVYHIJ/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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-12-13 10:38:46,533 truncating revision to first 12 chars 2016-12-13 10:38:46,533 Setting DEBUG logging. 2016-12-13 10:38:46,533 attempt 1/10 2016-12-13 10:38:46,533 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/489f981e8c2b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-13 10:38:48,709 unpacking tar archive at: mozilla-central-489f981e8c2b/testing/mozharness/ program finished with exit code 0 elapsedTime=2.422255 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-13 10:38:48.894688) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 10:38:48.894988) ========= script_repo_revision: 489f981e8c2beb050d7faee956dd940431bdafe6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 10:38:48.895383) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 10:38:48.895677) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 10:38:48.914454) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-12-13 10:38:48.914763) ========= /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.dfBtSggJSq/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.Y1HHKVYHIJ/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 10:38:49 INFO - MultiFileLogger online at 20161213 10:38:49 in /builds/slave/test 10:38:49 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 10:38:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:38:49 INFO - {'append_to_log': False, 10:38:49 INFO - 'base_work_dir': '/builds/slave/test', 10:38:49 INFO - 'blob_upload_branch': 'Firefox', 10:38:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:38:49 INFO - 'branch': 'Firefox', 10:38:49 INFO - 'buildbot_json_path': 'buildprops.json', 10:38:49 INFO - 'config_files': ('talos/mac_config.py',), 10:38:49 INFO - 'default_actions': ('clobber', 10:38:49 INFO - 'read-buildbot-config', 10:38:49 INFO - 'download-and-extract', 10:38:49 INFO - 'populate-webroot', 10:38:49 INFO - 'create-virtualenv', 10:38:49 INFO - 'install', 10:38:49 INFO - 'run-tests'), 10:38:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:38:49 INFO - 'download_minidump_stackwalk': True, 10:38:49 INFO - 'download_symbols': 'ondemand', 10:38:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:38:49 INFO - 'tooltool.py': '/tools/tooltool.py', 10:38:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:38:49 INFO - '/tools/misc-python/virtualenv.py')}, 10:38:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:38:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:38:49 INFO - 'installer_path': 'installer.exe', 10:38:49 INFO - 'log_level': 'info', 10:38:49 INFO - 'log_name': 'talos', 10:38:49 INFO - 'log_to_console': True, 10:38:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:38:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:38:49 INFO - 'opt_config_files': (), 10:38:49 INFO - 'pip_index': False, 10:38:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:38:49 INFO - 'cmd': ('bash', 10:38:49 INFO - '-c', 10:38:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:38:49 INFO - 'enabled': True, 10:38:49 INFO - 'halt_on_failure': False, 10:38:49 INFO - 'name': 'check_screen_resolution'},), 10:38:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:38:49 INFO - 'cmd': ('bash', 10:38:49 INFO - '-c', 10:38:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:38:49 INFO - 'enabled': True, 10:38:49 INFO - 'halt_on_failure': False, 10:38:49 INFO - 'name': 'check_screen_resolution'},), 10:38:49 INFO - 'run_cmd_checks_enabled': True, 10:38:49 INFO - 'sps_profile': False, 10:38:49 INFO - 'sps_profile_interval': 0, 10:38:49 INFO - 'suite': 'dromaeojs-e10s', 10:38:49 INFO - 'system_bits': '32', 10:38:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:38:49 INFO - 'title': 't-yosemite-r7-0320', 10:38:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:38:49 INFO - 'use_talos_json': True, 10:38:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:38:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:38:49 INFO - 'work_dir': 'build'} 10:38:49 INFO - [mozharness: 2016-12-13 18:38:49.118728Z] Running clobber step. 10:38:49 INFO - Running pre-action listener: _resource_record_pre_action 10:38:49 INFO - Running main action method: clobber 10:38:49 INFO - rmtree: /builds/slave/test/build 10:38:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:38:50 INFO - Running post-action listener: _resource_record_post_action 10:38:50 INFO - [mozharness: 2016-12-13 18:38:50.638976Z] Finished clobber step (success) 10:38:50 INFO - [mozharness: 2016-12-13 18:38:50.639129Z] Running read-buildbot-config step. 10:38:50 INFO - Running pre-action listener: _resource_record_pre_action 10:38:50 INFO - Running main action method: read_buildbot_config 10:38:50 INFO - Using buildbot properties: 10:38:50 INFO - { 10:38:50 INFO - "project": "", 10:38:50 INFO - "product": "firefox", 10:38:50 INFO - "script_repo_revision": "production", 10:38:50 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:38:50 INFO - "repository": "", 10:38:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:38:50 INFO - "buildid": "20161213091200", 10:38:50 INFO - "pgo_build": "False", 10:38:50 INFO - "basedir": "/builds/slave/test", 10:38:50 INFO - "buildnumber": 30, 10:38:50 INFO - "slavename": "t-yosemite-r7-0320", 10:38:50 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 10:38:50 INFO - "platform": "yosemite_r7", 10:38:50 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:38:50 INFO - "branch": "mozilla-central", 10:38:50 INFO - "repo_path": "mozilla-central", 10:38:50 INFO - "revision": "489f981e8c2beb050d7faee956dd940431bdafe6", 10:38:50 INFO - "stage_platform": "macosx64", 10:38:50 INFO - "builduid": "ace1b13492f34da99303ec294fac7598", 10:38:50 INFO - "slavebuilddir": "test" 10:38:50 INFO - } 10:38:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg. 10:38:50 INFO - Running post-action listener: _resource_record_post_action 10:38:50 INFO - [mozharness: 2016-12-13 18:38:50.642438Z] Finished read-buildbot-config step (success) 10:38:50 INFO - [mozharness: 2016-12-13 18:38:50.642545Z] Running download-and-extract step. 10:38:50 INFO - Running pre-action listener: _resource_record_pre_action 10:38:50 INFO - Running main action method: download_and_extract 10:38:50 INFO - mkdir: /builds/slave/test/build/tests 10:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:38:50 INFO - trying https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json 10:38:50 INFO - Downloading https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 10:38:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json'}, attempt #1 10:38:52 INFO - Downloaded 1235 bytes. 10:38:52 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 10:38:52 INFO - Using the following test package requirements: 10:38:52 INFO - {u'common': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 10:38:52 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 10:38:52 INFO - u'firefox-53.0a1.en-US.mac64.cppunittest.tests.zip'], 10:38:52 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 10:38:52 INFO - u'firefox-53.0a1.en-US.mac64.gtest.tests.zip'], 10:38:52 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 10:38:52 INFO - u'jsshell-mac64.zip'], 10:38:52 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 10:38:52 INFO - u'firefox-53.0a1.en-US.mac64.mochitest.tests.zip'], 10:38:52 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 10:38:52 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 10:38:52 INFO - u'firefox-53.0a1.en-US.mac64.reftest.tests.zip'], 10:38:52 INFO - u'talos': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 10:38:52 INFO - u'firefox-53.0a1.en-US.mac64.talos.tests.zip'], 10:38:52 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 10:38:52 INFO - u'firefox-53.0a1.en-US.mac64.web-platform.tests.zip'], 10:38:52 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 10:38:52 INFO - u'firefox-53.0a1.en-US.mac64.xpcshell.tests.zip']} 10:38:52 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip'] for test suite category: common 10:38:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 10:38:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 10:38:52 INFO - Fetch https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 10:38:53 INFO - Expected file size: 16276433 10:38:53 INFO - Obtained file size: 16276433 10:38:59 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip', u'firefox-53.0a1.en-US.mac64.talos.tests.zip'] for test suite category: talos 10:38:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 10:38:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 10:38:59 INFO - Fetch https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 10:39:00 INFO - Expected file size: 16276433 10:39:00 INFO - Obtained file size: 16276433 10:39:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip 10:39:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip'}, attempt #1 10:39:07 INFO - Fetch https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip into memory 10:39:07 INFO - Expected file size: 14409734 10:39:07 INFO - Obtained file size: 14409734 10:39:08 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')]} 10:39:08 INFO - trying https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 10:39:08 INFO - Downloading https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg 10:39:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg'}, attempt #1 10:39:11 INFO - Downloaded 69716041 bytes. 10:39:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 10:39:11 INFO - mkdir: /builds/slave/test/properties 10:39:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:39:11 INFO - Writing to file /builds/slave/test/properties/build_url 10:39:11 INFO - Contents: 10:39:11 INFO - build_url:https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 10:39:11 INFO - Running post-action listener: _resource_record_post_action 10:39:11 INFO - Running post-action listener: set_extra_try_arguments 10:39:11 INFO - [mozharness: 2016-12-13 18:39:11.987563Z] Finished download-and-extract step (success) 10:39:11 INFO - [mozharness: 2016-12-13 18:39:11.987714Z] Running populate-webroot step. 10:39:11 INFO - Running pre-action listener: _resource_record_pre_action 10:39:11 INFO - Running main action method: populate_webroot 10:39:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:39:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:39:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:39:11 INFO - '--tppagecycles', 10:39:11 INFO - '7'], 10:39:11 INFO - 'tests': ['tsvgm']}}, 10:39:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:39:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:39:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:39:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:39:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:39:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:39:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:39:11 INFO - 'talos_options': ['--disable-e10s'], 10:39:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:39:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:39:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:39:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:39:11 INFO - 'talos_options': ['--disable-e10s'], 10:39:11 INFO - 'tests': ['damp', 'tps']}, 10:39:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:39:11 INFO - 'tests': ['damp', 'tps']}, 10:39:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:39:11 INFO - 'tests': ['dromaeo_dom']}, 10:39:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:39:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:39:11 INFO - 'tests': ['basic_compositor_video']}, 10:39:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:39:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:39:11 INFO - 'tests': ['a11yr', 10:39:11 INFO - 'ts_paint', 10:39:11 INFO - 'tpaint', 10:39:11 INFO - 'sessionrestore', 10:39:11 INFO - 'sessionrestore_no_auto_restore', 10:39:11 INFO - 'tabpaint']}, 10:39:11 INFO - 'other-e10s': {'tests': ['a11yr', 10:39:11 INFO - 'ts_paint', 10:39:11 INFO - 'tpaint', 10:39:12 INFO - 'sessionrestore', 10:39:12 INFO - 'sessionrestore_no_auto_restore', 10:39:12 INFO - 'tabpaint']}, 10:39:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:39:12 INFO - 'ts_paint', 10:39:12 INFO - 'tpaint', 10:39:12 INFO - 'sessionrestore', 10:39:12 INFO - 'sessionrestore_no_auto_restore', 10:39:12 INFO - 'tabpaint']}, 10:39:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:39:12 INFO - 'ts_paint', 10:39:12 INFO - 'tpaint', 10:39:12 INFO - 'sessionrestore', 10:39:12 INFO - 'sessionrestore_no_auto_restore', 10:39:12 INFO - 'tabpaint']}, 10:39:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:39:12 INFO - 'tests': ['a11yr', 10:39:12 INFO - 'ts_paint', 10:39:12 INFO - 'tpaint', 10:39:12 INFO - 'sessionrestore', 10:39:12 INFO - 'sessionrestore_no_auto_restore', 10:39:12 INFO - 'tabpaint']}, 10:39:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:39:12 INFO - 'tests': ['a11yr', 10:39:12 INFO - 'ts_paint', 10:39:12 INFO - 'tpaint', 10:39:12 INFO - 'sessionrestore', 10:39:12 INFO - 'sessionrestore_no_auto_restore', 10:39:12 INFO - 'tabpaint']}, 10:39:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:39:12 INFO - 'tests': ['tsvgx', 10:39:12 INFO - 'tsvgr_opacity', 10:39:12 INFO - 'tart', 10:39:12 INFO - 'tscrollx', 10:39:12 INFO - 'cart', 10:39:12 INFO - 'tsvg_static']}, 10:39:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:39:12 INFO - 'tsvgr_opacity', 10:39:12 INFO - 'tart', 10:39:12 INFO - 'tscrollx', 10:39:12 INFO - 'cart', 10:39:12 INFO - 'tsvg_static']}, 10:39:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:39:12 INFO - 'talos_options': ['--disable-e10s'], 10:39:12 INFO - 'tests': ['tp5o']}, 10:39:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:39:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:39:12 INFO - 'talos_options': ['--disable-e10s', 10:39:12 INFO - '--xperf_path', 10:39:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:39:12 INFO - 'tests': ['tp5n']}, 10:39:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:39:12 INFO - 'talos_options': ['--xperf_path', 10:39:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:39:12 INFO - 'tests': ['tp5n']}}, 10:39:12 INFO - 'talos.zip': {'path': '', 10:39:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:39:12 INFO - Running post-action listener: _resource_record_post_action 10:39:12 INFO - [mozharness: 2016-12-13 18:39:12.006004Z] Finished populate-webroot step (success) 10:39:12 INFO - [mozharness: 2016-12-13 18:39:12.006111Z] Running create-virtualenv step. 10:39:12 INFO - Running pre-action listener: _resource_record_pre_action 10:39:12 INFO - Running main action method: create_virtualenv 10:39:12 INFO - Creating virtualenv /builds/slave/test/build/venv 10:39:12 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 10:39:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:39:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:39:12 INFO - Using real prefix '/tools/python27' 10:39:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:39:12 INFO - Installing distribute.............................................................................................................................................................................................done. 10:39:15 INFO - Installing pip.................done. 10:39:15 INFO - Return code: 0 10:39:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:39:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:39:15 INFO - Reading from file tmpfile_stdout 10:39:15 INFO - Output received: 10:39:15 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) 10:39:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:39:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:16 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 0x104e6b3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104de1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa618572500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c80d30>, '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 0x104ae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c78b20>, '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.dfBtSggJSq/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.Y1HHKVYHIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 10:39:16 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 10:39:16 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 10:39:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dfBtSggJSq/Render', 10:39:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:16 INFO - 'HOME': '/Users/cltbld', 10:39:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:16 INFO - 'LOGNAME': 'cltbld', 10:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:16 INFO - 'MOZ_NO_REMOTE': '1', 10:39:16 INFO - 'NO_EM_RESTART': '1', 10:39:16 INFO - 'PAGER': '/bin/cat', 10:39:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:16 INFO - 'PWD': '/builds/slave/test', 10:39:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:16 INFO - 'SHELL': '/bin/bash', 10:39:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y1HHKVYHIJ/Listeners', 10:39:16 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 10:39:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:16 INFO - 'USER': 'cltbld', 10:39:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:16 INFO - 'XPC_FLAGS': '0x0', 10:39:16 INFO - 'XPC_SERVICE_NAME': '0', 10:39:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:16 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 10:39:16 INFO - Cleaning up... 10:39:16 INFO - Return code: 0 10:39:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:39:16 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')]} 10:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:16 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')]} 10:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104e6b3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104de1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa618572500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c80d30>, '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 0x104ae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c78b20>, '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.dfBtSggJSq/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.Y1HHKVYHIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 10:39:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:39:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dfBtSggJSq/Render', 10:39:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:17 INFO - 'HOME': '/Users/cltbld', 10:39:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:17 INFO - 'LOGNAME': 'cltbld', 10:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:17 INFO - 'MOZ_NO_REMOTE': '1', 10:39:17 INFO - 'NO_EM_RESTART': '1', 10:39:17 INFO - 'PAGER': '/bin/cat', 10:39:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:17 INFO - 'PWD': '/builds/slave/test', 10:39:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:17 INFO - 'SHELL': '/bin/bash', 10:39:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y1HHKVYHIJ/Listeners', 10:39:17 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 10:39:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:17 INFO - 'USER': 'cltbld', 10:39:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:17 INFO - 'XPC_FLAGS': '0x0', 10:39:17 INFO - 'XPC_SERVICE_NAME': '0', 10:39:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:17 INFO - Downloading/unpacking psutil>=3.1.1 10:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:39:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:39:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:39:20 INFO - Installing collected packages: psutil 10:39:20 INFO - Running setup.py install for psutil 10:39:20 INFO - building 'psutil._psutil_osx' extension 10:39:20 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 10:39:21 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 10:39:21 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 10:39:21 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 10:39:21 INFO - building 'psutil._psutil_posix' extension 10:39:21 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 10:39:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:39:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:39:21 INFO - ^ 10:39:21 INFO - 1 warning generated. 10:39:21 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 10:39:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:39:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:39:21 INFO - Successfully installed psutil 10:39:21 INFO - Cleaning up... 10:39:21 INFO - Return code: 0 10:39:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:39:21 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')]} 10:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:21 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')]} 10:39:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:21 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 0x104e6b3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104de1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa618572500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c80d30>, '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 0x104ae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c78b20>, '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.dfBtSggJSq/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.Y1HHKVYHIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 10:39:21 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 10:39:21 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 10:39:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dfBtSggJSq/Render', 10:39:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:21 INFO - 'HOME': '/Users/cltbld', 10:39:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:21 INFO - 'LOGNAME': 'cltbld', 10:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:21 INFO - 'MOZ_NO_REMOTE': '1', 10:39:21 INFO - 'NO_EM_RESTART': '1', 10:39:21 INFO - 'PAGER': '/bin/cat', 10:39:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:21 INFO - 'PWD': '/builds/slave/test', 10:39:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:21 INFO - 'SHELL': '/bin/bash', 10:39:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y1HHKVYHIJ/Listeners', 10:39:21 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 10:39:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:21 INFO - 'USER': 'cltbld', 10:39:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:21 INFO - 'XPC_FLAGS': '0x0', 10:39:21 INFO - 'XPC_SERVICE_NAME': '0', 10:39:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:39: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 10:39: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 10:39: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 10:39: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 10:39: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 10:39: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 10:39:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:39:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:39:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:39:24 INFO - Installing collected packages: mozsystemmonitor 10:39:24 INFO - Running setup.py install for mozsystemmonitor 10:39:24 INFO - Successfully installed mozsystemmonitor 10:39:24 INFO - Cleaning up... 10:39:24 INFO - Return code: 0 10:39:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104e6b3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104de1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa618572500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c80d30>, '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 0x104ae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c78b20>, '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.dfBtSggJSq/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.Y1HHKVYHIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 10:39:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:39:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:39:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dfBtSggJSq/Render', 10:39:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:24 INFO - 'HOME': '/Users/cltbld', 10:39:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:24 INFO - 'LOGNAME': 'cltbld', 10:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:24 INFO - 'MOZ_NO_REMOTE': '1', 10:39:24 INFO - 'NO_EM_RESTART': '1', 10:39:24 INFO - 'PAGER': '/bin/cat', 10:39:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:24 INFO - 'PWD': '/builds/slave/test', 10:39:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:24 INFO - 'SHELL': '/bin/bash', 10:39:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y1HHKVYHIJ/Listeners', 10:39:24 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 10:39:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:24 INFO - 'USER': 'cltbld', 10:39:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:24 INFO - 'XPC_FLAGS': '0x0', 10:39:24 INFO - 'XPC_SERVICE_NAME': '0', 10:39:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:25 INFO - Downloading/unpacking jsonschema==2.5.1 10:39:25 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 10:39:25 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 10:39:25 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 10:39:25 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 10:39:25 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 10:39:25 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 10:39:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:39:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:39: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 10:39: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 10:39: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 10:39: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 10:39: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 10:39: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 10:39:28 INFO - Downloading functools32-3.2.3-2.tar.gz 10:39:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:39:28 INFO - warning: no files found matching '*.txt' 10:39:28 INFO - no previously-included directories found matching 'build' 10:39:28 INFO - no previously-included directories found matching 'dist' 10:39:28 INFO - no previously-included directories found matching '.git*' 10:39:28 INFO - Installing collected packages: jsonschema, functools32 10:39:28 INFO - Running setup.py install for functools32 10:39:28 INFO - warning: no files found matching '*.txt' 10:39:28 INFO - no previously-included directories found matching 'build' 10:39:28 INFO - no previously-included directories found matching 'dist' 10:39:28 INFO - no previously-included directories found matching '.git*' 10:39:28 INFO - Successfully installed jsonschema functools32 10:39:28 INFO - Cleaning up... 10:39:28 INFO - Return code: 0 10:39:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:39:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:28 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 0x104e6b3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104de1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa618572500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c80d30>, '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 0x104ae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c78b20>, '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.dfBtSggJSq/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.Y1HHKVYHIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 10:39:28 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 10:39:28 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 10:39:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dfBtSggJSq/Render', 10:39:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:28 INFO - 'HOME': '/Users/cltbld', 10:39:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:28 INFO - 'LOGNAME': 'cltbld', 10:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:28 INFO - 'MOZ_NO_REMOTE': '1', 10:39:28 INFO - 'NO_EM_RESTART': '1', 10:39:28 INFO - 'PAGER': '/bin/cat', 10:39:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:28 INFO - 'PWD': '/builds/slave/test', 10:39:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:28 INFO - 'SHELL': '/bin/bash', 10:39:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y1HHKVYHIJ/Listeners', 10:39:28 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 10:39:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:28 INFO - 'USER': 'cltbld', 10:39:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:28 INFO - 'XPC_FLAGS': '0x0', 10:39:28 INFO - 'XPC_SERVICE_NAME': '0', 10:39:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:39:28 INFO - Cleaning up... 10:39:28 INFO - Return code: 0 10:39:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:39:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:28 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 0x104e6b3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104de1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa618572500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c80d30>, '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 0x104ae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c78b20>, '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.dfBtSggJSq/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.Y1HHKVYHIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 10:39:28 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 10:39:28 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 10:39:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dfBtSggJSq/Render', 10:39:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:28 INFO - 'HOME': '/Users/cltbld', 10:39:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:28 INFO - 'LOGNAME': 'cltbld', 10:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:28 INFO - 'MOZ_NO_REMOTE': '1', 10:39:28 INFO - 'NO_EM_RESTART': '1', 10:39:28 INFO - 'PAGER': '/bin/cat', 10:39:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:28 INFO - 'PWD': '/builds/slave/test', 10:39:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:28 INFO - 'SHELL': '/bin/bash', 10:39:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y1HHKVYHIJ/Listeners', 10:39:28 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 10:39:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:28 INFO - 'USER': 'cltbld', 10:39:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:28 INFO - 'XPC_FLAGS': '0x0', 10:39:28 INFO - 'XPC_SERVICE_NAME': '0', 10:39:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:29 INFO - Downloading/unpacking blobuploader==1.2.4 10:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:31 INFO - Downloading blobuploader-1.2.4.tar.gz 10:39:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:39:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:39:31 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 10:39:31 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 10:39:31 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 10:39:31 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 10:39:31 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 10:39:31 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 10:39:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:39:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:39:32 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 10:39:32 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 10:39:32 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 10:39:32 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 10:39:32 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 10:39:32 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 10:39:32 INFO - Downloading docopt-0.6.1.tar.gz 10:39:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:39:32 INFO - Installing collected packages: blobuploader, requests, docopt 10:39:32 INFO - Running setup.py install for blobuploader 10:39:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:39:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:39:33 INFO - Running setup.py install for requests 10:39:33 INFO - Running setup.py install for docopt 10:39:33 INFO - Successfully installed blobuploader requests docopt 10:39:33 INFO - Cleaning up... 10:39:33 INFO - Return code: 0 10:39:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:33 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 0x104e6b3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104de1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa618572500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c80d30>, '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 0x104ae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c78b20>, '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.dfBtSggJSq/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.Y1HHKVYHIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 10:39:33 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 10:39:33 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 10:39:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dfBtSggJSq/Render', 10:39:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:33 INFO - 'HOME': '/Users/cltbld', 10:39:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:33 INFO - 'LOGNAME': 'cltbld', 10:39:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:33 INFO - 'MOZ_NO_REMOTE': '1', 10:39:33 INFO - 'NO_EM_RESTART': '1', 10:39:33 INFO - 'PAGER': '/bin/cat', 10:39:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:33 INFO - 'PWD': '/builds/slave/test', 10:39:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:33 INFO - 'SHELL': '/bin/bash', 10:39:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y1HHKVYHIJ/Listeners', 10:39:33 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 10:39:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:33 INFO - 'USER': 'cltbld', 10:39:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:33 INFO - 'XPC_FLAGS': '0x0', 10:39:33 INFO - 'XPC_SERVICE_NAME': '0', 10:39:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:39:34 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-c2kpHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:39:34 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-tlI1_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:39:34 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-qZCq11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:39:34 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-rq5fkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:39:34 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-18ZOFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:39:34 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-uj1nfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:39:34 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-8MsfLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:39:34 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Vr7a3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:39:34 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-6usLgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:39:34 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Hx0dtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:39:35 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-eFICqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:39:35 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-vBO5EA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:39:35 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-02q43M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:39:35 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-SdCIoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:39:35 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-DIPCLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:39:35 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-2lvIOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:39:35 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-xrQoZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:39:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:39:35 INFO - Running setup.py install for manifestparser 10:39:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:39:35 INFO - Running setup.py install for mozcrash 10:39:36 INFO - Running setup.py install for mozdebug 10:39:36 INFO - Running setup.py install for mozdevice 10:39:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:39:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:39:36 INFO - Running setup.py install for mozfile 10:39:36 INFO - Running setup.py install for mozhttpd 10:39:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:39:36 INFO - Running setup.py install for mozinfo 10:39:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:39:36 INFO - Running setup.py install for mozInstall 10:39:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:39:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:39:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:39:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:39:37 INFO - Running setup.py install for mozleak 10:39:37 INFO - Running setup.py install for mozlog 10:39:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:39:37 INFO - Running setup.py install for moznetwork 10:39:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:39:37 INFO - Running setup.py install for mozprocess 10:39:37 INFO - Running setup.py install for mozprofile 10:39:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:39:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:39:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:39:37 INFO - Running setup.py install for mozrunner 10:39:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:39:37 INFO - Running setup.py install for mozscreenshot 10:39:38 INFO - Running setup.py install for moztest 10:39:38 INFO - Running setup.py install for mozversion 10:39:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:39:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:39:38 INFO - Cleaning up... 10:39:38 INFO - Return code: 0 10:39:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:39:38 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')]} 10:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:38 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')]} 10:39:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:38 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 0x104e6b3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104de1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa618572500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c80d30>, '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 0x104ae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c78b20>, '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.dfBtSggJSq/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.Y1HHKVYHIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 10:39:38 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 10:39:38 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 10:39:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dfBtSggJSq/Render', 10:39:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:38 INFO - 'HOME': '/Users/cltbld', 10:39:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:38 INFO - 'LOGNAME': 'cltbld', 10:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:38 INFO - 'MOZ_NO_REMOTE': '1', 10:39:38 INFO - 'NO_EM_RESTART': '1', 10:39:38 INFO - 'PAGER': '/bin/cat', 10:39:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:38 INFO - 'PWD': '/builds/slave/test', 10:39:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:38 INFO - 'SHELL': '/bin/bash', 10:39:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y1HHKVYHIJ/Listeners', 10:39:38 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 10:39:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:38 INFO - 'USER': 'cltbld', 10:39:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:38 INFO - 'XPC_FLAGS': '0x0', 10:39:38 INFO - 'XPC_SERVICE_NAME': '0', 10:39:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:39:38 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-kLkEII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:39:38 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)) 10:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:39:38 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-VQSnQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:39:38 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)) 10:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:39:38 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-GkCDeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:39:39 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)) 10:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:39:39 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-f_EHyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:39:39 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)) 10:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:39:39 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-9ouBfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:39:39 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)) 10:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:39:39 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-haML6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:39:39 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)) 10:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:39:39 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-t3tKAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:39:39 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)) 10:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:39:39 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-sxFN2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:39:39 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)) 10:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:39:39 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-qVK_88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:39:39 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)) 10:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:39:39 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-OxE06g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:39:39 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)) 10:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:39:39 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-ZbX0Pc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:39:39 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)) 10:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:39:39 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-xN7E8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:39:39 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)) 10:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:39:39 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-mu2nnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:39:40 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)) 10:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:39:40 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-O3ngkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:39:40 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)) 10:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:39:40 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Ebkztj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:39:40 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)) 10:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:39:40 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-HVwYav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:39:40 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)) 10:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:39:40 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-md7KRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:39:40 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)) 10:39:40 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)) 10:39:40 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)) 10:39:40 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)) 10:39:40 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)) 10:39:40 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)) 10:39:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:43 INFO - Downloading blessings-1.6.tar.gz 10:39:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:39:43 INFO - Installing collected packages: blessings 10:39:43 INFO - Running setup.py install for blessings 10:39:43 INFO - Successfully installed blessings 10:39:43 INFO - Cleaning up... 10:39:43 INFO - Return code: 0 10:39:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:39:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:39:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:39:43 INFO - Reading from file tmpfile_stdout 10:39:43 INFO - Current package versions: 10:39:43 INFO - blessings == 1.6 10:39:43 INFO - blobuploader == 1.2.4 10:39:43 INFO - docopt == 0.6.1 10:39:43 INFO - functools32 == 3.2.3-2 10:39:43 INFO - jsonschema == 2.5.1 10:39:43 INFO - manifestparser == 1.1 10:39:43 INFO - mozInstall == 1.12 10:39:43 INFO - mozcrash == 1.0 10:39:43 INFO - mozdebug == 0.1 10:39:43 INFO - mozdevice == 0.49 10:39:43 INFO - mozfile == 1.2 10:39:43 INFO - mozhttpd == 0.7 10:39:43 INFO - mozinfo == 0.9 10:39:43 INFO - mozleak == 0.1 10:39:43 INFO - mozlog == 3.4 10:39:43 INFO - moznetwork == 0.27 10:39:43 INFO - mozprocess == 0.23 10:39:43 INFO - mozprofile == 0.28 10:39:43 INFO - mozrunner == 6.13 10:39:43 INFO - mozscreenshot == 0.1 10:39:43 INFO - mozsystemmonitor == 0.3 10:39:43 INFO - moztest == 0.7 10:39:43 INFO - mozversion == 1.4 10:39:43 INFO - psutil == 3.1.1 10:39:43 INFO - requests == 1.2.3 10:39:43 INFO - wsgiref == 0.1.2 10:39:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:39:43 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')]} 10:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:43 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')]} 10:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:43 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 0x104e6b3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104de1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa618572500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c80d30>, '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 0x104ae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c78b20>, '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.dfBtSggJSq/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.Y1HHKVYHIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 10:39:43 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 10:39:43 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 10:39:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dfBtSggJSq/Render', 10:39:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:43 INFO - 'HOME': '/Users/cltbld', 10:39:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:43 INFO - 'LOGNAME': 'cltbld', 10:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:43 INFO - 'MOZ_NO_REMOTE': '1', 10:39:43 INFO - 'NO_EM_RESTART': '1', 10:39:43 INFO - 'PAGER': '/bin/cat', 10:39:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:43 INFO - 'PWD': '/builds/slave/test', 10:39:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:43 INFO - 'SHELL': '/bin/bash', 10:39:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y1HHKVYHIJ/Listeners', 10:39:43 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 10:39:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:43 INFO - 'USER': 'cltbld', 10:39:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:43 INFO - 'XPC_FLAGS': '0x0', 10:39:43 INFO - 'XPC_SERVICE_NAME': '0', 10:39:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:44 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)) 10:39:44 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)) 10:39:44 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)) 10:39:44 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)) 10:39:44 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)) 10:39:44 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)) 10:39:44 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)) 10:39:44 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)) 10:39:44 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)) 10:39:44 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)) 10:39:44 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)) 10:39:44 INFO - Cleaning up... 10:39:44 INFO - Return code: 0 10:39:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:39: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')]} 10:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39: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')]} 10:39:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:44 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 0x104e6b3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104de1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa618572500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c80d30>, '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 0x104ae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c78b20>, '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.dfBtSggJSq/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.Y1HHKVYHIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 10:39:44 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 10:39:44 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 10:39:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dfBtSggJSq/Render', 10:39:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:44 INFO - 'HOME': '/Users/cltbld', 10:39:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:44 INFO - 'LOGNAME': 'cltbld', 10:39:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:44 INFO - 'MOZ_NO_REMOTE': '1', 10:39:44 INFO - 'NO_EM_RESTART': '1', 10:39:44 INFO - 'PAGER': '/bin/cat', 10:39:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:44 INFO - 'PWD': '/builds/slave/test', 10:39:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:44 INFO - 'SHELL': '/bin/bash', 10:39:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y1HHKVYHIJ/Listeners', 10:39:44 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 10:39:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:44 INFO - 'USER': 'cltbld', 10:39:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:44 INFO - 'XPC_FLAGS': '0x0', 10:39:44 INFO - 'XPC_SERVICE_NAME': '0', 10:39:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:39:44 INFO - Cleaning up... 10:39:44 INFO - Return code: 0 10:39:44 INFO - Running post-action listener: _resource_record_post_action 10:39:44 INFO - Running post-action listener: _start_resource_monitoring 10:39:44 INFO - Starting resource monitoring. 10:39:44 INFO - [mozharness: 2016-12-13 18:39:44.329889Z] Finished create-virtualenv step (success) 10:39:44 INFO - [mozharness: 2016-12-13 18:39:44.330866Z] Running install step. 10:39:44 INFO - Running pre-action listener: _resource_record_pre_action 10:39:44 INFO - Running main action method: install 10:39:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:39:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:39:44 INFO - Reading from file tmpfile_stdout 10:39:44 INFO - Detecting whether we're running mozinstall >=1.0... 10:39:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:39:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:39:44 INFO - Reading from file tmpfile_stdout 10:39:44 INFO - Output received: 10:39:44 INFO - Usage: mozinstall [options] installer 10:39:44 INFO - Options: 10:39:44 INFO - -h, --help show this help message and exit 10:39:44 INFO - -d DEST, --destination=DEST 10:39:44 INFO - Directory to install application into. [default: 10:39:44 INFO - "/builds/slave/test"] 10:39:44 INFO - --app=APP Application being installed. [default: firefox] 10:39:44 INFO - mkdir: /builds/slave/test/build/application 10:39:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg', '--destination', '/builds/slave/test/build/application'] 10:39:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg --destination /builds/slave/test/build/application 10:40:06 INFO - Reading from file tmpfile_stdout 10:40:06 INFO - Output received: 10:40:06 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:40:06 INFO - Running post-action listener: _resource_record_post_action 10:40:06 INFO - [mozharness: 2016-12-13 18:40:06.279919Z] Finished install step (success) 10:40:06 INFO - [mozharness: 2016-12-13 18:40:06.280067Z] Running run-tests step. 10:40:06 INFO - Running pre-action listener: _resource_record_pre_action 10:40:06 INFO - Running main action method: run_tests 10:40:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:40:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:40:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:40:06 INFO - 2016-12-13 10:40:06.294 screenresolution[1909:14315] starting screenresolution argv=screenresolution get 10:40:06 INFO - 2016-12-13 10:40:06.297 screenresolution[1909:14315] Display 0: 1600x1200x32@60 10:40:06 INFO - 2016-12-13 10:40:06.303 screenresolution[1910:14317] starting screenresolution argv=screenresolution list 10:40:06 INFO - Available Modes on Display 0 10:40:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:40:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:40:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:40:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:40:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:40:06 INFO - Intel Iris: 10:40:06 INFO - Chipset Model: Intel Iris 10:40:06 INFO - Type: GPU 10:40:06 INFO - Bus: Built-In 10:40:06 INFO - VRAM (Dynamic, Max): 1536 MB 10:40:06 INFO - Vendor: Intel (0x8086) 10:40:06 INFO - Device ID: 0x0a2e 10:40:06 INFO - Revision ID: 0x0009 10:40:06 INFO - Displays: 10:40:06 INFO - Display: 10:40:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:40:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:40:06 INFO - Display Serial Number: 1600x1200 60 10:40:06 INFO - Main Display: Yes 10:40:06 INFO - Mirror: Off 10:40:06 INFO - Online: Yes 10:40:06 INFO - Rotation: Supported 10:40:06 INFO - Return code: 0 10:40:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:40:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:40:06 INFO - Python 2.7.3 10:40:06 INFO - Return code: 0 10:40:06 INFO - grabbing minidump binary from tooltool 10:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:06 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 0x104c80d30>, '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 0x104ae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c78b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:40:06 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 10:40:06 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 10:40:06 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 10:40:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:40:06 INFO - Return code: 0 10:40:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:40:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:40:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:40:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:40:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:40:06 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/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0320', '--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 10:40:06 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/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip --title t-yosemite-r7-0320 --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 10:40:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dfBtSggJSq/Render', 10:40:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:40:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:40:06 INFO - 'HOME': '/Users/cltbld', 10:40:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:40:06 INFO - 'LOGNAME': 'cltbld', 10:40:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:40:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:06 INFO - 'MOZ_NO_REMOTE': '1', 10:40:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:40:06 INFO - 'NO_EM_RESTART': '1', 10:40:06 INFO - 'PAGER': '/bin/cat', 10:40:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:06 INFO - 'PWD': '/builds/slave/test', 10:40:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:40:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:40:06 INFO - 'SHELL': '/bin/bash', 10:40:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y1HHKVYHIJ/Listeners', 10:40:06 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 10:40:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:40:06 INFO - 'USER': 'cltbld', 10:40:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:40:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:06 INFO - 'XPC_FLAGS': '0x0', 10:40:06 INFO - 'XPC_SERVICE_NAME': '0', 10:40:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:40:06 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/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0320', '--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 10:40:06 INFO - mozversion application_buildid: 20161213091200 10:40:06 INFO - mozversion application_changeset: 489f981e8c2beb050d7faee956dd940431bdafe6 10:40:06 INFO - mozversion application_display_name: Nightly 10:40:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:40:06 INFO - mozversion application_name: Firefox 10:40:06 INFO - mozversion application_remotingname: firefox 10:40:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:40:06 INFO - mozversion application_vendor: Mozilla 10:40:06 INFO - mozversion application_version: 53.0a1 10:40:06 INFO - mozversion platform_buildid: 20161213091200 10:40:06 INFO - mozversion platform_changeset: 489f981e8c2beb050d7faee956dd940431bdafe6 10:40:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:40:06 INFO - mozversion platform_version: 53.0a1 10:40:06 INFO - using testdate: 1481654406 10:40:06 INFO - actual date: 1481654406 10:40:06 INFO - starting webserver on 'localhost:51503' 10:40:06 INFO - SUITE-START | Running 2 tests 10:40:06 INFO - TEST-START | dromaeo_css 10:40:06 INFO - operating with platform_type : mac_ 10:40:06 INFO - Initialising browser for dromaeo_css test... 10:40:06 INFO - TEST-INFO | started process 1920 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpACLJ4y/profile http://localhost:51503/getInfo.html) 10:40:09 INFO - PROCESS | 1920 | __metrics Screen width/height:1600/1200 10:40:09 INFO - PROCESS | 1920 | colorDepth:24 10:40:09 INFO - PROCESS | 1920 | Browser inner width/height: 1024/689 10:40:09 INFO - PROCESS | 1920 | __metrics 10:40:09 INFO - PROCESS | 1920 | 2016-12-13 10:40:09.675 plugin-container[1922:14471] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a47, name = 'com.apple.tsm.portname' 10:40:09 INFO - PROCESS | 1920 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:40:09 INFO - PROCESS | 1920 | 2016-12-13 10:40:09.679 plugin-container[1922:14471] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9223, name = 'com.apple.CFPasteboardClient' 10:40:09 INFO - PROCESS | 1920 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:40:09 INFO - PROCESS | 1920 | 2016-12-13 10:40:09.680 plugin-container[1922:14471] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:40:09 ERROR - PROCESS | 1920 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3212: TypeError: this.tabs is undefined 10:40:10 INFO - TEST-INFO | 1920: exit 0 10:40:10 INFO - Browser initialized. 10:40:10 INFO - Running cycle 1/1 for dromaeo_css test... 10:40:10 INFO - TEST-INFO | started process 1923 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpACLJ4y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:40:12 INFO - PROCESS | 1923 | 2016-12-13 10:40:12.723 plugin-container[1924:14592] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3f, name = 'com.apple.tsm.portname' 10:40:12 INFO - PROCESS | 1923 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:40:12 INFO - PROCESS | 1923 | 2016-12-13 10:40:12.724 plugin-container[1924:14592] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x431b, name = 'com.apple.CFPasteboardClient' 10:40:12 INFO - PROCESS | 1923 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:40:12 INFO - PROCESS | 1923 | 2016-12-13 10:40:12.724 plugin-container[1924:14592] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:40:22 INFO - PROCESS | 1923 | RSS: Main: 237166592 10:40:22 INFO - PROCESS | 1923 | 10:41:12 INFO - PROCESS | 1923 | 1481654472104 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] 10:43:25 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:51503/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51503/tests/dromaeo/cssquery-ext.html) 10:43:26 INFO - PROCESS | 1923 | RSS: Main: 258220032 10:43:26 INFO - PROCESS | 1923 | 10:46:29 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:51503/tests/dromaeo/cssquery-ext.html (next: http://localhost:51503/tests/dromaeo/cssquery-jquery.html) 10:46:30 INFO - PROCESS | 1923 | RSS: Main: 266895360 10:46:30 INFO - PROCESS | 1923 | 10:49:32 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:51503/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51503/tests/dromaeo/cssquery-mootools.html) 10:49:32 INFO - PROCESS | 1923 | RSS: Main: 272052224 10:49:32 INFO - PROCESS | 1923 | 10:52:34 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:51503/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51503/tests/dromaeo/cssquery-prototype.html) 10:52:35 INFO - PROCESS | 1923 | RSS: Main: 270790656 10:52:35 INFO - PROCESS | 1923 | 10:55:38 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:51503/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51503/tests/dromaeo/cssquery-yui.html) 10:55:38 INFO - PROCESS | 1923 | RSS: Main: 276103168 10:55:38 INFO - PROCESS | 1923 | 10:58:41 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:51503/tests/dromaeo/cssquery-yui.html (next: http://localhost:51503/tests/dromaeo/cssquery-dojo.html) 10:58:41 INFO - PROCESS | 1923 | RSS: Main: 279072768 10:58:41 INFO - PROCESS | 1923 | 10:58:41 INFO - PROCESS | 1923 | __start_tp_report 10:58:41 INFO - PROCESS | 1923 | _x_x_mozilla_page_load 10:58:41 INFO - PROCESS | 1923 | _x_x_mozilla_page_load_details 10:58:41 INFO - PROCESS | 1923 | |i|pagename|runs| 10:58:41 INFO - PROCESS | 1923 | |0;dojo.html;3367.2255381262307;3371.5616969793923;3373.443381841996;3391.77953433027;3410.7782994105382;5620.353659329178;5675.290588676416;5697.914531282029;5705.372409035002;5713.857153571153;4708.599769019637;5597.328320601523;5654.688992105433;5694.5729070319785;5718.513926316268;5142.717150556737;5167;5191.896162076775;5206.245094461301;5220.947790522103;5142.511461411179;5167.250748641463;5223.112070947948;5261.552768014704;5281.075811732951;5184.922226166611;5230.450802665741;5247.47525247476;5255.527002569787;5281.075811732951;5096.210087436453;5100.15847385181;5126.154184559543;5173.17229243323;5178.9900969311;5016.49835016499;5093.312402825608;5114.028334616411;5116.718580478109;5145.6398052136365;4467.687261891669;4808.797800549863;5210.192420174879;5538.47384498476;5689.715514224272;6068.423499767515;6110.480609148228;6139.048447490646;6146.29317628474;6162.445379915829;6038.969805150946;6094.238220222473;6119.204503414572;6120.1737765401995;6146.969265153645;5752.108423194411;5786.103154011135;5806.88386232273;5807.767689292381;5851.444112809277;6212.099245609361;6262.624242545371;6280.246370435577;6307.716152773136;6361.554691171574;4995.200767877122;6122.112293717475;6131.448169664663;6141.6007959482495;6145.938540614537;5252.9737351313;6076.5442591805795;6126.264848218242;6141.600795948339;6187.690615469299;5507.256520369779;6118.497354392036;6119.99004232014;6124.601900876429;6144.262688477412;5625.578081643893;6135.785247516315;6181.443670069715;6187.16473276111;6201.720922558496;4899.240617704261;4900.803967841246;4925.187344088257;4958.206686930074;4961.801527938915;4345.456817897762;4350.390945267665;4364.367166760865;4374.212641724456;4378.233809083461;5858.882822343529;5860.355360910296;5873.58884878063;5894.17481552583;5936.7328470218945;6175.536834737412;6182.814515564541;6185.907211391833;6208.068789681493;6213.1922850029205;5665.6034077614995;5725.627834190765;5738.225339579187;5801.245838041112;5843.328017277982;4388;5366.007288651612;5373.838784836461;5380.569554435636;5381.354237491526;6207.379262073757;6228.875422491434;6292.402221788922;6297.748090076438;6300.21247344082;6158.414950579688;6167.198264225622;6176.69116544162;6181.412765787243;6196.194494715838;6382.680865956777;6385.106085148176;6385.840353991001;6388.361163883575;6432.09950606906;6049.485793707584;6087;6120.632762034114;6154.3845615438095;6159.19930409044;6117.796956032775;6145.9692701536205;6160.075988601746;6205.937940620716;6237.220347456568;5967.791127310524;6084.939150608614;6095.939040609537;6098.207233059674;6122.479589234965;5884.705764711833;5942.58401911862;6062.878742425215;6081.483073938764;6089.238845144357;5696.946064977992;5873.882522349614;5884.205632239593;5887.087501437284;5930.021546444961;5991.8915000725;6062.575619706578;6106.786262480792;6128.325884152829;6134.202553668173;4939.580135688507;5899.587028908107;5932.673702946379;5951.791687290924;5964.970175149097 10:58:41 INFO - PROCESS | 1923 | |1;ext.html;419.47146595289934;451.30048424941333;464.275729861416;468.48232702863356;510.08439850468403;31395.215119621993;41239;41351.79324103375;41417;43497.565024349744;41891.790541047325;42439.575604243946;42451.15097698052;42495.78752106235;42512;8411.747647570552;9384.81230375392;9603.759906002371;9652.662156824512;9687.5640596173;8528.78678033051;11284.322940623548;11565.768684626302;11589.014933730601;11754.118441116907;11490.827637585442;11501.539938402453;11549;11560.59537916173;11578.363190024545;11401.258918170333;11431.714207144805;11445.484953177127;11446.027087697597;11504.827427588592;11371.545138194546;11415;11443.542258309657;11452.484638191301;11454.885451145465;39687.80156099201;39860.202795944206;39985.400218996445;40115.197696046205;40151;3238.789478683878;3316.7346612271203;3481.8085005324697;3541.557305336833;3783.1298801275584;27353.632318384;30067.548986765218;30407.543886841715;30524.69475305241;31111;3041.330907200412;3044.8325342106177;3073.8770449182007;3087.938241235163;3121.4069326828057;476344;476406;484531;484594.1540584584;485538.57230713975;48049.519504805205;58912.05439728082;59038.70480647569;59157.112643310385;59418.81162376728;48238.75880620575;61730;61922.69038654778;62663.373366266664;62783.17475713604;15704.214789260492;15874.920625396799;15909.920450397674;15943;15949.441769538242;11239.887601124048;11507.482163302671;12301.384930753427;12419.813702794465;12421.689457763629;13472.393742281622;15985.840141598668;16488.422905198262;16491.34034638601;16527.173641317888;5931.466168044896;6510.511711621647;6644.933550664528;6662.600243985376;6669.733210671616;818;855.5251835231506;916.4776077635817;938.9155525368211;1000.2897942460934;28687.713122868503;29617.407651846843;29935.850320748257;29957.70042299549;30332.393352133276;872.9437380769214;954.399792997758;986.5166068626321;1065.093482666019;1092.4046394714899;13238.470461181638;15545.611359715871;15628.921855390878;15745.524060514246;15829.762553561706;603937.7637341773;606214;608738;609065;610154;57821.13268300979;57887.71056144776;58105.418945810845;58135.418645813;58173.41826581764;1373.3133433283358;1381.4750394849893;1382.163790906487;1393.7491251574813;1396.9930150349182;28863.7113628861;29558.852205738833;29574.704252958054;30411.391772163992;30482.542761859033;49870.75323116951;50125.24812127748;50152.99694006173;50191.49808502015;50225.74887125541;532327;534037;534201;535625;536155;38595.421068684554;38947;39212.803935981276;39779.801100995464;39855.601443985186;43300.56699433091;43672.56327436812;45492.77253613843;47033;47343.81640458878;38144;38403.807980959915;38560.42159367556;39524.01189970274;39977;38168.61831381651;38313.808430957666;38801.02997425087;39399.606003939596;39563.604363955994;37564;38027.42958855675;38177.809110954266;38311.42532861954;38393.23213535769;32348.35303293874;32961.01116966495;33288.00135995924;33289.334213316084;34435.31129377449;21851;22752.658710119693;25240;25730.228093157235;25984.960601575724 10:58:41 INFO - PROCESS | 1923 | |2;jquery.html;362.88750487348926;367.5313974682279;368.6166386957564;378.97536660117106;393.3450804410655;18812.247510099598;19161.52096197594;19454.22183112674;19490.610187796236;19662.21351145956;11709.59016434425;11848.407579621027;11933.34366609836;12091;12108.394580270995;4119.4644696189525;5240.161574148137;5298.09932311508;5352.304200453936;5361.035013697533;3802.296575133609;4016.7991600419864;5303.23103150043;5343.786248550054;5612.943870561304;5324.973375133139;5752.539796816244;5900.055991041413;5974.014287642555;5987.970060149693;5732.254806875121;5914.615549989237;5970.731317090741;5974.522038236931;5981.371955944606;5735.283089613798;5742.483176514133;5742.913856292159;5745.482906538432;5759.136129580555;21484;23759.049638014458;24411.511769764682;24614.630780538126;24976.250712478653;2150.53763440861;2332.428555004035;2340.7659234076455;2427.5509030829353;2502.624606309068;9505.524723763854;10037.648682296158;10080.092791648787;11459.885401146048;14031.64920876976;1799.7660304160506;1850.8334249917436;1879.3610172541264;1910.1022519415992;1922.0774028466274;110147;112528.43735781351;112634;114346;115482;11161.776764464665;11356.148288878201;11371.090312774959;11395.316281023164;11623.186376953532;14370.784438233435;14376.35306411214;14389.28053597316;14415.92792036054;14434.473967055723;6616.503762217853;8079.757607271791;8237.46456480327;8305.37709671777;8408.2432581068;8102;8127.674893004332;8128.268455838885;8247.587620619064;8279.668813247403;3829.636184562462;4053.0677944073027;4407.515173330931;4479.70881892676;4511.526289739596;1646.538969088657;1730.4376077774523;1774.4144432337298;1833.1842131424435;1963.460048486649;825.9215374539409;906.9047749986288;908.3369140527452;924.8797656304637;971.3200759468259;17189.914050429667;18378.172982215834;18651.694381393172;20280.797192028185;21198.47003824917;841.2680967558264;882.5851849630664;914.9451032938046;943.7734943613483;947.625687853294;10709.518071686793;11179.776404471864;11203;11206.15953803468;11214.215004949576;500468;503238;512042.75914481503;515362;516091;114444.85555144509;117590.41204793921;120684;126219.36890315673;127485;981.1611072533025;985.2413641496008;1009.7223263602568;1063.3832377221192;1067.8451624514403;17284.13467511492;18063.63872722512;19119.426417207505;19778.208871645547;19960.70058949088;42225.35521092739;49357.50642493673;54544.18183727327;54719.17921231105;56314.1552876699;65554.36114097186;66178;77970.2202977963;78996.21003789888;79014.60492697729;6210.689465526796;8147.79630509242;8277.917220827714;8321.667133314842;8334.70828521023;10668.652896362788;12112.21270617407;13035.608931732064;13222.338883056002;13422.120903073774;11088.112950963743;11115.221934464833;11211.495482703134;11235.55057797679;11517.136214784092;8949.284057275272;9137.680181193893;10994;11097.611583594535;11216.831747523956;11234.382108984084;11318.377489238172;11511.366874821964;11615.361155136548;11713.472893719632;7898.052233731989;7944.245296696805;8229.95885020571;8230.259276665129;8251.133630968661;8324.292435143081;9453.905460945303;9914.900850991398;10360.481975901326;11097.33415995043 10:58:41 INFO - PROCESS | 1923 | |3;mootools.html;1378.9655258618534;1503.586628569145;1680.8823382363232;1813.6191399806048;1817.9909100454495;7490.400767938566;7612.923870761305;7761.961190194055;8461.830763384736;8507.149285071497;7856.9607151964165;8128.512289262649;8137.877931831013;8238;8255.876161857577;1911.6845720456108;2336.194013065498;2339;2340.719113706358;2345.4839935214227;2319.072371051576;2341.203990643181;2356.1871154451774;2364.042562762084;2375.0143690368564;2219.056900817154;2219.6004719150546;2237.5748607764554;2245.62947113726;2249.9887500562554;2257.57106149831;2291.633338665814;2318.5826551220775;2318.96521552176;2321.361625552978;2277.385106021365;2305.4927915858652;2336.9649455258186;2341.484873327865;2344.308429013445;8328.875066874001;8387.496750194947;8400.033996090468;8405.327573794082;8414.957925210334;5004.349434573519;5175.378954525443;5177.611679124081;5193.584513238932;5206.193040078794;3217.6943190396873;3331.933361332784;3450.0857272822723;3508.982455087734;3512.332656795201;1007.2646967713611;1027.9588816447333;1031.2008193649906;1047.4343854318658;1050.716306597222;10501.842472362921;10561.41912194829;10567.048965593056;10658.78682426347;10707.411092389915;4449.644028477714;4506.662000349987;4714.787834547454;4732.077244937204;4735.526447355306;9121.954390228006;9205.81588368229;9241.168294853362;9242.12199841014;9260.212881905114;5142.562882155059;5172.508611681884;5176.534111929945;5193.766280517386;5250.553702935294;4228.767417792051;4572.268437050056;4644.953550464452;4686.95313046872;4745.976270118627;3824.3116239077235;3830.0616348994677;3895.902602434962;3918.7256892017854;3959.089409435846;1108.8855700021427;1262.3435813377175;1274.0635632809876;1278.3735969374939;1295.591888555102;690.1132045321738;739.4897520710692;781.6638845296463;917.4128557723062;930.8464103422995;5470.781168753205;5474.616776825584;5522.199281104217;5646.943530564724;5875.265591801025;882.148726478951;893.8525143351275;912.2200518556539;946.2335508238349;988.8417853143462;3683.2081102562543;3733.8879833605033;3793.696504279651;3851.6340947610493;3924.941125883114;9634.421934683802;10016.499175041365;10021.09810117093;10051.296409251428;10053.994600539887;8842.381033327734;9537;9808.36245644045;9884.406935583887;10016.599336026624;6156.415140561639;7625.69497220116;7708.768736937901;7828.2954534092205;7848.686052557834;5064.898702026013;5414.675119492843;5671.801486948102;5801.970990145022;5876.588638795243;8940.821183576421;9028.909710902806;9098.454092754457;9191.402558833654;9281.978982312075;7583.810404739926;9144.725658229998;9160.175584197454;9225.031371706144;9233.261339092991;6504.056911747675;6661.600303981777;6984.301569842975;7061.717531298896;7297.890531641923;7573.734919277799;7712.460127791001;7782.105057918412;7782.182870798485;7814.921850781419;6929.480288978246;6987.9301206987275;6988.825279368057;7113.288671132846;7171.605561694157;6822.522423430312;6841.62371069596;6954.443644508326;6967.895481567679;7028.6485675714985;6234.657093859882;6345.428911397997;6431.356864313719;6504.9674751625935;6518.445932095825;4737.66836321468;4741.668083234141;4802.375691160127;4890.095332363524;4983.72589507566;4850.660453768202;4856.757162141808;4920.089783389941;4950.108980383421;5019.7490125494305 10:58:41 INFO - PROCESS | 1923 | |4;prototype.html;309.6562815275045;353.0714221597199;357.2854291417166;367.87860006197957;372.0753926492665;4293.935590966138;4296.861331747085;5250.9737451312785;5362.27609272748;5376.569874410047;4937.382827146606;5053.6715113517685;5246.344206974129;5275.261463395128;5301.3373328333955;3503.8598456061727;3743.5882052974152;4056.9594304057023;4162.0635357044575;4208.97895510522;3893.9026524336837;4148.859063757476;4167.270727622669;4170.70805043647;4192.874213773592;3373.207296285371;4126.195391898581;4137.54487006429;4139.627433530982;4140.855070072548;3634.1278093257692;3811.5616704079107;4082.9795851020704;4131.752094874287;4161.375793630979;3251.951220731691;3369.9157521061925;3680.907977300562;3685.594584595692;3701.3152566775234;4983.973724822937;5024.321716568253;5140.922886156711;5150.922736158961;5172.793088276464;3938.2320447512748;4274.743515389056;4382.342648602703;4729.527047295243;4775.498572649891;4699.530046995307;5505.229267902497;5532.944670553324;5568.554515638739;5588.497035266845;3534.240138370237;4008.579099194601;4014.498187726534;4048.7975601220114;4059.9594004060173;4514.210013247669;5202.531772140488;5484.506394424481;5643.351014633328;5765.048766953448;3591.371509985794;4118.485189351331;4121.425218008008;4127.33962565988;4148.771817550064;3485.390056740111;3570.9821450892578;4142.606452387079;4199.895002624898;4216.30430978885;4170.749755014709;4724.71651700899;4744.976275118672;4768;4780.49804770501;4544.477385100689;5008.499150085036;5626.943730562723;5641.492265696107;5661.631993920382;1140.823172408278;1168.4975460552043;1339.3303348325837;1353.9439237394847;1355.620426280643;882.5482081975243;925.7779730755339;965.9806803863884;970.4565443351746;976.9706908792748;4382.978085109554;4562.885927851764;4964.3298154748645;5018.698878067327;5020.924686129711;5313;5401.7029063401105;5460.481254280837;5463.562914966793;5471.50756431915;4244.830206791694;4611.815527378867;4795.6163506919365;5006.3491746073505;5007.349044624176;2847.5870998705072;2851.5904061068363;2863.6993115722967;2876.180288617734;2884.4519541287086;4799.136155492045;4978.5270399312;4990.625703072212;5118.97440512795;5615.719214039282;4412.713173643703;4742.766880610997;5178.766955487012;5193.597728613253;5410.458954104558;5102.540771330524;6050.788222412194;6099.84750381244;6113.0743815697915;6122.081687746873;5407.513323800877;5635.323761148688;5820;5835.854103647443;5919.230500034968;4956.752162391794;5348.491893270133;5379.704116273642;5477.72611369422;5714.914056369478;6023.27720673522;6032.819015429544;6113.724882380215;6125.724342404692;6140;3781.978865706189;3857.884263471988;3866.5553461352306;3881.223755248905;3897.0452239200445;4977.900441991067;5460.3993560707495;5511.448855114457;5751.568632352507;5771.220885180447;4777.474477807369;5367.463253674601;5462.453754624506;5607.719614019365;5624.775008999594;5503.3120859892515;5544.528715059265;5550.916736249041;5587.888242235052;5605.635633683797;4905.803767849389;4992.9764398298985;5420.295361603125;5426.348838139448;5469.113155961187;5542.251796007487;5559.388467268678;5562.777488900399;5570.61005729595;5575.832725018256;5313.415524292402;5382.757775900016;5392.379876314118;5422.153369480896;5451.0752258373905 10:58:41 INFO - PROCESS | 1923 | |5;yui.html;700.6706847781544;729.8104090332757;731.2614259597806;740.966351939045;763.602926478231;12719.682007949807;14664.41342346305;15388.692226155485;16442;17210.655786884254;15237.61905952349;15292.770608440855;15309.69380612387;15327.00374475661;15334.769978450333;732.4030914804443;769.9884501732464;793.6864938349348;896.7623579751371;903.6295119001211;696.362828012368;719.9640017999105;874.816288579399;888.8533391990314;907.3557773980482;869.7303835810887;930.1675000874213;932.6129656192672;936.6347124621403;937.1378331934602;929.4284015330524;930.4370855632346;930.7207837648713;934.1592566689966;935.4527601353217;656;698.5424546921774;698.8043347862556;701.0675801184412;701.1165930927068;12122.818157727641;14713.485028023968;14893.255337233204;15118.39526418942;15139.394424223017;13463.461461541527;13641.104081207011;13733.519326823513;13786.103903246258;13831.446742130303;11347.602833900773;11489.253198542068;11600.709982250426;11773.705657358549;12000.21998570099;3597.1007248187952;3611.56661200655;3663.1757854482794;3721.5348081489815;3830.4062870255157;95151.52424237903;107722.46138769334;107938.46030769795;110854.89145108526;111550.44224778905;10533.84199237012;10545.578176872992;10555.630552930765;10580.52387642558;10818.675439736662;21599.352019439128;21638.675419868716;21659.566808663738;21703.891480542497;21750.129994800347;7526.736564220226;7643.1974642662835;7715.614219289126;7769.922300777033;7862.803429914184;4185.765199266224;4311.159323931866;4325.7620830853975;4367.737935723867;4492.842750503717;3516.5252690886405;3578.9957623730274;3605.6394360563736;3605.6935160511653;3613.114786877232;610.7083518358639;646.7099129123719;652.6736631684158;652.8890088684935;653.1085068880943;552.8424399046253;642.9389208025231;668.8595394967111;679.3512195852949;679.6126208061456;9082.772930676785;9105.063025839087;9253.861192082124;9274.859226230463;9365.344425890122;634.5558109323492;665.2416245480157;665.5740326191242;688.6625553478759;691.5574032619128;4269.786510674454;4307.289297265916;4891.997140586172;4948.8762780930765;5005.6996580205305;99591;101359.49320253351;102045.48977255214;104551;106230;92889;94144.52927735317;94186.58720119066;95341;96942.51528742311;80730.59634701906;83499;83623.16376836275;84110.31779364379;85387;9497.382670126419;9804.705858824247;9806;9878.259130565093;9892.258080643836;52752.736236318575;53851;53934.730326348115;54157.45842541524;55627;75095;75531;77244.2275577237;79010;80955;10786.946065269623;11531.654050378502;12845.935770321088;12896.613101606967;13108.279044652254;14445.711085778436;14592.708145836812;14955.177465239516;15143.242837858283;15553.144577048372;12396.442160102997;13092.01809864283;13454.596362109152;13806.65483362924;14022.546054440636;13243.933780331037;13293.335333233494;13752.31238438094;13780.448782049007;14008.929955350159;10924.852316250315;13574.52489162914;13633.250171240677;13645.385957631732;13930.651733706738;10894.509747061244;10906.61826836057;11148.219624626197;11307.321560706385;11527.365994870363;7991.520508769492;11185.496652650812;11225.382603956861;11465.770684586094;11498.94250528742 10:58:41 INFO - PROCESS | 1923 | __end_tp_report 10:58:41 INFO - PROCESS | 1923 | __start_cc_report 10:58:41 INFO - PROCESS | 1923 | _x_x_mozilla_cycle_collect,384 10:58:41 INFO - PROCESS | 1923 | __end_cc_report 10:58:41 INFO - PROCESS | 1923 | __startTimestamp1481655521911__endTimestamp 10:58:41 INFO - PROCESS | 1923 | 10:58:41 INFO - PROCESS | 1923 | ------- Summary: start ------- 10:58:41 INFO - PROCESS | 1923 | Number of tests: 6 10:58:41 INFO - PROCESS | 1923 | 10:58:41 INFO - PROCESS | 1923 | [#0] dojo.html Cycles:165 Average:5666.47 Median:5887.09 stddev:654.45 (11.1%) stddev-sans-first:631.11 10:58:41 INFO - PROCESS | 1923 | Values: 3367.2 3371.6 3373.4 3391.8 3410.8 5620.4 5675.3 5697.9 5705.4 5713.9 4708.6 5597.3 5654.7 5694.6 5718.5 5142.7 5167.0 5191.9 5206.2 5220.9 5142.5 5167.3 5223.1 5261.6 5281.1 5184.9 5230.5 5247.5 5255.5 5281.1 5096.2 5100.2 5126.2 5173.2 5179.0 5016.5 5093.3 5114.0 5116.7 5145.6 4467.7 4808.8 5210.2 5538.5 5689.7 6068.4 6110.5 6139.0 6146.3 6162.4 6039.0 6094.2 6119.2 6120.2 6147.0 5752.1 5786.1 5806.9 5807.8 5851.4 6212.1 6262.6 6280.2 6307.7 6361.6 4995.2 6122.1 6131.4 6141.6 6145.9 5253.0 6076.5 6126.3 6141.6 6187.7 5507.3 6118.5 6120.0 6124.6 6144.3 5625.6 6135.8 6181.4 6187.2 6201.7 4899.2 4900.8 4925.2 4958.2 4961.8 4345.5 4350.4 4364.4 4374.2 4378.2 5858.9 5860.4 5873.6 5894.2 5936.7 6175.5 6182.8 6185.9 6208.1 6213.2 5665.6 5725.6 5738.2 5801.2 5843.3 4388.0 5366.0 5373.8 5380.6 5381.4 6207.4 6228.9 6292.4 6297.7 6300.2 6158.4 6167.2 6176.7 6181.4 6196.2 6382.7 6385.1 6385.8 6388.4 6432.1 6049.5 6087.0 6120.6 6154.4 6159.2 6117.8 6146.0 6160.1 6205.9 6237.2 5967.8 6084.9 6095.9 6098.2 6122.5 5884.7 5942.6 6062.9 6081.5 6089.2 5696.9 5873.9 5884.2 5887.1 5930.0 5991.9 6062.6 6106.8 6128.3 6134.2 4939.6 5899.6 5932.7 5951.8 5965.0 10:58:41 INFO - PROCESS | 1923 | 10:58:41 INFO - PROCESS | 1923 | [#1] ext.html Cycles:180 Average:67999.55 Median:38398.52 stddev:144927.53 (377.4%) stddev-sans-first:145245.27 10:58:41 INFO - PROCESS | 1923 | Values: 419.5 451.3 464.3 468.5 510.1 31395.2 41239.0 41351.8 41417.0 43497.6 41891.8 42439.6 42451.2 42495.8 42512.0 8411.7 9384.8 9603.8 9652.7 9687.6 8528.8 11284.3 11565.8 11589.0 11754.1 11490.8 11501.5 11549.0 11560.6 11578.4 11401.3 11431.7 11445.5 11446.0 11504.8 11371.5 11415.0 11443.5 11452.5 11454.9 39687.8 39860.2 39985.4 40115.2 40151.0 3238.8 3316.7 3481.8 3541.6 3783.1 27353.6 30067.5 30407.5 30524.7 31111.0 3041.3 3044.8 3073.9 3087.9 3121.4 476344.0 476406.0 484531.0 484594.2 485538.6 48049.5 58912.1 59038.7 59157.1 59418.8 48238.8 61730.0 61922.7 62663.4 62783.2 15704.2 15874.9 15909.9 15943.0 15949.4 11239.9 11507.5 12301.4 12419.8 12421.7 13472.4 15985.8 16488.4 16491.3 16527.2 5931.5 6510.5 6644.9 6662.6 6669.7 818.0 855.5 916.5 938.9 1000.3 28687.7 29617.4 29935.9 29957.7 30332.4 872.9 954.4 986.5 1065.1 1092.4 13238.5 15545.6 15628.9 15745.5 15829.8 603937.8 606214.0 608738.0 609065.0 610154.0 57821.1 57887.7 58105.4 58135.4 58173.4 1373.3 1381.5 1382.2 1393.7 1397.0 28863.7 29558.9 29574.7 30411.4 30482.5 49870.8 50125.2 50153.0 50191.5 50225.7 532327.0 534037.0 534201.0 535625.0 536155.0 38595.4 38947.0 39212.8 39779.8 39855.6 43300.6 43672.6 45492.8 47033.0 47343.8 38144.0 38403.8 38560.4 39524.0 39977.0 38168.6 38313.8 38801.0 39399.6 39563.6 37564.0 38027.4 38177.8 38311.4 38393.2 32348.4 32961.0 33288.0 33289.3 34435.3 21851.0 22752.7 25240.0 25730.2 25985.0 10:58:41 INFO - PROCESS | 1923 | 10:58:41 INFO - PROCESS | 1923 | [#2] jquery.html Cycles:180 Average:31608.93 Median:13739.44 stddev:85660.80 (623.5%) stddev-sans-first:85868.97 10:58:41 INFO - PROCESS | 1923 | Values: 362.9 367.5 368.6 379.0 393.3 18812.2 19161.5 19454.2 19490.6 19662.2 11709.6 11848.4 11933.3 12091.0 12108.4 4119.5 5240.2 5298.1 5352.3 5361.0 3802.3 4016.8 5303.2 5343.8 5612.9 5325.0 5752.5 5900.1 5974.0 5988.0 5732.3 5914.6 5970.7 5974.5 5981.4 5735.3 5742.5 5742.9 5745.5 5759.1 21484.0 23759.0 24411.5 24614.6 24976.3 2150.5 2332.4 2340.8 2427.6 2502.6 9505.5 10037.6 10080.1 11459.9 14031.6 1799.8 1850.8 1879.4 1910.1 1922.1 110147.0 112528.4 112634.0 114346.0 115482.0 11161.8 11356.1 11371.1 11395.3 11623.2 14370.8 14376.4 14389.3 14415.9 14434.5 6616.5 8079.8 8237.5 8305.4 8408.2 8102.0 8127.7 8128.3 8247.6 8279.7 3829.6 4053.1 4407.5 4479.7 4511.5 1646.5 1730.4 1774.4 1833.2 1963.5 825.9 906.9 908.3 924.9 971.3 17189.9 18378.2 18651.7 20280.8 21198.5 841.3 882.6 914.9 943.8 947.6 10709.5 11179.8 11203.0 11206.2 11214.2 500468.0 503238.0 512042.8 515362.0 516091.0 114444.9 117590.4 120684.0 126219.4 127485.0 981.2 985.2 1009.7 1063.4 1067.8 17284.1 18063.6 19119.4 19778.2 19960.7 42225.4 49357.5 54544.2 54719.2 56314.2 65554.4 66178.0 77970.2 78996.2 79014.6 6210.7 8147.8 8277.9 8321.7 8334.7 10668.7 12112.2 13035.6 13222.3 13422.1 11088.1 11115.2 11211.5 11235.6 11517.1 8949.3 9137.7 10994.0 11097.6 11216.8 11234.4 11318.4 11511.4 11615.4 11713.5 7898.1 7944.2 8230.0 8230.3 8251.1 8324.3 9453.9 9914.9 10360.5 11097.3 10:58:41 INFO - PROCESS | 1923 | 10:58:41 INFO - PROCESS | 1923 | [#3] mootools.html Cycles:180 Average:5359.39 Median:5177.07 stddev:2889.94 (55.8%) stddev-sans-first:2882.57 10:58:41 INFO - PROCESS | 1923 | Values: 1379.0 1503.6 1680.9 1813.6 1818.0 7490.4 7612.9 7762.0 8461.8 8507.1 7857.0 8128.5 8137.9 8238.0 8255.9 1911.7 2336.2 2339.0 2340.7 2345.5 2319.1 2341.2 2356.2 2364.0 2375.0 2219.1 2219.6 2237.6 2245.6 2250.0 2257.6 2291.6 2318.6 2319.0 2321.4 2277.4 2305.5 2337.0 2341.5 2344.3 8328.9 8387.5 8400.0 8405.3 8415.0 5004.3 5175.4 5177.6 5193.6 5206.2 3217.7 3331.9 3450.1 3509.0 3512.3 1007.3 1028.0 1031.2 1047.4 1050.7 10501.8 10561.4 10567.0 10658.8 10707.4 4449.6 4506.7 4714.8 4732.1 4735.5 9122.0 9205.8 9241.2 9242.1 9260.2 5142.6 5172.5 5176.5 5193.8 5250.6 4228.8 4572.3 4645.0 4687.0 4746.0 3824.3 3830.1 3895.9 3918.7 3959.1 1108.9 1262.3 1274.1 1278.4 1295.6 690.1 739.5 781.7 917.4 930.8 5470.8 5474.6 5522.2 5646.9 5875.3 882.1 893.9 912.2 946.2 988.8 3683.2 3733.9 3793.7 3851.6 3924.9 9634.4 10016.5 10021.1 10051.3 10054.0 8842.4 9537.0 9808.4 9884.4 10016.6 6156.4 7625.7 7708.8 7828.3 7848.7 5064.9 5414.7 5671.8 5802.0 5876.6 8940.8 9028.9 9098.5 9191.4 9282.0 7583.8 9144.7 9160.2 9225.0 9233.3 6504.1 6661.6 6984.3 7061.7 7297.9 7573.7 7712.5 7782.1 7782.2 7814.9 6929.5 6987.9 6988.8 7113.3 7171.6 6822.5 6841.6 6954.4 6967.9 7028.6 6234.7 6345.4 6431.4 6505.0 6518.4 4737.7 4741.7 4802.4 4890.1 4983.7 4850.7 4856.8 4920.1 4950.1 5019.7 10:58:41 INFO - PROCESS | 1923 | 10:58:41 INFO - PROCESS | 1923 | [#4] prototype.html Cycles:180 Average:4490.76 Median:4987.30 stddev:1349.45 (27.1%) stddev-sans-first:1316.24 10:58:41 INFO - PROCESS | 1923 | Values: 309.7 353.1 357.3 367.9 372.1 4293.9 4296.9 5251.0 5362.3 5376.6 4937.4 5053.7 5246.3 5275.3 5301.3 3503.9 3743.6 4057.0 4162.1 4209.0 3893.9 4148.9 4167.3 4170.7 4192.9 3373.2 4126.2 4137.5 4139.6 4140.9 3634.1 3811.6 4083.0 4131.8 4161.4 3252.0 3369.9 3680.9 3685.6 3701.3 4984.0 5024.3 5140.9 5150.9 5172.8 3938.2 4274.7 4382.3 4729.5 4775.5 4699.5 5505.2 5532.9 5568.6 5588.5 3534.2 4008.6 4014.5 4048.8 4060.0 4514.2 5202.5 5484.5 5643.4 5765.0 3591.4 4118.5 4121.4 4127.3 4148.8 3485.4 3571.0 4142.6 4199.9 4216.3 4170.7 4724.7 4745.0 4768.0 4780.5 4544.5 5008.5 5626.9 5641.5 5661.6 1140.8 1168.5 1339.3 1353.9 1355.6 882.5 925.8 966.0 970.5 977.0 4383.0 4562.9 4964.3 5018.7 5020.9 5313.0 5401.7 5460.5 5463.6 5471.5 4244.8 4611.8 4795.6 5006.3 5007.3 2847.6 2851.6 2863.7 2876.2 2884.5 4799.1 4978.5 4990.6 5119.0 5615.7 4412.7 4742.8 5178.8 5193.6 5410.5 5102.5 6050.8 6099.8 6113.1 6122.1 5407.5 5635.3 5820.0 5835.9 5919.2 4956.8 5348.5 5379.7 5477.7 5714.9 6023.3 6032.8 6113.7 6125.7 6140.0 3782.0 3857.9 3866.6 3881.2 3897.0 4977.9 5460.4 5511.4 5751.6 5771.2 4777.5 5367.5 5462.5 5607.7 5624.8 5503.3 5544.5 5550.9 5587.9 5605.6 4905.8 4993.0 5420.3 5426.3 5469.1 5542.3 5559.4 5562.8 5570.6 5575.8 5313.4 5382.8 5392.4 5422.2 5451.1 10:58:41 INFO - PROCESS | 1923 | 10:58:41 INFO - PROCESS | 1923 | [#5] yui.html Cycles:180 Average:21132.40 Median:4318.46 stddev:30740.02 (711.8%) stddev-sans-first:30787.97 10:58:41 INFO - PROCESS | 1923 | Values: 700.7 729.8 731.3 741.0 763.6 12719.7 14664.4 15388.7 16442.0 17210.7 15237.6 15292.8 15309.7 15327.0 15334.8 732.4 770.0 793.7 896.8 903.6 696.4 720.0 874.8 888.9 907.4 869.7 930.2 932.6 936.6 937.1 929.4 930.4 930.7 934.2 935.5 656.0 698.5 698.8 701.1 701.1 12122.8 14713.5 14893.3 15118.4 15139.4 13463.5 13641.1 13733.5 13786.1 13831.4 11347.6 11489.3 11600.7 11773.7 12000.2 3597.1 3611.6 3663.2 3721.5 3830.4 95151.5 107722.5 107938.5 110854.9 111550.4 10533.8 10545.6 10555.6 10580.5 10818.7 21599.4 21638.7 21659.6 21703.9 21750.1 7526.7 7643.2 7715.6 7769.9 7862.8 4185.8 4311.2 4325.8 4367.7 4492.8 3516.5 3579.0 3605.6 3605.7 3613.1 610.7 646.7 652.7 652.9 653.1 552.8 642.9 668.9 679.4 679.6 9082.8 9105.1 9253.9 9274.9 9365.3 634.6 665.2 665.6 688.7 691.6 4269.8 4307.3 4892.0 4948.9 5005.7 99591.0 101359.5 102045.5 104551.0 106230.0 92889.0 94144.5 94186.6 95341.0 96942.5 80730.6 83499.0 83623.2 84110.3 85387.0 9497.4 9804.7 9806.0 9878.3 9892.3 52752.7 53851.0 53934.7 54157.5 55627.0 75095.0 75531.0 77244.2 79010.0 80955.0 10786.9 11531.7 12845.9 12896.6 13108.3 14445.7 14592.7 14955.2 15143.2 15553.1 12396.4 13092.0 13454.6 13806.7 14022.5 13243.9 13293.3 13752.3 13780.4 14008.9 10924.9 13574.5 13633.3 13645.4 13930.7 10894.5 10906.6 11148.2 11307.3 11527.4 7991.5 11185.5 11225.4 11465.8 11498.9 10:58:41 INFO - PROCESS | 1923 | -------- Summary: end -------- 10:58:41 INFO - PROCESS | 1923 | 10:58:42 INFO - TEST-INFO | 1923: exit 0 10:58:42 INFO - TEST-OK | dromaeo_css | took 1115690ms 10:58:42 INFO - TEST-START | kraken 10:58:42 INFO - operating with platform_type : mac_ 10:58:42 INFO - Initialising browser for kraken test... 10:58:42 INFO - TEST-INFO | started process 1929 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpIl6YrX/profile http://localhost:51503/getInfo.html) 10:58:45 INFO - PROCESS | 1929 | 2016-12-13 10:58:45.491 plugin-container[1930:16840] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 10:58:45 INFO - PROCESS | 1929 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:58:45 INFO - PROCESS | 1929 | 2016-12-13 10:58:45.493 plugin-container[1930:16840] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 10:58:45 INFO - PROCESS | 1929 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:58:45 INFO - PROCESS | 1929 | 2016-12-13 10:58:45.493 plugin-container[1930:16840] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:58:45 INFO - PROCESS | 1929 | __metrics Screen width/height:1600/1200 10:58:45 INFO - PROCESS | 1929 | colorDepth:24 10:58:45 INFO - PROCESS | 1929 | Browser inner width/height: 1024/689 10:58:45 INFO - PROCESS | 1929 | __metrics 10:58:45 ERROR - PROCESS | 1929 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3212: TypeError: this.tabs is undefined 10:58:46 INFO - TEST-INFO | 1929: exit 0 10:58:46 INFO - Browser initialized. 10:58:46 INFO - Running cycle 1/1 for kraken test... 10:58:46 INFO - TEST-INFO | started process 1931 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpIl6YrX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:58:48 INFO - PROCESS | 1931 | 2016-12-13 10:58:48.626 plugin-container[1932:16954] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8743, name = 'com.apple.tsm.portname' 10:58:48 INFO - PROCESS | 1931 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:58:48 INFO - PROCESS | 1931 | 2016-12-13 10:58:48.627 plugin-container[1932:16954] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4623, name = 'com.apple.CFPasteboardClient' 10:58:48 INFO - PROCESS | 1931 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:58:48 INFO - PROCESS | 1931 | 2016-12-13 10:58:48.627 plugin-container[1932:16954] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:58:58 INFO - PROCESS | 1931 | RSS: Main: 237223936 10:58:58 INFO - PROCESS | 1931 | 10:59:01 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51503/tests/kraken/driver.html?testName=audio-beat-detection) 10:59:02 INFO - PROCESS | 1931 | RSS: Main: 249622528 10:59:02 INFO - PROCESS | 1931 | 10:59:04 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51503/tests/kraken/driver.html?testName=audio-dft) 10:59:05 INFO - PROCESS | 1931 | RSS: Main: 257286144 10:59:05 INFO - PROCESS | 1931 | 10:59:08 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51503/tests/kraken/driver.html?testName=audio-fft) 10:59:09 INFO - PROCESS | 1931 | RSS: Main: 259850240 10:59:09 INFO - PROCESS | 1931 | 10:59:11 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51503/tests/kraken/driver.html?testName=audio-oscillator) 10:59:12 INFO - PROCESS | 1931 | RSS: Main: 261120000 10:59:12 INFO - PROCESS | 1931 | 10:59:14 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51503/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:59:14 INFO - PROCESS | 1931 | RSS: Main: 262782976 10:59:14 INFO - PROCESS | 1931 | 10:59:18 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51503/tests/kraken/driver.html?testName=imaging-darkroom) 10:59:18 INFO - PROCESS | 1931 | RSS: Main: 268521472 10:59:18 INFO - PROCESS | 1931 | 10:59:21 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51503/tests/kraken/driver.html?testName=imaging-desaturate) 10:59:22 INFO - PROCESS | 1931 | RSS: Main: 268308480 10:59:22 INFO - PROCESS | 1931 | 10:59:25 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51503/tests/kraken/driver.html?testName=json-parse-financial) 10:59:26 INFO - PROCESS | 1931 | RSS: Main: 268300288 10:59:26 INFO - PROCESS | 1931 | 10:59:27 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51503/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:59:28 INFO - PROCESS | 1931 | RSS: Main: 267456512 10:59:28 INFO - PROCESS | 1931 | 10:59:30 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51503/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:59:31 INFO - PROCESS | 1931 | RSS: Main: 267526144 10:59:31 INFO - PROCESS | 1931 | 10:59:33 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51503/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:59:34 INFO - PROCESS | 1931 | RSS: Main: 267538432 10:59:34 INFO - PROCESS | 1931 | 10:59:37 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51503/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:59:38 INFO - PROCESS | 1931 | RSS: Main: 267874304 10:59:38 INFO - PROCESS | 1931 | 10:59:41 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51503/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:59:42 INFO - PROCESS | 1931 | RSS: Main: 265347072 10:59:42 INFO - PROCESS | 1931 | 10:59:43 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51503/tests/kraken/driver.html?testName=ai-astar) 10:59:44 INFO - PROCESS | 1931 | RSS: Main: 268767232 10:59:44 INFO - PROCESS | 1931 | 10:59:44 INFO - PROCESS | 1931 | __start_tp_report 10:59:44 INFO - PROCESS | 1931 | _x_x_mozilla_page_load 10:59:44 INFO - PROCESS | 1931 | _x_x_mozilla_page_load_details 10:59:44 INFO - PROCESS | 1931 | |i|pagename|runs| 10:59:44 INFO - PROCESS | 1931 | |0;ai-astar;106;118;117;118;117;116;124;117;118;120 10:59:44 INFO - PROCESS | 1931 | |1;audio-beat-detection;149;119;118;156;119;120;124;146;132;108 10:59:44 INFO - PROCESS | 1931 | |2;audio-dft;194;206;204;272;281;200;194;196;195;206 10:59:44 INFO - PROCESS | 1931 | |3;audio-fft;91;76;86;95;59;58;57;52;77;69 10:59:44 INFO - PROCESS | 1931 | |4;audio-oscillator;102;71;72;95;95;100;96;70;72;83 10:59:44 INFO - PROCESS | 1931 | |5;imaging-gaussian-blur;110;163;109;113;153;113;170;172;110;112 10:59:44 INFO - PROCESS | 1931 | |6;imaging-darkroom;151;124;141;176;134;99;99;99;105;101 10:59:44 INFO - PROCESS | 1931 | |7;imaging-desaturate;101;95;147;136;138;144;93;94;100;147 10:59:44 INFO - PROCESS | 1931 | |8;json-parse-financial;57;56;56;56;59;57;57;56;57;54 10:59:44 INFO - PROCESS | 1931 | |9;json-stringify-tinderbox;69;78;69;80;69;70;98;58;71;97 10:59:44 INFO - PROCESS | 1931 | |10;stanford-crypto-aes;94;82;107;112;112;88;81;92;112;111 10:59:44 INFO - PROCESS | 1931 | |11;stanford-crypto-ccm;155;168;162;180;164;159;172;153;208;162 10:59:44 INFO - PROCESS | 1931 | |12;stanford-crypto-pbkdf2;199;212;177;182;203;175;174;229;225;231 10:59:44 INFO - PROCESS | 1931 | |13;stanford-crypto-sha256-iterative;68;69;70;67;80;68;63;84;70;63 10:59:44 INFO - PROCESS | 1931 | __end_tp_report 10:59:44 INFO - PROCESS | 1931 | __start_cc_report 10:59:44 INFO - PROCESS | 1931 | _x_x_mozilla_cycle_collect,956 10:59:44 INFO - PROCESS | 1931 | __end_cc_report 10:59:44 INFO - PROCESS | 1931 | __startTimestamp1481655584147__endTimestamp 10:59:44 INFO - PROCESS | 1931 | 10:59:44 INFO - PROCESS | 1931 | ------- Summary: start ------- 10:59:44 INFO - PROCESS | 1931 | Number of tests: 14 10:59:44 INFO - PROCESS | 1931 | 10:59:44 INFO - PROCESS | 1931 | [#0] ai-astar Cycles:10 Average:117.10 Median:118.00 stddev:4.51 (3.8%) stddev-sans-first:2.40 10:59:44 INFO - PROCESS | 1931 | Values: 106.0 118.0 117.0 118.0 117.0 116.0 124.0 117.0 118.0 120.0 10:59:44 INFO - PROCESS | 1931 | 10:59:44 INFO - PROCESS | 1931 | [#1] audio-beat-detection Cycles:10 Average:129.10 Median:128.00 stddev:15.97 (12.5%) stddev-sans-first:15.23 10:59:44 INFO - PROCESS | 1931 | Values: 149.0 119.0 118.0 156.0 119.0 120.0 124.0 146.0 132.0 108.0 10:59:44 INFO - PROCESS | 1931 | 10:59:44 INFO - PROCESS | 1931 | [#2] audio-dft Cycles:10 Average:214.80 Median:205.00 stddev:32.92 (16.1%) stddev-sans-first:34.05 10:59:44 INFO - PROCESS | 1931 | Values: 194.0 206.0 204.0 272.0 281.0 200.0 194.0 196.0 195.0 206.0 10:59:44 INFO - PROCESS | 1931 | 10:59:44 INFO - PROCESS | 1931 | [#3] audio-fft Cycles:10 Average:72.00 Median:76.50 stddev:15.37 (20.1%) stddev-sans-first:14.68 10:59:44 INFO - PROCESS | 1931 | Values: 91.0 76.0 86.0 95.0 59.0 58.0 57.0 52.0 77.0 69.0 10:59:44 INFO - PROCESS | 1931 | 10:59:44 INFO - PROCESS | 1931 | [#4] audio-oscillator Cycles:10 Average:85.60 Median:77.50 stddev:13.31 (17.2%) stddev-sans-first:12.73 10:59:44 INFO - PROCESS | 1931 | Values: 102.0 71.0 72.0 95.0 95.0 100.0 96.0 70.0 72.0 83.0 10:59:44 INFO - PROCESS | 1931 | 10:59:44 INFO - PROCESS | 1931 | [#5] imaging-gaussian-blur Cycles:10 Average:132.50 Median:133.00 stddev:28.01 (21.1%) stddev-sans-first:28.50 10:59:44 INFO - PROCESS | 1931 | Values: 110.0 163.0 109.0 113.0 153.0 113.0 170.0 172.0 110.0 112.0 10:59:44 INFO - PROCESS | 1931 | 10:59:44 INFO - PROCESS | 1931 | [#6] imaging-darkroom Cycles:10 Average:122.90 Median:163.50 stddev:27.03 (16.5%) stddev-sans-first:26.69 10:59:44 INFO - PROCESS | 1931 | Values: 151.0 124.0 141.0 176.0 134.0 99.0 99.0 99.0 105.0 101.0 10:59:44 INFO - PROCESS | 1931 | 10:59:44 INFO - PROCESS | 1931 | [#7] imaging-desaturate Cycles:10 Average:119.50 Median:147.00 stddev:24.50 (16.7%) stddev-sans-first:25.06 10:59:44 INFO - PROCESS | 1931 | Values: 101.0 95.0 147.0 136.0 138.0 144.0 93.0 94.0 100.0 147.0 10:59:44 INFO - PROCESS | 1931 | 10:59:44 INFO - PROCESS | 1931 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.00 stddev:1.27 (2.2%) stddev-sans-first:1.33 10:59:44 INFO - PROCESS | 1931 | Values: 57.0 56.0 56.0 56.0 59.0 57.0 57.0 56.0 57.0 54.0 10:59:44 INFO - PROCESS | 1931 | 10:59:44 INFO - PROCESS | 1931 | [#9] json-stringify-tinderbox Cycles:10 Average:75.90 Median:74.50 stddev:12.81 (17.2%) stddev-sans-first:13.34 10:59:44 INFO - PROCESS | 1931 | Values: 69.0 78.0 69.0 80.0 69.0 70.0 98.0 58.0 71.0 97.0 10:59:44 INFO - PROCESS | 1931 | 10:59:44 INFO - PROCESS | 1931 | [#10] stanford-crypto-aes Cycles:10 Average:99.10 Median:81.50 stddev:13.01 (16.0%) stddev-sans-first:13.67 10:59:44 INFO - PROCESS | 1931 | Values: 94.0 82.0 107.0 112.0 112.0 88.0 81.0 92.0 112.0 111.0 10:59:44 INFO - PROCESS | 1931 | 10:59:44 INFO - PROCESS | 1931 | [#11] stanford-crypto-ccm Cycles:10 Average:168.30 Median:166.00 stddev:16.06 (9.7%) stddev-sans-first:16.30 10:59:44 INFO - PROCESS | 1931 | Values: 155.0 168.0 162.0 180.0 164.0 159.0 172.0 153.0 208.0 162.0 10:59:44 INFO - PROCESS | 1931 | 10:59:44 INFO - PROCESS | 1931 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:200.70 Median:207.50 stddev:22.93 (11.0%) stddev-sans-first:24.31 10:59:44 INFO - PROCESS | 1931 | Values: 199.0 212.0 177.0 182.0 203.0 175.0 174.0 229.0 225.0 231.0 10:59:44 INFO - PROCESS | 1931 | 10:59:44 INFO - PROCESS | 1931 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:69.50 stddev:6.76 (9.7%) stddev-sans-first:7.13 10:59:44 INFO - PROCESS | 1931 | Values: 68.0 69.0 70.0 67.0 80.0 68.0 63.0 84.0 70.0 63.0 10:59:44 INFO - PROCESS | 1931 | -------- Summary: end -------- 10:59:44 INFO - PROCESS | 1931 | 10:59:44 INFO - TEST-INFO | 1931: exit 0 10:59:45 INFO - TEST-OK | kraken | took 62473ms 10:59:45 INFO - SUITE-END | took 1178s 10:59:45 INFO - Completed test suite (00:19:38) 10:59:45 INFO - javascript benchmark 10:59:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7180.354048198264, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3367.2255381262307, 3371.5616969793923, 3373.443381841996, 3391.77953433027, 3410.7782994105382, 5620.353659329178, 5675.290588676416, 5697.914531282029, 5705.372409035002, 5713.857153571153, 4708.599769019637, 5597.328320601523, 5654.688992105433, 5694.5729070319785, 5718.513926316268, 5142.717150556737, 5167.0, 5191.896162076775, 5206.245094461301, 5220.947790522103, 5142.511461411179, 5167.250748641463, 5223.112070947948, 5261.552768014704, 5281.075811732951, 5184.922226166611, 5230.450802665741, 5247.47525247476, 5255.527002569787, 5281.075811732951, 5096.210087436453, 5100.15847385181, 5126.154184559543, 5173.17229243323, 5178.9900969311, 5016.49835016499, 5093.312402825608, 5114.028334616411, 5116.718580478109, 5145.6398052136365, 4467.687261891669, 4808.797800549863, 5210.192420174879, 5538.47384498476, 5689.715514224272, 6068.423499767515, 6110.480609148228, 6139.048447490646, 6146.29317628474, 6162.445379915829, 6038.969805150946, 6094.238220222473, 6119.204503414572, 6120.1737765401995, 6146.969265153645, 5752.108423194411, 5786.103154011135, 5806.88386232273, 5807.767689292381, 5851.444112809277, 6212.099245609361, 6262.624242545371, 6280.246370435577, 6307.716152773136, 6361.554691171574, 4995.200767877122, 6122.112293717475, 6131.448169664663, 6141.6007959482495, 6145.938540614537, 5252.9737351313, 6076.5442591805795, 6126.264848218242, 6141.600795948339, 6187.690615469299, 5507.256520369779, 6118.497354392036, 6119.99004232014, 6124.601900876429, 6144.262688477412, 5625.578081643893, 6135.785247516315, 6181.443670069715, 6187.16473276111, 6201.720922558496, 4899.240617704261, 4900.803967841246, 4925.187344088257, 4958.206686930074, 4961.801527938915, 4345.456817897762, 4350.390945267665, 4364.367166760865, 4374.212641724456, 4378.233809083461, 5858.882822343529, 5860.355360910296, 5873.58884878063, 5894.17481552583, 5936.7328470218945, 6175.536834737412, 6182.814515564541, 6185.907211391833, 6208.068789681493, 6213.1922850029205, 5665.6034077614995, 5725.627834190765, 5738.225339579187, 5801.245838041112, 5843.328017277982, 4388.0, 5366.007288651612, 5373.838784836461, 5380.569554435636, 5381.354237491526, 6207.379262073757, 6228.875422491434, 6292.402221788922, 6297.748090076438, 6300.21247344082, 6158.414950579688, 6167.198264225622, 6176.69116544162, 6181.412765787243, 6196.194494715838, 6382.680865956777, 6385.106085148176, 6385.840353991001, 6388.361163883575, 6432.09950606906, 6049.485793707584, 6087.0, 6120.632762034114, 6154.3845615438095, 6159.19930409044, 6117.796956032775, 6145.9692701536205, 6160.075988601746, 6205.937940620716, 6237.220347456568, 5967.791127310524, 6084.939150608614, 6095.939040609537, 6098.207233059674, 6122.479589234965, 5884.705764711833, 5942.58401911862, 6062.878742425215, 6081.483073938764, 6089.238845144357, 5696.946064977992, 5873.882522349614, 5884.205632239593, 5887.087501437284, 5930.021546444961, 5991.8915000725, 6062.575619706578, 6106.786262480792, 6128.325884152829, 6134.202553668173, 4939.580135688507, 5899.587028908107, 5932.673702946379, 5951.791687290924, 5964.970175149097], "value": 5625.990309271311, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.47146595289934, 451.30048424941333, 464.275729861416, 468.48232702863356, 510.08439850468403, 31395.215119621993, 41239.0, 41351.79324103375, 41417.0, 43497.565024349744, 41891.790541047325, 42439.575604243946, 42451.15097698052, 42495.78752106235, 42512.0, 8411.747647570552, 9384.81230375392, 9603.759906002371, 9652.662156824512, 9687.5640596173, 8528.78678033051, 11284.322940623548, 11565.768684626302, 11589.014933730601, 11754.118441116907, 11490.827637585442, 11501.539938402453, 11549.0, 11560.59537916173, 11578.363190024545, 11401.258918170333, 11431.714207144805, 11445.484953177127, 11446.027087697597, 11504.827427588592, 11371.545138194546, 11415.0, 11443.542258309657, 11452.484638191301, 11454.885451145465, 39687.80156099201, 39860.202795944206, 39985.400218996445, 40115.197696046205, 40151.0, 3238.789478683878, 3316.7346612271203, 3481.8085005324697, 3541.557305336833, 3783.1298801275584, 27353.632318384, 30067.548986765218, 30407.543886841715, 30524.69475305241, 31111.0, 3041.330907200412, 3044.8325342106177, 3073.8770449182007, 3087.938241235163, 3121.4069326828057, 476344.0, 476406.0, 484531.0, 484594.1540584584, 485538.57230713975, 48049.519504805205, 58912.05439728082, 59038.70480647569, 59157.112643310385, 59418.81162376728, 48238.75880620575, 61730.0, 61922.69038654778, 62663.373366266664, 62783.17475713604, 15704.214789260492, 15874.920625396799, 15909.920450397674, 15943.0, 15949.441769538242, 11239.887601124048, 11507.482163302671, 12301.384930753427, 12419.813702794465, 12421.689457763629, 13472.393742281622, 15985.840141598668, 16488.422905198262, 16491.34034638601, 16527.173641317888, 5931.466168044896, 6510.511711621647, 6644.933550664528, 6662.600243985376, 6669.733210671616, 818.0, 855.5251835231506, 916.4776077635817, 938.9155525368211, 1000.2897942460934, 28687.713122868503, 29617.407651846843, 29935.850320748257, 29957.70042299549, 30332.393352133276, 872.9437380769214, 954.399792997758, 986.5166068626321, 1065.093482666019, 1092.4046394714899, 13238.470461181638, 15545.611359715871, 15628.921855390878, 15745.524060514246, 15829.762553561706, 603937.7637341773, 606214.0, 608738.0, 609065.0, 610154.0, 57821.13268300979, 57887.71056144776, 58105.418945810845, 58135.418645813, 58173.41826581764, 1373.3133433283358, 1381.4750394849893, 1382.163790906487, 1393.7491251574813, 1396.9930150349182, 28863.7113628861, 29558.852205738833, 29574.704252958054, 30411.391772163992, 30482.542761859033, 49870.75323116951, 50125.24812127748, 50152.99694006173, 50191.49808502015, 50225.74887125541, 532327.0, 534037.0, 534201.0, 535625.0, 536155.0, 38595.421068684554, 38947.0, 39212.803935981276, 39779.801100995464, 39855.601443985186, 43300.56699433091, 43672.56327436812, 45492.77253613843, 47033.0, 47343.81640458878, 38144.0, 38403.807980959915, 38560.42159367556, 39524.01189970274, 39977.0, 38168.61831381651, 38313.808430957666, 38801.02997425087, 39399.606003939596, 39563.604363955994, 37564.0, 38027.42958855675, 38177.809110954266, 38311.42532861954, 38393.23213535769, 32348.35303293874, 32961.01116966495, 33288.00135995924, 33289.334213316084, 34435.31129377449, 21851.0, 22752.658710119693, 25240.0, 25730.228093157235, 25984.960601575724], "value": 19963.75935176334, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.88750487348926, 367.5313974682279, 368.6166386957564, 378.97536660117106, 393.3450804410655, 18812.247510099598, 19161.52096197594, 19454.22183112674, 19490.610187796236, 19662.21351145956, 11709.59016434425, 11848.407579621027, 11933.34366609836, 12091.0, 12108.394580270995, 4119.4644696189525, 5240.161574148137, 5298.09932311508, 5352.304200453936, 5361.035013697533, 3802.296575133609, 4016.7991600419864, 5303.23103150043, 5343.786248550054, 5612.943870561304, 5324.973375133139, 5752.539796816244, 5900.055991041413, 5974.014287642555, 5987.970060149693, 5732.254806875121, 5914.615549989237, 5970.731317090741, 5974.522038236931, 5981.371955944606, 5735.283089613798, 5742.483176514133, 5742.913856292159, 5745.482906538432, 5759.136129580555, 21484.0, 23759.049638014458, 24411.511769764682, 24614.630780538126, 24976.250712478653, 2150.53763440861, 2332.428555004035, 2340.7659234076455, 2427.5509030829353, 2502.624606309068, 9505.524723763854, 10037.648682296158, 10080.092791648787, 11459.885401146048, 14031.64920876976, 1799.7660304160506, 1850.8334249917436, 1879.3610172541264, 1910.1022519415992, 1922.0774028466274, 110147.0, 112528.43735781351, 112634.0, 114346.0, 115482.0, 11161.776764464665, 11356.148288878201, 11371.090312774959, 11395.316281023164, 11623.186376953532, 14370.784438233435, 14376.35306411214, 14389.28053597316, 14415.92792036054, 14434.473967055723, 6616.503762217853, 8079.757607271791, 8237.46456480327, 8305.37709671777, 8408.2432581068, 8102.0, 8127.674893004332, 8128.268455838885, 8247.587620619064, 8279.668813247403, 3829.636184562462, 4053.0677944073027, 4407.515173330931, 4479.70881892676, 4511.526289739596, 1646.538969088657, 1730.4376077774523, 1774.4144432337298, 1833.1842131424435, 1963.460048486649, 825.9215374539409, 906.9047749986288, 908.3369140527452, 924.8797656304637, 971.3200759468259, 17189.914050429667, 18378.172982215834, 18651.694381393172, 20280.797192028185, 21198.47003824917, 841.2680967558264, 882.5851849630664, 914.9451032938046, 943.7734943613483, 947.625687853294, 10709.518071686793, 11179.776404471864, 11203.0, 11206.15953803468, 11214.215004949576, 500468.0, 503238.0, 512042.75914481503, 515362.0, 516091.0, 114444.85555144509, 117590.41204793921, 120684.0, 126219.36890315673, 127485.0, 981.1611072533025, 985.2413641496008, 1009.7223263602568, 1063.3832377221192, 1067.8451624514403, 17284.13467511492, 18063.63872722512, 19119.426417207505, 19778.208871645547, 19960.70058949088, 42225.35521092739, 49357.50642493673, 54544.18183727327, 54719.17921231105, 56314.1552876699, 65554.36114097186, 66178.0, 77970.2202977963, 78996.21003789888, 79014.60492697729, 6210.689465526796, 8147.79630509242, 8277.917220827714, 8321.667133314842, 8334.70828521023, 10668.652896362788, 12112.21270617407, 13035.608931732064, 13222.338883056002, 13422.120903073774, 11088.112950963743, 11115.221934464833, 11211.495482703134, 11235.55057797679, 11517.136214784092, 8949.284057275272, 9137.680181193893, 10994.0, 11097.611583594535, 11216.831747523956, 11234.382108984084, 11318.377489238172, 11511.366874821964, 11615.361155136548, 11713.472893719632, 7898.052233731989, 7944.245296696805, 8229.95885020571, 8230.259276665129, 8251.133630968661, 8324.292435143081, 9453.905460945303, 9914.900850991398, 10360.481975901326, 11097.33415995043], "value": 9118.077547490271, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1378.9655258618534, 1503.586628569145, 1680.8823382363232, 1813.6191399806048, 1817.9909100454495, 7490.400767938566, 7612.923870761305, 7761.961190194055, 8461.830763384736, 8507.149285071497, 7856.9607151964165, 8128.512289262649, 8137.877931831013, 8238.0, 8255.876161857577, 1911.6845720456108, 2336.194013065498, 2339.0, 2340.719113706358, 2345.4839935214227, 2319.072371051576, 2341.203990643181, 2356.1871154451774, 2364.042562762084, 2375.0143690368564, 2219.056900817154, 2219.6004719150546, 2237.5748607764554, 2245.62947113726, 2249.9887500562554, 2257.57106149831, 2291.633338665814, 2318.5826551220775, 2318.96521552176, 2321.361625552978, 2277.385106021365, 2305.4927915858652, 2336.9649455258186, 2341.484873327865, 2344.308429013445, 8328.875066874001, 8387.496750194947, 8400.033996090468, 8405.327573794082, 8414.957925210334, 5004.349434573519, 5175.378954525443, 5177.611679124081, 5193.584513238932, 5206.193040078794, 3217.6943190396873, 3331.933361332784, 3450.0857272822723, 3508.982455087734, 3512.332656795201, 1007.2646967713611, 1027.9588816447333, 1031.2008193649906, 1047.4343854318658, 1050.716306597222, 10501.842472362921, 10561.41912194829, 10567.048965593056, 10658.78682426347, 10707.411092389915, 4449.644028477714, 4506.662000349987, 4714.787834547454, 4732.077244937204, 4735.526447355306, 9121.954390228006, 9205.81588368229, 9241.168294853362, 9242.12199841014, 9260.212881905114, 5142.562882155059, 5172.508611681884, 5176.534111929945, 5193.766280517386, 5250.553702935294, 4228.767417792051, 4572.268437050056, 4644.953550464452, 4686.95313046872, 4745.976270118627, 3824.3116239077235, 3830.0616348994677, 3895.902602434962, 3918.7256892017854, 3959.089409435846, 1108.8855700021427, 1262.3435813377175, 1274.0635632809876, 1278.3735969374939, 1295.591888555102, 690.1132045321738, 739.4897520710692, 781.6638845296463, 917.4128557723062, 930.8464103422995, 5470.781168753205, 5474.616776825584, 5522.199281104217, 5646.943530564724, 5875.265591801025, 882.148726478951, 893.8525143351275, 912.2200518556539, 946.2335508238349, 988.8417853143462, 3683.2081102562543, 3733.8879833605033, 3793.696504279651, 3851.6340947610493, 3924.941125883114, 9634.421934683802, 10016.499175041365, 10021.09810117093, 10051.296409251428, 10053.994600539887, 8842.381033327734, 9537.0, 9808.36245644045, 9884.406935583887, 10016.599336026624, 6156.415140561639, 7625.69497220116, 7708.768736937901, 7828.2954534092205, 7848.686052557834, 5064.898702026013, 5414.675119492843, 5671.801486948102, 5801.970990145022, 5876.588638795243, 8940.821183576421, 9028.909710902806, 9098.454092754457, 9191.402558833654, 9281.978982312075, 7583.810404739926, 9144.725658229998, 9160.175584197454, 9225.031371706144, 9233.261339092991, 6504.056911747675, 6661.600303981777, 6984.301569842975, 7061.717531298896, 7297.890531641923, 7573.734919277799, 7712.460127791001, 7782.105057918412, 7782.182870798485, 7814.921850781419, 6929.480288978246, 6987.9301206987275, 6988.825279368057, 7113.288671132846, 7171.605561694157, 6822.522423430312, 6841.62371069596, 6954.443644508326, 6967.895481567679, 7028.6485675714985, 6234.657093859882, 6345.428911397997, 6431.356864313719, 6504.9674751625935, 6518.445932095825, 4737.66836321468, 4741.668083234141, 4802.375691160127, 4890.095332363524, 4983.72589507566, 4850.660453768202, 4856.757162141808, 4920.089783389941, 4950.108980383421, 5019.7490125494305], "value": 4362.471093160594, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.6562815275045, 353.0714221597199, 357.2854291417166, 367.87860006197957, 372.0753926492665, 4293.935590966138, 4296.861331747085, 5250.9737451312785, 5362.27609272748, 5376.569874410047, 4937.382827146606, 5053.6715113517685, 5246.344206974129, 5275.261463395128, 5301.3373328333955, 3503.8598456061727, 3743.5882052974152, 4056.9594304057023, 4162.0635357044575, 4208.97895510522, 3893.9026524336837, 4148.859063757476, 4167.270727622669, 4170.70805043647, 4192.874213773592, 3373.207296285371, 4126.195391898581, 4137.54487006429, 4139.627433530982, 4140.855070072548, 3634.1278093257692, 3811.5616704079107, 4082.9795851020704, 4131.752094874287, 4161.375793630979, 3251.951220731691, 3369.9157521061925, 3680.907977300562, 3685.594584595692, 3701.3152566775234, 4983.973724822937, 5024.321716568253, 5140.922886156711, 5150.922736158961, 5172.793088276464, 3938.2320447512748, 4274.743515389056, 4382.342648602703, 4729.527047295243, 4775.498572649891, 4699.530046995307, 5505.229267902497, 5532.944670553324, 5568.554515638739, 5588.497035266845, 3534.240138370237, 4008.579099194601, 4014.498187726534, 4048.7975601220114, 4059.9594004060173, 4514.210013247669, 5202.531772140488, 5484.506394424481, 5643.351014633328, 5765.048766953448, 3591.371509985794, 4118.485189351331, 4121.425218008008, 4127.33962565988, 4148.771817550064, 3485.390056740111, 3570.9821450892578, 4142.606452387079, 4199.895002624898, 4216.30430978885, 4170.749755014709, 4724.71651700899, 4744.976275118672, 4768.0, 4780.49804770501, 4544.477385100689, 5008.499150085036, 5626.943730562723, 5641.492265696107, 5661.631993920382, 1140.823172408278, 1168.4975460552043, 1339.3303348325837, 1353.9439237394847, 1355.620426280643, 882.5482081975243, 925.7779730755339, 965.9806803863884, 970.4565443351746, 976.9706908792748, 4382.978085109554, 4562.885927851764, 4964.3298154748645, 5018.698878067327, 5020.924686129711, 5313.0, 5401.7029063401105, 5460.481254280837, 5463.562914966793, 5471.50756431915, 4244.830206791694, 4611.815527378867, 4795.6163506919365, 5006.3491746073505, 5007.349044624176, 2847.5870998705072, 2851.5904061068363, 2863.6993115722967, 2876.180288617734, 2884.4519541287086, 4799.136155492045, 4978.5270399312, 4990.625703072212, 5118.97440512795, 5615.719214039282, 4412.713173643703, 4742.766880610997, 5178.766955487012, 5193.597728613253, 5410.458954104558, 5102.540771330524, 6050.788222412194, 6099.84750381244, 6113.0743815697915, 6122.081687746873, 5407.513323800877, 5635.323761148688, 5820.0, 5835.854103647443, 5919.230500034968, 4956.752162391794, 5348.491893270133, 5379.704116273642, 5477.72611369422, 5714.914056369478, 6023.27720673522, 6032.819015429544, 6113.724882380215, 6125.724342404692, 6140.0, 3781.978865706189, 3857.884263471988, 3866.5553461352306, 3881.223755248905, 3897.0452239200445, 4977.900441991067, 5460.3993560707495, 5511.448855114457, 5751.568632352507, 5771.220885180447, 4777.474477807369, 5367.463253674601, 5462.453754624506, 5607.719614019365, 5624.775008999594, 5503.3120859892515, 5544.528715059265, 5550.916736249041, 5587.888242235052, 5605.635633683797, 4905.803767849389, 4992.9764398298985, 5420.295361603125, 5426.348838139448, 5469.113155961187, 5542.251796007487, 5559.388467268678, 5562.777488900399, 5570.61005729595, 5575.832725018256, 5313.415524292402, 5382.757775900016, 5392.379876314118, 5422.153369480896, 5451.0752258373905], "value": 4077.3499926275585, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.6706847781544, 729.8104090332757, 731.2614259597806, 740.966351939045, 763.602926478231, 12719.682007949807, 14664.41342346305, 15388.692226155485, 16442.0, 17210.655786884254, 15237.61905952349, 15292.770608440855, 15309.69380612387, 15327.00374475661, 15334.769978450333, 732.4030914804443, 769.9884501732464, 793.6864938349348, 896.7623579751371, 903.6295119001211, 696.362828012368, 719.9640017999105, 874.816288579399, 888.8533391990314, 907.3557773980482, 869.7303835810887, 930.1675000874213, 932.6129656192672, 936.6347124621403, 937.1378331934602, 929.4284015330524, 930.4370855632346, 930.7207837648713, 934.1592566689966, 935.4527601353217, 656.0, 698.5424546921774, 698.8043347862556, 701.0675801184412, 701.1165930927068, 12122.818157727641, 14713.485028023968, 14893.255337233204, 15118.39526418942, 15139.394424223017, 13463.461461541527, 13641.104081207011, 13733.519326823513, 13786.103903246258, 13831.446742130303, 11347.602833900773, 11489.253198542068, 11600.709982250426, 11773.705657358549, 12000.21998570099, 3597.1007248187952, 3611.56661200655, 3663.1757854482794, 3721.5348081489815, 3830.4062870255157, 95151.52424237903, 107722.46138769334, 107938.46030769795, 110854.89145108526, 111550.44224778905, 10533.84199237012, 10545.578176872992, 10555.630552930765, 10580.52387642558, 10818.675439736662, 21599.352019439128, 21638.675419868716, 21659.566808663738, 21703.891480542497, 21750.129994800347, 7526.736564220226, 7643.1974642662835, 7715.614219289126, 7769.922300777033, 7862.803429914184, 4185.765199266224, 4311.159323931866, 4325.7620830853975, 4367.737935723867, 4492.842750503717, 3516.5252690886405, 3578.9957623730274, 3605.6394360563736, 3605.6935160511653, 3613.114786877232, 610.7083518358639, 646.7099129123719, 652.6736631684158, 652.8890088684935, 653.1085068880943, 552.8424399046253, 642.9389208025231, 668.8595394967111, 679.3512195852949, 679.6126208061456, 9082.772930676785, 9105.063025839087, 9253.861192082124, 9274.859226230463, 9365.344425890122, 634.5558109323492, 665.2416245480157, 665.5740326191242, 688.6625553478759, 691.5574032619128, 4269.786510674454, 4307.289297265916, 4891.997140586172, 4948.8762780930765, 5005.6996580205305, 99591.0, 101359.49320253351, 102045.48977255214, 104551.0, 106230.0, 92889.0, 94144.52927735317, 94186.58720119066, 95341.0, 96942.51528742311, 80730.59634701906, 83499.0, 83623.16376836275, 84110.31779364379, 85387.0, 9497.382670126419, 9804.705858824247, 9806.0, 9878.259130565093, 9892.258080643836, 52752.736236318575, 53851.0, 53934.730326348115, 54157.45842541524, 55627.0, 75095.0, 75531.0, 77244.2275577237, 79010.0, 80955.0, 10786.946065269623, 11531.654050378502, 12845.935770321088, 12896.613101606967, 13108.279044652254, 14445.711085778436, 14592.708145836812, 14955.177465239516, 15143.242837858283, 15553.144577048372, 12396.442160102997, 13092.01809864283, 13454.596362109152, 13806.65483362924, 14022.546054440636, 13243.933780331037, 13293.335333233494, 13752.31238438094, 13780.448782049007, 14008.929955350159, 10924.852316250315, 13574.52489162914, 13633.250171240677, 13645.385957631732, 13930.651733706738, 10894.509747061244, 10906.61826836057, 11148.219624626197, 11307.321560706385, 11527.365994870363, 7991.520508769492, 11185.496652650812, 11225.382603956861, 11465.770684586094, 11498.94250528742], "value": 7522.679355178802, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1664.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 117.0, 118.0, 117.0, 116.0, 124.0, 117.0, 118.0, 120.0], "value": 117.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 119.0, 118.0, 156.0, 119.0, 120.0, 124.0, 146.0, 132.0, 108.0], "value": 129.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 206.0, 204.0, 272.0, 281.0, 200.0, 194.0, 196.0, 195.0, 206.0], "value": 214.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 76.0, 86.0, 95.0, 59.0, 58.0, 57.0, 52.0, 77.0, 69.0], "value": 72.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 71.0, 72.0, 95.0, 95.0, 100.0, 96.0, 70.0, 72.0, 83.0], "value": 85.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 163.0, 109.0, 113.0, 153.0, 113.0, 170.0, 172.0, 110.0, 112.0], "value": 132.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 141.0, 176.0, 134.0, 99.0, 99.0, 99.0, 105.0, 101.0], "value": 122.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 95.0, 147.0, 136.0, 138.0, 144.0, 93.0, 94.0, 100.0, 147.0], "value": 119.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 56.0, 59.0, 57.0, 57.0, 56.0, 57.0, 54.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 78.0, 69.0, 80.0, 69.0, 70.0, 98.0, 58.0, 71.0, 97.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 82.0, 107.0, 112.0, 112.0, 88.0, 81.0, 92.0, 112.0, 111.0], "value": 99.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 168.0, 162.0, 180.0, 164.0, 159.0, 172.0, 153.0, 208.0, 162.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 212.0, 177.0, 182.0, 203.0, 175.0, 174.0, 229.0, 225.0, 231.0], "value": 200.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 70.0, 67.0, 80.0, 68.0, 63.0, 84.0, 70.0, 63.0], "value": 70.2, "unit": "score"}]}]} 10:59:45 INFO - Return code: 0 10:59:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:59:45 ERROR - # TBPL SUCCESS # 10:59:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:59:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:59:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:59:45 INFO - 2016-12-13 10:59:45.467 screenresolution[1936:17340] starting screenresolution argv=screenresolution get 10:59:45 INFO - 2016-12-13 10:59:45.470 screenresolution[1936:17340] Display 0: 1600x1200x32@60 10:59:45 INFO - 2016-12-13 10:59:45.476 screenresolution[1937:17343] starting screenresolution argv=screenresolution list 10:59:45 INFO - Available Modes on Display 0 10:59:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:59:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:59:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:59:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:59:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:59:45 INFO - Intel Iris: 10:59:45 INFO - Chipset Model: Intel Iris 10:59:45 INFO - Type: GPU 10:59:45 INFO - Bus: Built-In 10:59:45 INFO - VRAM (Dynamic, Max): 1536 MB 10:59:45 INFO - Vendor: Intel (0x8086) 10:59:45 INFO - Device ID: 0x0a2e 10:59:45 INFO - Revision ID: 0x0009 10:59:45 INFO - Displays: 10:59:45 INFO - Display: 10:59:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:59:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:59:45 INFO - Display Serial Number: 1600x1200 60 10:59:45 INFO - Main Display: Yes 10:59:45 INFO - Mirror: Off 10:59:45 INFO - Online: Yes 10:59:45 INFO - Rotation: Supported 10:59:45 INFO - Return code: 0 10:59:45 INFO - Running post-action listener: _resource_record_post_action 10:59:45 INFO - [mozharness: 2016-12-13 18:59:45.713306Z] Finished run-tests step (success) 10:59:45 INFO - Running post-run listener: _resource_record_post_run 10:59:45 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 1603072; Write bytes: 551859712; Read time: 15; Write time: 1699 10:59:45 INFO - TinderboxPrint: CPU usage
54.6% 10:59:45 INFO - TinderboxPrint: I/O read bytes / time
1,603,072 / 15 10:59:45 INFO - TinderboxPrint: I/O write bytes / time
551,859,712 / 1,699 10:59:45 INFO - TinderboxPrint: CPU idle
2,178.7 (45.4%) 10:59:45 INFO - TinderboxPrint: CPU system
969.9 (20.2%) 10:59:45 INFO - TinderboxPrint: CPU user
1,653.0 (34.4%) 10:59:45 INFO - TinderboxPrint: Swap in / out
251,670,528 / 0 10:59:45 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 228340224; Write bytes: 220958720; Read time: 16502; Write time: 472 10:59:45 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 1603072; Write bytes: 301606400; Read time: 15; Write time: 1158 10:59:46 INFO - Running post-run listener: _upload_blobber_files 10:59:46 INFO - Blob upload gear active. 10:59:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:59:46 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 10:59:46 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'] 10:59:46 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 10:59:46 INFO - (blobuploader) - INFO - Open directory for files ... 10:59:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:59:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:59:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:59:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:59:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:59:47 INFO - (blobuploader) - INFO - Done attempting. 10:59:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:59:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:59:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:59:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:59:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:59:48 INFO - (blobuploader) - INFO - Done attempting. 10:59:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:59:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:59:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:59:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:59:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:59:50 INFO - (blobuploader) - INFO - Done attempting. 10:59:50 INFO - (blobuploader) - INFO - Iteration through files over. 10:59:50 INFO - Return code: 0 10:59:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:59:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:59:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd04a51b2978d7263aa46474eba280a82bf6efbd24672ef79a4b1a45fb6e95f447909b89ed9736bae57208d1091f3ff144304cd9b5c9df12f1945f7292a0a602", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81e156f0540b3865a3cb781df225ffbd6c013d038e538ed5ab6380d49bb25f41225c4c7f02cd25ff3a505223fc44d1fcd0ca52c47f89b371250f840514cfec94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fc7eee1d62f2dd34d01458e229bf8b5576f430eb108e72431abc298c227c4a93be9d2085de5e648abe2883236d63977cd602db3a784927157d68838cb2e445f"} 10:59:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:59:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:59:50 INFO - Contents: 10:59:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd04a51b2978d7263aa46474eba280a82bf6efbd24672ef79a4b1a45fb6e95f447909b89ed9736bae57208d1091f3ff144304cd9b5c9df12f1945f7292a0a602", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81e156f0540b3865a3cb781df225ffbd6c013d038e538ed5ab6380d49bb25f41225c4c7f02cd25ff3a505223fc44d1fcd0ca52c47f89b371250f840514cfec94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fc7eee1d62f2dd34d01458e229bf8b5576f430eb108e72431abc298c227c4a93be9d2085de5e648abe2883236d63977cd602db3a784927157d68838cb2e445f"} 10:59:50 INFO - Running post-run listener: copy_logs_to_upload_dir 10:59:50 INFO - Copying logs to upload dir... 10:59:50 INFO - mkdir: /builds/slave/test/build/upload/logs 10:59:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.971999 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-12-13 10:59:50.924130) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-13 10:59:50.927807) ========= 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.dfBtSggJSq/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.Y1HHKVYHIJ/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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/cd04a51b2978d7263aa46474eba280a82bf6efbd24672ef79a4b1a45fb6e95f447909b89ed9736bae57208d1091f3ff144304cd9b5c9df12f1945f7292a0a602", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81e156f0540b3865a3cb781df225ffbd6c013d038e538ed5ab6380d49bb25f41225c4c7f02cd25ff3a505223fc44d1fcd0ca52c47f89b371250f840514cfec94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fc7eee1d62f2dd34d01458e229bf8b5576f430eb108e72431abc298c227c4a93be9d2085de5e648abe2883236d63977cd602db3a784927157d68838cb2e445f"} build_url:https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg program finished with exit code 0 elapsedTime=0.011256 build_url: 'https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd04a51b2978d7263aa46474eba280a82bf6efbd24672ef79a4b1a45fb6e95f447909b89ed9736bae57208d1091f3ff144304cd9b5c9df12f1945f7292a0a602", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81e156f0540b3865a3cb781df225ffbd6c013d038e538ed5ab6380d49bb25f41225c4c7f02cd25ff3a505223fc44d1fcd0ca52c47f89b371250f840514cfec94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fc7eee1d62f2dd34d01458e229bf8b5576f430eb108e72431abc298c227c4a93be9d2085de5e648abe2883236d63977cd602db3a784927157d68838cb2e445f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-13 10:59:50.962907) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 10:59:50.963222) ========= 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.dfBtSggJSq/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.Y1HHKVYHIJ/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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.005336 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 10:59:51.011856) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-13 10:59:51.012161) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-13 10:59:51.012478) ========= ========= Total master_lag: 0.18 =========