builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0320 starttime: 1485575866.15 results: success (0) buildid: 20170127184008 builduid: 8e5e31ed05764a0a941a5d5653f6a4c5 revision: 045d8fe30f546ab08466c9586ce298e6459c2069 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 19:57:46.145529) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 19:57:46.146005) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 19:57:46.146305) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 19:57:47.048787) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 19:57:47.053170) ========= 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.mXytFqtRNx/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.voIA6b4kjG/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-27 19:57:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.3M=0.001s 2017-01-27 19:57:47 (18.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.493331 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 19:57:47.576098) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 19:57:47.576434) ========= 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.mXytFqtRNx/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.voIA6b4kjG/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.039280 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 19:57:47.639828) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-27 19:57:47.643199) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 045d8fe30f546ab08466c9586ce298e6459c2069 --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 045d8fe30f546ab08466c9586ce298e6459c2069 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mXytFqtRNx/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.voIA6b4kjG/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-27 19:57:47,750 truncating revision to first 12 chars 2017-01-27 19:57:47,750 Setting DEBUG logging. 2017-01-27 19:57:47,750 attempt 1/10 2017-01-27 19:57:47,750 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/045d8fe30f54?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-27 19:57:48,933 unpacking tar archive at: mozilla-central-045d8fe30f54/testing/mozharness/ program finished with exit code 0 elapsedTime=1.445865 ========= master_lag: 1.52 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-27 19:57:50.611205) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 19:57:50.611543) ========= script_repo_revision: 045d8fe30f546ab08466c9586ce298e6459c2069 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 19:57:50.611954) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 3 secs) (at 2017-01-27 19:57:50.612240) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 3 secs) (at 2017-01-27 19:57:54.446053) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-27 19:57:54.446433) ========= /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.mXytFqtRNx/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.voIA6b4kjG/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 19:57:54 INFO - MultiFileLogger online at 20170127 19:57:54 in /builds/slave/test 19:57:54 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 19:57:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:57:54 INFO - {'append_to_log': False, 19:57:54 INFO - 'base_work_dir': '/builds/slave/test', 19:57:54 INFO - 'blob_upload_branch': 'Firefox', 19:57:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:57:54 INFO - 'branch': 'Firefox', 19:57:54 INFO - 'buildbot_json_path': 'buildprops.json', 19:57:54 INFO - 'config_files': ('talos/mac_config.py',), 19:57:54 INFO - 'default_actions': ('clobber', 19:57:54 INFO - 'read-buildbot-config', 19:57:54 INFO - 'download-and-extract', 19:57:54 INFO - 'populate-webroot', 19:57:54 INFO - 'create-virtualenv', 19:57:54 INFO - 'install', 19:57:54 INFO - 'run-tests'), 19:57:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:57:54 INFO - 'download_minidump_stackwalk': True, 19:57:54 INFO - 'download_symbols': 'ondemand', 19:57:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:57:54 INFO - 'tooltool.py': '/tools/tooltool.py', 19:57:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:57:54 INFO - '/tools/misc-python/virtualenv.py')}, 19:57:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:57:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:57:54 INFO - 'installer_path': 'installer.exe', 19:57:54 INFO - 'log_level': 'info', 19:57:54 INFO - 'log_name': 'talos', 19:57:54 INFO - 'log_to_console': True, 19:57:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:57:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:57:54 INFO - 'opt_config_files': (), 19:57:54 INFO - 'pip_index': False, 19:57:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:57:54 INFO - 'cmd': ('bash', 19:57:54 INFO - '-c', 19:57:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:57:54 INFO - 'enabled': True, 19:57:54 INFO - 'halt_on_failure': False, 19:57:54 INFO - 'name': 'check_screen_resolution'},), 19:57:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:57:54 INFO - 'cmd': ('bash', 19:57:54 INFO - '-c', 19:57:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:57:54 INFO - 'enabled': True, 19:57:54 INFO - 'halt_on_failure': False, 19:57:54 INFO - 'name': 'check_screen_resolution'},), 19:57:54 INFO - 'run_cmd_checks_enabled': True, 19:57:54 INFO - 'sps_profile': False, 19:57:54 INFO - 'sps_profile_interval': 0, 19:57:54 INFO - 'suite': 'dromaeojs-e10s', 19:57:54 INFO - 'system_bits': '32', 19:57:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:57:54 INFO - 'title': 't-yosemite-r7-0320', 19:57:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:57:54 INFO - 'use_talos_json': True, 19:57:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:57:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:57:54 INFO - 'work_dir': 'build'} 19:57:54 INFO - [mozharness: 2017-01-28 03:57:54.664356Z] Running clobber step. 19:57:54 INFO - Running pre-action listener: _resource_record_pre_action 19:57:54 INFO - Running main action method: clobber 19:57:54 INFO - rmtree: /builds/slave/test/build 19:57:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:57:57 INFO - Running post-action listener: _resource_record_post_action 19:57:57 INFO - [mozharness: 2017-01-28 03:57:57.434364Z] Finished clobber step (success) 19:57:57 INFO - [mozharness: 2017-01-28 03:57:57.434559Z] Running read-buildbot-config step. 19:57:57 INFO - Running pre-action listener: _resource_record_pre_action 19:57:57 INFO - Running main action method: read_buildbot_config 19:57:57 INFO - Using buildbot properties: 19:57:57 INFO - { 19:57:57 INFO - "project": "", 19:57:57 INFO - "product": "firefox", 19:57:57 INFO - "script_repo_revision": "production", 19:57:57 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 19:57:57 INFO - "repository": "", 19:57:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 19:57:57 INFO - "buildid": "20170127184008", 19:57:57 INFO - "pgo_build": "False", 19:57:57 INFO - "basedir": "/builds/slave/test", 19:57:57 INFO - "buildnumber": 29, 19:57:57 INFO - "slavename": "t-yosemite-r7-0320", 19:57:57 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 19:57:57 INFO - "platform": "yosemite_r7", 19:57:57 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:57:57 INFO - "branch": "mozilla-central", 19:57:57 INFO - "repo_path": "mozilla-central", 19:57:57 INFO - "revision": "045d8fe30f546ab08466c9586ce298e6459c2069", 19:57:57 INFO - "stage_platform": "macosx64", 19:57:57 INFO - "builduid": "8e5e31ed05764a0a941a5d5653f6a4c5", 19:57:57 INFO - "slavebuilddir": "test" 19:57:57 INFO - } 19:57:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 19:57:57 INFO - Running post-action listener: _resource_record_post_action 19:57:57 INFO - [mozharness: 2017-01-28 03:57:57.438484Z] Finished read-buildbot-config step (success) 19:57:57 INFO - [mozharness: 2017-01-28 03:57:57.438730Z] Running download-and-extract step. 19:57:57 INFO - Running pre-action listener: _resource_record_pre_action 19:57:57 INFO - Running main action method: download_and_extract 19:57:57 INFO - mkdir: /builds/slave/test/build/tests 19:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:57:57 INFO - trying https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 19:57:57 INFO - Downloading https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 19:57:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 19:57:58 INFO - Downloaded 1199 bytes. 19:57:58 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 19:57:58 INFO - Using the following test package requirements: 19:57:58 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 19:57:58 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:57:58 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 19:57:58 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:57:58 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 19:57:58 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:57:58 INFO - u'jsshell-mac.zip'], 19:57:58 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:57:58 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 19:57:58 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 19:57:58 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:57:58 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 19:57:58 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:57:58 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 19:57:58 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:57:58 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 19:57:58 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:57:58 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 19:57:58 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:57:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 19:57:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:57:58 INFO - Fetch https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 19:57:59 INFO - Expected file size: 16361071 19:57:59 INFO - Obtained file size: 16361071 19:58:06 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:58:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 19:58:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:58:06 INFO - Fetch https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 19:58:07 INFO - Expected file size: 16361071 19:58:07 INFO - Obtained file size: 16361071 19:58:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 19:58:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:58:13 INFO - Fetch https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 19:58:14 INFO - Expected file size: 14403454 19:58:14 INFO - Obtained file size: 14403454 19:58:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:15 INFO - trying https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 19:58:15 INFO - Downloading https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 19:58:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 19:58:17 INFO - Downloaded 70134217 bytes. 19:58:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 19:58:17 INFO - mkdir: /builds/slave/test/properties 19:58:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:58:17 INFO - Writing to file /builds/slave/test/properties/build_url 19:58:17 INFO - Contents: 19:58:17 INFO - build_url:https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 19:58:17 INFO - Running post-action listener: _resource_record_post_action 19:58:17 INFO - Running post-action listener: set_extra_try_arguments 19:58:17 INFO - [mozharness: 2017-01-28 03:58:17.873880Z] Finished download-and-extract step (success) 19:58:17 INFO - [mozharness: 2017-01-28 03:58:17.874018Z] Running populate-webroot step. 19:58:17 INFO - Running pre-action listener: _resource_record_pre_action 19:58:17 INFO - Running main action method: populate_webroot 19:58:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:58:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:58:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:58:17 INFO - '--tppagecycles', 19:58:17 INFO - '7'], 19:58:17 INFO - 'tests': ['tsvgm']}}, 19:58:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:58:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:58:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:58:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:58:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:58:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:58:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:58:17 INFO - 'talos_options': ['--disable-e10s'], 19:58:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:58:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:58:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:58:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:58:17 INFO - 'talos_options': ['--disable-e10s'], 19:58:17 INFO - 'tests': ['damp', 'tps']}, 19:58:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:58:17 INFO - 'tests': ['damp', 'tps']}, 19:58:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:58:17 INFO - 'tests': ['dromaeo_dom']}, 19:58:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:58:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:58:17 INFO - 'tests': ['basic_compositor_video']}, 19:58:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:58:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:58:17 INFO - 'tests': ['a11yr', 19:58:17 INFO - 'ts_paint', 19:58:17 INFO - 'tpaint', 19:58:17 INFO - 'sessionrestore', 19:58:17 INFO - 'sessionrestore_no_auto_restore', 19:58:17 INFO - 'tabpaint']}, 19:58:17 INFO - 'other-e10s': {'tests': ['a11yr', 19:58:17 INFO - 'ts_paint', 19:58:17 INFO - 'tpaint', 19:58:17 INFO - 'sessionrestore', 19:58:17 INFO - 'sessionrestore_no_auto_restore', 19:58:17 INFO - 'tabpaint']}, 19:58:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:58:17 INFO - 'ts_paint', 19:58:17 INFO - 'tpaint', 19:58:17 INFO - 'sessionrestore', 19:58:17 INFO - 'sessionrestore_no_auto_restore', 19:58:17 INFO - 'tabpaint']}, 19:58:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:58:17 INFO - 'ts_paint', 19:58:17 INFO - 'tpaint', 19:58:17 INFO - 'sessionrestore', 19:58:17 INFO - 'sessionrestore_no_auto_restore', 19:58:17 INFO - 'tabpaint']}, 19:58:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:58:17 INFO - 'tests': ['a11yr', 19:58:17 INFO - 'ts_paint', 19:58:17 INFO - 'tpaint', 19:58:17 INFO - 'sessionrestore', 19:58:17 INFO - 'sessionrestore_no_auto_restore', 19:58:17 INFO - 'tabpaint']}, 19:58:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:58:17 INFO - 'tests': ['a11yr', 19:58:17 INFO - 'ts_paint', 19:58:17 INFO - 'tpaint', 19:58:17 INFO - 'sessionrestore', 19:58:17 INFO - 'sessionrestore_no_auto_restore', 19:58:17 INFO - 'tabpaint']}, 19:58:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:58:17 INFO - 'tests': ['tsvgx', 19:58:17 INFO - 'tsvgr_opacity', 19:58:17 INFO - 'tart', 19:58:17 INFO - 'tscrollx', 19:58:17 INFO - 'cart', 19:58:17 INFO - 'tsvg_static']}, 19:58:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:58:17 INFO - 'tsvgr_opacity', 19:58:17 INFO - 'tart', 19:58:17 INFO - 'tscrollx', 19:58:17 INFO - 'cart', 19:58:17 INFO - 'tsvg_static']}, 19:58:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:58:17 INFO - 'talos_options': ['--disable-e10s'], 19:58:17 INFO - 'tests': ['tp5o']}, 19:58:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:58:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:58:17 INFO - 'talos_options': ['--disable-e10s', 19:58:17 INFO - '--xperf_path', 19:58:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:58:17 INFO - 'tests': ['tp5n']}, 19:58:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:58:17 INFO - 'talos_options': ['--xperf_path', 19:58:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:58:17 INFO - 'tests': ['tp5n']}}, 19:58:17 INFO - 'talos.zip': {'path': '', 19:58:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:58:17 INFO - Running post-action listener: _resource_record_post_action 19:58:17 INFO - [mozharness: 2017-01-28 03:58:17.892757Z] Finished populate-webroot step (success) 19:58:17 INFO - [mozharness: 2017-01-28 03:58:17.892879Z] Running create-virtualenv step. 19:58:17 INFO - Running pre-action listener: _resource_record_pre_action 19:58:17 INFO - Running main action method: create_virtualenv 19:58:17 INFO - Creating virtualenv /builds/slave/test/build/venv 19:58:17 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 19:58:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:58:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:58:18 INFO - Using real prefix '/tools/python27' 19:58:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:58:18 INFO - Installing distribute.............................................................................................................................................................................................done. 19:58:21 INFO - Installing pip.................done. 19:58:21 INFO - Return code: 0 19:58:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:58:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:58:21 INFO - Reading from file tmpfile_stdout 19:58:21 INFO - Output received: 19:58:21 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) 19:58:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:58: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')]} 19:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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')]} 19:58:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106bb6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8633c5c540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106994d30>, '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 0x1068bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106989be8>, '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.mXytFqtRNx/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.voIA6b4kjG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:58:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:58:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:58:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mXytFqtRNx/Render', 19:58:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:21 INFO - 'HOME': '/Users/cltbld', 19:58:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:21 INFO - 'LOGNAME': 'cltbld', 19:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:21 INFO - 'MOZ_NO_REMOTE': '1', 19:58:21 INFO - 'NO_EM_RESTART': '1', 19:58:21 INFO - 'PAGER': '/bin/cat', 19:58:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:21 INFO - 'PWD': '/builds/slave/test', 19:58:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:21 INFO - 'SHELL': '/bin/bash', 19:58:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.voIA6b4kjG/Listeners', 19:58:21 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 19:58:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:21 INFO - 'USER': 'cltbld', 19:58:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:21 INFO - 'XPC_FLAGS': '0x0', 19:58:21 INFO - 'XPC_SERVICE_NAME': '0', 19:58:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:58:22 INFO - Cleaning up... 19:58:22 INFO - Return code: 0 19:58:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106bb6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8633c5c540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106994d30>, '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 0x1068bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106989be8>, '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.mXytFqtRNx/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.voIA6b4kjG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:58:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:58:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:58:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mXytFqtRNx/Render', 19:58:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:22 INFO - 'HOME': '/Users/cltbld', 19:58:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:22 INFO - 'LOGNAME': 'cltbld', 19:58:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:22 INFO - 'MOZ_NO_REMOTE': '1', 19:58:22 INFO - 'NO_EM_RESTART': '1', 19:58:22 INFO - 'PAGER': '/bin/cat', 19:58:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:22 INFO - 'PWD': '/builds/slave/test', 19:58:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:22 INFO - 'SHELL': '/bin/bash', 19:58:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.voIA6b4kjG/Listeners', 19:58:22 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 19:58:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:22 INFO - 'USER': 'cltbld', 19:58:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:22 INFO - 'XPC_FLAGS': '0x0', 19:58:22 INFO - 'XPC_SERVICE_NAME': '0', 19:58:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:22 INFO - Downloading/unpacking psutil>=3.1.1 19:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:58:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:58:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:58:26 INFO - Installing collected packages: psutil 19:58:26 INFO - Running setup.py install for psutil 19:58:26 INFO - building 'psutil._psutil_osx' extension 19:58:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 19:58:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 19:58:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 19:58:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 19:58:27 INFO - building 'psutil._psutil_posix' extension 19:58:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 19:58:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:58:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:58:27 INFO - ^ 19:58:27 INFO - 1 warning generated. 19:58:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 19:58:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:58:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:58:27 INFO - Successfully installed psutil 19:58:27 INFO - Cleaning up... 19:58:27 INFO - Return code: 0 19:58:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106bb6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8633c5c540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106994d30>, '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 0x1068bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106989be8>, '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.mXytFqtRNx/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.voIA6b4kjG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:58:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:58:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:58:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mXytFqtRNx/Render', 19:58:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:27 INFO - 'HOME': '/Users/cltbld', 19:58:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:27 INFO - 'LOGNAME': 'cltbld', 19:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:27 INFO - 'MOZ_NO_REMOTE': '1', 19:58:27 INFO - 'NO_EM_RESTART': '1', 19:58:27 INFO - 'PAGER': '/bin/cat', 19:58:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:27 INFO - 'PWD': '/builds/slave/test', 19:58:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:27 INFO - 'SHELL': '/bin/bash', 19:58:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.voIA6b4kjG/Listeners', 19:58:27 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 19:58:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:27 INFO - 'USER': 'cltbld', 19:58:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:27 INFO - 'XPC_FLAGS': '0x0', 19:58:27 INFO - 'XPC_SERVICE_NAME': '0', 19:58:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:58:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:58:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:58:30 INFO - Installing collected packages: mozsystemmonitor 19:58:30 INFO - Running setup.py install for mozsystemmonitor 19:58:30 INFO - Successfully installed mozsystemmonitor 19:58:30 INFO - Cleaning up... 19:58:30 INFO - Return code: 0 19:58:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106bb6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8633c5c540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106994d30>, '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 0x1068bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106989be8>, '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.mXytFqtRNx/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.voIA6b4kjG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:58:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:58:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:58:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mXytFqtRNx/Render', 19:58:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:30 INFO - 'HOME': '/Users/cltbld', 19:58:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:30 INFO - 'LOGNAME': 'cltbld', 19:58:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:30 INFO - 'MOZ_NO_REMOTE': '1', 19:58:30 INFO - 'NO_EM_RESTART': '1', 19:58:30 INFO - 'PAGER': '/bin/cat', 19:58:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:30 INFO - 'PWD': '/builds/slave/test', 19:58:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:30 INFO - 'SHELL': '/bin/bash', 19:58:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.voIA6b4kjG/Listeners', 19:58:30 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 19:58:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:30 INFO - 'USER': 'cltbld', 19:58:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:30 INFO - 'XPC_FLAGS': '0x0', 19:58:30 INFO - 'XPC_SERVICE_NAME': '0', 19:58:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:30 INFO - Downloading/unpacking jsonschema==2.5.1 19:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:58:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:33 INFO - Downloading functools32-3.2.3-2.tar.gz 19:58:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:58:34 INFO - warning: no files found matching '*.txt' 19:58:34 INFO - no previously-included directories found matching 'build' 19:58:34 INFO - no previously-included directories found matching 'dist' 19:58:34 INFO - no previously-included directories found matching '.git*' 19:58:34 INFO - Installing collected packages: jsonschema, functools32 19:58:34 INFO - Running setup.py install for functools32 19:58:34 INFO - warning: no files found matching '*.txt' 19:58:34 INFO - no previously-included directories found matching 'build' 19:58:34 INFO - no previously-included directories found matching 'dist' 19:58:34 INFO - no previously-included directories found matching '.git*' 19:58:34 INFO - Successfully installed jsonschema functools32 19:58:34 INFO - Cleaning up... 19:58:34 INFO - Return code: 0 19:58:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106bb6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8633c5c540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106994d30>, '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 0x1068bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106989be8>, '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.mXytFqtRNx/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.voIA6b4kjG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:58:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:58:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:58:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mXytFqtRNx/Render', 19:58:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:34 INFO - 'HOME': '/Users/cltbld', 19:58:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:34 INFO - 'LOGNAME': 'cltbld', 19:58:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:34 INFO - 'MOZ_NO_REMOTE': '1', 19:58:34 INFO - 'NO_EM_RESTART': '1', 19:58:34 INFO - 'PAGER': '/bin/cat', 19:58:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:34 INFO - 'PWD': '/builds/slave/test', 19:58:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:34 INFO - 'SHELL': '/bin/bash', 19:58:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.voIA6b4kjG/Listeners', 19:58:34 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 19:58:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:34 INFO - 'USER': 'cltbld', 19:58:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:34 INFO - 'XPC_FLAGS': '0x0', 19:58:34 INFO - 'XPC_SERVICE_NAME': '0', 19:58:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:58:34 INFO - Cleaning up... 19:58:34 INFO - Return code: 0 19:58:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106bb6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8633c5c540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106994d30>, '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 0x1068bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106989be8>, '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.mXytFqtRNx/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.voIA6b4kjG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:58:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:58:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:58:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mXytFqtRNx/Render', 19:58:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:34 INFO - 'HOME': '/Users/cltbld', 19:58:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:34 INFO - 'LOGNAME': 'cltbld', 19:58:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:34 INFO - 'MOZ_NO_REMOTE': '1', 19:58:34 INFO - 'NO_EM_RESTART': '1', 19:58:34 INFO - 'PAGER': '/bin/cat', 19:58:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:34 INFO - 'PWD': '/builds/slave/test', 19:58:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:34 INFO - 'SHELL': '/bin/bash', 19:58:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.voIA6b4kjG/Listeners', 19:58:34 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 19:58:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:34 INFO - 'USER': 'cltbld', 19:58:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:34 INFO - 'XPC_FLAGS': '0x0', 19:58:34 INFO - 'XPC_SERVICE_NAME': '0', 19:58:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:34 INFO - Downloading/unpacking blobuploader==1.2.4 19:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:37 INFO - Downloading blobuploader-1.2.4.tar.gz 19:58:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:58:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:58:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:38 INFO - Downloading docopt-0.6.1.tar.gz 19:58:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:58:39 INFO - Installing collected packages: blobuploader, requests, docopt 19:58:39 INFO - Running setup.py install for blobuploader 19:58:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:58:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:58:39 INFO - Running setup.py install for requests 19:58:39 INFO - Running setup.py install for docopt 19:58:39 INFO - Successfully installed blobuploader requests docopt 19:58:39 INFO - Cleaning up... 19:58:39 INFO - Return code: 0 19:58:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:39 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 0x106bb6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8633c5c540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106994d30>, '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 0x1068bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106989be8>, '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.mXytFqtRNx/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.voIA6b4kjG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:58:39 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 19:58:39 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 19:58:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mXytFqtRNx/Render', 19:58:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:39 INFO - 'HOME': '/Users/cltbld', 19:58:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:39 INFO - 'LOGNAME': 'cltbld', 19:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:39 INFO - 'MOZ_NO_REMOTE': '1', 19:58:39 INFO - 'NO_EM_RESTART': '1', 19:58:39 INFO - 'PAGER': '/bin/cat', 19:58:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:39 INFO - 'PWD': '/builds/slave/test', 19:58:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:39 INFO - 'SHELL': '/bin/bash', 19:58:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.voIA6b4kjG/Listeners', 19:58:39 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 19:58:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:39 INFO - 'USER': 'cltbld', 19:58:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:39 INFO - 'XPC_FLAGS': '0x0', 19:58:39 INFO - 'XPC_SERVICE_NAME': '0', 19:58:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:58:40 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-63OUEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:58:40 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-dIFPrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:58:40 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-SNSdSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:58:40 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-3gqDfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:58:40 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-qS3CeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:58:40 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-zaxx7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:58:40 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-fhbSxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:58:40 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-FRQcAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:58:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-NmV9rU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:58:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-BtJRov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:58:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-s4FBtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:58:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Dcc5Xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:58:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-EvS5pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:58:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-qr_H98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:58:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-I8ajrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:58:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-48NQoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:58:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-jmpieu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:58:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:58:42 INFO - Running setup.py install for manifestparser 19:58:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:58:42 INFO - Running setup.py install for mozcrash 19:58:42 INFO - Running setup.py install for mozdebug 19:58:42 INFO - Running setup.py install for mozdevice 19:58:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:58:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:58:42 INFO - Running setup.py install for mozfile 19:58:42 INFO - Running setup.py install for mozhttpd 19:58:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:58:42 INFO - Running setup.py install for mozinfo 19:58:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:58:43 INFO - Running setup.py install for mozInstall 19:58:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:58:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:58:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:58:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:58:43 INFO - Running setup.py install for mozleak 19:58:43 INFO - Running setup.py install for mozlog 19:58:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:58:43 INFO - Running setup.py install for moznetwork 19:58:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:58:43 INFO - Running setup.py install for mozprocess 19:58:43 INFO - Running setup.py install for mozprofile 19:58:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:58:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:58:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:58:43 INFO - Running setup.py install for mozrunner 19:58:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:58:44 INFO - Running setup.py install for mozscreenshot 19:58:44 INFO - Running setup.py install for moztest 19:58:44 INFO - Running setup.py install for mozversion 19:58:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:58:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:58:44 INFO - Cleaning up... 19:58:44 INFO - Return code: 0 19:58:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:58: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')]} 19:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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')]} 19:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:44 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 0x106bb6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8633c5c540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106994d30>, '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 0x1068bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106989be8>, '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.mXytFqtRNx/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.voIA6b4kjG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:58:44 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 19:58:44 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 19:58:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mXytFqtRNx/Render', 19:58:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:44 INFO - 'HOME': '/Users/cltbld', 19:58:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:44 INFO - 'LOGNAME': 'cltbld', 19:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:44 INFO - 'MOZ_NO_REMOTE': '1', 19:58:44 INFO - 'NO_EM_RESTART': '1', 19:58:44 INFO - 'PAGER': '/bin/cat', 19:58:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:44 INFO - 'PWD': '/builds/slave/test', 19:58:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:44 INFO - 'SHELL': '/bin/bash', 19:58:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.voIA6b4kjG/Listeners', 19:58:44 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 19:58:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:44 INFO - 'USER': 'cltbld', 19:58:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:44 INFO - 'XPC_FLAGS': '0x0', 19:58:44 INFO - 'XPC_SERVICE_NAME': '0', 19:58:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:58:44 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-CohMbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:58:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:58:45 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-LGJbZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:58:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:58:45 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-sUxhFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:58:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:58:45 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Elm96e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:58:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:58:45 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-mLxXQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:58:45 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)) 19:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:58:45 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-mhNPMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:58:45 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)) 19:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:58:45 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-_loHL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:58:45 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)) 19:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:58:45 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-nge70k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:58:45 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)) 19:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:58:45 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-7vJmlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:58:45 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)) 19:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:58:45 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-zq1dct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:58:45 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)) 19:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:58:45 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-O7PUVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:58:46 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-2KLV5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 19:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:58:46 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-hP2pWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:58:46 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-DLTUqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:58:46 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)) 19:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:58:46 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-65NUdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:58:46 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)) 19:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:58:46 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-kBFcTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:58:46 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)) 19:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:58:46 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-9VRSaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:58:46 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)) 19:58:46 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)) 19:58:46 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)) 19:58:46 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)) 19:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:58:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:58:46 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 19:58:46 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 19:58:46 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 19:58:46 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 19:58:46 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 19:58:46 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 19:58:49 INFO - Downloading blessings-1.6.tar.gz 19:58:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:58:49 INFO - Installing collected packages: blessings 19:58:49 INFO - Running setup.py install for blessings 19:58:49 INFO - Successfully installed blessings 19:58:49 INFO - Cleaning up... 19:58:49 INFO - Return code: 0 19:58:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:58:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:58:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:58:49 INFO - Reading from file tmpfile_stdout 19:58:49 INFO - Current package versions: 19:58:49 INFO - blessings == 1.6 19:58:49 INFO - blobuploader == 1.2.4 19:58:49 INFO - docopt == 0.6.1 19:58:49 INFO - functools32 == 3.2.3-2 19:58:49 INFO - jsonschema == 2.5.1 19:58:49 INFO - manifestparser == 1.1 19:58:49 INFO - mozInstall == 1.12 19:58:49 INFO - mozcrash == 1.0 19:58:49 INFO - mozdebug == 0.1 19:58:49 INFO - mozdevice == 0.49 19:58:49 INFO - mozfile == 1.2 19:58:49 INFO - mozhttpd == 0.7 19:58:49 INFO - mozinfo == 0.9 19:58:49 INFO - mozleak == 0.1 19:58:49 INFO - mozlog == 3.4 19:58:49 INFO - moznetwork == 0.27 19:58:49 INFO - mozprocess == 0.24 19:58:49 INFO - mozprofile == 0.28 19:58:49 INFO - mozrunner == 6.13 19:58:49 INFO - mozscreenshot == 0.1 19:58:49 INFO - mozsystemmonitor == 0.3 19:58:49 INFO - moztest == 0.8 19:58:49 INFO - mozversion == 1.4 19:58:49 INFO - psutil == 3.1.1 19:58:49 INFO - requests == 1.2.3 19:58:49 INFO - wsgiref == 0.1.2 19:58:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:58: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')]} 19:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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')]} 19:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:49 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 0x106bb6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8633c5c540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106994d30>, '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 0x1068bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106989be8>, '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.mXytFqtRNx/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.voIA6b4kjG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:58:49 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 19:58:49 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 19:58:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mXytFqtRNx/Render', 19:58:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:49 INFO - 'HOME': '/Users/cltbld', 19:58:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:49 INFO - 'LOGNAME': 'cltbld', 19:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:49 INFO - 'MOZ_NO_REMOTE': '1', 19:58:49 INFO - 'NO_EM_RESTART': '1', 19:58:49 INFO - 'PAGER': '/bin/cat', 19:58:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:49 INFO - 'PWD': '/builds/slave/test', 19:58:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:49 INFO - 'SHELL': '/bin/bash', 19:58:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.voIA6b4kjG/Listeners', 19:58:49 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 19:58:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:49 INFO - 'USER': 'cltbld', 19:58:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:49 INFO - 'XPC_FLAGS': '0x0', 19:58:49 INFO - 'XPC_SERVICE_NAME': '0', 19:58:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:50 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)) 19:58:50 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)) 19:58:50 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)) 19:58:50 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)) 19:58:50 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)) 19:58:50 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)) 19:58:50 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)) 19:58:50 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)) 19:58:50 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)) 19:58:50 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)) 19:58:50 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)) 19:58:50 INFO - Cleaning up... 19:58:50 INFO - Return code: 0 19:58:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:50 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 0x106bb6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8633c5c540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106994d30>, '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 0x1068bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106989be8>, '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.mXytFqtRNx/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.voIA6b4kjG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:58:50 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 19:58:50 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 19:58:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mXytFqtRNx/Render', 19:58:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:50 INFO - 'HOME': '/Users/cltbld', 19:58:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:50 INFO - 'LOGNAME': 'cltbld', 19:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:50 INFO - 'MOZ_NO_REMOTE': '1', 19:58:50 INFO - 'NO_EM_RESTART': '1', 19:58:50 INFO - 'PAGER': '/bin/cat', 19:58:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:50 INFO - 'PWD': '/builds/slave/test', 19:58:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:50 INFO - 'SHELL': '/bin/bash', 19:58:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.voIA6b4kjG/Listeners', 19:58:50 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 19:58:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:50 INFO - 'USER': 'cltbld', 19:58:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:50 INFO - 'XPC_FLAGS': '0x0', 19:58:50 INFO - 'XPC_SERVICE_NAME': '0', 19:58:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:58:50 INFO - Cleaning up... 19:58:50 INFO - Return code: 0 19:58:50 INFO - Running post-action listener: _resource_record_post_action 19:58:50 INFO - Running post-action listener: _start_resource_monitoring 19:58:50 INFO - Starting resource monitoring. 19:58:50 INFO - [mozharness: 2017-01-28 03:58:50.554242Z] Finished create-virtualenv step (success) 19:58:50 INFO - [mozharness: 2017-01-28 03:58:50.555279Z] Running install step. 19:58:50 INFO - Running pre-action listener: _resource_record_pre_action 19:58:50 INFO - Running main action method: install 19:58:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:58:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:58:50 INFO - Reading from file tmpfile_stdout 19:58:50 INFO - Detecting whether we're running mozinstall >=1.0... 19:58:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:58:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:58:50 INFO - Reading from file tmpfile_stdout 19:58:50 INFO - Output received: 19:58:50 INFO - Usage: mozinstall [options] installer 19:58:50 INFO - Options: 19:58:50 INFO - -h, --help show this help message and exit 19:58:50 INFO - -d DEST, --destination=DEST 19:58:50 INFO - Directory to install application into. [default: 19:58:50 INFO - "/builds/slave/test"] 19:58:50 INFO - --app=APP Application being installed. [default: firefox] 19:58:50 INFO - mkdir: /builds/slave/test/build/application 19:58:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:58:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:59:12 INFO - Reading from file tmpfile_stdout 19:59:12 INFO - Output received: 19:59:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:59:12 INFO - Running post-action listener: _resource_record_post_action 19:59:12 INFO - [mozharness: 2017-01-28 03:59:12.796100Z] Finished install step (success) 19:59:12 INFO - [mozharness: 2017-01-28 03:59:12.796239Z] Running run-tests step. 19:59:12 INFO - Running pre-action listener: _resource_record_pre_action 19:59:12 INFO - Running main action method: run_tests 19:59:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:59:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:59:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:59:12 INFO - 2017-01-27 19:59:12.810 screenresolution[1623:7581] starting screenresolution argv=screenresolution get 19:59:12 INFO - 2017-01-27 19:59:12.813 screenresolution[1623:7581] Display 0: 1600x1200x32@60 19:59:12 INFO - 2017-01-27 19:59:12.819 screenresolution[1624:7584] starting screenresolution argv=screenresolution list 19:59:12 INFO - Available Modes on Display 0 19:59:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:59:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:59:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:59:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:59:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:59:13 INFO - Intel Iris: 19:59:13 INFO - Chipset Model: Intel Iris 19:59:13 INFO - Type: GPU 19:59:13 INFO - Bus: Built-In 19:59:13 INFO - VRAM (Dynamic, Max): 1536 MB 19:59:13 INFO - Vendor: Intel (0x8086) 19:59:13 INFO - Device ID: 0x0a2e 19:59:13 INFO - Revision ID: 0x0009 19:59:13 INFO - Displays: 19:59:13 INFO - Display: 19:59:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:59:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:59:13 INFO - Display Serial Number: 1600x1200 60 19:59:13 INFO - Main Display: Yes 19:59:13 INFO - Mirror: Off 19:59:13 INFO - Online: Yes 19:59:13 INFO - Rotation: Supported 19:59:13 INFO - Return code: 0 19:59:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:59:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:59:13 INFO - Python 2.7.3 19:59:13 INFO - Return code: 0 19:59:13 INFO - grabbing minidump binary from tooltool 19:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:59:13 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 0x106994d30>, '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 0x1068bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106989be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:59:13 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 19:59:13 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 19:59:13 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 19:59:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:59:13 INFO - Return code: 0 19:59:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:59:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:59:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:59:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:59:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:59:13 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/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0320', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:59:13 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/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0320 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:59:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mXytFqtRNx/Render', 19:59:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:59:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:59:13 INFO - 'HOME': '/Users/cltbld', 19:59:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:59:13 INFO - 'LOGNAME': 'cltbld', 19:59:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:59:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:13 INFO - 'MOZ_NO_REMOTE': '1', 19:59:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:59:13 INFO - 'NO_EM_RESTART': '1', 19:59:13 INFO - 'PAGER': '/bin/cat', 19:59:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:13 INFO - 'PWD': '/builds/slave/test', 19:59:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:59:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:59:13 INFO - 'SHELL': '/bin/bash', 19:59:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.voIA6b4kjG/Listeners', 19:59:13 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 19:59:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:59:13 INFO - 'USER': 'cltbld', 19:59:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:59:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:13 INFO - 'XPC_FLAGS': '0x0', 19:59:13 INFO - 'XPC_SERVICE_NAME': '0', 19:59:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:59:13 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/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0320', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:59:13 INFO - mozversion application_buildid: 20170127184008 19:59:13 INFO - mozversion application_changeset: 045d8fe30f546ab08466c9586ce298e6459c2069 19:59:13 INFO - mozversion application_display_name: Nightly 19:59:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:59:13 INFO - mozversion application_name: Firefox 19:59:13 INFO - mozversion application_remotingname: firefox 19:59:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:59:13 INFO - mozversion application_vendor: Mozilla 19:59:13 INFO - mozversion application_version: 54.0a1 19:59:13 INFO - mozversion platform_buildid: 20170127184008 19:59:13 INFO - mozversion platform_changeset: 045d8fe30f546ab08466c9586ce298e6459c2069 19:59:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:59:13 INFO - mozversion platform_version: 54.0a1 19:59:13 INFO - using testdate: 1485575953 19:59:13 INFO - actual date: 1485575953 19:59:13 INFO - starting webserver on 'localhost:49241' 19:59:13 INFO - SUITE-START | Running 2 tests 19:59:13 INFO - TEST-START | dromaeo_css 19:59:13 INFO - operating with platform_type : mac_ 19:59:13 INFO - Initialising browser for dromaeo_css test... 19:59:13 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpQiR9QT/profile http://localhost:49241/getInfo.html) 19:59:16 INFO - PROCESS | 1634 | 2017-01-27 19:59:16.325 plugin-container[1636:7753] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c43, name = 'com.apple.tsm.portname' 19:59:16 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:59:16 INFO - PROCESS | 1634 | 2017-01-27 19:59:16.329 plugin-container[1636:7753] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 19:59:16 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:59:16 INFO - PROCESS | 1634 | 2017-01-27 19:59:16.329 plugin-container[1636:7753] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:59:16 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 19:59:16 INFO - PROCESS | 1634 | colorDepth:24 19:59:16 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 19:59:16 INFO - PROCESS | 1634 | __metrics 19:59:16 ERROR - PROCESS | 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3279: TypeError: this.tabs is undefined 19:59:17 INFO - TEST-INFO | 1634: exit 0 19:59:17 INFO - Browser initialized. 19:59:17 INFO - Running cycle 1/1 for dromaeo_css test... 19:59:17 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpQiR9QT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:59:19 INFO - PROCESS | 1637 | 2017-01-27 19:59:19.763 plugin-container[1638:7870] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873b, name = 'com.apple.tsm.portname' 19:59:19 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:59:19 INFO - PROCESS | 1637 | 2017-01-27 19:59:19.764 plugin-container[1638:7870] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 19:59:19 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:59:19 INFO - PROCESS | 1637 | 2017-01-27 19:59:19.764 plugin-container[1638:7870] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:59:29 INFO - PROCESS | 1637 | RSS: Main: 233091072 19:59:29 INFO - PROCESS | 1637 | 20:02:31 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 20:02:33 INFO - PROCESS | 1637 | RSS: Main: 254877696 20:02:33 INFO - PROCESS | 1637 | 20:04:17 INFO - PROCESS | 1637 | ************************* 20:04:17 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 20:04:17 INFO - PROCESS | 1637 | 20:04:17 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:04:17 INFO - PROCESS | 1637 | Full stack: 20:04:17 INFO - PROCESS | 1637 | ************************* 20:05:35 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 20:05:36 INFO - PROCESS | 1637 | RSS: Main: 262471680 20:05:36 INFO - PROCESS | 1637 | 20:08:37 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 20:08:38 INFO - PROCESS | 1637 | RSS: Main: 273371136 20:08:38 INFO - PROCESS | 1637 | 20:11:40 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 20:11:41 INFO - PROCESS | 1637 | RSS: Main: 266305536 20:11:41 INFO - PROCESS | 1637 | 20:14:44 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 20:14:44 INFO - PROCESS | 1637 | RSS: Main: 271953920 20:14:44 INFO - PROCESS | 1637 | 20:17:47 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 20:17:47 INFO - PROCESS | 1637 | RSS: Main: 274636800 20:17:47 INFO - PROCESS | 1637 | 20:17:47 INFO - PROCESS | 1637 | __start_tp_report 20:17:47 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 20:17:47 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 20:17:47 INFO - PROCESS | 1637 | |i|pagename|runs| 20:17:47 INFO - PROCESS | 1637 | |0;dojo.html;3245.3833771583413;3280.852361643726;3296.456084746017;3296.779773918058;3311.420501412252;5461.044317244481;5498.092814685577;5498.505134537891;5517.668939863611;5535.501804837574;4479.484859241188;5319.255304257397;5510.1459273812625;5538.556915446775;5578.832635020955;4959.256111583273;5050.217216331456;5078.695278283296;5135.743212839343;5145;4922.655414121013;5085.440601533828;5159;5168.612354073441;5183.87040323993;4940.827071052496;4977.278294647256;5012.448630650625;5079.7714102865275;5123.077845987721;5034.0686972910125;5095.184770436749;5096.133657278272;5136.717480538568;5150.201718733565;4985.900281994376;4991.925121123186;4994.076095922266;5022.4224214215465;5027.019731152427;5348.973255133738;5415.160650099241;5424.755885985101;5542.140968149944;5546.667199968015;5153.587712982952;5878.588498805086;6089.634621922654;6120.38618382068;6145.600535965148;5827.35899051104;6175.2589689237575;6180.196574445338;6188.504919606421;6199.442050215457;5544.390117087117;5707.429257074301;5712.285964254468;5712.314522257273;5720.599558030939;6113.263474096239;6139.062858969336;6144.218176728788;6159.876802464015;6211.16149319845;5949.524038076944;6024.698765061729;6030.577859549877;6045.425684559959;6046.47231103532;5979.6711180884595;6065.939340606626;6131.877362452726;6148.8770224595255;6181.381861813873;4988.72562009093;5055.418626857885;5106.748846532623;5941.435563621449;6010.519158467399;6038.698065096815;6049.334573196945;6094.542909281821;6099.054646529795;6103.267607887082;3994.7802870842384;4867.610591152699;4869.878253043631;4873.951260487421;4891.437484689306;4273.35899615054;4276.18752437036;4307.160103779733;4324.654027677778;4363.432753742057;5600.047991841397;5602.915956260659;5625.606207565513;5658.179563963202;5667.773289068474;6021.668808215591;6079.3008803988105;6089.908651370233;6092.5430592705725;6097.664628445389;5389.973050134803;5436.238926550286;5535.418781028015;5542.528885044816;5560.77756889728;5336.306280183551;5345.1447768356875;5363.758630861621;5366.6779993200535;5392.433794451526;6181.629102253879;6188.81433556994;6190.102435146789;6216.937830621817;6230;6011.6693581853415;6026.728797204224;6074.088886667036;6112.449879510866;6117.296510901303;6111.622125543816;6157.4458298753325;6171.321154673072;6174.012158054869;6180.6909654517995;6072.028475443908;6073.997790364717;6076.179715738319;6078.571535689198;6088.786892458743;4820.035992801524;6004.729787159676;6112.297085835008;6113.633182008915;6132.969335153296;5819.476247137778;5855.209546711139;5861.736221870111;5988.820335389945;6023.337432882292;5907.232059832366;5952.76188952437;5961.821145365646;5965.552583556164;5971.701414929323;5487.478689524489;5488.91766623493;5698.401667824819;5720.3707592165665;5772.307323121252;5968.552358573212;5973.342932277359;5975.55183361241;6028.703828676856;6058.939410605837;5749.482546570829;5787.7395517200985;5797.2173756542325;5797.956367853658;5803.593748437569 20:17:47 INFO - PROCESS | 1637 | |1;ext.html;442.44473186151373;484.22040514771214;488.39195201973547;498.1108720933135;533.2534451767526;41202.79398603007;43356.78321608392;43376.34935475962;43389.34915976263;43391.566084339145;43787.78106109473;44305.77847110768;44420.3336949946;44467;44541.66375008747;8558.529280889548;9456.952715236413;9661;9663.806723865519;9675.564599593;8566.61450234741;11464.25482343645;11724.472398742035;11787.528498860036;11918;11686.06511479084;11746.647600571996;11764.294142351486;11776.7644647107;11793.705157371092;11657.708557286092;11697.766044679143;11749.4712737927;11753.588624398191;11756.412179390996;11548.24936379141;11620.302781833117;11626.825597616042;11631.941840290745;11641.883581164164;41285.96785080367;41345;41597.79201103975;41827.7908610458;42066.57933420657;4030.2544029354663;4032.717709760318;4055.371417430303;4063.7764922929227;4122;29941;31012.53481197784;31112;31306.21734456634;31842.681573184203;3122.3911337289237;3250.2686895448574;3306.173456635841;3312.8509217085048;3351.463765797461;472622;481841.5907920438;482460;483535.58232208964;483748;65004.67497662576;65369;65394.673026635515;65428;65552;67224.66387668031;68418.3158168422;68421.65789171022;68671.65664171748;68731.65634171898;15126.243687815566;15239.847601524065;15246.466373676869;15248.542543723706;15274.770878436831;11532.827007594893;11868.169228154118;12542.937285313516;12584.937075314565;12767.914727248288;18026.729599056023;18100.09499525045;18296.908515457337;18322.450326490227;18474.983875886686;6587.901181482282;6684.729901318734;6707.417644206917;6714.899276510856;6740.528163028639;768.4735955870246;853.9777253318668;873.4715497124275;895.4806212396925;899.3659470073583;29638.703612964026;30260;30886;31671.524927126113;31842.044738657878;1034.8602938603342;1044.383813550009;1049.7900419916048;1075.6181555547823;1093.1528065749108;15374.538763837103;15977.360905563879;15983;16076.598085047968;16344.053777144904;586387;591686;596415;596529.0347096473;600840;55487;55807;56190;56195.71902140463;56256;1361.7072329449215;1393.979090313646;1402.1657114017144;1405.6626409661812;1414.5261337451864;28182;28660.570091449063;29169.41661166807;29381;29466.968656096935;47708;48125.75937120292;48141.75929120472;48350.5164948346;48365;515279;515979;520080;520484;523149;22434.5513089734;22738.545229095656;24630.630540542264;25055.87472062628;25129.87435062813;42075.57924420839;43531.78234108809;43982.56017439785;45940;47137;29724.70275297306;34421.483677744356;35310.64689353176;37234.813825930694;38441.615583843806;36998.44502332521;37188.628113718514;37777.62222377741;38136;38193.42709859299;35371.99282402428;35567.11082222965;35585.46621800727;35599.64400355963;36437.724679636085;31443.37113257676;32721.836390817894;32960.83519582387;33025.174370640925;33160;20461.386158415273;22660.527065740673;23957;24316.51366972686;24441.755582443948 20:17:47 INFO - PROCESS | 1637 | |2;jquery.html;384.0992871715829;388.1054170137831;400.8476778824047;406.1085916413472;420.92844216483195;17524.47426577203;20523;20573.897130514346;21032.158713651475;21351.99999999998;20593.38219853403;20999.580008399862;21438.464038399048;21596.352109436702;21745.782542174573;5484.177373393983;5929.762809487637;5947.702614869261;5994.190784244137;6010.489108425789;4885.218365061591;5706.600537962344;5882.441168089024;5903.4686878180955;5906.202662640553;5990.910136347937;6095.116208149816;6109;6109.847253818668;6113.755449782026;5927.673977931212;6034.909476357836;6054.212952316215;6106.023036314168;6118.265808103034;5919.378465261172;5926.822195334147;5927.2590926134235;5932.050871860525;5942.762289508458;13630.386632601556;13821.654458638513;13842.723145537033;13843.30783460833;17717.557061073447;2577.6777902762155;2655.468906218764;2685.207863680219;2693.501702185102;2701.3246688327918;10101.292909496338;10159.339642923187;10175.949120254425;10661.040506354388;10683.145348372189;1828.168183476515;1879.144989029988;1893.6875415556417;1894.2233684189416;1895.4787433455772;124557;129718.35140824235;132339.33830330882;132720;133972.660273397;11421.371824549564;11787.410629468664;11925;11928.522859085539;11961.162718609788;15667.981581197413;15689.372425103096;15694.843051569338;15697;15704.29330680122;7064;8541.487510749375;8708.91291087081;8737.563121843883;8850.64597416109;8313;8332.208440198172;8363.28912042471;8440.15598440151;8461.069282378934;4737.407824021997;4814.374131362971;4818.253170758538;4862.8784280392565;4910.680805747615;2030.634485792542;2071.627107120733;2077.719507866449;2081.167532986787;2086.5722526881955;996.1383403356045;1014.7716763728102;1016.9644062457778;1023.1098943918838;1039.6465201831413;18510.537236569195;20683.482912926997;21049.579008419747;21109.68335474969;21401.892990534947;883.5228976352697;943.8867335919596;955.7515046087929;972.873526441558;1047.225053460449;9108.45349279032;9676.661316853877;10759.870213627457;11039.227254092137;11066.557337706563;684712;730136;730651;737935;748131;119186;157711;160996;163268;165467;1021.6475316015963;1036.9118624916816;1055.5935964653663;1059.4490864750287;1069.1607088435696;17037;17748.733768993734;18189.54526136857;18276.634467310312;18373.448796536126;47452.288215676104;56827.14759278697;57625.423745762004;58693;59210.40789592049;55982;83021;83222.58388708018;85062.57468712864;90553.83061592812;6242.656653883898;7061.293870612898;7366.447516436181;8467.83064338722;8879.156480134377;11346.659600212008;12748.107632465639;13488.93255533716;13597.252151131783;13659.863401366256;10989.725256868642;11228.438578071227;11545.6908618275;11744.354060526412;12079.818802718142;11308.095352371955;11443.599474018369;11455.026322762658;11925;11987.820182697442;9740.366876153028;10890.23768336209;11689.707757306136;11966.726321998793;12042.21725587834;7220.3862671671395;7596;7661.846763064819;7898.28915397594;7940.6029698513685;9828.655997040069;11611.88388116108;11707.121965852424;11727.648170554898;11789.587364442203 20:17:47 INFO - PROCESS | 1637 | |3;mootools.html;1311.9212847229164;1374.694040661372;1406.2898236390622;1416.5608661314986;1422.402590911817;7371.189169191398;7606.353459955911;7879;8297.668093276277;8323.667053317868;7793.883091753628;8065;8082.43422960393;8142.674293028286;8196.262336389724;2161.5244646177857;2200.7469141048746;2202.053117159621;2205.151016858513;2207.2716003718733;1991.890446025468;2076.95846083079;2253.526759380532;2283.383486458655;2299.482616411311;2096.2348742708878;2278.692376529172;2281.9885900570475;2291.7822806833406;2295.7819007194375;1708.957276068102;2019.3235266185845;2229.9665505017356;2261.185973049701;2289.3132060381818;2254.639257718757;2297.115610489957;2319.3969567912295;2328.2665960222475;2331.941701457477;6645.969874669434;8057.879131813028;8099.473534220257;8105.351571874236;8133.511989280603;5010.348654674869;5141.665791723526;5166.689998600096;5171.276021357013;5172.353455818023;3341.3150304187584;3450.9309813803834;3475.5134281200653;3515.929681406383;3517.7009954153928;1216.2398500936915;1218.939053047344;1245.7757603631342;1253.974920501594;1274.8852603265657;8609.913900860975;10405.84391234132;10480.423576703279;10513.211509136769;10518.263721539495;3536.6109727929907;4157.91684166315;4382.6493880490125;4450.1767173073085;4469.7988590513505;8391.832163356821;8419.158084191531;8465;8472.830543389098;8476.406651534457;4980.9252861207115;5053.98920215951;5081.110805609078;5085.694858308513;5089.236614507779;3923.9803800980812;4498.550144985541;4675;4675.719456832533;4753.762311884392;3637.781733096023;3645;3691.8892433227047;3703.2408356287438;3738.018850009499;1072.2708558180357;1110.9555617775197;1147.867995180565;1156.6062894212455;1173.9119566032582;746.559529877375;747.8205230744583;777.7200207925142;810.2302812328312;820.1962077164412;4639.559241872017;5434.456554344534;5595.9925281062815;5682.516986056232;5709.05800542914;720.7657511308846;881.8015946412006;945.7919257763281;980.9656662016795;1014.7463134216446;3715.7213209009433;3736.1967177057063;3833.386658134685;3847.403652433877;3894.045958740127;7782.455228134089;9100.908990910139;9462.053794620482;9549.140577348073;9742.756431089138;9517.524123793783;9636.903630963601;9650.420974741539;9651.469169195761;9658.855117173107;7077.256888026786;7302.306280903305;7391.6304184791625;7420.035395398671;7420.962895185489;5325.866853328698;5387.703676297841;5519.613627046068;5555.972220139035;5603.3836278008575;8865.911340886509;8916.955415223141;8919.10808919103;8951;8986.82026359456;8997.460152390615;9064.728058158265;9180.127887850644;9220.538973051187;9260.073992600686;6934.375906168469;7121.465890058163;7154.499185057204;7158.212596614264;7158.892616610651;7528.962355188189;7621.580813055335;7635.503692260208;7725;7735.265149810759;6254.437100660963;6954.408875245458;6988.615626140611;7113.53762005468;7156.427485801228;6983.441324694114;6987.1266091738535;7009.12385951756;7075.893861592183;7081.539699919489;5665.773369065191;6273.905891411724;6336.683165841598;6385.946318857336;6391.073294372383;4418.381426600343;4594.012287358234;4644.187267228154;4885.731284779229;4935.062338155739;4870.2938073979785;4947.851564453073;5032.874178145576;5068.189089745623;5124.615653825904 20:17:47 INFO - PROCESS | 1637 | |4;prototype.html;325.14649046253584;360.2650592790707;371.3631122624698;371.91631882826357;378.1472778883617;4569.817207311712;4997.275395067713;5125.487451254872;5498.202760599711;5598.13228949513;5367.651102678323;5445;5447.719785850322;5479.657483916446;5539.806106786264;3568.8929332119947;4263.339182426729;4283.5288118307035;4285.46431696038;4310.956890431087;3457.7406694497886;4080.8163632636456;4309.892252693677;4346.76092814895;4353.782310884459;3465.740069494798;3793.5068441102617;4272.829086836538;4284.357346398049;4295.346291677695;3395.7096303404796;3477.3566890125153;4157.293260145782;4277.540414261781;4290.034742183015;3404.4042292598697;3655.9086022849374;3771.774173393658;3826.196498735269;3851.2490064437447;4451.909282225843;5060.773259765691;5349.197620356938;5354.170103633943;5355.223492593591;4357.6228422972135;4738.573528382462;4953.628477864175;4962.932969411594;4973.5772459341;5833.00838857391;5846.3861294563885;5848.883022339572;5850.502707269887;5869.1196320551835;3280.458724310486;3959.940600890989;4087.8569250076403;4206.684498662582;4206.747595144301;4974.3087350301075;5358.490943360374;5554.694646758008;6183;6186.412290832409;3982.6415622594104;4276.893077673021;4289.9571004289555;4313.9137217255475;4316.776859917145;4164.916701665949;4280;4317.9136417271475;4340.804663790137;4381.780910954503;3927.56796752357;4840.104580652591;4930.852074437773;4954.603631709455;4967;4904.8308937403635;4993.325901003391;5304.389995150607;5827.3298570664065;5927.407259274124;1191.6365508519812;1271.3897329281997;1361;1394.2540740703878;1399.181478834893;967.8886928003229;986.2011770465946;994.9104580587637;996.7607774134301;1001.7746007148479;4230.915381692349;4767.399459521578;5157.174852023658;5169.715665638426;5180.507851754077;4948.183549714328;4963.751812409365;5170.6122040847085;5443.924182836685;5822.8164438335625;4918.704877707349;4935.925961110586;5087.31321271631;5149.777182710217;5177.663451875616;2470.5300346293925;2634.867007186928;2642.4582960493053;2715;3054.480738274499;5195.402298850575;5213.895722085537;5263.7894484220205;5278.65688730239;6032.471004462439;4909.189983652657;5479.397266300703;5642.802501912413;5702.857428564236;5889.1755154278435;4962.528559786742;5251.921221181762;5442.945005970577;5488.502731257268;5734.39788822176;4863.7324947128245;4927.876803079952;5134.7946082156295;5396.622236443412;5503.7066289422755;4726.3146843708155;5200.72582217344;5354.277172581652;5371.462853714597;5646.35066967304;5590.5248053915875;5986.431289027535;5997.5501837363245;6026.685323072205;6027.553387186956;3639.1993761372455;4077.26609210345;4089.631933126033;4121.670266378623;4150.8547200847825;4825.469198388245;5236.738163091906;5726.914096288642;6047.879042419039;6062.272527296576;5100.48995100487;5384.138537833927;5704.885902281848;5728;5892.40904955651;5180.922286165635;5449.855530338673;5795.971020144872;5803.678528588598;5878.529717622666;5369.409364969928;5661.915071274017;5698.401667824819;5709.22925405065;5734.426557344233;5045.394552653705;5300.3639563252655;5766.884662306814;5835.299764028344;5858.648481091148;4594.701344412736;4695.5539223773685;4805.770921589119;5718.428157184248;5748.942510575008 20:17:47 INFO - PROCESS | 1637 | |5;yui.html;685.5372623479157;689.5345641691857;757.6779868555863;817.0145258043726;823.1069289820542;11766.529338826447;14894.47869324574;14951.0281831681;15098.245087745623;17152.571185720364;16422.425215117473;16943.237554310053;16985;16990.15049247539;17045.403410880623;682.6791408038214;872.3849685971375;886.8182022685334;901.3825529512272;903.905089965554;693.5561240805888;707.4057791455176;871.7384784564637;893.6068130022802;894.6466145872377;932.8787257656495;943.617834776913;945.0927109974433;946.4179529589287;947.1144479911305;924.3668087360146;939.3002213351064;941.9199368053655;942.2556180617304;943.6602822983721;667.7295695243434;698.6052880122766;703.156212544943;704.8132244955091;707.5224223649017;15316.846831531653;15688.921555392264;15786.605334866605;15906.602334941603;16083.035017898846;14146.363413646308;14425.927870360581;14446;14453.927730361282;14487;11821.34982575958;11828.585999489977;11870.109741769316;11874.525018999317;11996.28022318655;3714.9071273218115;3730.5336832895887;3781.1681430085337;3786.2048969716393;3894.6300101490315;113833;115346;116111;116307;116762;10634.574617015387;10812.513436895359;10830.67507974762;10952.616658416917;11021.393823339793;22257.332280031624;22625.88687056587;22760.88619556925;22829.88585057064;22834;6508.576942498722;7625.923740762632;7717.344025757873;7732.226777322336;7798.493097948729;4213.384985572683;4289.699721019561;4290.120525292307;4290.721103128287;4399.978000109979;3556.2531868307947;3637.7089832813313;3663.7984910829628;3722.683571896419;3891.105045839473;693.8646963842103;695.1345574759457;696.1020283833899;699.7550857200041;713.9643017849087;571.3629303326761;642.7814543055383;664.4020381656451;671.2951401028901;672.8703652938493;8301.211384918422;9981.75228096488;10230.28388012832;10330.535125919352;10393.376397416028;650.187265917603;683.1460674157304;686.7802303262907;699.2203692882501;701.2321507948787;4858.222684370484;5026.52248036436;5038.622103342191;5062.139436295838;5065.822696205615;88261;101545.98454015513;106000;106963;108190;97144;97439;98668;98964;99060;83302;84069.57965210135;84647;84990.99999999876;86163;9556.904430955601;9568.76078098053;9599.616015359308;9642.71071867845;9688.46713430768;42247.57752422436;51088.233676494136;53157.936841262184;53724.656883578224;53842;70266.64866675634;70380.29619703942;71328.64335678288;72177;72469;11346.262492937933;11522.942385288019;11615.245009074382;11724.92442842007;12016.218945768496;10728.624498142528;12946.546870859474;12989.740769912969;13141.54004609834;13148.276844773629;11800.291982481078;11830.349330786545;11876.228045177037;12024.398780060787;12402.689932751753;11725.355105469282;11860.703482413008;12120.818187727014;12356.752864942831;12438.564650237198;11633.23184511543;11806.409679515818;11860.22908510944;11876.76246475083;12010.459529321026;10064;10258.794824103625;10294.433806140734;10366.481675916324;10842.620508282173;9108.407953483002;9811.754706132118;9831;9834.508274586098;9837.754056148653 20:17:47 INFO - PROCESS | 1637 | __end_tp_report 20:17:47 INFO - PROCESS | 1637 | __start_cc_report 20:17:47 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,384 20:17:47 INFO - PROCESS | 1637 | __end_cc_report 20:17:47 INFO - PROCESS | 1637 | __startTimestamp1485577067733__endTimestamp 20:17:47 INFO - PROCESS | 1637 | 20:17:47 INFO - PROCESS | 1637 | ------- Summary: start ------- 20:17:47 INFO - PROCESS | 1637 | Number of tests: 6 20:17:47 INFO - PROCESS | 1637 | 20:17:47 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5559.99 Median:5720.37 stddev:643.72 (11.3%) stddev-sans-first:619.56 20:17:47 INFO - PROCESS | 1637 | Values: 3245.4 3280.9 3296.5 3296.8 3311.4 5461.0 5498.1 5498.5 5517.7 5535.5 4479.5 5319.3 5510.1 5538.6 5578.8 4959.3 5050.2 5078.7 5135.7 5145.0 4922.7 5085.4 5159.0 5168.6 5183.9 4940.8 4977.3 5012.4 5079.8 5123.1 5034.1 5095.2 5096.1 5136.7 5150.2 4985.9 4991.9 4994.1 5022.4 5027.0 5349.0 5415.2 5424.8 5542.1 5546.7 5153.6 5878.6 6089.6 6120.4 6145.6 5827.4 6175.3 6180.2 6188.5 6199.4 5544.4 5707.4 5712.3 5712.3 5720.6 6113.3 6139.1 6144.2 6159.9 6211.2 5949.5 6024.7 6030.6 6045.4 6046.5 5979.7 6065.9 6131.9 6148.9 6181.4 4988.7 5055.4 5106.7 5941.4 6010.5 6038.7 6049.3 6094.5 6099.1 6103.3 3994.8 4867.6 4869.9 4874.0 4891.4 4273.4 4276.2 4307.2 4324.7 4363.4 5600.0 5602.9 5625.6 5658.2 5667.8 6021.7 6079.3 6089.9 6092.5 6097.7 5390.0 5436.2 5535.4 5542.5 5560.8 5336.3 5345.1 5363.8 5366.7 5392.4 6181.6 6188.8 6190.1 6216.9 6230.0 6011.7 6026.7 6074.1 6112.4 6117.3 6111.6 6157.4 6171.3 6174.0 6180.7 6072.0 6074.0 6076.2 6078.6 6088.8 4820.0 6004.7 6112.3 6113.6 6133.0 5819.5 5855.2 5861.7 5988.8 6023.3 5907.2 5952.8 5961.8 5965.6 5971.7 5487.5 5488.9 5698.4 5720.4 5772.3 5968.6 5973.3 5975.6 6028.7 6058.9 5749.5 5787.7 5797.2 5798.0 5803.6 20:17:47 INFO - PROCESS | 1637 | 20:17:47 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:67210.23 Median:36018.68 stddev:142182.20 (394.7%) stddev-sans-first:142492.68 20:17:47 INFO - PROCESS | 1637 | Values: 442.4 484.2 488.4 498.1 533.3 41202.8 43356.8 43376.3 43389.3 43391.6 43787.8 44305.8 44420.3 44467.0 44541.7 8558.5 9457.0 9661.0 9663.8 9675.6 8566.6 11464.3 11724.5 11787.5 11918.0 11686.1 11746.6 11764.3 11776.8 11793.7 11657.7 11697.8 11749.5 11753.6 11756.4 11548.2 11620.3 11626.8 11631.9 11641.9 41286.0 41345.0 41597.8 41827.8 42066.6 4030.3 4032.7 4055.4 4063.8 4122.0 29941.0 31012.5 31112.0 31306.2 31842.7 3122.4 3250.3 3306.2 3312.9 3351.5 472622.0 481841.6 482460.0 483535.6 483748.0 65004.7 65369.0 65394.7 65428.0 65552.0 67224.7 68418.3 68421.7 68671.7 68731.7 15126.2 15239.8 15246.5 15248.5 15274.8 11532.8 11868.2 12542.9 12584.9 12767.9 18026.7 18100.1 18296.9 18322.5 18475.0 6587.9 6684.7 6707.4 6714.9 6740.5 768.5 854.0 873.5 895.5 899.4 29638.7 30260.0 30886.0 31671.5 31842.0 1034.9 1044.4 1049.8 1075.6 1093.2 15374.5 15977.4 15983.0 16076.6 16344.1 586387.0 591686.0 596415.0 596529.0 600840.0 55487.0 55807.0 56190.0 56195.7 56256.0 1361.7 1394.0 1402.2 1405.7 1414.5 28182.0 28660.6 29169.4 29381.0 29467.0 47708.0 48125.8 48141.8 48350.5 48365.0 515279.0 515979.0 520080.0 520484.0 523149.0 22434.6 22738.5 24630.6 25055.9 25129.9 42075.6 43531.8 43982.6 45940.0 47137.0 29724.7 34421.5 35310.6 37234.8 38441.6 36998.4 37188.6 37777.6 38136.0 38193.4 35372.0 35567.1 35585.5 35599.6 36437.7 31443.4 32721.8 32960.8 33025.2 33160.0 20461.4 22660.5 23957.0 24316.5 24441.8 20:17:47 INFO - PROCESS | 1637 | 20:17:47 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:39548.08 Median:21230.84 stddev:121191.71 (570.8%) stddev-sans-first:121496.01 20:17:47 INFO - PROCESS | 1637 | Values: 384.1 388.1 400.8 406.1 420.9 17524.5 20523.0 20573.9 21032.2 21352.0 20593.4 20999.6 21438.5 21596.4 21745.8 5484.2 5929.8 5947.7 5994.2 6010.5 4885.2 5706.6 5882.4 5903.5 5906.2 5990.9 6095.1 6109.0 6109.8 6113.8 5927.7 6034.9 6054.2 6106.0 6118.3 5919.4 5926.8 5927.3 5932.1 5942.8 13630.4 13821.7 13842.7 13843.3 17717.6 2577.7 2655.5 2685.2 2693.5 2701.3 10101.3 10159.3 10175.9 10661.0 10683.1 1828.2 1879.1 1893.7 1894.2 1895.5 124557.0 129718.4 132339.3 132720.0 133972.7 11421.4 11787.4 11925.0 11928.5 11961.2 15668.0 15689.4 15694.8 15697.0 15704.3 7064.0 8541.5 8708.9 8737.6 8850.6 8313.0 8332.2 8363.3 8440.2 8461.1 4737.4 4814.4 4818.3 4862.9 4910.7 2030.6 2071.6 2077.7 2081.2 2086.6 996.1 1014.8 1017.0 1023.1 1039.6 18510.5 20683.5 21049.6 21109.7 21401.9 883.5 943.9 955.8 972.9 1047.2 9108.5 9676.7 10759.9 11039.2 11066.6 684712.0 730136.0 730651.0 737935.0 748131.0 119186.0 157711.0 160996.0 163268.0 165467.0 1021.6 1036.9 1055.6 1059.4 1069.2 17037.0 17748.7 18189.5 18276.6 18373.4 47452.3 56827.1 57625.4 58693.0 59210.4 55982.0 83021.0 83222.6 85062.6 90553.8 6242.7 7061.3 7366.4 8467.8 8879.2 11346.7 12748.1 13488.9 13597.3 13659.9 10989.7 11228.4 11545.7 11744.4 12079.8 11308.1 11443.6 11455.0 11925.0 11987.8 9740.4 10890.2 11689.7 11966.7 12042.2 7220.4 7596.0 7661.8 7898.3 7940.6 9828.7 11611.9 11707.1 11727.6 11789.6 20:17:47 INFO - PROCESS | 1637 | 20:17:47 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5229.59 Median:5249.11 stddev:2814.74 (53.6%) stddev-sans-first:2807.23 20:17:47 INFO - PROCESS | 1637 | Values: 1311.9 1374.7 1406.3 1416.6 1422.4 7371.2 7606.4 7879.0 8297.7 8323.7 7793.9 8065.0 8082.4 8142.7 8196.3 2161.5 2200.7 2202.1 2205.2 2207.3 1991.9 2077.0 2253.5 2283.4 2299.5 2096.2 2278.7 2282.0 2291.8 2295.8 1709.0 2019.3 2230.0 2261.2 2289.3 2254.6 2297.1 2319.4 2328.3 2331.9 6646.0 8057.9 8099.5 8105.4 8133.5 5010.3 5141.7 5166.7 5171.3 5172.4 3341.3 3450.9 3475.5 3515.9 3517.7 1216.2 1218.9 1245.8 1254.0 1274.9 8609.9 10405.8 10480.4 10513.2 10518.3 3536.6 4157.9 4382.6 4450.2 4469.8 8391.8 8419.2 8465.0 8472.8 8476.4 4980.9 5054.0 5081.1 5085.7 5089.2 3924.0 4498.6 4675.0 4675.7 4753.8 3637.8 3645.0 3691.9 3703.2 3738.0 1072.3 1111.0 1147.9 1156.6 1173.9 746.6 747.8 777.7 810.2 820.2 4639.6 5434.5 5596.0 5682.5 5709.1 720.8 881.8 945.8 981.0 1014.7 3715.7 3736.2 3833.4 3847.4 3894.0 7782.5 9100.9 9462.1 9549.1 9742.8 9517.5 9636.9 9650.4 9651.5 9658.9 7077.3 7302.3 7391.6 7420.0 7421.0 5325.9 5387.7 5519.6 5556.0 5603.4 8865.9 8917.0 8919.1 8951.0 8986.8 8997.5 9064.7 9180.1 9220.5 9260.1 6934.4 7121.5 7154.5 7158.2 7158.9 7529.0 7621.6 7635.5 7725.0 7735.3 6254.4 6954.4 6988.6 7113.5 7156.4 6983.4 6987.1 7009.1 7075.9 7081.5 5665.8 6273.9 6336.7 6385.9 6391.1 4418.4 4594.0 4644.2 4885.7 4935.1 4870.3 4947.9 5032.9 5068.2 5124.6 20:17:47 INFO - PROCESS | 1637 | 20:17:47 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4579.40 Median:4995.30 stddev:1364.40 (27.3%) stddev-sans-first:1330.34 20:17:47 INFO - PROCESS | 1637 | Values: 325.1 360.3 371.4 371.9 378.1 4569.8 4997.3 5125.5 5498.2 5598.1 5367.7 5445.0 5447.7 5479.7 5539.8 3568.9 4263.3 4283.5 4285.5 4311.0 3457.7 4080.8 4309.9 4346.8 4353.8 3465.7 3793.5 4272.8 4284.4 4295.3 3395.7 3477.4 4157.3 4277.5 4290.0 3404.4 3655.9 3771.8 3826.2 3851.2 4451.9 5060.8 5349.2 5354.2 5355.2 4357.6 4738.6 4953.6 4962.9 4973.6 5833.0 5846.4 5848.9 5850.5 5869.1 3280.5 3959.9 4087.9 4206.7 4206.7 4974.3 5358.5 5554.7 6183.0 6186.4 3982.6 4276.9 4290.0 4313.9 4316.8 4164.9 4280.0 4317.9 4340.8 4381.8 3927.6 4840.1 4930.9 4954.6 4967.0 4904.8 4993.3 5304.4 5827.3 5927.4 1191.6 1271.4 1361.0 1394.3 1399.2 967.9 986.2 994.9 996.8 1001.8 4230.9 4767.4 5157.2 5169.7 5180.5 4948.2 4963.8 5170.6 5443.9 5822.8 4918.7 4935.9 5087.3 5149.8 5177.7 2470.5 2634.9 2642.5 2715.0 3054.5 5195.4 5213.9 5263.8 5278.7 6032.5 4909.2 5479.4 5642.8 5702.9 5889.2 4962.5 5251.9 5442.9 5488.5 5734.4 4863.7 4927.9 5134.8 5396.6 5503.7 4726.3 5200.7 5354.3 5371.5 5646.4 5590.5 5986.4 5997.6 6026.7 6027.6 3639.2 4077.3 4089.6 4121.7 4150.9 4825.5 5236.7 5726.9 6047.9 6062.3 5100.5 5384.1 5704.9 5728.0 5892.4 5180.9 5449.9 5796.0 5803.7 5878.5 5369.4 5661.9 5698.4 5709.2 5734.4 5045.4 5300.4 5766.9 5835.3 5858.6 4594.7 4695.6 4805.8 5718.4 5748.9 20:17:47 INFO - PROCESS | 1637 | 20:17:47 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:21139.69 Median:4290.42 stddev:31393.01 (731.7%) stddev-sans-first:31443.51 20:17:47 INFO - PROCESS | 1637 | Values: 685.5 689.5 757.7 817.0 823.1 11766.5 14894.5 14951.0 15098.2 17152.6 16422.4 16943.2 16985.0 16990.2 17045.4 682.7 872.4 886.8 901.4 903.9 693.6 707.4 871.7 893.6 894.6 932.9 943.6 945.1 946.4 947.1 924.4 939.3 941.9 942.3 943.7 667.7 698.6 703.2 704.8 707.5 15316.8 15688.9 15786.6 15906.6 16083.0 14146.4 14425.9 14446.0 14453.9 14487.0 11821.3 11828.6 11870.1 11874.5 11996.3 3714.9 3730.5 3781.2 3786.2 3894.6 113833.0 115346.0 116111.0 116307.0 116762.0 10634.6 10812.5 10830.7 10952.6 11021.4 22257.3 22625.9 22760.9 22829.9 22834.0 6508.6 7625.9 7717.3 7732.2 7798.5 4213.4 4289.7 4290.1 4290.7 4400.0 3556.3 3637.7 3663.8 3722.7 3891.1 693.9 695.1 696.1 699.8 714.0 571.4 642.8 664.4 671.3 672.9 8301.2 9981.8 10230.3 10330.5 10393.4 650.2 683.1 686.8 699.2 701.2 4858.2 5026.5 5038.6 5062.1 5065.8 88261.0 101546.0 106000.0 106963.0 108190.0 97144.0 97439.0 98668.0 98964.0 99060.0 83302.0 84069.6 84647.0 84991.0 86163.0 9556.9 9568.8 9599.6 9642.7 9688.5 42247.6 51088.2 53157.9 53724.7 53842.0 70266.6 70380.3 71328.6 72177.0 72469.0 11346.3 11522.9 11615.2 11724.9 12016.2 10728.6 12946.5 12989.7 13141.5 13148.3 11800.3 11830.3 11876.2 12024.4 12402.7 11725.4 11860.7 12120.8 12356.8 12438.6 11633.2 11806.4 11860.2 11876.8 12010.5 10064.0 10258.8 10294.4 10366.5 10842.6 9108.4 9811.8 9831.0 9834.5 9837.8 20:17:47 INFO - PROCESS | 1637 | -------- Summary: end -------- 20:17:47 INFO - PROCESS | 1637 | 20:17:48 INFO - TEST-INFO | 1637: exit 0 20:17:48 INFO - TEST-OK | dromaeo_css | took 1115094ms 20:17:48 INFO - TEST-START | kraken 20:17:48 INFO - operating with platform_type : mac_ 20:17:48 INFO - Initialising browser for kraken test... 20:17:48 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpV7LRVJ/profile http://localhost:49241/getInfo.html) 20:17:51 INFO - PROCESS | 1649 | 2017-01-27 20:17:51.425 plugin-container[1650:10320] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c3f, name = 'com.apple.tsm.portname' 20:17:51 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:17:51 INFO - PROCESS | 1649 | 2017-01-27 20:17:51.428 plugin-container[1650:10320] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900f, name = 'com.apple.CFPasteboardClient' 20:17:51 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:17:51 INFO - PROCESS | 1649 | 2017-01-27 20:17:51.428 plugin-container[1650:10320] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:17:51 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 20:17:51 INFO - PROCESS | 1649 | colorDepth:24 20:17:51 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 20:17:51 INFO - PROCESS | 1649 | __metrics 20:17:51 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3279: TypeError: this.tabs is undefined 20:17:52 INFO - TEST-INFO | 1649: exit 0 20:17:52 INFO - Browser initialized. 20:17:52 INFO - Running cycle 1/1 for kraken test... 20:17:52 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpV7LRVJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:17:54 INFO - PROCESS | 1651 | 2017-01-27 20:17:54.747 plugin-container[1652:10432] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 20:17:54 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:17:54 INFO - PROCESS | 1651 | 2017-01-27 20:17:54.747 plugin-container[1652:10432] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 20:17:54 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:17:54 INFO - PROCESS | 1651 | 2017-01-27 20:17:54.747 plugin-container[1652:10432] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:18:04 INFO - PROCESS | 1651 | RSS: Main: 233152512 20:18:04 INFO - PROCESS | 1651 | 20:18:07 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 20:18:08 INFO - PROCESS | 1651 | RSS: Main: 246878208 20:18:08 INFO - PROCESS | 1651 | 20:18:10 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 20:18:11 INFO - PROCESS | 1651 | RSS: Main: 254808064 20:18:11 INFO - PROCESS | 1651 | 20:18:14 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 20:18:15 INFO - PROCESS | 1651 | RSS: Main: 257507328 20:18:15 INFO - PROCESS | 1651 | 20:18:17 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 20:18:18 INFO - PROCESS | 1651 | RSS: Main: 258670592 20:18:18 INFO - PROCESS | 1651 | 20:18:20 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:18:20 INFO - PROCESS | 1651 | RSS: Main: 259022848 20:18:20 INFO - PROCESS | 1651 | 20:18:23 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 20:18:24 INFO - PROCESS | 1651 | RSS: Main: 264683520 20:18:24 INFO - PROCESS | 1651 | 20:18:27 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 20:18:28 INFO - PROCESS | 1651 | RSS: Main: 263753728 20:18:28 INFO - PROCESS | 1651 | 20:18:31 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 20:18:32 INFO - PROCESS | 1651 | RSS: Main: 263917568 20:18:32 INFO - PROCESS | 1651 | 20:18:33 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:18:34 INFO - PROCESS | 1651 | RSS: Main: 263294976 20:18:34 INFO - PROCESS | 1651 | 20:18:36 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:18:37 INFO - PROCESS | 1651 | RSS: Main: 264556544 20:18:37 INFO - PROCESS | 1651 | 20:18:39 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:18:39 INFO - PROCESS | 1651 | RSS: Main: 264609792 20:18:39 INFO - PROCESS | 1651 | 20:18:42 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:18:43 INFO - PROCESS | 1651 | RSS: Main: 264962048 20:18:43 INFO - PROCESS | 1651 | 20:18:46 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:18:47 INFO - PROCESS | 1651 | RSS: Main: 264806400 20:18:47 INFO - PROCESS | 1651 | 20:18:49 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 20:18:49 INFO - PROCESS | 1651 | RSS: Main: 266727424 20:18:49 INFO - PROCESS | 1651 | 20:18:49 INFO - PROCESS | 1651 | __start_tp_report 20:18:49 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 20:18:49 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 20:18:49 INFO - PROCESS | 1651 | |i|pagename|runs| 20:18:49 INFO - PROCESS | 1651 | |0;ai-astar;107;119;119;118;116;119;126;118;119;119 20:18:49 INFO - PROCESS | 1651 | |1;audio-beat-detection;145;113;114;152;113;116;113;115;140;115 20:18:49 INFO - PROCESS | 1651 | |2;audio-dft;201;212;263;248;198;200;199;198;200;191 20:18:49 INFO - PROCESS | 1651 | |3;audio-fft;88;60;59;84;63;61;62;59;80;76 20:18:49 INFO - PROCESS | 1651 | |4;audio-oscillator;88;71;83;73;72;72;85;71;75;86 20:18:49 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;137;133;90;87;89;108;90;132;81;132 20:18:49 INFO - PROCESS | 1651 | |6;imaging-darkroom;155;116;152;118;153;155;97;98;97;106 20:18:49 INFO - PROCESS | 1651 | |7;imaging-desaturate;79;104;84;118;151;150;93;92;105;92 20:18:49 INFO - PROCESS | 1651 | |8;json-parse-financial;61;56;61;64;64;84;88;63;62;61 20:18:49 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;93;69;73;85;81;76;71;72;74;75 20:18:49 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;90;89;87;89;90;85;90;87;95;79 20:18:49 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;144;146;142;143;148;154;154;145;227;163 20:18:49 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;178;178;179;179;181;180;180;246;245;182 20:18:49 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;72;69;70;68;71;71;64;75;78;73 20:18:49 INFO - PROCESS | 1651 | __end_tp_report 20:18:49 INFO - PROCESS | 1651 | __start_cc_report 20:18:49 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,948 20:18:49 INFO - PROCESS | 1651 | __end_cc_report 20:18:49 INFO - PROCESS | 1651 | __startTimestamp1485577129516__endTimestamp 20:18:49 INFO - PROCESS | 1651 | 20:18:49 INFO - PROCESS | 1651 | ------- Summary: start ------- 20:18:49 INFO - PROCESS | 1651 | Number of tests: 14 20:18:49 INFO - PROCESS | 1651 | 20:18:49 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:118.00 Median:119.00 stddev:4.64 (3.9%) stddev-sans-first:2.73 20:18:49 INFO - PROCESS | 1651 | Values: 107.0 119.0 119.0 118.0 116.0 119.0 126.0 118.0 119.0 119.0 20:18:49 INFO - PROCESS | 1651 | 20:18:49 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:123.60 Median:115.50 stddev:15.52 (13.4%) stddev-sans-first:14.40 20:18:49 INFO - PROCESS | 1651 | Values: 145.0 113.0 114.0 152.0 113.0 116.0 113.0 115.0 140.0 115.0 20:18:49 INFO - PROCESS | 1651 | 20:18:49 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:211.00 Median:200.50 stddev:24.26 (12.1%) stddev-sans-first:25.46 20:18:49 INFO - PROCESS | 1651 | Values: 201.0 212.0 263.0 248.0 198.0 200.0 199.0 198.0 200.0 191.0 20:18:49 INFO - PROCESS | 1651 | 20:18:49 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:69.20 Median:69.50 stddev:11.48 (16.5%) stddev-sans-first:9.96 20:18:49 INFO - PROCESS | 1651 | Values: 88.0 60.0 59.0 84.0 63.0 61.0 62.0 59.0 80.0 76.0 20:18:49 INFO - PROCESS | 1651 | 20:18:49 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:79.00 stddev:7.00 (8.9%) stddev-sans-first:6.33 20:18:49 INFO - PROCESS | 1651 | Values: 88.0 71.0 83.0 73.0 72.0 72.0 85.0 71.0 75.0 86.0 20:18:49 INFO - PROCESS | 1651 | 20:18:49 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:107.90 Median:84.00 stddev:23.09 (27.5%) stddev-sans-first:21.95 20:18:49 INFO - PROCESS | 1651 | Values: 137.0 133.0 90.0 87.0 89.0 108.0 90.0 132.0 81.0 132.0 20:18:49 INFO - PROCESS | 1651 | 20:18:49 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:124.70 Median:155.00 stddev:26.03 (16.8%) stddev-sans-first:25.20 20:18:49 INFO - PROCESS | 1651 | Values: 155.0 116.0 152.0 118.0 153.0 155.0 97.0 98.0 97.0 106.0 20:18:49 INFO - PROCESS | 1651 | 20:18:49 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:106.80 Median:81.50 stddev:25.56 (31.4%) stddev-sans-first:25.05 20:18:49 INFO - PROCESS | 1651 | Values: 79.0 104.0 84.0 118.0 151.0 150.0 93.0 92.0 105.0 92.0 20:18:49 INFO - PROCESS | 1651 | 20:18:49 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:63.50 stddev:10.62 (16.7%) stddev-sans-first:11.08 20:18:49 INFO - PROCESS | 1651 | Values: 61.0 56.0 61.0 64.0 64.0 84.0 88.0 63.0 62.0 61.0 20:18:49 INFO - PROCESS | 1651 | 20:18:49 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:76.90 Median:75.50 stddev:7.39 (9.8%) stddev-sans-first:5.04 20:18:49 INFO - PROCESS | 1651 | Values: 93.0 69.0 73.0 85.0 81.0 76.0 71.0 72.0 74.0 75.0 20:18:49 INFO - PROCESS | 1651 | 20:18:49 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:89.50 stddev:4.15 (4.6%) stddev-sans-first:4.34 20:18:49 INFO - PROCESS | 1651 | Values: 90.0 89.0 87.0 89.0 90.0 85.0 90.0 87.0 95.0 79.0 20:18:49 INFO - PROCESS | 1651 | 20:18:49 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:156.60 Median:151.00 stddev:25.58 (16.9%) stddev-sans-first:26.72 20:18:49 INFO - PROCESS | 1651 | Values: 144.0 146.0 142.0 143.0 148.0 154.0 154.0 145.0 227.0 163.0 20:18:49 INFO - PROCESS | 1651 | 20:18:49 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.80 Median:180.50 stddev:27.80 (15.4%) stddev-sans-first:28.97 20:18:49 INFO - PROCESS | 1651 | Values: 178.0 178.0 179.0 179.0 181.0 180.0 180.0 246.0 245.0 182.0 20:18:49 INFO - PROCESS | 1651 | 20:18:49 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:71.50 stddev:3.84 (5.4%) stddev-sans-first:4.06 20:18:49 INFO - PROCESS | 1651 | Values: 72.0 69.0 70.0 68.0 71.0 71.0 64.0 75.0 78.0 73.0 20:18:49 INFO - PROCESS | 1651 | -------- Summary: end -------- 20:18:49 INFO - PROCESS | 1651 | 20:18:50 INFO - TEST-INFO | 1651: exit 0 20:18:50 INFO - TEST-OK | kraken | took 62099ms 20:18:50 INFO - SUITE-END | took 1177s 20:18:50 INFO - Completed test suite (00:19:37) 20:18:50 INFO - javascript benchmark 20:18:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7234.668581694446, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3245.3833771583413, 3280.852361643726, 3296.456084746017, 3296.779773918058, 3311.420501412252, 5461.044317244481, 5498.092814685577, 5498.505134537891, 5517.668939863611, 5535.501804837574, 4479.484859241188, 5319.255304257397, 5510.1459273812625, 5538.556915446775, 5578.832635020955, 4959.256111583273, 5050.217216331456, 5078.695278283296, 5135.743212839343, 5145.0, 4922.655414121013, 5085.440601533828, 5159.0, 5168.612354073441, 5183.87040323993, 4940.827071052496, 4977.278294647256, 5012.448630650625, 5079.7714102865275, 5123.077845987721, 5034.0686972910125, 5095.184770436749, 5096.133657278272, 5136.717480538568, 5150.201718733565, 4985.900281994376, 4991.925121123186, 4994.076095922266, 5022.4224214215465, 5027.019731152427, 5348.973255133738, 5415.160650099241, 5424.755885985101, 5542.140968149944, 5546.667199968015, 5153.587712982952, 5878.588498805086, 6089.634621922654, 6120.38618382068, 6145.600535965148, 5827.35899051104, 6175.2589689237575, 6180.196574445338, 6188.504919606421, 6199.442050215457, 5544.390117087117, 5707.429257074301, 5712.285964254468, 5712.314522257273, 5720.599558030939, 6113.263474096239, 6139.062858969336, 6144.218176728788, 6159.876802464015, 6211.16149319845, 5949.524038076944, 6024.698765061729, 6030.577859549877, 6045.425684559959, 6046.47231103532, 5979.6711180884595, 6065.939340606626, 6131.877362452726, 6148.8770224595255, 6181.381861813873, 4988.72562009093, 5055.418626857885, 5106.748846532623, 5941.435563621449, 6010.519158467399, 6038.698065096815, 6049.334573196945, 6094.542909281821, 6099.054646529795, 6103.267607887082, 3994.7802870842384, 4867.610591152699, 4869.878253043631, 4873.951260487421, 4891.437484689306, 4273.35899615054, 4276.18752437036, 4307.160103779733, 4324.654027677778, 4363.432753742057, 5600.047991841397, 5602.915956260659, 5625.606207565513, 5658.179563963202, 5667.773289068474, 6021.668808215591, 6079.3008803988105, 6089.908651370233, 6092.5430592705725, 6097.664628445389, 5389.973050134803, 5436.238926550286, 5535.418781028015, 5542.528885044816, 5560.77756889728, 5336.306280183551, 5345.1447768356875, 5363.758630861621, 5366.6779993200535, 5392.433794451526, 6181.629102253879, 6188.81433556994, 6190.102435146789, 6216.937830621817, 6230.0, 6011.6693581853415, 6026.728797204224, 6074.088886667036, 6112.449879510866, 6117.296510901303, 6111.622125543816, 6157.4458298753325, 6171.321154673072, 6174.012158054869, 6180.6909654517995, 6072.028475443908, 6073.997790364717, 6076.179715738319, 6078.571535689198, 6088.786892458743, 4820.035992801524, 6004.729787159676, 6112.297085835008, 6113.633182008915, 6132.969335153296, 5819.476247137778, 5855.209546711139, 5861.736221870111, 5988.820335389945, 6023.337432882292, 5907.232059832366, 5952.76188952437, 5961.821145365646, 5965.552583556164, 5971.701414929323, 5487.478689524489, 5488.91766623493, 5698.401667824819, 5720.3707592165665, 5772.307323121252, 5968.552358573212, 5973.342932277359, 5975.55183361241, 6028.703828676856, 6058.939410605837, 5749.482546570829, 5787.7395517200985, 5797.2173756542325, 5797.956367853658, 5803.593748437569], "value": 5519.560365826618, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [442.44473186151373, 484.22040514771214, 488.39195201973547, 498.1108720933135, 533.2534451767526, 41202.79398603007, 43356.78321608392, 43376.34935475962, 43389.34915976263, 43391.566084339145, 43787.78106109473, 44305.77847110768, 44420.3336949946, 44467.0, 44541.66375008747, 8558.529280889548, 9456.952715236413, 9661.0, 9663.806723865519, 9675.564599593, 8566.61450234741, 11464.25482343645, 11724.472398742035, 11787.528498860036, 11918.0, 11686.06511479084, 11746.647600571996, 11764.294142351486, 11776.7644647107, 11793.705157371092, 11657.708557286092, 11697.766044679143, 11749.4712737927, 11753.588624398191, 11756.412179390996, 11548.24936379141, 11620.302781833117, 11626.825597616042, 11631.941840290745, 11641.883581164164, 41285.96785080367, 41345.0, 41597.79201103975, 41827.7908610458, 42066.57933420657, 4030.2544029354663, 4032.717709760318, 4055.371417430303, 4063.7764922929227, 4122.0, 29941.0, 31012.53481197784, 31112.0, 31306.21734456634, 31842.681573184203, 3122.3911337289237, 3250.2686895448574, 3306.173456635841, 3312.8509217085048, 3351.463765797461, 472622.0, 481841.5907920438, 482460.0, 483535.58232208964, 483748.0, 65004.67497662576, 65369.0, 65394.673026635515, 65428.0, 65552.0, 67224.66387668031, 68418.3158168422, 68421.65789171022, 68671.65664171748, 68731.65634171898, 15126.243687815566, 15239.847601524065, 15246.466373676869, 15248.542543723706, 15274.770878436831, 11532.827007594893, 11868.169228154118, 12542.937285313516, 12584.937075314565, 12767.914727248288, 18026.729599056023, 18100.09499525045, 18296.908515457337, 18322.450326490227, 18474.983875886686, 6587.901181482282, 6684.729901318734, 6707.417644206917, 6714.899276510856, 6740.528163028639, 768.4735955870246, 853.9777253318668, 873.4715497124275, 895.4806212396925, 899.3659470073583, 29638.703612964026, 30260.0, 30886.0, 31671.524927126113, 31842.044738657878, 1034.8602938603342, 1044.383813550009, 1049.7900419916048, 1075.6181555547823, 1093.1528065749108, 15374.538763837103, 15977.360905563879, 15983.0, 16076.598085047968, 16344.053777144904, 586387.0, 591686.0, 596415.0, 596529.0347096473, 600840.0, 55487.0, 55807.0, 56190.0, 56195.71902140463, 56256.0, 1361.7072329449215, 1393.979090313646, 1402.1657114017144, 1405.6626409661812, 1414.5261337451864, 28182.0, 28660.570091449063, 29169.41661166807, 29381.0, 29466.968656096935, 47708.0, 48125.75937120292, 48141.75929120472, 48350.5164948346, 48365.0, 515279.0, 515979.0, 520080.0, 520484.0, 523149.0, 22434.5513089734, 22738.545229095656, 24630.630540542264, 25055.87472062628, 25129.87435062813, 42075.57924420839, 43531.78234108809, 43982.56017439785, 45940.0, 47137.0, 29724.70275297306, 34421.483677744356, 35310.64689353176, 37234.813825930694, 38441.615583843806, 36998.44502332521, 37188.628113718514, 37777.62222377741, 38136.0, 38193.42709859299, 35371.99282402428, 35567.11082222965, 35585.46621800727, 35599.64400355963, 36437.724679636085, 31443.37113257676, 32721.836390817894, 32960.83519582387, 33025.174370640925, 33160.0, 20461.386158415273, 22660.527065740673, 23957.0, 24316.51366972686, 24441.755582443948], "value": 20048.794488746422, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.0992871715829, 388.1054170137831, 400.8476778824047, 406.1085916413472, 420.92844216483195, 17524.47426577203, 20523.0, 20573.897130514346, 21032.158713651475, 21351.99999999998, 20593.38219853403, 20999.580008399862, 21438.464038399048, 21596.352109436702, 21745.782542174573, 5484.177373393983, 5929.762809487637, 5947.702614869261, 5994.190784244137, 6010.489108425789, 4885.218365061591, 5706.600537962344, 5882.441168089024, 5903.4686878180955, 5906.202662640553, 5990.910136347937, 6095.116208149816, 6109.0, 6109.847253818668, 6113.755449782026, 5927.673977931212, 6034.909476357836, 6054.212952316215, 6106.023036314168, 6118.265808103034, 5919.378465261172, 5926.822195334147, 5927.2590926134235, 5932.050871860525, 5942.762289508458, 13630.386632601556, 13821.654458638513, 13842.723145537033, 13843.30783460833, 17717.557061073447, 2577.6777902762155, 2655.468906218764, 2685.207863680219, 2693.501702185102, 2701.3246688327918, 10101.292909496338, 10159.339642923187, 10175.949120254425, 10661.040506354388, 10683.145348372189, 1828.168183476515, 1879.144989029988, 1893.6875415556417, 1894.2233684189416, 1895.4787433455772, 124557.0, 129718.35140824235, 132339.33830330882, 132720.0, 133972.660273397, 11421.371824549564, 11787.410629468664, 11925.0, 11928.522859085539, 11961.162718609788, 15667.981581197413, 15689.372425103096, 15694.843051569338, 15697.0, 15704.29330680122, 7064.0, 8541.487510749375, 8708.91291087081, 8737.563121843883, 8850.64597416109, 8313.0, 8332.208440198172, 8363.28912042471, 8440.15598440151, 8461.069282378934, 4737.407824021997, 4814.374131362971, 4818.253170758538, 4862.8784280392565, 4910.680805747615, 2030.634485792542, 2071.627107120733, 2077.719507866449, 2081.167532986787, 2086.5722526881955, 996.1383403356045, 1014.7716763728102, 1016.9644062457778, 1023.1098943918838, 1039.6465201831413, 18510.537236569195, 20683.482912926997, 21049.579008419747, 21109.68335474969, 21401.892990534947, 883.5228976352697, 943.8867335919596, 955.7515046087929, 972.873526441558, 1047.225053460449, 9108.45349279032, 9676.661316853877, 10759.870213627457, 11039.227254092137, 11066.557337706563, 684712.0, 730136.0, 730651.0, 737935.0, 748131.0, 119186.0, 157711.0, 160996.0, 163268.0, 165467.0, 1021.6475316015963, 1036.9118624916816, 1055.5935964653663, 1059.4490864750287, 1069.1607088435696, 17037.0, 17748.733768993734, 18189.54526136857, 18276.634467310312, 18373.448796536126, 47452.288215676104, 56827.14759278697, 57625.423745762004, 58693.0, 59210.40789592049, 55982.0, 83021.0, 83222.58388708018, 85062.57468712864, 90553.83061592812, 6242.656653883898, 7061.293870612898, 7366.447516436181, 8467.83064338722, 8879.156480134377, 11346.659600212008, 12748.107632465639, 13488.93255533716, 13597.252151131783, 13659.863401366256, 10989.725256868642, 11228.438578071227, 11545.6908618275, 11744.354060526412, 12079.818802718142, 11308.095352371955, 11443.599474018369, 11455.026322762658, 11925.0, 11987.820182697442, 9740.366876153028, 10890.23768336209, 11689.707757306136, 11966.726321998793, 12042.21725587834, 7220.3862671671395, 7596.0, 7661.846763064819, 7898.28915397594, 7940.6029698513685, 9828.655997040069, 11611.88388116108, 11707.121965852424, 11727.648170554898, 11789.587364442203], "value": 9749.821517031553, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1311.9212847229164, 1374.694040661372, 1406.2898236390622, 1416.5608661314986, 1422.402590911817, 7371.189169191398, 7606.353459955911, 7879.0, 8297.668093276277, 8323.667053317868, 7793.883091753628, 8065.0, 8082.43422960393, 8142.674293028286, 8196.262336389724, 2161.5244646177857, 2200.7469141048746, 2202.053117159621, 2205.151016858513, 2207.2716003718733, 1991.890446025468, 2076.95846083079, 2253.526759380532, 2283.383486458655, 2299.482616411311, 2096.2348742708878, 2278.692376529172, 2281.9885900570475, 2291.7822806833406, 2295.7819007194375, 1708.957276068102, 2019.3235266185845, 2229.9665505017356, 2261.185973049701, 2289.3132060381818, 2254.639257718757, 2297.115610489957, 2319.3969567912295, 2328.2665960222475, 2331.941701457477, 6645.969874669434, 8057.879131813028, 8099.473534220257, 8105.351571874236, 8133.511989280603, 5010.348654674869, 5141.665791723526, 5166.689998600096, 5171.276021357013, 5172.353455818023, 3341.3150304187584, 3450.9309813803834, 3475.5134281200653, 3515.929681406383, 3517.7009954153928, 1216.2398500936915, 1218.939053047344, 1245.7757603631342, 1253.974920501594, 1274.8852603265657, 8609.913900860975, 10405.84391234132, 10480.423576703279, 10513.211509136769, 10518.263721539495, 3536.6109727929907, 4157.91684166315, 4382.6493880490125, 4450.1767173073085, 4469.7988590513505, 8391.832163356821, 8419.158084191531, 8465.0, 8472.830543389098, 8476.406651534457, 4980.9252861207115, 5053.98920215951, 5081.110805609078, 5085.694858308513, 5089.236614507779, 3923.9803800980812, 4498.550144985541, 4675.0, 4675.719456832533, 4753.762311884392, 3637.781733096023, 3645.0, 3691.8892433227047, 3703.2408356287438, 3738.018850009499, 1072.2708558180357, 1110.9555617775197, 1147.867995180565, 1156.6062894212455, 1173.9119566032582, 746.559529877375, 747.8205230744583, 777.7200207925142, 810.2302812328312, 820.1962077164412, 4639.559241872017, 5434.456554344534, 5595.9925281062815, 5682.516986056232, 5709.05800542914, 720.7657511308846, 881.8015946412006, 945.7919257763281, 980.9656662016795, 1014.7463134216446, 3715.7213209009433, 3736.1967177057063, 3833.386658134685, 3847.403652433877, 3894.045958740127, 7782.455228134089, 9100.908990910139, 9462.053794620482, 9549.140577348073, 9742.756431089138, 9517.524123793783, 9636.903630963601, 9650.420974741539, 9651.469169195761, 9658.855117173107, 7077.256888026786, 7302.306280903305, 7391.6304184791625, 7420.035395398671, 7420.962895185489, 5325.866853328698, 5387.703676297841, 5519.613627046068, 5555.972220139035, 5603.3836278008575, 8865.911340886509, 8916.955415223141, 8919.10808919103, 8951.0, 8986.82026359456, 8997.460152390615, 9064.728058158265, 9180.127887850644, 9220.538973051187, 9260.073992600686, 6934.375906168469, 7121.465890058163, 7154.499185057204, 7158.212596614264, 7158.892616610651, 7528.962355188189, 7621.580813055335, 7635.503692260208, 7725.0, 7735.265149810759, 6254.437100660963, 6954.408875245458, 6988.615626140611, 7113.53762005468, 7156.427485801228, 6983.441324694114, 6987.1266091738535, 7009.12385951756, 7075.893861592183, 7081.539699919489, 5665.773369065191, 6273.905891411724, 6336.683165841598, 6385.946318857336, 6391.073294372383, 4418.381426600343, 4594.012287358234, 4644.187267228154, 4885.731284779229, 4935.062338155739, 4870.2938073979785, 4947.851564453073, 5032.874178145576, 5068.189089745623, 5124.615653825904], "value": 4255.221996774098, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.14649046253584, 360.2650592790707, 371.3631122624698, 371.91631882826357, 378.1472778883617, 4569.817207311712, 4997.275395067713, 5125.487451254872, 5498.202760599711, 5598.13228949513, 5367.651102678323, 5445.0, 5447.719785850322, 5479.657483916446, 5539.806106786264, 3568.8929332119947, 4263.339182426729, 4283.5288118307035, 4285.46431696038, 4310.956890431087, 3457.7406694497886, 4080.8163632636456, 4309.892252693677, 4346.76092814895, 4353.782310884459, 3465.740069494798, 3793.5068441102617, 4272.829086836538, 4284.357346398049, 4295.346291677695, 3395.7096303404796, 3477.3566890125153, 4157.293260145782, 4277.540414261781, 4290.034742183015, 3404.4042292598697, 3655.9086022849374, 3771.774173393658, 3826.196498735269, 3851.2490064437447, 4451.909282225843, 5060.773259765691, 5349.197620356938, 5354.170103633943, 5355.223492593591, 4357.6228422972135, 4738.573528382462, 4953.628477864175, 4962.932969411594, 4973.5772459341, 5833.00838857391, 5846.3861294563885, 5848.883022339572, 5850.502707269887, 5869.1196320551835, 3280.458724310486, 3959.940600890989, 4087.8569250076403, 4206.684498662582, 4206.747595144301, 4974.3087350301075, 5358.490943360374, 5554.694646758008, 6183.0, 6186.412290832409, 3982.6415622594104, 4276.893077673021, 4289.9571004289555, 4313.9137217255475, 4316.776859917145, 4164.916701665949, 4280.0, 4317.9136417271475, 4340.804663790137, 4381.780910954503, 3927.56796752357, 4840.104580652591, 4930.852074437773, 4954.603631709455, 4967.0, 4904.8308937403635, 4993.325901003391, 5304.389995150607, 5827.3298570664065, 5927.407259274124, 1191.6365508519812, 1271.3897329281997, 1361.0, 1394.2540740703878, 1399.181478834893, 967.8886928003229, 986.2011770465946, 994.9104580587637, 996.7607774134301, 1001.7746007148479, 4230.915381692349, 4767.399459521578, 5157.174852023658, 5169.715665638426, 5180.507851754077, 4948.183549714328, 4963.751812409365, 5170.6122040847085, 5443.924182836685, 5822.8164438335625, 4918.704877707349, 4935.925961110586, 5087.31321271631, 5149.777182710217, 5177.663451875616, 2470.5300346293925, 2634.867007186928, 2642.4582960493053, 2715.0, 3054.480738274499, 5195.402298850575, 5213.895722085537, 5263.7894484220205, 5278.65688730239, 6032.471004462439, 4909.189983652657, 5479.397266300703, 5642.802501912413, 5702.857428564236, 5889.1755154278435, 4962.528559786742, 5251.921221181762, 5442.945005970577, 5488.502731257268, 5734.39788822176, 4863.7324947128245, 4927.876803079952, 5134.7946082156295, 5396.622236443412, 5503.7066289422755, 4726.3146843708155, 5200.72582217344, 5354.277172581652, 5371.462853714597, 5646.35066967304, 5590.5248053915875, 5986.431289027535, 5997.5501837363245, 6026.685323072205, 6027.553387186956, 3639.1993761372455, 4077.26609210345, 4089.631933126033, 4121.670266378623, 4150.8547200847825, 4825.469198388245, 5236.738163091906, 5726.914096288642, 6047.879042419039, 6062.272527296576, 5100.48995100487, 5384.138537833927, 5704.885902281848, 5728.0, 5892.40904955651, 5180.922286165635, 5449.855530338673, 5795.971020144872, 5803.678528588598, 5878.529717622666, 5369.409364969928, 5661.915071274017, 5698.401667824819, 5709.22925405065, 5734.426557344233, 5045.394552653705, 5300.3639563252655, 5766.884662306814, 5835.299764028344, 5858.648481091148, 4594.701344412736, 4695.5539223773685, 4805.770921589119, 5718.428157184248, 5748.942510575008], "value": 4164.439814440752, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.5372623479157, 689.5345641691857, 757.6779868555863, 817.0145258043726, 823.1069289820542, 11766.529338826447, 14894.47869324574, 14951.0281831681, 15098.245087745623, 17152.571185720364, 16422.425215117473, 16943.237554310053, 16985.0, 16990.15049247539, 17045.403410880623, 682.6791408038214, 872.3849685971375, 886.8182022685334, 901.3825529512272, 903.905089965554, 693.5561240805888, 707.4057791455176, 871.7384784564637, 893.6068130022802, 894.6466145872377, 932.8787257656495, 943.617834776913, 945.0927109974433, 946.4179529589287, 947.1144479911305, 924.3668087360146, 939.3002213351064, 941.9199368053655, 942.2556180617304, 943.6602822983721, 667.7295695243434, 698.6052880122766, 703.156212544943, 704.8132244955091, 707.5224223649017, 15316.846831531653, 15688.921555392264, 15786.605334866605, 15906.602334941603, 16083.035017898846, 14146.363413646308, 14425.927870360581, 14446.0, 14453.927730361282, 14487.0, 11821.34982575958, 11828.585999489977, 11870.109741769316, 11874.525018999317, 11996.28022318655, 3714.9071273218115, 3730.5336832895887, 3781.1681430085337, 3786.2048969716393, 3894.6300101490315, 113833.0, 115346.0, 116111.0, 116307.0, 116762.0, 10634.574617015387, 10812.513436895359, 10830.67507974762, 10952.616658416917, 11021.393823339793, 22257.332280031624, 22625.88687056587, 22760.88619556925, 22829.88585057064, 22834.0, 6508.576942498722, 7625.923740762632, 7717.344025757873, 7732.226777322336, 7798.493097948729, 4213.384985572683, 4289.699721019561, 4290.120525292307, 4290.721103128287, 4399.978000109979, 3556.2531868307947, 3637.7089832813313, 3663.7984910829628, 3722.683571896419, 3891.105045839473, 693.8646963842103, 695.1345574759457, 696.1020283833899, 699.7550857200041, 713.9643017849087, 571.3629303326761, 642.7814543055383, 664.4020381656451, 671.2951401028901, 672.8703652938493, 8301.211384918422, 9981.75228096488, 10230.28388012832, 10330.535125919352, 10393.376397416028, 650.187265917603, 683.1460674157304, 686.7802303262907, 699.2203692882501, 701.2321507948787, 4858.222684370484, 5026.52248036436, 5038.622103342191, 5062.139436295838, 5065.822696205615, 88261.0, 101545.98454015513, 106000.0, 106963.0, 108190.0, 97144.0, 97439.0, 98668.0, 98964.0, 99060.0, 83302.0, 84069.57965210135, 84647.0, 84990.99999999876, 86163.0, 9556.904430955601, 9568.76078098053, 9599.616015359308, 9642.71071867845, 9688.46713430768, 42247.57752422436, 51088.233676494136, 53157.936841262184, 53724.656883578224, 53842.0, 70266.64866675634, 70380.29619703942, 71328.64335678288, 72177.0, 72469.0, 11346.262492937933, 11522.942385288019, 11615.245009074382, 11724.92442842007, 12016.218945768496, 10728.624498142528, 12946.546870859474, 12989.740769912969, 13141.54004609834, 13148.276844773629, 11800.291982481078, 11830.349330786545, 11876.228045177037, 12024.398780060787, 12402.689932751753, 11725.355105469282, 11860.703482413008, 12120.818187727014, 12356.752864942831, 12438.564650237198, 11633.23184511543, 11806.409679515818, 11860.22908510944, 11876.76246475083, 12010.459529321026, 10064.0, 10258.794824103625, 10294.433806140734, 10366.481675916324, 10842.620508282173, 9108.407953483002, 9811.754706132118, 9831.0, 9834.508274586098, 9837.754056148653], "value": 7498.84982969628, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1590.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 119.0, 119.0, 118.0, 116.0, 119.0, 126.0, 118.0, 119.0, 119.0], "value": 118.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 113.0, 114.0, 152.0, 113.0, 116.0, 113.0, 115.0, 140.0, 115.0], "value": 123.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 212.0, 263.0, 248.0, 198.0, 200.0, 199.0, 198.0, 200.0, 191.0], "value": 211.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 60.0, 59.0, 84.0, 63.0, 61.0, 62.0, 59.0, 80.0, 76.0], "value": 69.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 83.0, 73.0, 72.0, 72.0, 85.0, 71.0, 75.0, 86.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 133.0, 90.0, 87.0, 89.0, 108.0, 90.0, 132.0, 81.0, 132.0], "value": 107.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 116.0, 152.0, 118.0, 153.0, 155.0, 97.0, 98.0, 97.0, 106.0], "value": 124.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 104.0, 84.0, 118.0, 151.0, 150.0, 93.0, 92.0, 105.0, 92.0], "value": 106.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 56.0, 61.0, 64.0, 64.0, 84.0, 88.0, 63.0, 62.0, 61.0], "value": 66.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 69.0, 73.0, 85.0, 81.0, 76.0, 71.0, 72.0, 74.0, 75.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 87.0, 89.0, 90.0, 85.0, 90.0, 87.0, 95.0, 79.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 146.0, 142.0, 143.0, 148.0, 154.0, 154.0, 145.0, 227.0, 163.0], "value": 156.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 178.0, 179.0, 179.0, 181.0, 180.0, 180.0, 246.0, 245.0, 182.0], "value": 192.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 70.0, 68.0, 71.0, 71.0, 64.0, 75.0, 78.0, 73.0], "value": 71.1, "unit": "score"}]}]} 20:18:50 INFO - Return code: 0 20:18:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:18:50 ERROR - # TBPL SUCCESS # 20:18:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:18:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:18:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:18:50 INFO - 2017-01-27 20:18:50.867 screenresolution[1656:10828] starting screenresolution argv=screenresolution get 20:18:50 INFO - 2017-01-27 20:18:50.872 screenresolution[1656:10828] Display 0: 1600x1200x32@60 20:18:50 INFO - 2017-01-27 20:18:50.878 screenresolution[1657:10831] starting screenresolution argv=screenresolution list 20:18:50 INFO - Available Modes on Display 0 20:18:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:18:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:18:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:18:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:18:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:18:51 INFO - Intel Iris: 20:18:51 INFO - Chipset Model: Intel Iris 20:18:51 INFO - Type: GPU 20:18:51 INFO - Bus: Built-In 20:18:51 INFO - VRAM (Dynamic, Max): 1536 MB 20:18:51 INFO - Vendor: Intel (0x8086) 20:18:51 INFO - Device ID: 0x0a2e 20:18:51 INFO - Revision ID: 0x0009 20:18:51 INFO - Displays: 20:18:51 INFO - Display: 20:18:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:18:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:18:51 INFO - Display Serial Number: 1600x1200 60 20:18:51 INFO - Main Display: Yes 20:18:51 INFO - Mirror: Off 20:18:51 INFO - Online: Yes 20:18:51 INFO - Rotation: Supported 20:18:51 INFO - Return code: 0 20:18:51 INFO - Running post-action listener: _resource_record_post_action 20:18:51 INFO - [mozharness: 2017-01-28 04:18:51.125126Z] Finished run-tests step (success) 20:18:51 INFO - Running post-run listener: _resource_record_post_run 20:18:51 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 38607360; Write bytes: 557736960; Read time: 242; Write time: 1717 20:18:51 INFO - TinderboxPrint: CPU usage
54.4% 20:18:51 INFO - TinderboxPrint: I/O read bytes / time
38,607,360 / 242 20:18:51 INFO - TinderboxPrint: I/O write bytes / time
557,736,960 / 1,717 20:18:51 INFO - TinderboxPrint: CPU idle
2,187.3 (45.6%) 20:18:51 INFO - TinderboxPrint: CPU system
966.1 (20.1%) 20:18:51 INFO - TinderboxPrint: CPU user
1,648.4 (34.3%) 20:18:51 INFO - TinderboxPrint: Swap in / out
291,139,584 / 0 20:18:51 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 250534400; Write bytes: 242542592; Read time: 18060; Write time: 517 20:18:51 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 35228160; Write bytes: 301800448; Read time: 220; Write time: 1164 20:18:51 INFO - Running post-run listener: _upload_blobber_files 20:18:51 INFO - Blob upload gear active. 20:18:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:18:51 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 20:18:51 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'] 20:18:51 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 20:18:52 INFO - (blobuploader) - INFO - Open directory for files ... 20:18:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:18:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:18:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:18:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:18:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:18:53 INFO - (blobuploader) - INFO - Done attempting. 20:18:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:18:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:18:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:18:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:18:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:18:54 INFO - (blobuploader) - INFO - Done attempting. 20:18:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:18:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:18:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:18:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:18:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:18:55 INFO - (blobuploader) - INFO - Done attempting. 20:18:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:18:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:18:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:18:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:18:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:18:57 INFO - (blobuploader) - INFO - Done attempting. 20:18:57 INFO - (blobuploader) - INFO - Iteration through files over. 20:18:57 INFO - Return code: 0 20:18:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:18:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:18:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13e9c8e28786978a749acfeed6bd0e726838ab70f4f34b1bff572f871cdf287bea95fb1fe8a04f831c13ff1e3b332d6d9a0fa85cc9218e1d05dd6d673650ead6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/edf6d3b225de1b2d760d021b15a51e08d6337af4099a2dbc7046b9efa1b4756ae3c3a01e57554124c4595f8d62bb6dd267fe5d7982b220503db0770bddfd776a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/792f7324739af63dc4badcb618599cb074e10f17c226c8708d32d4e67466d74dac0a1e1f62939982ba8104a1c1f23fa9bf70b155738889f4b2edd09c6cdfe167", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7971dd40f301561c6c6c15f21b34e0e6e717247ee1934af3d9afb3103cd7d95a374ad653b64db062dd82c6cf2f1ee167285996d65c7edfa8d471a0a605228b42"} 20:18:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:18:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:18:57 INFO - Contents: 20:18:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13e9c8e28786978a749acfeed6bd0e726838ab70f4f34b1bff572f871cdf287bea95fb1fe8a04f831c13ff1e3b332d6d9a0fa85cc9218e1d05dd6d673650ead6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/edf6d3b225de1b2d760d021b15a51e08d6337af4099a2dbc7046b9efa1b4756ae3c3a01e57554124c4595f8d62bb6dd267fe5d7982b220503db0770bddfd776a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/792f7324739af63dc4badcb618599cb074e10f17c226c8708d32d4e67466d74dac0a1e1f62939982ba8104a1c1f23fa9bf70b155738889f4b2edd09c6cdfe167", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7971dd40f301561c6c6c15f21b34e0e6e717247ee1934af3d9afb3103cd7d95a374ad653b64db062dd82c6cf2f1ee167285996d65c7edfa8d471a0a605228b42"} 20:18:57 INFO - Running post-run listener: copy_logs_to_upload_dir 20:18:57 INFO - Copying logs to upload dir... 20:18:57 INFO - mkdir: /builds/slave/test/build/upload/logs 20:18:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.051471 ========= master_lag: 1.36 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-27 20:18:58.862445) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 20:18:58.867616) ========= 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.mXytFqtRNx/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.voIA6b4kjG/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13e9c8e28786978a749acfeed6bd0e726838ab70f4f34b1bff572f871cdf287bea95fb1fe8a04f831c13ff1e3b332d6d9a0fa85cc9218e1d05dd6d673650ead6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/edf6d3b225de1b2d760d021b15a51e08d6337af4099a2dbc7046b9efa1b4756ae3c3a01e57554124c4595f8d62bb6dd267fe5d7982b220503db0770bddfd776a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/792f7324739af63dc4badcb618599cb074e10f17c226c8708d32d4e67466d74dac0a1e1f62939982ba8104a1c1f23fa9bf70b155738889f4b2edd09c6cdfe167", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7971dd40f301561c6c6c15f21b34e0e6e717247ee1934af3d9afb3103cd7d95a374ad653b64db062dd82c6cf2f1ee167285996d65c7edfa8d471a0a605228b42"} build_url:https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011564 build_url: 'https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13e9c8e28786978a749acfeed6bd0e726838ab70f4f34b1bff572f871cdf287bea95fb1fe8a04f831c13ff1e3b332d6d9a0fa85cc9218e1d05dd6d673650ead6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/edf6d3b225de1b2d760d021b15a51e08d6337af4099a2dbc7046b9efa1b4756ae3c3a01e57554124c4595f8d62bb6dd267fe5d7982b220503db0770bddfd776a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/792f7324739af63dc4badcb618599cb074e10f17c226c8708d32d4e67466d74dac0a1e1f62939982ba8104a1c1f23fa9bf70b155738889f4b2edd09c6cdfe167", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7971dd40f301561c6c6c15f21b34e0e6e717247ee1934af3d9afb3103cd7d95a374ad653b64db062dd82c6cf2f1ee167285996d65c7edfa8d471a0a605228b42"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 20:18:58.915719) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 20:18:58.916125) ========= 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.mXytFqtRNx/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.voIA6b4kjG/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005280 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 20:18:58.964915) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 20:18:58.965240) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 20:18:58.965575) ========= ========= Total master_lag: 3.02 =========