builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0255 starttime: 1493010581.57 results: success (0) buildid: 20170423203720 builduid: fcfc73032d194d86b76b336d88b766e8 revision: 73752931e273091185e1e4b5231c28beed657cc8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-23 22:09:41.570776) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-23 22:09:41.571245) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-23 22:09:41.572278) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-23 22:09:41.601584) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-23 22:09:41.602008) ========= 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.OznSQrfn1q/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.B8Lu6LTZgB/Listeners TMPDIR=/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-23 22:09:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.9M=0.001s 2017-04-23 22:09:42 (18.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.658234 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-23 22:09:42.286137) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-23 22:09:42.286506) ========= 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.OznSQrfn1q/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.B8Lu6LTZgB/Listeners TMPDIR=/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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.027035 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-23 22:09:42.335482) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-23 22:09:42.335806) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 73752931e273091185e1e4b5231c28beed657cc8 --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 73752931e273091185e1e4b5231c28beed657cc8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OznSQrfn1q/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.B8Lu6LTZgB/Listeners TMPDIR=/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-23 22:09:42,440 truncating revision to first 12 chars 2017-04-23 22:09:42,440 Setting DEBUG logging. 2017-04-23 22:09:42,440 attempt 1/10 2017-04-23 22:09:42,440 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/73752931e273?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-23 22:09:43,226 unpacking tar archive at: mozilla-central-73752931e273/testing/mozharness/ program finished with exit code 0 elapsedTime=1.070051 ========= master_lag: 0.56 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-23 22:09:43.970123) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-23 22:09:43.970391) ========= script_repo_revision: 73752931e273091185e1e4b5231c28beed657cc8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-23 22:09:43.970749) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-23 22:09:43.974040) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-23 22:09:44.011120) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-23 22:09:44.011390) ========= /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.OznSQrfn1q/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.B8Lu6LTZgB/Listeners TMPDIR=/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 22:09:44 INFO - MultiFileLogger online at 20170423 22:09:44 in /builds/slave/test 22:09:44 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 22:09:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:09:44 INFO - {'append_to_log': False, 22:09:44 INFO - 'base_work_dir': '/builds/slave/test', 22:09:44 INFO - 'blob_upload_branch': 'Firefox', 22:09:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:09:44 INFO - 'branch': 'Firefox', 22:09:44 INFO - 'buildbot_json_path': 'buildprops.json', 22:09:44 INFO - 'config_files': ('talos/mac_config.py',), 22:09:44 INFO - 'default_actions': ('clobber', 22:09:44 INFO - 'read-buildbot-config', 22:09:44 INFO - 'download-and-extract', 22:09:44 INFO - 'populate-webroot', 22:09:44 INFO - 'create-virtualenv', 22:09:44 INFO - 'install', 22:09:44 INFO - 'run-tests'), 22:09:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:09:44 INFO - 'download_minidump_stackwalk': True, 22:09:44 INFO - 'download_symbols': 'ondemand', 22:09:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:09:44 INFO - 'tooltool.py': '/tools/tooltool.py', 22:09:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:09:44 INFO - '/tools/misc-python/virtualenv.py')}, 22:09:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:09:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:09:44 INFO - 'gecko_profile': False, 22:09:44 INFO - 'gecko_profile_interval': 0, 22:09:44 INFO - 'installer_path': 'installer.exe', 22:09:44 INFO - 'log_level': 'info', 22:09:44 INFO - 'log_name': 'talos', 22:09:44 INFO - 'log_to_console': True, 22:09:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:09:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:09:44 INFO - 'opt_config_files': (), 22:09:44 INFO - 'pip_index': False, 22:09:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:09:44 INFO - 'cmd': ('bash', 22:09:44 INFO - '-c', 22:09:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:09:44 INFO - 'enabled': True, 22:09:44 INFO - 'halt_on_failure': False, 22:09:44 INFO - 'name': 'check_screen_resolution'},), 22:09:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:09:44 INFO - 'cmd': ('bash', 22:09:44 INFO - '-c', 22:09:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:09:44 INFO - 'enabled': True, 22:09:44 INFO - 'halt_on_failure': False, 22:09:44 INFO - 'name': 'check_screen_resolution'},), 22:09:44 INFO - 'run_cmd_checks_enabled': True, 22:09:44 INFO - 'suite': 'dromaeojs-e10s', 22:09:44 INFO - 'system_bits': '32', 22:09:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:09:44 INFO - 'title': 't-yosemite-r7-0255', 22:09:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:09:44 INFO - 'use_talos_json': True, 22:09:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:09:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:09:44 INFO - 'work_dir': 'build'} 22:09:44 INFO - [mozharness: 2017-04-24 05:09:44.225481Z] Running clobber step. 22:09:44 INFO - Running pre-action listener: _resource_record_pre_action 22:09:44 INFO - Running main action method: clobber 22:09:44 INFO - rmtree: /builds/slave/test/build 22:09:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:09:46 INFO - Running post-action listener: _resource_record_post_action 22:09:46 INFO - [mozharness: 2017-04-24 05:09:46.844619Z] Finished clobber step (success) 22:09:46 INFO - [mozharness: 2017-04-24 05:09:46.844880Z] Running read-buildbot-config step. 22:09:46 INFO - Running pre-action listener: _resource_record_pre_action 22:09:46 INFO - Running main action method: read_buildbot_config 22:09:46 INFO - Using buildbot properties: 22:09:46 INFO - { 22:09:46 INFO - "project": "", 22:09:46 INFO - "product": "firefox", 22:09:46 INFO - "script_repo_revision": "production", 22:09:46 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 22:09:46 INFO - "repository": "", 22:09:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 22:09:46 INFO - "buildid": "20170423203720", 22:09:46 INFO - "pgo_build": "False", 22:09:46 INFO - "basedir": "/builds/slave/test", 22:09:46 INFO - "buildnumber": 46, 22:09:46 INFO - "slavename": "t-yosemite-r7-0255", 22:09:46 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 22:09:46 INFO - "platform": "yosemite_r7", 22:09:46 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 22:09:46 INFO - "branch": "mozilla-central", 22:09:46 INFO - "repo_path": "mozilla-central", 22:09:46 INFO - "revision": "73752931e273091185e1e4b5231c28beed657cc8", 22:09:46 INFO - "stage_platform": "macosx64", 22:09:46 INFO - "builduid": "fcfc73032d194d86b76b336d88b766e8", 22:09:46 INFO - "slavebuilddir": "test" 22:09:46 INFO - } 22:09:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/CVjp-fVsSF-4hohxzZO8WQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 22:09:46 INFO - Running post-action listener: _resource_record_post_action 22:09:46 INFO - [mozharness: 2017-04-24 05:09:46.850369Z] Finished read-buildbot-config step (success) 22:09:46 INFO - [mozharness: 2017-04-24 05:09:46.850530Z] Running download-and-extract step. 22:09:46 INFO - Running pre-action listener: _resource_record_pre_action 22:09:46 INFO - Running main action method: download_and_extract 22:09:46 INFO - mkdir: /builds/slave/test/build/tests 22:09:46 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')]} 22:09:46 INFO - trying https://queue.taskcluster.net/v1/task/CVjp-fVsSF-4hohxzZO8WQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 22:09:46 INFO - Downloading https://queue.taskcluster.net/v1/task/CVjp-fVsSF-4hohxzZO8WQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 22:09:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CVjp-fVsSF-4hohxzZO8WQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 22:09:48 INFO - Downloaded 1325 bytes. 22:09:48 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 22:09:48 INFO - Using the following test package requirements: 22:09:48 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 22:09:48 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 22:09:48 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 22:09:48 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 22:09:48 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 22:09:48 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 22:09:48 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 22:09:48 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 22:09:48 INFO - u'jsshell-mac.zip'], 22:09:48 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 22:09:48 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 22:09:48 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 22:09:48 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 22:09:48 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 22:09:48 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 22:09:48 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 22:09:48 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 22:09:48 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 22:09:48 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 22:09:48 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 22:09:48 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:09:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CVjp-fVsSF-4hohxzZO8WQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 22:09:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CVjp-fVsSF-4hohxzZO8WQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:09:48 INFO - Fetch https://queue.taskcluster.net/v1/task/CVjp-fVsSF-4hohxzZO8WQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 22:09:49 INFO - Content-Length response header: 52523367 22:09:49 INFO - Bytes received: 52523367 22:10:06 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 22:10:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CVjp-fVsSF-4hohxzZO8WQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 22:10:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CVjp-fVsSF-4hohxzZO8WQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:10:06 INFO - Fetch https://queue.taskcluster.net/v1/task/CVjp-fVsSF-4hohxzZO8WQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 22:10:08 INFO - Content-Length response header: 52523367 22:10:08 INFO - Bytes received: 52523367 22:10:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CVjp-fVsSF-4hohxzZO8WQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 22:10:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CVjp-fVsSF-4hohxzZO8WQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 22:10:24 INFO - Fetch https://queue.taskcluster.net/v1/task/CVjp-fVsSF-4hohxzZO8WQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 22:10:24 INFO - Content-Length response header: 14408822 22:10:24 INFO - Bytes received: 14408822 22:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:10:25 INFO - trying https://queue.taskcluster.net/v1/task/CVjp-fVsSF-4hohxzZO8WQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 22:10:25 INFO - Downloading https://queue.taskcluster.net/v1/task/CVjp-fVsSF-4hohxzZO8WQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 22:10:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CVjp-fVsSF-4hohxzZO8WQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 22:10:27 INFO - Downloaded 71041265 bytes. 22:10:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CVjp-fVsSF-4hohxzZO8WQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 22:10:27 INFO - mkdir: /builds/slave/test/properties 22:10:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:10:27 INFO - Writing to file /builds/slave/test/properties/build_url 22:10:27 INFO - Contents: 22:10:27 INFO - build_url:https://queue.taskcluster.net/v1/task/CVjp-fVsSF-4hohxzZO8WQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 22:10:27 INFO - Running post-action listener: _resource_record_post_action 22:10:27 INFO - Running post-action listener: set_extra_try_arguments 22:10:27 INFO - [mozharness: 2017-04-24 05:10:27.872873Z] Finished download-and-extract step (success) 22:10:27 INFO - [mozharness: 2017-04-24 05:10:27.872973Z] Running populate-webroot step. 22:10:27 INFO - Running pre-action listener: _resource_record_pre_action 22:10:27 INFO - Running main action method: populate_webroot 22:10:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:10:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:10:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:10:27 INFO - '--tppagecycles', 22:10:27 INFO - '7'], 22:10:27 INFO - 'tests': ['tsvgm']}}, 22:10:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:10:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:10:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:10:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:10:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:10:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:10:27 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:10:27 INFO - 'talos_options': ['--disable-e10s'], 22:10:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:10:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:10:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:10:27 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:10:27 INFO - 'talos_options': ['--disable-e10s'], 22:10:27 INFO - 'tests': ['damp', 'tps']}, 22:10:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:10:27 INFO - 'tests': ['damp', 'tps']}, 22:10:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:10:27 INFO - 'tests': ['dromaeo_dom']}, 22:10:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:10:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:10:27 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 22:10:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 22:10:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:10:27 INFO - 'tests': ['a11yr', 22:10:27 INFO - 'ts_paint', 22:10:27 INFO - 'tpaint', 22:10:27 INFO - 'sessionrestore', 22:10:27 INFO - 'sessionrestore_no_auto_restore', 22:10:27 INFO - 'tabpaint']}, 22:10:27 INFO - 'other-e10s': {'tests': ['a11yr', 22:10:27 INFO - 'ts_paint', 22:10:27 INFO - 'tpaint', 22:10:27 INFO - 'sessionrestore', 22:10:27 INFO - 'sessionrestore_no_auto_restore', 22:10:27 INFO - 'tabpaint']}, 22:10:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:10:27 INFO - 'ts_paint', 22:10:27 INFO - 'tpaint', 22:10:27 INFO - 'sessionrestore', 22:10:27 INFO - 'sessionrestore_no_auto_restore', 22:10:27 INFO - 'tabpaint']}, 22:10:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:10:27 INFO - 'ts_paint', 22:10:27 INFO - 'tpaint', 22:10:27 INFO - 'sessionrestore', 22:10:27 INFO - 'sessionrestore_no_auto_restore', 22:10:27 INFO - 'tabpaint']}, 22:10:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:10:27 INFO - 'tests': ['a11yr', 22:10:27 INFO - 'ts_paint', 22:10:27 INFO - 'tpaint', 22:10:27 INFO - 'sessionrestore', 22:10:27 INFO - 'sessionrestore_no_auto_restore', 22:10:27 INFO - 'tabpaint']}, 22:10:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:10:27 INFO - 'tests': ['a11yr', 22:10:27 INFO - 'ts_paint', 22:10:27 INFO - 'tpaint', 22:10:27 INFO - 'sessionrestore', 22:10:27 INFO - 'sessionrestore_no_auto_restore', 22:10:27 INFO - 'tabpaint']}, 22:10:27 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 22:10:27 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 22:10:27 INFO - 'bloom_basic_ref']}, 22:10:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:10:27 INFO - 'tests': ['tsvgx', 22:10:27 INFO - 'tsvgr_opacity', 22:10:27 INFO - 'tart', 22:10:27 INFO - 'tscrollx', 22:10:27 INFO - 'cart', 22:10:27 INFO - 'tsvg_static']}, 22:10:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:10:27 INFO - 'tsvgr_opacity', 22:10:27 INFO - 'tart', 22:10:27 INFO - 'tscrollx', 22:10:27 INFO - 'cart', 22:10:27 INFO - 'tsvg_static']}, 22:10:27 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:10:27 INFO - 'talos_options': ['--disable-e10s'], 22:10:27 INFO - 'tests': ['tp5o']}, 22:10:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:10:27 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:10:27 INFO - 'talos_options': ['--disable-e10s', 22:10:27 INFO - '--xperf_path', 22:10:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:10:27 INFO - 'tests': ['tp5n']}, 22:10:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:10:27 INFO - 'talos_options': ['--xperf_path', 22:10:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:10:27 INFO - 'tests': ['tp5n']}}, 22:10:27 INFO - 'talos.zip': {'path': '', 22:10:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:10:27 INFO - Running post-action listener: _resource_record_post_action 22:10:27 INFO - [mozharness: 2017-04-24 05:10:27.892233Z] Finished populate-webroot step (success) 22:10:27 INFO - [mozharness: 2017-04-24 05:10:27.892358Z] Running create-virtualenv step. 22:10:27 INFO - Running pre-action listener: _resource_record_pre_action 22:10:27 INFO - Running main action method: create_virtualenv 22:10:27 INFO - Creating virtualenv /builds/slave/test/build/venv 22:10:27 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 22:10:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:10:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:10:28 INFO - Using real prefix '/tools/python27' 22:10:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:10:28 INFO - Installing distribute.............................................................................................................................................................................................done. 22:10:31 INFO - Installing pip.................done. 22:10:31 INFO - Return code: 0 22:10:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:10:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:10:31 INFO - Reading from file tmpfile_stdout 22:10:31 INFO - Output received: 22:10:31 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) 22:10:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:10:31 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')]} 22:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:31 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')]} 22:10:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:31 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 0x10d5d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd5b59c370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3b2d30>, '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 0x10d2d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3a7be8>, '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.OznSQrfn1q/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.B8Lu6LTZgB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 22:10:31 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 22:10:31 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 22:10:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OznSQrfn1q/Render', 22:10:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:10:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:10:31 INFO - 'HOME': '/Users/cltbld', 22:10:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:10:31 INFO - 'LOGNAME': 'cltbld', 22:10:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:31 INFO - 'MOZ_NO_REMOTE': '1', 22:10:31 INFO - 'NO_EM_RESTART': '1', 22:10:31 INFO - 'PAGER': '/bin/cat', 22:10:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:10:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:31 INFO - 'PWD': '/builds/slave/test', 22:10:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:10:31 INFO - 'SHELL': '/bin/bash', 22:10:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B8Lu6LTZgB/Listeners', 22:10:31 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 22:10:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:10:31 INFO - 'USER': 'cltbld', 22:10:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:10:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:10:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:31 INFO - 'XPC_FLAGS': '0x0', 22:10:31 INFO - 'XPC_SERVICE_NAME': '0', 22:10:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:10:32 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 22:10:32 INFO - Cleaning up... 22:10:32 INFO - Return code: 0 22:10:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:32 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 0x10d5d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd5b59c370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3b2d30>, '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 0x10d2d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3a7be8>, '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.OznSQrfn1q/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.B8Lu6LTZgB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 22:10:32 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 22:10:32 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 22:10:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OznSQrfn1q/Render', 22:10:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:10:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:10:32 INFO - 'HOME': '/Users/cltbld', 22:10:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:10:32 INFO - 'LOGNAME': 'cltbld', 22:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:32 INFO - 'MOZ_NO_REMOTE': '1', 22:10:32 INFO - 'NO_EM_RESTART': '1', 22:10:32 INFO - 'PAGER': '/bin/cat', 22:10:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:32 INFO - 'PWD': '/builds/slave/test', 22:10:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:10:32 INFO - 'SHELL': '/bin/bash', 22:10:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B8Lu6LTZgB/Listeners', 22:10:32 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 22:10:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:10:32 INFO - 'USER': 'cltbld', 22:10:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:10:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:32 INFO - 'XPC_FLAGS': '0x0', 22:10:32 INFO - 'XPC_SERVICE_NAME': '0', 22:10:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:10:32 INFO - Downloading/unpacking psutil>=3.1.1 22:10: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 22:10: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 22:10: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 22:10: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 22:10: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 22:10: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 22:10:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:10:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:10:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:10:36 INFO - Installing collected packages: psutil 22:10:36 INFO - Running setup.py install for psutil 22:10:36 INFO - building 'psutil._psutil_osx' extension 22:10:36 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 22:10:37 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 22:10:37 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 22:10:37 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 22:10:37 INFO - building 'psutil._psutil_posix' extension 22:10:37 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 22:10:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:10:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:10:37 INFO - ^ 22:10:37 INFO - 1 warning generated. 22:10:37 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 22:10:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:10:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:10:37 INFO - Successfully installed psutil 22:10:37 INFO - Cleaning up... 22:10:37 INFO - Return code: 0 22:10:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:10:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd5b59c370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3b2d30>, '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 0x10d2d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3a7be8>, '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.OznSQrfn1q/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.B8Lu6LTZgB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 22:10:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:10:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:10:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OznSQrfn1q/Render', 22:10:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:10:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:10:37 INFO - 'HOME': '/Users/cltbld', 22:10:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:10:37 INFO - 'LOGNAME': 'cltbld', 22:10:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:37 INFO - 'MOZ_NO_REMOTE': '1', 22:10:37 INFO - 'NO_EM_RESTART': '1', 22:10:37 INFO - 'PAGER': '/bin/cat', 22:10:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:10:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:37 INFO - 'PWD': '/builds/slave/test', 22:10:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:10:37 INFO - 'SHELL': '/bin/bash', 22:10:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B8Lu6LTZgB/Listeners', 22:10:37 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 22:10:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:10:37 INFO - 'USER': 'cltbld', 22:10:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:10:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:10:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:37 INFO - 'XPC_FLAGS': '0x0', 22:10:37 INFO - 'XPC_SERVICE_NAME': '0', 22:10:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:10:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:10:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:10:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:10:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:10:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:10:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:10:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:10:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:10:40 INFO - Installing collected packages: mozsystemmonitor 22:10:40 INFO - Running setup.py install for mozsystemmonitor 22:10:40 INFO - Successfully installed mozsystemmonitor 22:10:40 INFO - Cleaning up... 22:10:40 INFO - Return code: 0 22:10:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:10:40 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')]} 22:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:40 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')]} 22:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:40 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 0x10d5d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd5b59c370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3b2d30>, '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 0x10d2d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3a7be8>, '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.OznSQrfn1q/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.B8Lu6LTZgB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 22:10:40 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 22:10:40 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 22:10:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OznSQrfn1q/Render', 22:10:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:10:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:10:40 INFO - 'HOME': '/Users/cltbld', 22:10:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:10:40 INFO - 'LOGNAME': 'cltbld', 22:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:40 INFO - 'MOZ_NO_REMOTE': '1', 22:10:40 INFO - 'NO_EM_RESTART': '1', 22:10:40 INFO - 'PAGER': '/bin/cat', 22:10:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:40 INFO - 'PWD': '/builds/slave/test', 22:10:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:10:40 INFO - 'SHELL': '/bin/bash', 22:10:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B8Lu6LTZgB/Listeners', 22:10:40 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 22:10:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:10:40 INFO - 'USER': 'cltbld', 22:10:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:10:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:40 INFO - 'XPC_FLAGS': '0x0', 22:10:40 INFO - 'XPC_SERVICE_NAME': '0', 22:10:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:10:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:10:41 INFO - Downloading/unpacking jsonschema==2.5.1 22:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:10:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:10:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:10:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:10:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:10:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:10:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:10:43 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 22:10:43 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 22:10:43 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 22:10:43 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 22:10:43 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 22:10:43 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 22:10:44 INFO - Downloading functools32-3.2.3-2.tar.gz 22:10:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:10:44 INFO - warning: no files found matching '*.txt' 22:10:44 INFO - no previously-included directories found matching 'build' 22:10:44 INFO - no previously-included directories found matching 'dist' 22:10:44 INFO - no previously-included directories found matching '.git*' 22:10:44 INFO - Installing collected packages: jsonschema, functools32 22:10:44 INFO - Running setup.py install for functools32 22:10:44 INFO - warning: no files found matching '*.txt' 22:10:44 INFO - no previously-included directories found matching 'build' 22:10:44 INFO - no previously-included directories found matching 'dist' 22:10:44 INFO - no previously-included directories found matching '.git*' 22:10:44 INFO - Successfully installed jsonschema functools32 22:10:44 INFO - Cleaning up... 22:10:44 INFO - Return code: 0 22:10:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:10: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')]} 22:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10: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')]} 22:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10: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', '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 0x10d5d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd5b59c370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3b2d30>, '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 0x10d2d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3a7be8>, '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.OznSQrfn1q/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.B8Lu6LTZgB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 22:10: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:10: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 functools32==3.2.3-2 22:10:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OznSQrfn1q/Render', 22:10:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:10:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:10:44 INFO - 'HOME': '/Users/cltbld', 22:10:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:10:44 INFO - 'LOGNAME': 'cltbld', 22:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:44 INFO - 'MOZ_NO_REMOTE': '1', 22:10:44 INFO - 'NO_EM_RESTART': '1', 22:10:44 INFO - 'PAGER': '/bin/cat', 22:10:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:44 INFO - 'PWD': '/builds/slave/test', 22:10:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:10:44 INFO - 'SHELL': '/bin/bash', 22:10:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B8Lu6LTZgB/Listeners', 22:10:44 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 22:10:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:10:44 INFO - 'USER': 'cltbld', 22:10:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:10:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:44 INFO - 'XPC_FLAGS': '0x0', 22:10:44 INFO - 'XPC_SERVICE_NAME': '0', 22:10:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:10:44 INFO - Cleaning up... 22:10:44 INFO - Return code: 0 22:10:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:10: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')]} 22:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10: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')]} 22:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10: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', '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 0x10d5d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd5b59c370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3b2d30>, '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 0x10d2d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3a7be8>, '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.OznSQrfn1q/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.B8Lu6LTZgB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 22:10: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:10: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 blobuploader==1.2.4 22:10:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OznSQrfn1q/Render', 22:10:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:10:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:10:44 INFO - 'HOME': '/Users/cltbld', 22:10:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:10:44 INFO - 'LOGNAME': 'cltbld', 22:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:44 INFO - 'MOZ_NO_REMOTE': '1', 22:10:44 INFO - 'NO_EM_RESTART': '1', 22:10:44 INFO - 'PAGER': '/bin/cat', 22:10:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:44 INFO - 'PWD': '/builds/slave/test', 22:10:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:10:44 INFO - 'SHELL': '/bin/bash', 22:10:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B8Lu6LTZgB/Listeners', 22:10:44 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 22:10:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:10:44 INFO - 'USER': 'cltbld', 22:10:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:10:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:44 INFO - 'XPC_FLAGS': '0x0', 22:10:44 INFO - 'XPC_SERVICE_NAME': '0', 22:10:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:10:44 INFO - Downloading/unpacking blobuploader==1.2.4 22:10:44 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 22:10:44 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 22:10:44 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 22:10:44 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 22:10:44 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 22:10:44 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 22:10:47 INFO - Downloading blobuploader-1.2.4.tar.gz 22:10:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:10:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:10:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:10:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:10:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:10:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:10:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:10:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:10:48 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 22:10:48 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 22:10:48 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 22:10:48 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 22:10:48 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 22:10:48 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 22:10:48 INFO - Downloading docopt-0.6.1.tar.gz 22:10:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:10:48 INFO - Installing collected packages: blobuploader, requests, docopt 22:10:48 INFO - Running setup.py install for blobuploader 22:10:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:10:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:10:49 INFO - Running setup.py install for requests 22:10:49 INFO - Running setup.py install for docopt 22:10:49 INFO - Successfully installed blobuploader requests docopt 22:10:49 INFO - Cleaning up... 22:10:49 INFO - Return code: 0 22:10:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:10:49 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')]} 22:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:49 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')]} 22:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:49 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 0x10d5d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd5b59c370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3b2d30>, '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 0x10d2d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3a7be8>, '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.OznSQrfn1q/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.B8Lu6LTZgB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 22:10:49 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 22:10:49 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 22:10:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OznSQrfn1q/Render', 22:10:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:10:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:10:49 INFO - 'HOME': '/Users/cltbld', 22:10:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:10:49 INFO - 'LOGNAME': 'cltbld', 22:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:49 INFO - 'MOZ_NO_REMOTE': '1', 22:10:49 INFO - 'NO_EM_RESTART': '1', 22:10:49 INFO - 'PAGER': '/bin/cat', 22:10:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:49 INFO - 'PWD': '/builds/slave/test', 22:10:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:10:49 INFO - 'SHELL': '/bin/bash', 22:10:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B8Lu6LTZgB/Listeners', 22:10:49 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 22:10:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:10:49 INFO - 'USER': 'cltbld', 22:10:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:10:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:49 INFO - 'XPC_FLAGS': '0x0', 22:10:49 INFO - 'XPC_SERVICE_NAME': '0', 22:10:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:10:50 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-tlo2Ez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:10:50 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-lCjNBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:10:50 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-eGoprF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:10:50 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-P8ic0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:10:50 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-j6W5SI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:10:50 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-m9Ig6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:10:50 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-WZTZsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:10:50 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-Y5zT1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:10:50 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-ZfGfT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:10:50 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-JZyXRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:10:51 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-qDV47e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:10:51 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-xSl6xp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:10:51 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-DbAljE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:10:51 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-1ZQP1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:10:51 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-fYqqIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:10:51 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-vrvSf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:10:51 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-H00jQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:10:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:10:51 INFO - Running setup.py install for manifestparser 22:10:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:10:51 INFO - Running setup.py install for mozcrash 22:10:52 INFO - Running setup.py install for mozdebug 22:10:52 INFO - Running setup.py install for mozdevice 22:10:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:10:52 INFO - Running setup.py install for mozfile 22:10:52 INFO - Running setup.py install for mozhttpd 22:10:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:10:52 INFO - Running setup.py install for mozinfo 22:10:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:10:52 INFO - Running setup.py install for mozInstall 22:10:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:10:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:10:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:10:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:10:52 INFO - Running setup.py install for mozleak 22:10:53 INFO - Running setup.py install for mozlog 22:10:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:10:53 INFO - Running setup.py install for moznetwork 22:10:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:10:53 INFO - Running setup.py install for mozprocess 22:10:53 INFO - Running setup.py install for mozprofile 22:10:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:10:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:10:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:10:53 INFO - Running setup.py install for mozrunner 22:10:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:10:53 INFO - Running setup.py install for mozscreenshot 22:10:54 INFO - Running setup.py install for moztest 22:10:54 INFO - Running setup.py install for mozversion 22:10:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:10:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:10:54 INFO - Cleaning up... 22:10:54 INFO - Return code: 0 22:10:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:10:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:10:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:54 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 0x10d5d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd5b59c370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3b2d30>, '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 0x10d2d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3a7be8>, '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.OznSQrfn1q/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.B8Lu6LTZgB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 22:10:54 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 22:10:54 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 22:10:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OznSQrfn1q/Render', 22:10:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:10:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:10:54 INFO - 'HOME': '/Users/cltbld', 22:10:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:10:54 INFO - 'LOGNAME': 'cltbld', 22:10:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:54 INFO - 'MOZ_NO_REMOTE': '1', 22:10:54 INFO - 'NO_EM_RESTART': '1', 22:10:54 INFO - 'PAGER': '/bin/cat', 22:10:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:10:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:54 INFO - 'PWD': '/builds/slave/test', 22:10:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:10:54 INFO - 'SHELL': '/bin/bash', 22:10:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B8Lu6LTZgB/Listeners', 22:10:54 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 22:10:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:10:54 INFO - 'USER': 'cltbld', 22:10:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:10:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:10:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:54 INFO - 'XPC_FLAGS': '0x0', 22:10:54 INFO - 'XPC_SERVICE_NAME': '0', 22:10:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:10:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:10:54 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-0aDWXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:10:54 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)) 22:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:10:54 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-gaytcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:10:54 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)) 22:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:10:54 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-HU2ltX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:10:54 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)) 22:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:10:54 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-g79PrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:10:55 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-ERXtl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:10:55 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)) 22:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:10:55 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-VZfUxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:10:55 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)) 22:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:10:55 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-Qo5t0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:10:55 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)) 22:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:10:55 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-CZ6ahY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:10:55 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)) 22:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:10:55 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-OdOPZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:10:55 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)) 22:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:10:55 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-HAA78D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:10:55 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)) 22:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:10:55 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-Gq0G4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:10:55 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)) 22:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:10:55 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-nmEAi5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:10:55 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-RP0gFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:10:56 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)) 22:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:10:56 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-bGal07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:10:56 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)) 22:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:10:56 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-M49HPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:10:56 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)) 22:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:10:56 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-sfQKjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:10:56 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-xd9bjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:10:56 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)) 22:10:56 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)) 22:10:56 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)) 22:10:56 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)) 22:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:10:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:10:56 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 22:10:56 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 22:10:56 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 22:10:56 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 22:10:56 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 22:10:56 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 22:11:00 INFO - Downloading blessings-1.6.tar.gz 22:11:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:11:00 INFO - Installing collected packages: blessings 22:11:00 INFO - Running setup.py install for blessings 22:11:00 INFO - Successfully installed blessings 22:11:00 INFO - Cleaning up... 22:11:00 INFO - Return code: 0 22:11:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:11:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:11:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:11:00 INFO - Reading from file tmpfile_stdout 22:11:00 INFO - Current package versions: 22:11:00 INFO - blessings == 1.6 22:11:00 INFO - blobuploader == 1.2.4 22:11:00 INFO - docopt == 0.6.1 22:11:00 INFO - functools32 == 3.2.3-2 22:11:00 INFO - jsonschema == 2.5.1 22:11:00 INFO - manifestparser == 1.1 22:11:00 INFO - mozInstall == 1.12 22:11:00 INFO - mozcrash == 1.0 22:11:00 INFO - mozdebug == 0.1 22:11:00 INFO - mozdevice == 0.50 22:11:00 INFO - mozfile == 1.2 22:11:00 INFO - mozhttpd == 0.7 22:11:00 INFO - mozinfo == 0.9 22:11:00 INFO - mozleak == 0.1 22:11:00 INFO - mozlog == 3.4 22:11:00 INFO - moznetwork == 0.27 22:11:00 INFO - mozprocess == 0.25 22:11:00 INFO - mozprofile == 0.28 22:11:00 INFO - mozrunner == 6.13 22:11:00 INFO - mozscreenshot == 0.1 22:11:00 INFO - mozsystemmonitor == 0.3 22:11:00 INFO - moztest == 0.8 22:11:00 INFO - mozversion == 1.4 22:11:00 INFO - psutil == 3.1.1 22:11:00 INFO - requests == 1.2.3 22:11:00 INFO - wsgiref == 0.1.2 22:11:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:11:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:00 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 0x10d5d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd5b59c370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3b2d30>, '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 0x10d2d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3a7be8>, '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.OznSQrfn1q/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.B8Lu6LTZgB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 22:11:00 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 22:11:00 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 22:11:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OznSQrfn1q/Render', 22:11:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:11:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:11:00 INFO - 'HOME': '/Users/cltbld', 22:11:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:11:00 INFO - 'LOGNAME': 'cltbld', 22:11:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:00 INFO - 'MOZ_NO_REMOTE': '1', 22:11:00 INFO - 'NO_EM_RESTART': '1', 22:11:00 INFO - 'PAGER': '/bin/cat', 22:11:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:11:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:00 INFO - 'PWD': '/builds/slave/test', 22:11:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:11:00 INFO - 'SHELL': '/bin/bash', 22:11:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B8Lu6LTZgB/Listeners', 22:11:00 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 22:11:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:11:00 INFO - 'USER': 'cltbld', 22:11:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:11:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:00 INFO - 'XPC_FLAGS': '0x0', 22:11:00 INFO - 'XPC_SERVICE_NAME': '0', 22:11:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:00 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)) 22:11:00 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)) 22:11:00 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)) 22:11:00 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)) 22:11:00 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)) 22:11:00 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)) 22:11:00 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)) 22:11:00 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)) 22:11:00 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)) 22:11:00 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)) 22:11:00 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)) 22:11:00 INFO - Cleaning up... 22:11:00 INFO - Return code: 0 22:11:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:11:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:00 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 0x10d5d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd5b59c370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3b2d30>, '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 0x10d2d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3a7be8>, '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.OznSQrfn1q/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.B8Lu6LTZgB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 22:11:00 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 22:11:00 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 22:11:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OznSQrfn1q/Render', 22:11:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:11:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:11:00 INFO - 'HOME': '/Users/cltbld', 22:11:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:11:00 INFO - 'LOGNAME': 'cltbld', 22:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:01 INFO - 'MOZ_NO_REMOTE': '1', 22:11:01 INFO - 'NO_EM_RESTART': '1', 22:11:01 INFO - 'PAGER': '/bin/cat', 22:11:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:01 INFO - 'PWD': '/builds/slave/test', 22:11:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:11:01 INFO - 'SHELL': '/bin/bash', 22:11:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B8Lu6LTZgB/Listeners', 22:11:01 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 22:11:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:11:01 INFO - 'USER': 'cltbld', 22:11:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:11:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:01 INFO - 'XPC_FLAGS': '0x0', 22:11:01 INFO - 'XPC_SERVICE_NAME': '0', 22:11:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:11:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:11:01 INFO - Cleaning up... 22:11:01 INFO - Return code: 0 22:11:01 INFO - Running post-action listener: _resource_record_post_action 22:11:01 INFO - Running post-action listener: _start_resource_monitoring 22:11:01 INFO - Starting resource monitoring. 22:11:01 INFO - [mozharness: 2017-04-24 05:11:01.290003Z] Finished create-virtualenv step (success) 22:11:01 INFO - [mozharness: 2017-04-24 05:11:01.291040Z] Running install step. 22:11:01 INFO - Running pre-action listener: _resource_record_pre_action 22:11:01 INFO - Running main action method: install 22:11:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:11:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:11:01 INFO - Reading from file tmpfile_stdout 22:11:01 INFO - Detecting whether we're running mozinstall >=1.0... 22:11:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:11:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:11:01 INFO - Reading from file tmpfile_stdout 22:11:01 INFO - Output received: 22:11:01 INFO - Usage: mozinstall [options] installer 22:11:01 INFO - Options: 22:11:01 INFO - -h, --help show this help message and exit 22:11:01 INFO - -d DEST, --destination=DEST 22:11:01 INFO - Directory to install application into. [default: 22:11:01 INFO - "/builds/slave/test"] 22:11:01 INFO - --app=APP Application being installed. [default: firefox] 22:11:01 INFO - mkdir: /builds/slave/test/build/application 22:11:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 22:11:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 22:11:21 INFO - Reading from file tmpfile_stdout 22:11:21 INFO - Output received: 22:11:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:11:21 INFO - Running post-action listener: _resource_record_post_action 22:11:21 INFO - [mozharness: 2017-04-24 05:11:21.614925Z] Finished install step (success) 22:11:21 INFO - [mozharness: 2017-04-24 05:11:21.615050Z] Running run-tests step. 22:11:21 INFO - Running pre-action listener: _resource_record_pre_action 22:11:21 INFO - Running main action method: run_tests 22:11:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:11:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:11:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:11:21 INFO - 2017-04-23 22:11:21.629 screenresolution[1637:8223] starting screenresolution argv=screenresolution get 22:11:21 INFO - 2017-04-23 22:11:21.632 screenresolution[1637:8223] Display 0: 1600x1200x32@60 22:11:21 INFO - 2017-04-23 22:11:21.637 screenresolution[1638:8225] starting screenresolution argv=screenresolution list 22:11:21 INFO - Available Modes on Display 0 22:11:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:11:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:11:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:11:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:11:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:11:21 INFO - Intel Iris: 22:11:21 INFO - Chipset Model: Intel Iris 22:11:21 INFO - Type: GPU 22:11:21 INFO - Bus: Built-In 22:11:21 INFO - VRAM (Dynamic, Max): 1536 MB 22:11:21 INFO - Vendor: Intel (0x8086) 22:11:21 INFO - Device ID: 0x0a2e 22:11:21 INFO - Revision ID: 0x0009 22:11:21 INFO - Displays: 22:11:21 INFO - Display: 22:11:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:11:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:11:21 INFO - Display Serial Number: 1600x1200 60 22:11:21 INFO - Main Display: Yes 22:11:21 INFO - Mirror: Off 22:11:21 INFO - Online: Yes 22:11:21 INFO - Rotation: Supported 22:11:21 INFO - Return code: 0 22:11:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:11:21 INFO - Python 2.7.3 22:11:21 INFO - Return code: 0 22:11:21 INFO - grabbing minidump binary from tooltool 22:11: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')]} 22:11:21 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 0x10d3b2d30>, '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 0x10d2d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3a7be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:11:21 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 22:11:21 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 22:11:21 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 22:11:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:11:21 INFO - Return code: 0 22:11:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:11:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:11:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:11:21 INFO - ENV: RUST_BACKTRACE is now 1 22:11:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:11:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:11:21 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/CVjp-fVsSF-4hohxzZO8WQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0255', '--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 22:11:21 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/CVjp-fVsSF-4hohxzZO8WQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0255 --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 22:11:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OznSQrfn1q/Render', 22:11:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:11:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:11:22 INFO - 'HOME': '/Users/cltbld', 22:11:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:11:22 INFO - 'LOGNAME': 'cltbld', 22:11:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:11:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:22 INFO - 'MOZ_NO_REMOTE': '1', 22:11:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:11:22 INFO - 'NO_EM_RESTART': '1', 22:11:22 INFO - 'PAGER': '/bin/cat', 22:11:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:22 INFO - 'PWD': '/builds/slave/test', 22:11:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:11:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:11:22 INFO - 'RUST_BACKTRACE': '1', 22:11:22 INFO - 'SHELL': '/bin/bash', 22:11:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B8Lu6LTZgB/Listeners', 22:11:22 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 22:11:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:11:22 INFO - 'USER': 'cltbld', 22:11:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:11:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:22 INFO - 'XPC_FLAGS': '0x0', 22:11:22 INFO - 'XPC_SERVICE_NAME': '0', 22:11:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:11:22 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/CVjp-fVsSF-4hohxzZO8WQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0255', '--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 22:11:22 INFO - mozversion application_buildid: 20170423203720 22:11:22 INFO - mozversion application_changeset: 73752931e273091185e1e4b5231c28beed657cc8 22:11:22 INFO - mozversion application_display_name: Nightly 22:11:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:11:22 INFO - mozversion application_name: Firefox 22:11:22 INFO - mozversion application_remotingname: firefox 22:11:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:11:22 INFO - mozversion application_vendor: Mozilla 22:11:22 INFO - mozversion application_version: 55.0a1 22:11:22 INFO - mozversion platform_buildid: 20170423203720 22:11:22 INFO - mozversion platform_changeset: 73752931e273091185e1e4b5231c28beed657cc8 22:11:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:11:22 INFO - mozversion platform_version: 55.0a1 22:11:22 INFO - using testdate: 1493010682 22:11:22 INFO - actual date: 1493010682 22:11:22 INFO - starting webserver on 'localhost:49246' 22:11:22 INFO - SUITE-START | Running 2 tests 22:11:22 INFO - TEST-START | dromaeo_css 22:11:22 INFO - operating with platform_type : mac_ 22:11:22 INFO - Initialising browser for dromaeo_css test... 22:11:22 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/tmp9kP7uj/profile http://localhost:49246/getInfo.html) 22:11:25 INFO - PID 1648 | 2017-04-23 22:11:25.148 plugin-container[1650:8417] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4953, name = 'com.apple.tsm.portname' 22:11:25 INFO - PID 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:11:25 INFO - PID 1648 | 2017-04-23 22:11:25.152 plugin-container[1650:8417] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9f0b, name = 'com.apple.CFPasteboardClient' 22:11:25 INFO - PID 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:11:25 INFO - PID 1648 | 2017-04-23 22:11:25.152 plugin-container[1650:8417] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 22:11:25 INFO - PID 1648 | __metrics Screen width/height:1600/1200 22:11:25 INFO - PID 1648 | colorDepth:24 22:11:25 INFO - PID 1648 | Browser inner width/height: 1024/689 22:11:25 INFO - PID 1648 | __metrics 22:11:25 ERROR - PID 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 22:11:26 INFO - TEST-INFO | 1648: exit 0 22:11:26 INFO - Browser initialized. 22:11:26 INFO - Running cycle 1/1 for dromaeo_css test... 22:11:26 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/tmp9kP7uj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:11:28 INFO - PID 1652 | 2017-04-23 22:11:28.573 plugin-container[1653:8553] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x943f, name = 'com.apple.tsm.portname' 22:11:28 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:11:28 INFO - PID 1652 | 2017-04-23 22:11:28.574 plugin-container[1653:8553] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 22:11:28 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:11:28 INFO - PID 1652 | 2017-04-23 22:11:28.574 plugin-container[1653:8553] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 22:11:38 INFO - PID 1652 | RSS: Main: 236191744 22:11:38 INFO - PID 1652 | 22:14:42 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 22:14:43 INFO - PID 1652 | RSS: Main: 255037440 22:14:43 INFO - PID 1652 | 22:16:26 INFO - PID 1652 | ************************* 22:16:26 INFO - PID 1652 | A coding exception was thrown and uncaught in a Task. 22:16:26 INFO - PID 1652 | 22:16:26 ERROR - PID 1652 | Full message: TypeError: NetworkError when attempting to fetch resource. 22:16:26 INFO - PID 1652 | Full stack: 22:16:26 INFO - PID 1652 | ************************* 22:16:26 INFO - PID 1652 | ************************* 22:16:26 INFO - PID 1652 | A coding exception was thrown and uncaught in a Task. 22:16:26 INFO - PID 1652 | 22:16:26 ERROR - PID 1652 | Full message: TypeError: NetworkError when attempting to fetch resource. 22:16:26 INFO - PID 1652 | Full stack: 22:16:26 INFO - PID 1652 | ************************* 22:16:26 INFO - PID 1652 | ************************* 22:16:26 INFO - PID 1652 | A coding exception was thrown and uncaught in a Task. 22:16:26 INFO - PID 1652 | 22:16:26 ERROR - PID 1652 | Full message: TypeError: NetworkError when attempting to fetch resource. 22:16:26 INFO - PID 1652 | Full stack: 22:16:26 INFO - PID 1652 | ************************* 22:16:26 INFO - PID 1652 | ************************* 22:16:26 INFO - PID 1652 | A coding exception was thrown and uncaught in a Task. 22:16:26 INFO - PID 1652 | 22:16:26 ERROR - PID 1652 | Full message: TypeError: NetworkError when attempting to fetch resource. 22:16:26 INFO - PID 1652 | Full stack: 22:16:26 INFO - PID 1652 | ************************* 22:17:45 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 22:17:46 INFO - PID 1652 | RSS: Main: 258174976 22:17:46 INFO - PID 1652 | 22:20:48 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 22:20:48 INFO - PID 1652 | RSS: Main: 267255808 22:20:48 INFO - PID 1652 | 22:23:50 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 22:23:51 INFO - PID 1652 | RSS: Main: 260268032 22:23:51 INFO - PID 1652 | 22:26:54 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 22:26:54 INFO - PID 1652 | RSS: Main: 268795904 22:26:54 INFO - PID 1652 | 22:29:56 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 22:29:56 INFO - PID 1652 | RSS: Main: 263462912 22:29:56 INFO - PID 1652 | 22:29:56 INFO - PID 1652 | __start_tp_report 22:29:56 INFO - PID 1652 | _x_x_mozilla_page_load 22:29:56 INFO - PID 1652 | _x_x_mozilla_page_load_details 22:29:56 INFO - PID 1652 | |i|pagename|runs| 22:29:56 INFO - PID 1652 | |0;dojo.html;3147.7009684080012;3310.337932413518;3487.8430470628828;3581.0689220802583;3597.802120883352;5088.592912566995;5387.919181212285;5976.701164941757;6164.075388691698;6222.5021998240145;6210.906836397447;6212;6215.5338349623735;6282;6287.842803929892;5289.444608316129;5431.592630552725;5443.972780136094;5475.835724928259;5481.780728770845;5476.58925580581;5523.199136125259;5532.806351777688;5538.141588053858;5575.776968921258;5258.2638430619745;5308.097623404031;5367.731613419313;5429.67421954684;5446.863828404302;5421.756020979065;5431.6740995540395;5461.262729531502;5464.26232458617;5473.425290344497;5366.892662146735;5394.271773310631;5399.595030372738;5441.374241962146;5468.043092458804;6089.512838972872;6109.205803245594;6116.944513560587;6261.405166509175;6273.62358258506;6576.605403675747;6670.799876003728;6689.93310066898;6690.297518760509;6694.029365741989;6769.356911093439;6793.728250869959;6801.625910574917;6809.216940051908;6810.863782724367;6169.9383006170265;6250;6368.235811702579;6369.363063693593;6370.490360771128;5272.7100009499845;5645.745941432645;6682.599044057372;6838.965805170942;6865.622390768555;6346.143270658495;6428.935710642927;6440.838979025468;6480.643564603898;6524.934750652433;6628.072069910217;6732.831679208059;6749.730010799612;6787.694553745093;6807;6659.933400666028;6667.099941507931;6683.198016238082;6685.665716714145;6697.062411262427;5546.528545073714;6389.872202555923;6500.837479063061;6552.50856185788;6627.834304142339;4458.509563947963;5286.259923610698;5289.18017707256;5306.071437498423;5309.150535914312;4675.719456832601;4703.623710103184;4728.763561821964;4751.714897106184;4762.261849413347;5992.951233534114;6170.629762214281;6186.257649082139;6203.96898015516;6258.561900666909;6741.123653925057;6778.932210677929;6798.354156355138;6812.216595091529;6828.283030281848;6316.273628532777;6326.114343991845;6333.429991300805;6333.746650134035;6351.809445716636;5713;5782.421757824184;5918.585699001029;5925.911111333334;5937.198478205387;6728.529002969843;6876.828079298058;6941.201761797256;6977.7208911642965;6978.860422791414;5630.296212973379;6786.660666966533;6808.251092379934;6809.489288303298;6822.795316140524;6860.725570977105;6902.275261097512;6944.861102778017;6974.093367862146;7022.297770222936;6400.39196276353;6492.961126219782;6650.800475985729;6672.266050734513;6683.532152749261;6799;6804.251532331538;6822.727090916308;6823.829404264933;6828.248892621907;6288.339724329063;6346.492280617632;6400.359964003563;6423.100765892872;6545.934540654723;6551.868962620816;6573.079768832272;6576.112224849584;6578.605283682994;6594;4919.335889654851;6260.624362538262;6331.92357299251;6350.936490635035;6444.452221561032;6452.709628066655;6535.085088087577;6579.243387010555;6588.736450541925;6605.867882642224;6375.87248255023;6387.041943708481;6397.616143031433;6399.616023038632;6404.9039264412 22:29:56 INFO - PID 1652 | |1;ext.html;776.7863837444704;1098.0666433531499;1101.3391964821108;1241.7144056866925;1254.3728135932033;35868.103297417576;36812.26375472489;36821.447678284814;36898.262034759326;36912.446313305256;37054.8147259264;37416.62583374165;37430;37497.43753843695;37634.24731505368;7930.444868859182;8110.675572977074;8543.401961862672;8755.562221888911;8785.38502304839;8617.052124266325;8705.782355441133;8713.128687131299;8720.171583699539;8735;8655.134486551358;8681.001684806233;8691.130886911322;8722.912770872274;8732.607032683545;7385.372243359321;8559.614817333173;8692.826143477127;8721.084286149926;8722.08418116095;8544.145585441469;8604.913950860473;8619.138086191393;8620.094890036518;8620.913790862074;37106.8144659275;37294.62705372939;37334.813325933465;37509.81245093785;37516.249675006344;3611.819409029564;3635.163912300186;3641.18073433478;3651.8174091295327;3657.0674478008204;24898.626520602207;30439.695603043907;30615.846920765252;30750.923717669997;30827.537586936214;3148.7481001520055;3186.283086305586;3189.0911090339373;3190.2502911815936;3196.9200769980703;275046;277196;278134;280012;280080;46193.53806461892;46574.99999999932;46899.5310046902;46996.06007879892;47313.763431182626;49236.50763492319;49339.506604934206;49421;49458.752706236235;49460.75269623629;14012.369443375073;14068.08557443763;14110.294485275695;14119;14131.646708832155;11315;11334.319940803578;11358.920902514248;11378.829317560243;11541.36522491271;13213.801792973112;13248.27134507592;13264.668383290302;13281.804637582663;13405.061645684904;4943.382077240345;5167.22491626259;5593.580481463907;5843.707814609253;5912.645241285537;883;992.4243938515643;1039.0700323210835;1051.8579991701022;1067.5089458849016;23394.298171054896;24459.87770061138;24500.01999919983;24567.754322456545;24724.505509889703;1107.1585594947899;1109.6837401340579;1133.699569614053;1135.0862555642623;1145.0839328537138;12060.40105587932;12454.25274483534;12479.75040499185;12504.312262825631;12628;341666;342177;343939;343940;345745;54103.458965409845;54444.45555544473;54522.727386362814;54585.1812222809;54634.726826365615;1311.5016293808483;1461.6418977350618;1519.3618680154361;1525.656727236363;1534.4936171063523;17989.550261243574;23936.162234321717;24299.757002430455;24445.633315500636;24499.877500612383;37840;37935.62064379321;38017.61982380252;38095.61904380921;38097.4285385725;289328.0869552195;290832.54583726946;292217;293125;294125;34158.487622685185;34606.96179114631;35597.46603800997;36252.63747362493;36412.81793591015;45103.54896450994;45345.31982020338;45834.54165458303;45923.77038114788;45998;26625.714257222135;27493.45013099687;29646;31356;31423.685763142075;30295.697043029286;30862.69137308688;31240.687593123777;31363.686363136076;31453.37093258076;37789;37821.43267850929;37840;37841.432378514895;38386.232275354894;25341.87329063343;29962.25094372658;30347.937822176118;30809.8459507701;31941.520877186395;20565.280215192397;24557.754422455546;24577.609701897487;24652.630210546497;24868 22:29:56 INFO - PID 1652 | |2;jquery.html;405.464786481844;425.4702894895855;432.1745466159634;436.8492869959863;459.84349361356175;19774.60450790985;21079.683804742923;21670.674939875913;21862.781372186273;21925.561488770236;18243.72634410485;20996.89501552494;22431.102755889744;22539.8730063497;22606;6177.320494745586;6289.654069026202;6348.619082855021;6362.363763623647;6367.61794292344;6122.8469288267925;6215.12988181655;6219.5073182436345;6281.7173227204885;6292.8741425171465;6047.48596369307;6220.377962203766;6243.032329988836;6258.311585725566;6262.624242545439;6162.476189523896;6283.937160628381;6285.779997700059;6291.024891141903;6302.432781049704;4763.833265835679;5460.863478413072;5601.495865372136;5632.915506267409;5636.2954630671165;27282.727172728217;27592.310192245153;27716.30709232265;27813.58279625787;28464;2002.1891134090718;2289.1873384948435;2307.457747429353;2309.1802410144323;2313.6066868632374;15163.559461851106;15225.467108651144;17746.46760597184;17898.642027159385;18667.159977800897;1854.944351669452;2157.719496465465;2201.966970495444;2208.646616541346;2212.900419481111;132069.6793032067;146785;157195.42804572036;157880.21059894742;167610;12265.938670306592;12907.677308067374;13123.081384303006;13185.340732963314;13185.60443186706;16830.326786928632;16860.398262165076;16861.156942153088;16913.323467061426;16930.492085237463;8651.567421629019;8885.555722213992;8963.865542016874;9045.547722613843;9085.454872707658;8406.285465735358;8413.326933845277;8419.915800842036;8567.871481927776;8570.528620925908;6867.381935625817;7779.7666070017995;7817.140114587391;7893;8005.479643823133;1912.7895931447529;1991.158178684711;2023.8279746221442;2167.783221677851;2180.3785921012436;772.8330221365666;809.2635701511714;903.9548022598843;954.1841725324886;984.3109823123842;16297.755533667005;19903.232242617545;21523.246686365903;21872.671909921362;22124.55750884973;971.868797712314;997.4962643864802;1005.1506477026901;1009.0666133826181;1017.2726500551993;10502.632407865842;11188.601424821898;11213.66359009231;11271.267367621078;11283.774324513464;562143;566699.8295196022;578076;583966;585451;88266.55866720754;103362;136634;136638.31680841531;136796.63203367838;1139.3050239354154;1144.3134119528384;1188.9464974076013;1189.9048076153888;1193.0515240383916;15504.457343992906;18024.098795060458;18534.536636584195;18935.958522281406;19232.942188179786;56629.0275964489;56700;57726.71136644458;57853.13220301783;58025.41974580369;77354.83967740375;82657;83648;84910.87722806979;85067.57466212877;8838.64645414202;8939.418937769024;9027;9251.722448326562;9336.253099751868;14616.488422905148;14687;14790.852091478948;15014.399424022917;15197.316120774813;12008.279503229835;12095.637130886087;12312.26126432417;12371;12413.93793031029;10726.249162558857;10864.511097000812;11016.50425730828;11567.884321157017;11580.36308003068;12341.382930853242;12390.380480975735;12459.750804983669;12462.688432789253;12514.18657787241;7761.223877612194;8728.563571821256;8995.415298005608;9031.187193152648;9376.812463750823;12020.398980051137;12147.392630368622;12230.877691222973;12280.815787763013;12298 22:29:56 INFO - PID 1652 | |3;mootools.html;1248.363334699303;1319.5975227555596;1425.843157252702;1452.5134080083171;1465.538355418044;10140.594376224943;10354.53404596793;11556.826647600283;12102.515899364036;12113.515459381626;10901.509432075556;11474.942625286883;11742;11836.28982261065;11944.761104777921;2513.798896088313;2535;2554.795616350697;2555.8338707984017;2556.821022528424;2111.883846388448;2423.587990041697;2547.7707006369424;2558.8976440942433;2563.4360440703017;2151.677248412735;2473.6907886514186;2569.717331093578;2573.90991315304;2581;2509.14689005738;2522.4576716006054;2537.4163942293285;2541.0471073347494;2547.261294224673;2508.2851387354517;2518.4333524956924;2532.8480291182586;2543.160756950202;2553.4510080332816;11954.641360759191;12101.93949030258;12118.636440906786;12123.575674851338;12231.877681223163;6610.867782644368;6772.018057381652;6871.003704462825;6872.828179295558;6886.586804791728;4156.210320039183;4410.294352903552;4448.955510444886;4477.395551600524;4486.55134486552;1233.901287896975;1252.8496580410317;1301.6290357248233;1305.6670549010037;1308.8822006019504;17063.914680426642;17086.658266834595;17218.827811721847;17222.569435764206;17234.310627574756;5872;6046.788362407383;6281.96859015702;6286.5599408041;6338.619682819046;14158.929205354114;14179.64550886236;14213.005089643626;14220.786688199685;14266.001379903515;6884.759033433806;6922.446204303644;7036.894446583306;7045.647717614099;7059.682314295869;6107;6228.159198508234;6280.780172693934;6307.24313082433;6370.968145159337;3915.5497117831246;4073.6944729145434;4547.704399214041;4792.305115758196;4809.254565542346;1304.530369067135;1353.4247944623496;1475.1960181701;1494;1512.9470468533768;762.6491813765618;764.2586690909809;794.2057942057942;800.1118758178417;811.8147504643287;6037.09443583466;6383.968080159662;6659.4350327672955;7042.92957070433;7071.469639777038;914.5472990869562;946.2808265718104;947.3557980573277;949.0035462764071;951.4529145741088;3737.4767532545466;3944.5463771666628;3997.8805934338434;4084;4271.188474189894;15048.473303434328;15354.462593809163;15539.5338139856;15654.217289135499;15663.765043524356;9946.452945087945;12232.204906681038;14201.36093875778;15619.60950976212;16026.358945642278;8445.57772111392;8710.303175745925;8824.602892869836;8842.027376988526;8845.51349675774;7117.679704413417;7157.781087862779;7200.747973820891;7281.745138920112;7365.116186057493;13630.727385452434;13819.30903454803;14174.787378189541;14176.645583860485;14250.71498570002;11974.640760776841;13867;14021.719565608835;14346.784798227825;14401.42394304216;9693.27300452483;9897.703068907944;9986.300958932805;10004.24968127408;10018.3488073275;10796.892031079902;10831.24181307301;10973.286736362112;11084.168687348643;11089.445527723421;7787.493812902143;8901.243394311556;9395.953020234854;9418.811623767624;9459.432434053979;7101.573905565682;9088.454692718458;9128.49793261377;9258.35191536586;9378.249740020918;8297.626606802587;8371.581420929051;8483.915160848312;8513.19124683154;8522.957385213034;5191.454897235736;6005.699715014144;6084.69576521181;6277.340879207617;6311.368863113652;6099.512039036955;6207.131001659681;6286.779962701284;6318;6343 22:29:56 INFO - PID 1652 | |4;prototype.html;390.8710125658533;409.7254839257697;410.96095870892253;416.0783863741809;418.5751462265801;5817.912731309034;6153.876922461548;6217.37826217378;6293.30773614902;6326.683665816702;6124.571280010401;6163.9213137700835;6181.350958149397;6186.75252989881;6195;4529.2526733089;4539.704919180259;4556.589906908378;4556.84051058213;4560.361549383089;3760.3231418344685;4375.387445757597;4479.977600112011;4481.170983368071;4512.932306015412;3458.3774920514297;3739.1773809761808;4130.277201489742;4375.453068366454;4464.8883777905485;3827.445020472044;4032.41529978153;4124.6906482013665;4482.731036137826;4496.685232033759;3220;3371.477420999749;3694.9815250923575;3887.086534664352;3895.7078219133678;5946.672932988684;5968.462838344526;6010.729517171738;6024.698765061773;6055.27336719592;4609.838655647036;4739.4075740532435;5168.302279192336;5233.555147812441;5442.829791594826;5390.838274851761;6307.966617221765;6527.640979746112;6607.207135143765;6631.839428100111;4244.830206791756;4429.11417716458;4441.244988351956;4453.755043472608;4460.197164510387;6706.497012724065;6876.011913090396;6913.965430172867;7003.677205323939;7026.578405295699;4194.664426845845;4321.222180007629;4477.067520773899;4501.88745281364;4505.234110201273;4334.263175260214;4569.748663823521;4583.335416364608;4602.171609110325;4603.424571928509;4467.7319360838455;5257.158854583248;5384.811531596453;5405.405405405402;5405.891882162414;4912.631552633567;5904.966630839586;6589.86820263592;6610.338966103352;6658.167729033871;1404.2767974493145;1492.6640656612271;1549.4886687393134;1561.9222736311908;1562.2969663651402;869.6304070769897;1025.779457416659;1028.3521381529738;1030.0523518363125;1034.1158309645296;5181.974090129525;5281.287026251483;6220.34686357935;6238.532110091761;6238.750449982041;5973.940260597426;6524.380183882524;6818.454523638097;6896.862062758717;6898.965505172542;5830.38780928005;5903.58674892762;6161.289032825543;6209.813705588749;6215.968920155461;3254.3491301739273;3412.5904891412692;3573.0710015396185;3589.9282014360087;3596.604373518911;6596.406323430914;6990.580565166005;7073.080499535027;7100;7132.251113633098;5617.915731264035;6961.338672826073;7060.293970602898;7064.834302340057;7140.642967851587;6675.766348177791;6957.234704182536;7043.330883565951;7062.293770622897;7069.858602827914;5792.478676919098;6831.208679183101;6838.418734407631;6842.828929276808;6856.314368563104;5259.579233661374;6443.484521238383;6620.933790662032;6693.665316734046;6714.798556043326;6920.342567456084;6933.029375887279;7109.431245500244;7113.146422429341;7123.216446191019;4687.19562448493;4964.7765850537535;4979.68038469813;4996.650234483696;5009.899802004013;5469.890602187855;6706.932930670826;6743.786118498521;6853.451723862178;6856.691448884912;6181.567290289817;6634.137562116894;6649.2685804562425;6652.866942661023;6664.766733164316;5220.155015516477;6266.433391652087;6611;6643.970184621391;6650.46796256308;5421.349438067457;6036.939630603813;6555.573887697285;6557.967210163919;6559;6094.14681944537;6466.833610740455;6636.933630663824;6690.264070952094;6767.593944363157;5905.291365036223;6463.482921366373;6466.353364663496;6478.805635830932;6485.189351331083 22:29:56 INFO - PID 1652 | |5;yui.html;785.4541093939714;821.273173241681;839.1021606880638;858.5535521528806;866.4368160695548;16177.029378237314;16552.999999999985;16602.75095873563;18408.171632276546;19049;17413.042282674447;17501.82498175018;17663.735043974317;17733.911330443363;17787.91106044468;941.7833898203401;946.2004606107828;958.8082383523289;960.7357976556433;966.2270183852925;971.820213260549;972.9756756081084;974.2595627323215;975.5756246032963;980.96076156954;1009.0817356205854;1020.8366661334188;1022.1720406470745;1022.3865680591659;1030.1243942648764;1000.1348833259251;1004.6082028009082;1015.7866847961974;1016.903394177552;1024.8309029010204;721.2679130682361;734.7354952217197;748.7229725001785;748.7454265549685;752.9661165247577;16447.93088449259;16496.587585310343;16575.41986030495;16715.83284167155;16772.245248963827;16306.918465407596;16666.749998750027;16672.249748761336;16773;16858.325666973305;13693.452261909611;13881.652958676013;13883.791743123862;13960;13988.370523326475;3406.710429613461;3455.1189446690933;3489.8953031409096;3493.283876805249;3498.8775392861126;130594;131839.34080329537;132065;133703;134833.65166348408;13104.2137471752;13275;13320.134191277535;13385.263810490516;13390.397432115578;25341.113061042775;25522.979080836558;25725.614115788278;25992.8700356497;26124.608130878052;7641.885371719429;7642.04474440695;7670.96164519185;7710.460267781314;7722.11195712489;3634.436662317345;3645.981770091186;3832.3485007548784;3931.8820435386983;3976.681865450757;4365.4979677337515;4403.119376124788;4427.380166776654;4469.307257375112;4470.955290447054;894.3918135667808;901.8061116859907;909.9272058235325;910.1262787723726;910.9726708198765;632.7658766256515;652.064287747075;660.3066779881106;662.6620423584006;667.7329068372593;10925.562977480971;11427.885721142848;11692.590759323553;11751;12188.81716774249;648.8345471904634;650.1125963060483;652.1424327009967;660.5863452212269;679.9932000680029;5209.853832156919;5291.391489978625;5314.309139811877;5408.621396502207;5481.095619222783;91150;91878.08121918829;92931.53534232285;93739;94008;70419.64790176017;77210.61394692991;77984;79673.60163199146;79727;75000;75832.24167758362;76126.09684757814;76155;77120.22879771242;10933.507992140214;11762.176647634584;11775.52897884075;12272.631821045383;12318.568850090203;39902.20195596014;39929.40105898356;40280.59719402769;40353.596464034985;40573.79713101416;50923.745381272856;51451.742741286056;51565;51664.22503662373;51668;15305.46430874914;15557.844421556092;15620.140892251035;15692.293846777151;15797.131157786433;17209.483715488554;17272;17435.30258789634;17618.73571896397;17686.02726849984;15797.68404631878;15817.762733559235;15881.364745410054;16008.839911600735;16143.67712645717;15939.521814345588;15981.840181598036;16116.27476763572;16169.67660646757;16193.190340483165;14589.635259118182;15541.98977066487;15948.840511594735;15992;15998.360065597246;11351.035162011322;11382.260153090023;11638.53445862156;11971.820422693492;12070.215435996983;11262.267952583055;12154.209976351509;12203.694907627025;12690.555830546256;12818.55135070268 22:29:56 INFO - PID 1652 | __end_tp_report 22:29:56 INFO - PID 1652 | __start_cc_report 22:29:56 INFO - PID 1652 | _x_x_mozilla_cycle_collect,431 22:29:56 INFO - PID 1652 | __end_cc_report 22:29:56 INFO - PID 1652 | __startTimestamp1493011796655__endTimestamp 22:29:56 INFO - PID 1652 | 22:29:56 INFO - PID 1652 | ------- Summary: start ------- 22:29:56 INFO - PID 1652 | Number of tests: 6 22:29:56 INFO - PID 1652 | 22:29:56 INFO - PID 1652 | [#0] dojo.html Cycles:165 Average:6114.78 Median:6351.81 stddev:765.70 (12.1%) stddev-sans-first:731.81 22:29:56 INFO - PID 1652 | Values: 3147.7 3310.3 3487.8 3581.1 3597.8 5088.6 5387.9 5976.7 6164.1 6222.5 6210.9 6212.0 6215.5 6282.0 6287.8 5289.4 5431.6 5444.0 5475.8 5481.8 5476.6 5523.2 5532.8 5538.1 5575.8 5258.3 5308.1 5367.7 5429.7 5446.9 5421.8 5431.7 5461.3 5464.3 5473.4 5366.9 5394.3 5399.6 5441.4 5468.0 6089.5 6109.2 6116.9 6261.4 6273.6 6576.6 6670.8 6689.9 6690.3 6694.0 6769.4 6793.7 6801.6 6809.2 6810.9 6169.9 6250.0 6368.2 6369.4 6370.5 5272.7 5645.7 6682.6 6839.0 6865.6 6346.1 6428.9 6440.8 6480.6 6524.9 6628.1 6732.8 6749.7 6787.7 6807.0 6659.9 6667.1 6683.2 6685.7 6697.1 5546.5 6389.9 6500.8 6552.5 6627.8 4458.5 5286.3 5289.2 5306.1 5309.2 4675.7 4703.6 4728.8 4751.7 4762.3 5993.0 6170.6 6186.3 6204.0 6258.6 6741.1 6778.9 6798.4 6812.2 6828.3 6316.3 6326.1 6333.4 6333.7 6351.8 5713.0 5782.4 5918.6 5925.9 5937.2 6728.5 6876.8 6941.2 6977.7 6978.9 5630.3 6786.7 6808.3 6809.5 6822.8 6860.7 6902.3 6944.9 6974.1 7022.3 6400.4 6493.0 6650.8 6672.3 6683.5 6799.0 6804.3 6822.7 6823.8 6828.2 6288.3 6346.5 6400.4 6423.1 6545.9 6551.9 6573.1 6576.1 6578.6 6594.0 4919.3 6260.6 6331.9 6350.9 6444.5 6452.7 6535.1 6579.2 6588.7 6605.9 6375.9 6387.0 6397.6 6399.6 6404.9 22:29:56 INFO - PID 1652 | 22:29:56 INFO - PID 1652 | [#1] ext.html Cycles:180 Average:45398.04 Median:343939.50 stddev:80272.96 (23.3%) stddev-sans-first:80428.24 22:29:56 INFO - PID 1652 | Values: 776.8 1098.1 1101.3 1241.7 1254.4 35868.1 36812.3 36821.4 36898.3 36912.4 37054.8 37416.6 37430.0 37497.4 37634.2 7930.4 8110.7 8543.4 8755.6 8785.4 8617.1 8705.8 8713.1 8720.2 8735.0 8655.1 8681.0 8691.1 8722.9 8732.6 7385.4 8559.6 8692.8 8721.1 8722.1 8544.1 8604.9 8619.1 8620.1 8620.9 37106.8 37294.6 37334.8 37509.8 37516.2 3611.8 3635.2 3641.2 3651.8 3657.1 24898.6 30439.7 30615.8 30750.9 30827.5 3148.7 3186.3 3189.1 3190.3 3196.9 275046.0 277196.0 278134.0 280012.0 280080.0 46193.5 46575.0 46899.5 46996.1 47313.8 49236.5 49339.5 49421.0 49458.8 49460.8 14012.4 14068.1 14110.3 14119.0 14131.6 11315.0 11334.3 11358.9 11378.8 11541.4 13213.8 13248.3 13264.7 13281.8 13405.1 4943.4 5167.2 5593.6 5843.7 5912.6 883.0 992.4 1039.1 1051.9 1067.5 23394.3 24459.9 24500.0 24567.8 24724.5 1107.2 1109.7 1133.7 1135.1 1145.1 12060.4 12454.3 12479.8 12504.3 12628.0 341666.0 342177.0 343939.0 343940.0 345745.0 54103.5 54444.5 54522.7 54585.2 54634.7 1311.5 1461.6 1519.4 1525.7 1534.5 17989.6 23936.2 24299.8 24445.6 24499.9 37840.0 37935.6 38017.6 38095.6 38097.4 289328.1 290832.5 292217.0 293125.0 294125.0 34158.5 34607.0 35597.5 36252.6 36412.8 45103.5 45345.3 45834.5 45923.8 45998.0 26625.7 27493.5 29646.0 31356.0 31423.7 30295.7 30862.7 31240.7 31363.7 31453.4 37789.0 37821.4 37840.0 37841.4 38386.2 25341.9 29962.3 30347.9 30809.8 31941.5 20565.3 24557.8 24577.6 24652.6 24868.0 22:29:56 INFO - PID 1652 | 22:29:56 INFO - PID 1652 | [#2] jquery.html Cycles:180 Average:36133.87 Median:22485.49 stddev:97033.61 (431.5%) stddev-sans-first:97268.74 22:29:56 INFO - PID 1652 | Values: 405.5 425.5 432.2 436.8 459.8 19774.6 21079.7 21670.7 21862.8 21925.6 18243.7 20996.9 22431.1 22539.9 22606.0 6177.3 6289.7 6348.6 6362.4 6367.6 6122.8 6215.1 6219.5 6281.7 6292.9 6047.5 6220.4 6243.0 6258.3 6262.6 6162.5 6283.9 6285.8 6291.0 6302.4 4763.8 5460.9 5601.5 5632.9 5636.3 27282.7 27592.3 27716.3 27813.6 28464.0 2002.2 2289.2 2307.5 2309.2 2313.6 15163.6 15225.5 17746.5 17898.6 18667.2 1854.9 2157.7 2202.0 2208.6 2212.9 132069.7 146785.0 157195.4 157880.2 167610.0 12265.9 12907.7 13123.1 13185.3 13185.6 16830.3 16860.4 16861.2 16913.3 16930.5 8651.6 8885.6 8963.9 9045.5 9085.5 8406.3 8413.3 8419.9 8567.9 8570.5 6867.4 7779.8 7817.1 7893.0 8005.5 1912.8 1991.2 2023.8 2167.8 2180.4 772.8 809.3 904.0 954.2 984.3 16297.8 19903.2 21523.2 21872.7 22124.6 971.9 997.5 1005.2 1009.1 1017.3 10502.6 11188.6 11213.7 11271.3 11283.8 562143.0 566699.8 578076.0 583966.0 585451.0 88266.6 103362.0 136634.0 136638.3 136796.6 1139.3 1144.3 1188.9 1189.9 1193.1 15504.5 18024.1 18534.5 18936.0 19232.9 56629.0 56700.0 57726.7 57853.1 58025.4 77354.8 82657.0 83648.0 84910.9 85067.6 8838.6 8939.4 9027.0 9251.7 9336.3 14616.5 14687.0 14790.9 15014.4 15197.3 12008.3 12095.6 12312.3 12371.0 12413.9 10726.2 10864.5 11016.5 11567.9 11580.4 12341.4 12390.4 12459.8 12462.7 12514.2 7761.2 8728.6 8995.4 9031.2 9376.8 12020.4 12147.4 12230.9 12280.8 12298.0 22:29:56 INFO - PID 1652 | 22:29:56 INFO - PID 1652 | [#3] mootools.html Cycles:180 Average:7289.02 Median:3159.24 stddev:4635.12 (146.7%) stddev-sans-first:4625.89 22:29:56 INFO - PID 1652 | Values: 1248.4 1319.6 1425.8 1452.5 1465.5 10140.6 10354.5 11556.8 12102.5 12113.5 10901.5 11474.9 11742.0 11836.3 11944.8 2513.8 2535.0 2554.8 2555.8 2556.8 2111.9 2423.6 2547.8 2558.9 2563.4 2151.7 2473.7 2569.7 2573.9 2581.0 2509.1 2522.5 2537.4 2541.0 2547.3 2508.3 2518.4 2532.8 2543.2 2553.5 11954.6 12101.9 12118.6 12123.6 12231.9 6610.9 6772.0 6871.0 6872.8 6886.6 4156.2 4410.3 4449.0 4477.4 4486.6 1233.9 1252.8 1301.6 1305.7 1308.9 17063.9 17086.7 17218.8 17222.6 17234.3 5872.0 6046.8 6282.0 6286.6 6338.6 14158.9 14179.6 14213.0 14220.8 14266.0 6884.8 6922.4 7036.9 7045.6 7059.7 6107.0 6228.2 6280.8 6307.2 6371.0 3915.5 4073.7 4547.7 4792.3 4809.3 1304.5 1353.4 1475.2 1494.0 1512.9 762.6 764.3 794.2 800.1 811.8 6037.1 6384.0 6659.4 7042.9 7071.5 914.5 946.3 947.4 949.0 951.5 3737.5 3944.5 3997.9 4084.0 4271.2 15048.5 15354.5 15539.5 15654.2 15663.8 9946.5 12232.2 14201.4 15619.6 16026.4 8445.6 8710.3 8824.6 8842.0 8845.5 7117.7 7157.8 7200.7 7281.7 7365.1 13630.7 13819.3 14174.8 14176.6 14250.7 11974.6 13867.0 14021.7 14346.8 14401.4 9693.3 9897.7 9986.3 10004.2 10018.3 10796.9 10831.2 10973.3 11084.2 11089.4 7787.5 8901.2 9396.0 9418.8 9459.4 7101.6 9088.5 9128.5 9258.4 9378.2 8297.6 8371.6 8483.9 8513.2 8523.0 5191.5 6005.7 6084.7 6277.3 6311.4 6099.5 6207.1 6286.8 6318.0 6343.0 22:29:56 INFO - PID 1652 | 22:29:56 INFO - PID 1652 | [#4] prototype.html Cycles:180 Average:5305.67 Median:5971.20 stddev:1698.61 (28.4%) stddev-sans-first:1662.83 22:29:56 INFO - PID 1652 | Values: 390.9 409.7 411.0 416.1 418.6 5817.9 6153.9 6217.4 6293.3 6326.7 6124.6 6163.9 6181.4 6186.8 6195.0 4529.3 4539.7 4556.6 4556.8 4560.4 3760.3 4375.4 4480.0 4481.2 4512.9 3458.4 3739.2 4130.3 4375.5 4464.9 3827.4 4032.4 4124.7 4482.7 4496.7 3220.0 3371.5 3695.0 3887.1 3895.7 5946.7 5968.5 6010.7 6024.7 6055.3 4609.8 4739.4 5168.3 5233.6 5442.8 5390.8 6308.0 6527.6 6607.2 6631.8 4244.8 4429.1 4441.2 4453.8 4460.2 6706.5 6876.0 6914.0 7003.7 7026.6 4194.7 4321.2 4477.1 4501.9 4505.2 4334.3 4569.7 4583.3 4602.2 4603.4 4467.7 5257.2 5384.8 5405.4 5405.9 4912.6 5905.0 6589.9 6610.3 6658.2 1404.3 1492.7 1549.5 1561.9 1562.3 869.6 1025.8 1028.4 1030.1 1034.1 5182.0 5281.3 6220.3 6238.5 6238.8 5973.9 6524.4 6818.5 6896.9 6899.0 5830.4 5903.6 6161.3 6209.8 6216.0 3254.3 3412.6 3573.1 3589.9 3596.6 6596.4 6990.6 7073.1 7100.0 7132.3 5617.9 6961.3 7060.3 7064.8 7140.6 6675.8 6957.2 7043.3 7062.3 7069.9 5792.5 6831.2 6838.4 6842.8 6856.3 5259.6 6443.5 6620.9 6693.7 6714.8 6920.3 6933.0 7109.4 7113.1 7123.2 4687.2 4964.8 4979.7 4996.7 5009.9 5469.9 6706.9 6743.8 6853.5 6856.7 6181.6 6634.1 6649.3 6652.9 6664.8 5220.2 6266.4 6611.0 6644.0 6650.5 5421.3 6036.9 6555.6 6558.0 6559.0 6094.1 6466.8 6636.9 6690.3 6767.6 5905.3 6463.5 6466.4 6478.8 6485.2 22:29:56 INFO - PID 1652 | 22:29:56 INFO - PID 1652 | [#5] yui.html Cycles:180 Average:20879.76 Median:25432.05 stddev:29277.65 (115.1%) stddev-sans-first:29320.90 22:29:56 INFO - PID 1652 | Values: 785.5 821.3 839.1 858.6 866.4 16177.0 16553.0 16602.8 18408.2 19049.0 17413.0 17501.8 17663.7 17733.9 17787.9 941.8 946.2 958.8 960.7 966.2 971.8 973.0 974.3 975.6 981.0 1009.1 1020.8 1022.2 1022.4 1030.1 1000.1 1004.6 1015.8 1016.9 1024.8 721.3 734.7 748.7 748.7 753.0 16447.9 16496.6 16575.4 16715.8 16772.2 16306.9 16666.7 16672.2 16773.0 16858.3 13693.5 13881.7 13883.8 13960.0 13988.4 3406.7 3455.1 3489.9 3493.3 3498.9 130594.0 131839.3 132065.0 133703.0 134833.7 13104.2 13275.0 13320.1 13385.3 13390.4 25341.1 25523.0 25725.6 25992.9 26124.6 7641.9 7642.0 7671.0 7710.5 7722.1 3634.4 3646.0 3832.3 3931.9 3976.7 4365.5 4403.1 4427.4 4469.3 4471.0 894.4 901.8 909.9 910.1 911.0 632.8 652.1 660.3 662.7 667.7 10925.6 11427.9 11692.6 11751.0 12188.8 648.8 650.1 652.1 660.6 680.0 5209.9 5291.4 5314.3 5408.6 5481.1 91150.0 91878.1 92931.5 93739.0 94008.0 70419.6 77210.6 77984.0 79673.6 79727.0 75000.0 75832.2 76126.1 76155.0 77120.2 10933.5 11762.2 11775.5 12272.6 12318.6 39902.2 39929.4 40280.6 40353.6 40573.8 50923.7 51451.7 51565.0 51664.2 51668.0 15305.5 15557.8 15620.1 15692.3 15797.1 17209.5 17272.0 17435.3 17618.7 17686.0 15797.7 15817.8 15881.4 16008.8 16143.7 15939.5 15981.8 16116.3 16169.7 16193.2 14589.6 15542.0 15948.8 15992.0 15998.4 11351.0 11382.3 11638.5 11971.8 12070.2 11262.3 12154.2 12203.7 12690.6 12818.6 22:29:56 INFO - PID 1652 | -------- Summary: end -------- 22:29:56 INFO - PID 1652 | 22:29:57 INFO - TEST-INFO | 1652: exit 0 22:29:57 INFO - TEST-OK | dromaeo_css | took 1115066ms 22:29:57 INFO - TEST-START | kraken 22:29:57 INFO - operating with platform_type : mac_ 22:29:57 INFO - Initialising browser for kraken test... 22:29:57 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/tmpen3Eyr/profile http://localhost:49246/getInfo.html) 22:29:59 INFO - PID 1660 | 2017-04-23 22:29:59.716 plugin-container[1661:10731] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 22:29:59 INFO - PID 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:29:59 INFO - PID 1660 | 2017-04-23 22:29:59.720 plugin-container[1661:10731] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 22:29:59 INFO - PID 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:29:59 INFO - PID 1660 | 2017-04-23 22:29:59.720 plugin-container[1661:10731] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 22:29:59 INFO - PID 1660 | __metrics Screen width/height:1600/1200 22:29:59 INFO - PID 1660 | colorDepth:24 22:29:59 INFO - PID 1660 | Browser inner width/height: 1024/689 22:29:59 INFO - PID 1660 | __metrics 22:29:59 ERROR - PID 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 22:30:01 INFO - TEST-INFO | 1660: exit 0 22:30:01 INFO - Browser initialized. 22:30:01 INFO - Running cycle 1/1 for kraken test... 22:30:01 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/tmpen3Eyr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:30:03 INFO - PID 1663 | 2017-04-23 22:30:03.517 plugin-container[1664:10860] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 22:30:03 INFO - PID 1663 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:30:03 INFO - PID 1663 | 2017-04-23 22:30:03.518 plugin-container[1664:10860] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 22:30:03 INFO - PID 1663 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:30:03 INFO - PID 1663 | 2017-04-23 22:30:03.518 plugin-container[1664:10860] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 22:30:13 INFO - PID 1663 | RSS: Main: 251686912 22:30:13 INFO - PID 1663 | 22:30:15 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 22:30:16 INFO - PID 1663 | RSS: Main: 260042752 22:30:16 INFO - PID 1663 | 22:30:19 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 22:30:20 INFO - PID 1663 | RSS: Main: 267304960 22:30:20 INFO - PID 1663 | 22:30:23 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 22:30:24 INFO - PID 1663 | RSS: Main: 262897664 22:30:24 INFO - PID 1663 | 22:30:26 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 22:30:26 INFO - PID 1663 | RSS: Main: 264122368 22:30:26 INFO - PID 1663 | 22:30:28 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:30:29 INFO - PID 1663 | RSS: Main: 264454144 22:30:29 INFO - PID 1663 | 22:30:32 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 22:30:32 INFO - PID 1663 | RSS: Main: 270430208 22:30:32 INFO - PID 1663 | 22:30:35 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 22:30:36 INFO - PID 1663 | RSS: Main: 273248256 22:30:36 INFO - PID 1663 | 22:30:39 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 22:30:40 INFO - PID 1663 | RSS: Main: 272556032 22:30:40 INFO - PID 1663 | 22:30:41 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:30:42 INFO - PID 1663 | RSS: Main: 272109568 22:30:42 INFO - PID 1663 | 22:30:43 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:30:44 INFO - PID 1663 | RSS: Main: 272318464 22:30:44 INFO - PID 1663 | 22:30:46 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:30:47 INFO - PID 1663 | RSS: Main: 271675392 22:30:47 INFO - PID 1663 | 22:30:50 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:30:51 INFO - PID 1663 | RSS: Main: 271814656 22:30:51 INFO - PID 1663 | 22:30:54 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:30:54 INFO - PID 1663 | RSS: Main: 272125952 22:30:54 INFO - PID 1663 | 22:30:56 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 22:30:57 INFO - PID 1663 | RSS: Main: 273862656 22:30:57 INFO - PID 1663 | 22:30:57 INFO - PID 1663 | __start_tp_report 22:30:57 INFO - PID 1663 | _x_x_mozilla_page_load 22:30:57 INFO - PID 1663 | _x_x_mozilla_page_load_details 22:30:57 INFO - PID 1663 | |i|pagename|runs| 22:30:57 INFO - PID 1663 | |0;ai-astar;101;115;113;115;114;114;114;114;117;114 22:30:57 INFO - PID 1663 | |1;audio-beat-detection;143;111;110;149;110;113;113;116;152;149 22:30:57 INFO - PID 1663 | |2;audio-dft;203;200;203;218;206;225;199;198;202;190 22:30:57 INFO - PID 1663 | |3;audio-fft;69;75;48;81;88;51;64;83;90;83 22:30:57 INFO - PID 1663 | |4;audio-oscillator;83;69;83;72;67;69;84;66;72;112 22:30:57 INFO - PID 1663 | |5;imaging-gaussian-blur;105;91;89;90;91;104;138;102;89;91 22:30:57 INFO - PID 1663 | |6;imaging-darkroom;100;154;146;98;97;98;98;97;97;140 22:30:57 INFO - PID 1663 | |7;imaging-desaturate;91;96;90;91;94;89;97;93;91;91 22:30:57 INFO - PID 1663 | |8;json-parse-financial;51;49;52;51;51;51;52;52;53;52 22:30:57 INFO - PID 1663 | |9;json-stringify-tinderbox;59;66;72;88;92;57;57;58;57;49 22:30:57 INFO - PID 1663 | |10;stanford-crypto-aes;91;83;85;74;95;107;73;117;109;108 22:30:57 INFO - PID 1663 | |11;stanford-crypto-ccm;137;147;132;130;156;130;127;150;207;127 22:30:57 INFO - PID 1663 | |12;stanford-crypto-pbkdf2;209;237;181;180;184;180;186;240;236;190 22:30:57 INFO - PID 1663 | |13;stanford-crypto-sha256-iterative;77;93;71;60;94;96;100;100;104;59 22:30:57 INFO - PID 1663 | __end_tp_report 22:30:57 INFO - PID 1663 | __start_cc_report 22:30:57 INFO - PID 1663 | _x_x_mozilla_cycle_collect,1001 22:30:57 INFO - PID 1663 | __end_cc_report 22:30:57 INFO - PID 1663 | __startTimestamp1493011857144__endTimestamp 22:30:57 INFO - PID 1663 | 22:30:57 INFO - PID 1663 | ------- Summary: start ------- 22:30:57 INFO - PID 1663 | Number of tests: 14 22:30:57 INFO - PID 1663 | 22:30:57 INFO - PID 1663 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:4.38 (3.8%) stddev-sans-first:1.13 22:30:57 INFO - PID 1663 | Values: 101.0 115.0 113.0 115.0 114.0 114.0 114.0 114.0 117.0 114.0 22:30:57 INFO - PID 1663 | 22:30:57 INFO - PID 1663 | [#1] audio-beat-detection Cycles:10 Average:126.60 Median:129.50 stddev:18.84 (14.5%) stddev-sans-first:19.02 22:30:57 INFO - PID 1663 | Values: 143.0 111.0 110.0 149.0 110.0 113.0 113.0 116.0 152.0 149.0 22:30:57 INFO - PID 1663 | 22:30:57 INFO - PID 1663 | [#2] audio-dft Cycles:10 Average:204.40 Median:203.00 stddev:10.10 (5.0%) stddev-sans-first:10.70 22:30:57 INFO - PID 1663 | Values: 203.0 200.0 203.0 218.0 206.0 225.0 199.0 198.0 202.0 190.0 22:30:57 INFO - PID 1663 | 22:30:57 INFO - PID 1663 | [#3] audio-fft Cycles:10 Average:73.20 Median:82.00 stddev:14.86 (18.1%) stddev-sans-first:15.68 22:30:57 INFO - PID 1663 | Values: 69.0 75.0 48.0 81.0 88.0 51.0 64.0 83.0 90.0 83.0 22:30:57 INFO - PID 1663 | 22:30:57 INFO - PID 1663 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:72.00 stddev:13.90 (19.3%) stddev-sans-first:14.62 22:30:57 INFO - PID 1663 | Values: 83.0 69.0 83.0 72.0 67.0 69.0 84.0 66.0 72.0 112.0 22:30:57 INFO - PID 1663 | 22:30:57 INFO - PID 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:99.00 Median:89.50 stddev:15.14 (16.9%) stddev-sans-first:15.91 22:30:57 INFO - PID 1663 | Values: 105.0 91.0 89.0 90.0 91.0 104.0 138.0 102.0 89.0 91.0 22:30:57 INFO - PID 1663 | 22:30:57 INFO - PID 1663 | [#6] imaging-darkroom Cycles:10 Average:112.50 Median:97.00 stddev:23.82 (24.6%) stddev-sans-first:24.84 22:30:57 INFO - PID 1663 | Values: 100.0 154.0 146.0 98.0 97.0 98.0 98.0 97.0 97.0 140.0 22:30:57 INFO - PID 1663 | 22:30:57 INFO - PID 1663 | [#7] imaging-desaturate Cycles:10 Average:92.30 Median:92.00 stddev:2.63 (2.9%) stddev-sans-first:2.74 22:30:57 INFO - PID 1663 | Values: 91.0 96.0 90.0 91.0 94.0 89.0 97.0 93.0 91.0 91.0 22:30:57 INFO - PID 1663 | 22:30:57 INFO - PID 1663 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:52.00 stddev:1.07 (2.1%) stddev-sans-first:1.13 22:30:57 INFO - PID 1663 | Values: 51.0 49.0 52.0 51.0 51.0 51.0 52.0 52.0 53.0 52.0 22:30:57 INFO - PID 1663 | 22:30:57 INFO - PID 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:62.50 stddev:14.29 (22.9%) stddev-sans-first:14.96 22:30:57 INFO - PID 1663 | Values: 59.0 66.0 72.0 88.0 92.0 57.0 57.0 58.0 57.0 49.0 22:30:57 INFO - PID 1663 | 22:30:57 INFO - PID 1663 | [#10] stanford-crypto-aes Cycles:10 Average:94.20 Median:78.50 stddev:15.53 (19.8%) stddev-sans-first:16.43 22:30:57 INFO - PID 1663 | Values: 91.0 83.0 85.0 74.0 95.0 107.0 73.0 117.0 109.0 108.0 22:30:57 INFO - PID 1663 | 22:30:57 INFO - PID 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:142.00 stddev:24.31 (17.1%) stddev-sans-first:25.64 22:30:57 INFO - PID 1663 | Values: 137.0 147.0 132.0 130.0 156.0 130.0 127.0 150.0 207.0 127.0 22:30:57 INFO - PID 1663 | 22:30:57 INFO - PID 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:202.30 Median:199.50 stddev:25.83 (12.9%) stddev-sans-first:27.29 22:30:57 INFO - PID 1663 | Values: 209.0 237.0 181.0 180.0 184.0 180.0 186.0 240.0 236.0 190.0 22:30:57 INFO - PID 1663 | 22:30:57 INFO - PID 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:85.40 Median:74.00 stddev:17.12 (23.1%) stddev-sans-first:17.88 22:30:57 INFO - PID 1663 | Values: 77.0 93.0 71.0 60.0 94.0 96.0 100.0 100.0 104.0 59.0 22:30:57 INFO - PID 1663 | -------- Summary: end -------- 22:30:57 INFO - PID 1663 | 22:30:58 INFO - TEST-INFO | 1663: exit 0 22:30:58 INFO - TEST-OK | kraken | took 61060ms 22:30:58 INFO - SUITE-END | took 1176s 22:30:58 INFO - Completed test suite (00:19:36) 22:30:58 INFO - javascript benchmark 22:30:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7879.922829165428, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3147.7009684080012, 3310.337932413518, 3487.8430470628828, 3581.0689220802583, 3597.802120883352, 5088.592912566995, 5387.919181212285, 5976.701164941757, 6164.075388691698, 6222.5021998240145, 6210.906836397447, 6212.0, 6215.5338349623735, 6282.0, 6287.842803929892, 5289.444608316129, 5431.592630552725, 5443.972780136094, 5475.835724928259, 5481.780728770845, 5476.58925580581, 5523.199136125259, 5532.806351777688, 5538.141588053858, 5575.776968921258, 5258.2638430619745, 5308.097623404031, 5367.731613419313, 5429.67421954684, 5446.863828404302, 5421.756020979065, 5431.6740995540395, 5461.262729531502, 5464.26232458617, 5473.425290344497, 5366.892662146735, 5394.271773310631, 5399.595030372738, 5441.374241962146, 5468.043092458804, 6089.512838972872, 6109.205803245594, 6116.944513560587, 6261.405166509175, 6273.62358258506, 6576.605403675747, 6670.799876003728, 6689.93310066898, 6690.297518760509, 6694.029365741989, 6769.356911093439, 6793.728250869959, 6801.625910574917, 6809.216940051908, 6810.863782724367, 6169.9383006170265, 6250.0, 6368.235811702579, 6369.363063693593, 6370.490360771128, 5272.7100009499845, 5645.745941432645, 6682.599044057372, 6838.965805170942, 6865.622390768555, 6346.143270658495, 6428.935710642927, 6440.838979025468, 6480.643564603898, 6524.934750652433, 6628.072069910217, 6732.831679208059, 6749.730010799612, 6787.694553745093, 6807.0, 6659.933400666028, 6667.099941507931, 6683.198016238082, 6685.665716714145, 6697.062411262427, 5546.528545073714, 6389.872202555923, 6500.837479063061, 6552.50856185788, 6627.834304142339, 4458.509563947963, 5286.259923610698, 5289.18017707256, 5306.071437498423, 5309.150535914312, 4675.719456832601, 4703.623710103184, 4728.763561821964, 4751.714897106184, 4762.261849413347, 5992.951233534114, 6170.629762214281, 6186.257649082139, 6203.96898015516, 6258.561900666909, 6741.123653925057, 6778.932210677929, 6798.354156355138, 6812.216595091529, 6828.283030281848, 6316.273628532777, 6326.114343991845, 6333.429991300805, 6333.746650134035, 6351.809445716636, 5713.0, 5782.421757824184, 5918.585699001029, 5925.911111333334, 5937.198478205387, 6728.529002969843, 6876.828079298058, 6941.201761797256, 6977.7208911642965, 6978.860422791414, 5630.296212973379, 6786.660666966533, 6808.251092379934, 6809.489288303298, 6822.795316140524, 6860.725570977105, 6902.275261097512, 6944.861102778017, 6974.093367862146, 7022.297770222936, 6400.39196276353, 6492.961126219782, 6650.800475985729, 6672.266050734513, 6683.532152749261, 6799.0, 6804.251532331538, 6822.727090916308, 6823.829404264933, 6828.248892621907, 6288.339724329063, 6346.492280617632, 6400.359964003563, 6423.100765892872, 6545.934540654723, 6551.868962620816, 6573.079768832272, 6576.112224849584, 6578.605283682994, 6594.0, 4919.335889654851, 6260.624362538262, 6331.92357299251, 6350.936490635035, 6444.452221561032, 6452.709628066655, 6535.085088087577, 6579.243387010555, 6588.736450541925, 6605.867882642224, 6375.87248255023, 6387.041943708481, 6397.616143031433, 6399.616023038632, 6404.9039264412], "value": 6062.461672556969, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.7863837444704, 1098.0666433531499, 1101.3391964821108, 1241.7144056866925, 1254.3728135932033, 35868.103297417576, 36812.26375472489, 36821.447678284814, 36898.262034759326, 36912.446313305256, 37054.8147259264, 37416.62583374165, 37430.0, 37497.43753843695, 37634.24731505368, 7930.444868859182, 8110.675572977074, 8543.401961862672, 8755.562221888911, 8785.38502304839, 8617.052124266325, 8705.782355441133, 8713.128687131299, 8720.171583699539, 8735.0, 8655.134486551358, 8681.001684806233, 8691.130886911322, 8722.912770872274, 8732.607032683545, 7385.372243359321, 8559.614817333173, 8692.826143477127, 8721.084286149926, 8722.08418116095, 8544.145585441469, 8604.913950860473, 8619.138086191393, 8620.094890036518, 8620.913790862074, 37106.8144659275, 37294.62705372939, 37334.813325933465, 37509.81245093785, 37516.249675006344, 3611.819409029564, 3635.163912300186, 3641.18073433478, 3651.8174091295327, 3657.0674478008204, 24898.626520602207, 30439.695603043907, 30615.846920765252, 30750.923717669997, 30827.537586936214, 3148.7481001520055, 3186.283086305586, 3189.0911090339373, 3190.2502911815936, 3196.9200769980703, 275046.0, 277196.0, 278134.0, 280012.0, 280080.0, 46193.53806461892, 46574.99999999932, 46899.5310046902, 46996.06007879892, 47313.763431182626, 49236.50763492319, 49339.506604934206, 49421.0, 49458.752706236235, 49460.75269623629, 14012.369443375073, 14068.08557443763, 14110.294485275695, 14119.0, 14131.646708832155, 11315.0, 11334.319940803578, 11358.920902514248, 11378.829317560243, 11541.36522491271, 13213.801792973112, 13248.27134507592, 13264.668383290302, 13281.804637582663, 13405.061645684904, 4943.382077240345, 5167.22491626259, 5593.580481463907, 5843.707814609253, 5912.645241285537, 883.0, 992.4243938515643, 1039.0700323210835, 1051.8579991701022, 1067.5089458849016, 23394.298171054896, 24459.87770061138, 24500.01999919983, 24567.754322456545, 24724.505509889703, 1107.1585594947899, 1109.6837401340579, 1133.699569614053, 1135.0862555642623, 1145.0839328537138, 12060.40105587932, 12454.25274483534, 12479.75040499185, 12504.312262825631, 12628.0, 341666.0, 342177.0, 343939.0, 343940.0, 345745.0, 54103.458965409845, 54444.45555544473, 54522.727386362814, 54585.1812222809, 54634.726826365615, 1311.5016293808483, 1461.6418977350618, 1519.3618680154361, 1525.656727236363, 1534.4936171063523, 17989.550261243574, 23936.162234321717, 24299.757002430455, 24445.633315500636, 24499.877500612383, 37840.0, 37935.62064379321, 38017.61982380252, 38095.61904380921, 38097.4285385725, 289328.0869552195, 290832.54583726946, 292217.0, 293125.0, 294125.0, 34158.487622685185, 34606.96179114631, 35597.46603800997, 36252.63747362493, 36412.81793591015, 45103.54896450994, 45345.31982020338, 45834.54165458303, 45923.77038114788, 45998.0, 26625.714257222135, 27493.45013099687, 29646.0, 31356.0, 31423.685763142075, 30295.697043029286, 30862.69137308688, 31240.687593123777, 31363.686363136076, 31453.37093258076, 37789.0, 37821.43267850929, 37840.0, 37841.432378514895, 38386.232275354894, 25341.87329063343, 29962.25094372658, 30347.937822176118, 30809.8459507701, 31941.520877186395, 20565.280215192397, 24557.754422455546, 24577.609701897487, 24652.630210546497, 24868.0], "value": 17559.38404875093, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.464786481844, 425.4702894895855, 432.1745466159634, 436.8492869959863, 459.84349361356175, 19774.60450790985, 21079.683804742923, 21670.674939875913, 21862.781372186273, 21925.561488770236, 18243.72634410485, 20996.89501552494, 22431.102755889744, 22539.8730063497, 22606.0, 6177.320494745586, 6289.654069026202, 6348.619082855021, 6362.363763623647, 6367.61794292344, 6122.8469288267925, 6215.12988181655, 6219.5073182436345, 6281.7173227204885, 6292.8741425171465, 6047.48596369307, 6220.377962203766, 6243.032329988836, 6258.311585725566, 6262.624242545439, 6162.476189523896, 6283.937160628381, 6285.779997700059, 6291.024891141903, 6302.432781049704, 4763.833265835679, 5460.863478413072, 5601.495865372136, 5632.915506267409, 5636.2954630671165, 27282.727172728217, 27592.310192245153, 27716.30709232265, 27813.58279625787, 28464.0, 2002.1891134090718, 2289.1873384948435, 2307.457747429353, 2309.1802410144323, 2313.6066868632374, 15163.559461851106, 15225.467108651144, 17746.46760597184, 17898.642027159385, 18667.159977800897, 1854.944351669452, 2157.719496465465, 2201.966970495444, 2208.646616541346, 2212.900419481111, 132069.6793032067, 146785.0, 157195.42804572036, 157880.21059894742, 167610.0, 12265.938670306592, 12907.677308067374, 13123.081384303006, 13185.340732963314, 13185.60443186706, 16830.326786928632, 16860.398262165076, 16861.156942153088, 16913.323467061426, 16930.492085237463, 8651.567421629019, 8885.555722213992, 8963.865542016874, 9045.547722613843, 9085.454872707658, 8406.285465735358, 8413.326933845277, 8419.915800842036, 8567.871481927776, 8570.528620925908, 6867.381935625817, 7779.7666070017995, 7817.140114587391, 7893.0, 8005.479643823133, 1912.7895931447529, 1991.158178684711, 2023.8279746221442, 2167.783221677851, 2180.3785921012436, 772.8330221365666, 809.2635701511714, 903.9548022598843, 954.1841725324886, 984.3109823123842, 16297.755533667005, 19903.232242617545, 21523.246686365903, 21872.671909921362, 22124.55750884973, 971.868797712314, 997.4962643864802, 1005.1506477026901, 1009.0666133826181, 1017.2726500551993, 10502.632407865842, 11188.601424821898, 11213.66359009231, 11271.267367621078, 11283.774324513464, 562143.0, 566699.8295196022, 578076.0, 583966.0, 585451.0, 88266.55866720754, 103362.0, 136634.0, 136638.31680841531, 136796.63203367838, 1139.3050239354154, 1144.3134119528384, 1188.9464974076013, 1189.9048076153888, 1193.0515240383916, 15504.457343992906, 18024.098795060458, 18534.536636584195, 18935.958522281406, 19232.942188179786, 56629.0275964489, 56700.0, 57726.71136644458, 57853.13220301783, 58025.41974580369, 77354.83967740375, 82657.0, 83648.0, 84910.87722806979, 85067.57466212877, 8838.64645414202, 8939.418937769024, 9027.0, 9251.722448326562, 9336.253099751868, 14616.488422905148, 14687.0, 14790.852091478948, 15014.399424022917, 15197.316120774813, 12008.279503229835, 12095.637130886087, 12312.26126432417, 12371.0, 12413.93793031029, 10726.249162558857, 10864.511097000812, 11016.50425730828, 11567.884321157017, 11580.36308003068, 12341.382930853242, 12390.380480975735, 12459.750804983669, 12462.688432789253, 12514.18657787241, 7761.223877612194, 8728.563571821256, 8995.415298005608, 9031.187193152648, 9376.812463750823, 12020.398980051137, 12147.392630368622, 12230.877691222973, 12280.815787763013, 12298.0], "value": 10454.235319929641, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1248.363334699303, 1319.5975227555596, 1425.843157252702, 1452.5134080083171, 1465.538355418044, 10140.594376224943, 10354.53404596793, 11556.826647600283, 12102.515899364036, 12113.515459381626, 10901.509432075556, 11474.942625286883, 11742.0, 11836.28982261065, 11944.761104777921, 2513.798896088313, 2535.0, 2554.795616350697, 2555.8338707984017, 2556.821022528424, 2111.883846388448, 2423.587990041697, 2547.7707006369424, 2558.8976440942433, 2563.4360440703017, 2151.677248412735, 2473.6907886514186, 2569.717331093578, 2573.90991315304, 2581.0, 2509.14689005738, 2522.4576716006054, 2537.4163942293285, 2541.0471073347494, 2547.261294224673, 2508.2851387354517, 2518.4333524956924, 2532.8480291182586, 2543.160756950202, 2553.4510080332816, 11954.641360759191, 12101.93949030258, 12118.636440906786, 12123.575674851338, 12231.877681223163, 6610.867782644368, 6772.018057381652, 6871.003704462825, 6872.828179295558, 6886.586804791728, 4156.210320039183, 4410.294352903552, 4448.955510444886, 4477.395551600524, 4486.55134486552, 1233.901287896975, 1252.8496580410317, 1301.6290357248233, 1305.6670549010037, 1308.8822006019504, 17063.914680426642, 17086.658266834595, 17218.827811721847, 17222.569435764206, 17234.310627574756, 5872.0, 6046.788362407383, 6281.96859015702, 6286.5599408041, 6338.619682819046, 14158.929205354114, 14179.64550886236, 14213.005089643626, 14220.786688199685, 14266.001379903515, 6884.759033433806, 6922.446204303644, 7036.894446583306, 7045.647717614099, 7059.682314295869, 6107.0, 6228.159198508234, 6280.780172693934, 6307.24313082433, 6370.968145159337, 3915.5497117831246, 4073.6944729145434, 4547.704399214041, 4792.305115758196, 4809.254565542346, 1304.530369067135, 1353.4247944623496, 1475.1960181701, 1494.0, 1512.9470468533768, 762.6491813765618, 764.2586690909809, 794.2057942057942, 800.1118758178417, 811.8147504643287, 6037.09443583466, 6383.968080159662, 6659.4350327672955, 7042.92957070433, 7071.469639777038, 914.5472990869562, 946.2808265718104, 947.3557980573277, 949.0035462764071, 951.4529145741088, 3737.4767532545466, 3944.5463771666628, 3997.8805934338434, 4084.0, 4271.188474189894, 15048.473303434328, 15354.462593809163, 15539.5338139856, 15654.217289135499, 15663.765043524356, 9946.452945087945, 12232.204906681038, 14201.36093875778, 15619.60950976212, 16026.358945642278, 8445.57772111392, 8710.303175745925, 8824.602892869836, 8842.027376988526, 8845.51349675774, 7117.679704413417, 7157.781087862779, 7200.747973820891, 7281.745138920112, 7365.116186057493, 13630.727385452434, 13819.30903454803, 14174.787378189541, 14176.645583860485, 14250.71498570002, 11974.640760776841, 13867.0, 14021.719565608835, 14346.784798227825, 14401.42394304216, 9693.27300452483, 9897.703068907944, 9986.300958932805, 10004.24968127408, 10018.3488073275, 10796.892031079902, 10831.24181307301, 10973.286736362112, 11084.168687348643, 11089.445527723421, 7787.493812902143, 8901.243394311556, 9395.953020234854, 9418.811623767624, 9459.432434053979, 7101.573905565682, 9088.454692718458, 9128.49793261377, 9258.35191536586, 9378.249740020918, 8297.626606802587, 8371.581420929051, 8483.915160848312, 8513.19124683154, 8522.957385213034, 5191.454897235736, 6005.699715014144, 6084.69576521181, 6277.340879207617, 6311.368863113652, 6099.512039036955, 6207.131001659681, 6286.779962701284, 6318.0, 6343.0], "value": 5505.337860858546, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.8710125658533, 409.7254839257697, 410.96095870892253, 416.0783863741809, 418.5751462265801, 5817.912731309034, 6153.876922461548, 6217.37826217378, 6293.30773614902, 6326.683665816702, 6124.571280010401, 6163.9213137700835, 6181.350958149397, 6186.75252989881, 6195.0, 4529.2526733089, 4539.704919180259, 4556.589906908378, 4556.84051058213, 4560.361549383089, 3760.3231418344685, 4375.387445757597, 4479.977600112011, 4481.170983368071, 4512.932306015412, 3458.3774920514297, 3739.1773809761808, 4130.277201489742, 4375.453068366454, 4464.8883777905485, 3827.445020472044, 4032.41529978153, 4124.6906482013665, 4482.731036137826, 4496.685232033759, 3220.0, 3371.477420999749, 3694.9815250923575, 3887.086534664352, 3895.7078219133678, 5946.672932988684, 5968.462838344526, 6010.729517171738, 6024.698765061773, 6055.27336719592, 4609.838655647036, 4739.4075740532435, 5168.302279192336, 5233.555147812441, 5442.829791594826, 5390.838274851761, 6307.966617221765, 6527.640979746112, 6607.207135143765, 6631.839428100111, 4244.830206791756, 4429.11417716458, 4441.244988351956, 4453.755043472608, 4460.197164510387, 6706.497012724065, 6876.011913090396, 6913.965430172867, 7003.677205323939, 7026.578405295699, 4194.664426845845, 4321.222180007629, 4477.067520773899, 4501.88745281364, 4505.234110201273, 4334.263175260214, 4569.748663823521, 4583.335416364608, 4602.171609110325, 4603.424571928509, 4467.7319360838455, 5257.158854583248, 5384.811531596453, 5405.405405405402, 5405.891882162414, 4912.631552633567, 5904.966630839586, 6589.86820263592, 6610.338966103352, 6658.167729033871, 1404.2767974493145, 1492.6640656612271, 1549.4886687393134, 1561.9222736311908, 1562.2969663651402, 869.6304070769897, 1025.779457416659, 1028.3521381529738, 1030.0523518363125, 1034.1158309645296, 5181.974090129525, 5281.287026251483, 6220.34686357935, 6238.532110091761, 6238.750449982041, 5973.940260597426, 6524.380183882524, 6818.454523638097, 6896.862062758717, 6898.965505172542, 5830.38780928005, 5903.58674892762, 6161.289032825543, 6209.813705588749, 6215.968920155461, 3254.3491301739273, 3412.5904891412692, 3573.0710015396185, 3589.9282014360087, 3596.604373518911, 6596.406323430914, 6990.580565166005, 7073.080499535027, 7100.0, 7132.251113633098, 5617.915731264035, 6961.338672826073, 7060.293970602898, 7064.834302340057, 7140.642967851587, 6675.766348177791, 6957.234704182536, 7043.330883565951, 7062.293770622897, 7069.858602827914, 5792.478676919098, 6831.208679183101, 6838.418734407631, 6842.828929276808, 6856.314368563104, 5259.579233661374, 6443.484521238383, 6620.933790662032, 6693.665316734046, 6714.798556043326, 6920.342567456084, 6933.029375887279, 7109.431245500244, 7113.146422429341, 7123.216446191019, 4687.19562448493, 4964.7765850537535, 4979.68038469813, 4996.650234483696, 5009.899802004013, 5469.890602187855, 6706.932930670826, 6743.786118498521, 6853.451723862178, 6856.691448884912, 6181.567290289817, 6634.137562116894, 6649.2685804562425, 6652.866942661023, 6664.766733164316, 5220.155015516477, 6266.433391652087, 6611.0, 6643.970184621391, 6650.46796256308, 5421.349438067457, 6036.939630603813, 6555.573887697285, 6557.967210163919, 6559.0, 6094.14681944537, 6466.833610740455, 6636.933630663824, 6690.264070952094, 6767.593944363157, 5905.291365036223, 6463.482921366373, 6466.353364663496, 6478.805635830932, 6485.189351331083], "value": 4777.917599780463, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [785.4541093939714, 821.273173241681, 839.1021606880638, 858.5535521528806, 866.4368160695548, 16177.029378237314, 16552.999999999985, 16602.75095873563, 18408.171632276546, 19049.0, 17413.042282674447, 17501.82498175018, 17663.735043974317, 17733.911330443363, 17787.91106044468, 941.7833898203401, 946.2004606107828, 958.8082383523289, 960.7357976556433, 966.2270183852925, 971.820213260549, 972.9756756081084, 974.2595627323215, 975.5756246032963, 980.96076156954, 1009.0817356205854, 1020.8366661334188, 1022.1720406470745, 1022.3865680591659, 1030.1243942648764, 1000.1348833259251, 1004.6082028009082, 1015.7866847961974, 1016.903394177552, 1024.8309029010204, 721.2679130682361, 734.7354952217197, 748.7229725001785, 748.7454265549685, 752.9661165247577, 16447.93088449259, 16496.587585310343, 16575.41986030495, 16715.83284167155, 16772.245248963827, 16306.918465407596, 16666.749998750027, 16672.249748761336, 16773.0, 16858.325666973305, 13693.452261909611, 13881.652958676013, 13883.791743123862, 13960.0, 13988.370523326475, 3406.710429613461, 3455.1189446690933, 3489.8953031409096, 3493.283876805249, 3498.8775392861126, 130594.0, 131839.34080329537, 132065.0, 133703.0, 134833.65166348408, 13104.2137471752, 13275.0, 13320.134191277535, 13385.263810490516, 13390.397432115578, 25341.113061042775, 25522.979080836558, 25725.614115788278, 25992.8700356497, 26124.608130878052, 7641.885371719429, 7642.04474440695, 7670.96164519185, 7710.460267781314, 7722.11195712489, 3634.436662317345, 3645.981770091186, 3832.3485007548784, 3931.8820435386983, 3976.681865450757, 4365.4979677337515, 4403.119376124788, 4427.380166776654, 4469.307257375112, 4470.955290447054, 894.3918135667808, 901.8061116859907, 909.9272058235325, 910.1262787723726, 910.9726708198765, 632.7658766256515, 652.064287747075, 660.3066779881106, 662.6620423584006, 667.7329068372593, 10925.562977480971, 11427.885721142848, 11692.590759323553, 11751.0, 12188.81716774249, 648.8345471904634, 650.1125963060483, 652.1424327009967, 660.5863452212269, 679.9932000680029, 5209.853832156919, 5291.391489978625, 5314.309139811877, 5408.621396502207, 5481.095619222783, 91150.0, 91878.08121918829, 92931.53534232285, 93739.0, 94008.0, 70419.64790176017, 77210.61394692991, 77984.0, 79673.60163199146, 79727.0, 75000.0, 75832.24167758362, 76126.09684757814, 76155.0, 77120.22879771242, 10933.507992140214, 11762.176647634584, 11775.52897884075, 12272.631821045383, 12318.568850090203, 39902.20195596014, 39929.40105898356, 40280.59719402769, 40353.596464034985, 40573.79713101416, 50923.745381272856, 51451.742741286056, 51565.0, 51664.22503662373, 51668.0, 15305.46430874914, 15557.844421556092, 15620.140892251035, 15692.293846777151, 15797.131157786433, 17209.483715488554, 17272.0, 17435.30258789634, 17618.73571896397, 17686.02726849984, 15797.68404631878, 15817.762733559235, 15881.364745410054, 16008.839911600735, 16143.67712645717, 15939.521814345588, 15981.840181598036, 16116.27476763572, 16169.67660646757, 16193.190340483165, 14589.635259118182, 15541.98977066487, 15948.840511594735, 15992.0, 15998.360065597246, 11351.035162011322, 11382.260153090023, 11638.53445862156, 11971.820422693492, 12070.215435996983, 11262.267952583055, 12154.209976351509, 12203.694907627025, 12690.555830546256, 12818.55135070268], "value": 8177.649426611246, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 115.0, 113.0, 115.0, 114.0, 114.0, 114.0, 114.0, 117.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 111.0, 110.0, 149.0, 110.0, 113.0, 113.0, 116.0, 152.0, 149.0], "value": 126.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 200.0, 203.0, 218.0, 206.0, 225.0, 199.0, 198.0, 202.0, 190.0], "value": 204.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 75.0, 48.0, 81.0, 88.0, 51.0, 64.0, 83.0, 90.0, 83.0], "value": 73.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 69.0, 83.0, 72.0, 67.0, 69.0, 84.0, 66.0, 72.0, 112.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 91.0, 89.0, 90.0, 91.0, 104.0, 138.0, 102.0, 89.0, 91.0], "value": 99.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 154.0, 146.0, 98.0, 97.0, 98.0, 98.0, 97.0, 97.0, 140.0], "value": 112.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 96.0, 90.0, 91.0, 94.0, 89.0, 97.0, 93.0, 91.0, 91.0], "value": 92.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 52.0, 51.0, 51.0, 51.0, 52.0, 52.0, 53.0, 52.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 66.0, 72.0, 88.0, 92.0, 57.0, 57.0, 58.0, 57.0, 49.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 83.0, 85.0, 74.0, 95.0, 107.0, 73.0, 117.0, 109.0, 108.0], "value": 94.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 147.0, 132.0, 130.0, 156.0, 130.0, 127.0, 150.0, 207.0, 127.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [209.0, 237.0, 181.0, 180.0, 184.0, 180.0, 186.0, 240.0, 236.0, 190.0], "value": 202.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 93.0, 71.0, 60.0, 94.0, 96.0, 100.0, 100.0, 104.0, 59.0], "value": 85.4, "unit": "score"}]}]} 22:30:58 INFO - Return code: 0 22:30:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:30:58 ERROR - # TBPL SUCCESS # 22:30:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:30:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:30:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:30:58 INFO - 2017-04-23 22:30:58.967 screenresolution[1668:11257] starting screenresolution argv=screenresolution get 22:30:58 INFO - 2017-04-23 22:30:58.970 screenresolution[1668:11257] Display 0: 1600x1200x32@60 22:30:58 INFO - 2017-04-23 22:30:58.976 screenresolution[1669:11260] starting screenresolution argv=screenresolution list 22:30:58 INFO - Available Modes on Display 0 22:30:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:30:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:30:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:30:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:30:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:30:59 INFO - Intel Iris: 22:30:59 INFO - Chipset Model: Intel Iris 22:30:59 INFO - Type: GPU 22:30:59 INFO - Bus: Built-In 22:30:59 INFO - VRAM (Dynamic, Max): 1536 MB 22:30:59 INFO - Vendor: Intel (0x8086) 22:30:59 INFO - Device ID: 0x0a2e 22:30:59 INFO - Revision ID: 0x0009 22:30:59 INFO - Displays: 22:30:59 INFO - Display: 22:30:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:30:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:30:59 INFO - Display Serial Number: 1600x1200 60 22:30:59 INFO - Main Display: Yes 22:30:59 INFO - Mirror: Off 22:30:59 INFO - Online: Yes 22:30:59 INFO - Rotation: Supported 22:30:59 INFO - Return code: 0 22:30:59 INFO - Running post-action listener: _resource_record_post_action 22:30:59 INFO - [mozharness: 2017-04-24 05:30:59.212453Z] Finished run-tests step (success) 22:30:59 INFO - Running post-run listener: _resource_record_post_run 22:30:59 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 33829376; Write bytes: 513600512; Read time: 207; Write time: 1602 22:30:59 INFO - TinderboxPrint: CPU usage
54.1% 22:30:59 INFO - TinderboxPrint: I/O read bytes / time
33,829,376 / 207 22:30:59 INFO - TinderboxPrint: I/O write bytes / time
513,600,512 / 1,602 22:30:59 INFO - TinderboxPrint: CPU idle
2,200.4 (45.9%) 22:30:59 INFO - TinderboxPrint: CPU system
965.0 (20.1%) 22:30:59 INFO - TinderboxPrint: CPU user
1,624.2 (33.9%) 22:30:59 INFO - TinderboxPrint: Swap in / out
238,141,440 / 0 22:30:59 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205515264; Write bytes: 205301760; Read time: 15830; Write time: 416 22:30:59 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 31756800; Write bytes: 301249536; Read time: 188; Write time: 1158 22:30:59 INFO - Running post-run listener: _upload_blobber_files 22:30:59 INFO - Blob upload gear active. 22:30:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:30:59 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 22:30:59 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'] 22:30:59 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 22:31:00 INFO - (blobuploader) - INFO - Open directory for files ... 22:31:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:31:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:31:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:31:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:31:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:31:01 INFO - (blobuploader) - INFO - Done attempting. 22:31:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:31:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:31:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:31:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:31:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:31:02 INFO - (blobuploader) - INFO - Done attempting. 22:31:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:31:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:31:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:31:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:31:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:31:03 INFO - (blobuploader) - INFO - Done attempting. 22:31:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:31:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:31:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:31:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:31:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:31:05 INFO - (blobuploader) - INFO - Done attempting. 22:31:05 INFO - (blobuploader) - INFO - Iteration through files over. 22:31:05 INFO - Return code: 0 22:31:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:31:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:31:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b8f35ae1c54d026e9f9327823bc79bf9c32b5e401485c267badd036172cc40cf8addacbc2152b72a730a77c59ea2cc1bdf92ab7ebf1e9d6189abd77ee77db53", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6e4735040c4c54b0f4e20e3a0c3e94cff055b121050459ef99c6599ef24d597972a1c39e855ef327a54a0aed8b8f25cae99881e7d15714fad355c0c5d84252b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35f151909e1b4d43be2ebcd604b11e1179a8dd1bebc26e739261a6093e856e2235ff4bf4072f0156f165f74062ba30bf418721cada1366b01b2ae408edff808f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/baf6cc47d7be8a81f8e9a90eb53cfffd8474f35cd82ef1273795a3e348863fa038af3cc7fd9aef1f293d93352bf6315c43c6985bc73c39c348da976396a5ed64"} 22:31:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:31:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:31:05 INFO - Contents: 22:31:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b8f35ae1c54d026e9f9327823bc79bf9c32b5e401485c267badd036172cc40cf8addacbc2152b72a730a77c59ea2cc1bdf92ab7ebf1e9d6189abd77ee77db53", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6e4735040c4c54b0f4e20e3a0c3e94cff055b121050459ef99c6599ef24d597972a1c39e855ef327a54a0aed8b8f25cae99881e7d15714fad355c0c5d84252b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35f151909e1b4d43be2ebcd604b11e1179a8dd1bebc26e739261a6093e856e2235ff4bf4072f0156f165f74062ba30bf418721cada1366b01b2ae408edff808f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/baf6cc47d7be8a81f8e9a90eb53cfffd8474f35cd82ef1273795a3e348863fa038af3cc7fd9aef1f293d93352bf6315c43c6985bc73c39c348da976396a5ed64"} 22:31:05 INFO - Running post-run listener: copy_logs_to_upload_dir 22:31:05 INFO - Copying logs to upload dir... 22:31:05 INFO - mkdir: /builds/slave/test/build/upload/logs 22:31:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.121962 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-23 22:31:05.184696) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-23 22:31:05.188551) ========= 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.OznSQrfn1q/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.B8Lu6LTZgB/Listeners TMPDIR=/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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/2b8f35ae1c54d026e9f9327823bc79bf9c32b5e401485c267badd036172cc40cf8addacbc2152b72a730a77c59ea2cc1bdf92ab7ebf1e9d6189abd77ee77db53", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6e4735040c4c54b0f4e20e3a0c3e94cff055b121050459ef99c6599ef24d597972a1c39e855ef327a54a0aed8b8f25cae99881e7d15714fad355c0c5d84252b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35f151909e1b4d43be2ebcd604b11e1179a8dd1bebc26e739261a6093e856e2235ff4bf4072f0156f165f74062ba30bf418721cada1366b01b2ae408edff808f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/baf6cc47d7be8a81f8e9a90eb53cfffd8474f35cd82ef1273795a3e348863fa038af3cc7fd9aef1f293d93352bf6315c43c6985bc73c39c348da976396a5ed64"} build_url:https://queue.taskcluster.net/v1/task/CVjp-fVsSF-4hohxzZO8WQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011117 build_url: 'https://queue.taskcluster.net/v1/task/CVjp-fVsSF-4hohxzZO8WQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b8f35ae1c54d026e9f9327823bc79bf9c32b5e401485c267badd036172cc40cf8addacbc2152b72a730a77c59ea2cc1bdf92ab7ebf1e9d6189abd77ee77db53", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6e4735040c4c54b0f4e20e3a0c3e94cff055b121050459ef99c6599ef24d597972a1c39e855ef327a54a0aed8b8f25cae99881e7d15714fad355c0c5d84252b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35f151909e1b4d43be2ebcd604b11e1179a8dd1bebc26e739261a6093e856e2235ff4bf4072f0156f165f74062ba30bf418721cada1366b01b2ae408edff808f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/baf6cc47d7be8a81f8e9a90eb53cfffd8474f35cd82ef1273795a3e348863fa038af3cc7fd9aef1f293d93352bf6315c43c6985bc73c39c348da976396a5ed64"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-23 22:31:05.227105) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-23 22:31:05.227725) ========= 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.OznSQrfn1q/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.B8Lu6LTZgB/Listeners TMPDIR=/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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.005276 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-23 22:31:05.278150) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-23 22:31:05.278476) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-23 22:31:05.278860) ========= ========= Total master_lag: 0.74 =========